builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1465208560.1 results: success (0) buildid: 20160606003129 builduid: 7d903f5d265440108d9a2ff2229e14a9 revision: 8f2c9241267a2b73f55eb366ad20e25c305623e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.103982) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.105222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.106065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.123452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.124210) ========= 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-1465208560.861517-2052398798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 03:22:41-- 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% 220M=0s 2016-06-06 03:22:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.356364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.497847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.498252) ========= 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-1465208560.861517-2052398798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014061 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.553557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:40.554527) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8f2c9241267a2b73f55eb366ad20e25c305623e8 --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 8f2c9241267a2b73f55eb366ad20e25c305623e8 --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-1465208560.861517-2052398798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 03:22:42,073 truncating revision to first 12 chars 2016-06-06 03:22:42,073 Setting DEBUG logging. 2016-06-06 03:22:42,073 attempt 1/10 2016-06-06 03:22:42,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8f2c9241267a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 03:22:42,395 unpacking tar archive at: mozilla-aurora-8f2c9241267a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:41.235224) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:41.235787) ========= script_repo_revision: 8f2c9241267a2b73f55eb366ad20e25c305623e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:41.236398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:41.236844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 03:22:41.249265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-06 03:22:41.249584) ========= /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-1465208560.861517-2052398798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:42 INFO - MultiFileLogger online at 20160606 03:22:42 in /builds/slave/test 03:22:42 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 03:22:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:42 INFO - {'append_to_log': False, 03:22:42 INFO - 'base_work_dir': '/builds/slave/test', 03:22:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:22:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:42 INFO - 'branch': 'Mozilla-Aurora', 03:22:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:42 INFO - 'config_files': ('talos/linux_config.py',), 03:22:42 INFO - 'default_actions': ('clobber', 03:22:42 INFO - 'read-buildbot-config', 03:22:42 INFO - 'download-and-extract', 03:22:42 INFO - 'populate-webroot', 03:22:42 INFO - 'create-virtualenv', 03:22:42 INFO - 'install', 03:22:42 INFO - 'run-tests'), 03:22:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:42 INFO - 'download_minidump_stackwalk': True, 03:22:42 INFO - 'download_symbols': 'ondemand', 03:22:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:42 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:42 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:42 INFO - 'installer_path': 'installer.exe', 03:22:42 INFO - 'log_level': 'info', 03:22:42 INFO - 'log_name': 'talos', 03:22:42 INFO - 'log_to_console': True, 03:22:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:42 INFO - 'opt_config_files': (), 03:22:42 INFO - 'pip_index': False, 03:22:42 INFO - 'sps_profile': False, 03:22:42 INFO - 'sps_profile_interval': 0, 03:22:42 INFO - 'suite': 'dromaeojs-e10s', 03:22:42 INFO - 'system_bits': '32', 03:22:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:42 INFO - 'title': 'talos-linux64-ix-067', 03:22:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:42 INFO - 'use_talos_json': True, 03:22:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:42 INFO - 'work_dir': 'build'} 03:22:42 INFO - ##### 03:22:42 INFO - ##### Running clobber step. 03:22:42 INFO - ##### 03:22:42 INFO - Running pre-action listener: _resource_record_pre_action 03:22:42 INFO - Running main action method: clobber 03:22:42 INFO - rmtree: /builds/slave/test/build 03:22:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:43 INFO - Running post-action listener: _resource_record_post_action 03:22:43 INFO - ##### 03:22:43 INFO - ##### Running read-buildbot-config step. 03:22:43 INFO - ##### 03:22:43 INFO - Running pre-action listener: _resource_record_pre_action 03:22:43 INFO - Running main action method: read_buildbot_config 03:22:43 INFO - Using buildbot properties: 03:22:43 INFO - { 03:22:43 INFO - "project": "", 03:22:43 INFO - "product": "firefox", 03:22:43 INFO - "script_repo_revision": "production", 03:22:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:22:43 INFO - "repository": "", 03:22:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:22:43 INFO - "buildid": "20160606003129", 03:22:43 INFO - "pgo_build": "True", 03:22:43 INFO - "basedir": "/builds/slave/test", 03:22:43 INFO - "buildnumber": 386, 03:22:43 INFO - "slavename": "talos-linux64-ix-067", 03:22:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:22:43 INFO - "platform": "ubuntu64_hw", 03:22:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:22:43 INFO - "branch": "mozilla-aurora", 03:22:43 INFO - "repo_path": "releases/mozilla-aurora", 03:22:43 INFO - "revision": "8f2c9241267a2b73f55eb366ad20e25c305623e8", 03:22:43 INFO - "stage_platform": "linux64-pgo", 03:22:43 INFO - "builduid": "7d903f5d265440108d9a2ff2229e14a9", 03:22:43 INFO - "slavebuilddir": "test" 03:22:43 INFO - } 03:22:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:22:43 INFO - Running post-action listener: _resource_record_post_action 03:22:43 INFO - ##### 03:22:43 INFO - ##### Running download-and-extract step. 03:22:43 INFO - ##### 03:22:43 INFO - Running pre-action listener: _resource_record_pre_action 03:22:43 INFO - Running main action method: download_and_extract 03:22:43 INFO - mkdir: /builds/slave/test/build/tests 03:22: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')]} 03:22:43 INFO - https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:44 INFO - Downloaded 1361 bytes. 03:22:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:22:44 INFO - Using the following test package requirements: 03:22:44 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:44 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:22:44 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:22:44 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'jsshell-linux-x86_64.zip'], 03:22:44 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:22:44 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:44 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:22:44 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:22:44 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:22:44 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:22:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:44 INFO - https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:45 INFO - Downloaded 24177783 bytes. 03:22:45 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'] 03:22:45 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 03:22:46 INFO - Return code: 0 03:22:46 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 03:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:46 INFO - https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:48 INFO - Downloaded 24177783 bytes. 03:22: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'] 03:22: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 03:22:49 INFO - Return code: 0 03:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:49 INFO - https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:51 INFO - Downloaded 10840145 bytes. 03:22: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'] 03:22: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 03:22:51 INFO - Return code: 0 03:22:51 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')]} 03:22:51 INFO - https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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 03:22:56 INFO - Downloaded 62826299 bytes. 03:22:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:22:56 INFO - mkdir: /builds/slave/test/properties 03:22:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:56 INFO - Contents: 03:22:56 INFO - build_url:https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:22:57 INFO - Running post-action listener: _resource_record_post_action 03:22:57 INFO - Running post-action listener: set_extra_try_arguments 03:22:57 INFO - ##### 03:22:57 INFO - ##### Running populate-webroot step. 03:22:57 INFO - ##### 03:22:57 INFO - Running pre-action listener: _resource_record_pre_action 03:22:57 INFO - Running main action method: populate_webroot 03:22:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:57 INFO - '--tppagecycles', 03:22:57 INFO - '7'], 03:22:57 INFO - 'tests': ['tsvgm']}}, 03:22:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['damp', 'tps']}, 03:22:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'tests': ['damp', 'tps']}, 03:22:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['dromaeo_dom']}, 03:22:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['a11yr', 03:22:57 INFO - 'ts_paint', 03:22:57 INFO - 'tpaint', 03:22:57 INFO - 'sessionrestore', 03:22:57 INFO - 'sessionrestore_no_auto_restore', 03:22:57 INFO - 'tabpaint']}, 03:22:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['tsvgx', 03:22:57 INFO - 'tsvgr_opacity', 03:22:57 INFO - 'tart', 03:22:57 INFO - 'tscrollx', 03:22:57 INFO - 'cart']}, 03:22:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:57 INFO - 'tsvgr_opacity', 03:22:57 INFO - 'tart', 03:22:57 INFO - 'tscrollx', 03:22:57 INFO - 'cart']}, 03:22:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'talos_options': ['--disable-e10s'], 03:22:57 INFO - 'tests': ['tp5o']}, 03:22:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'tests': ['tp5o']}, 03:22:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'talos_options': ['--disable-e10s', 03:22:57 INFO - '--xperf_path', 03:22:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:57 INFO - 'tests': ['tp5n']}, 03:22:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:57 INFO - 'talos_options': ['--xperf_path', 03:22:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:57 INFO - 'tests': ['tp5n']}}, 03:22:57 INFO - 'talos.zip': {'path': '', 03:22:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:57 INFO - Running post-action listener: _resource_record_post_action 03:22:57 INFO - ##### 03:22:57 INFO - ##### Running create-virtualenv step. 03:22:57 INFO - ##### 03:22:57 INFO - Running pre-action listener: _resource_record_pre_action 03:22:57 INFO - Running main action method: create_virtualenv 03:22:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:57 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 03:22:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:57 INFO - Using real prefix '/usr' 03:22:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:00 INFO - Installing pip.................done. 03:23:00 INFO - Return code: 0 03:23:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23: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', 'pip>=1.5'] in /builds/slave/test/build 03:23: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 pip>=1.5 03:23:00 INFO - Using env: {'DISPLAY': ':0', 03:23:00 INFO - 'HOME': '/home/cltbld', 03:23:00 INFO - 'LANG': 'en_US.UTF-8', 03:23:00 INFO - 'LANGUAGE': 'en_US:en', 03:23:00 INFO - 'LOGNAME': 'cltbld', 03:23:00 INFO - 'MAIL': '/var/mail/cltbld', 03:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:00 INFO - 'MOZ_NO_REMOTE': '1', 03:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:00 INFO - 'NO_EM_RESTART': '1', 03:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:00 INFO - 'PWD': '/builds/slave/test', 03:23:00 INFO - 'SHELL': '/bin/bash', 03:23:00 INFO - 'SHLVL': '1', 03:23:00 INFO - 'TERM': 'linux', 03:23:00 INFO - 'TMOUT': '86400', 03:23:00 INFO - 'USER': 'cltbld', 03:23:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:00 INFO - '_': '/tools/buildbot/bin/python'} 03:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:00 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 03:23:00 INFO - Cleaning up... 03:23:00 INFO - Return code: 0 03:23:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', '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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:23: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 psutil>=0.7.1 03:23:00 INFO - Using env: {'DISPLAY': ':0', 03:23:00 INFO - 'HOME': '/home/cltbld', 03:23:00 INFO - 'LANG': 'en_US.UTF-8', 03:23:00 INFO - 'LANGUAGE': 'en_US:en', 03:23:00 INFO - 'LOGNAME': 'cltbld', 03:23:00 INFO - 'MAIL': '/var/mail/cltbld', 03:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:00 INFO - 'MOZ_NO_REMOTE': '1', 03:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:00 INFO - 'NO_EM_RESTART': '1', 03:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:00 INFO - 'PWD': '/builds/slave/test', 03:23:00 INFO - 'SHELL': '/bin/bash', 03:23:00 INFO - 'SHLVL': '1', 03:23:00 INFO - 'TERM': 'linux', 03:23:00 INFO - 'TMOUT': '86400', 03:23:00 INFO - 'USER': 'cltbld', 03:23:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:00 INFO - '_': '/tools/buildbot/bin/python'} 03:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:00 INFO - Downloading/unpacking psutil>=0.7.1 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:02 INFO - Installing collected packages: psutil 03:23:02 INFO - Running setup.py install for psutil 03:23:02 INFO - building 'psutil._psutil_linux' extension 03:23:02 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 03:23:02 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 03:23:02 INFO - building 'psutil._psutil_posix' extension 03:23:02 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 03:23:03 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 03:23:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:03 INFO - Successfully installed psutil 03:23:03 INFO - Cleaning up... 03:23:03 INFO - Return code: 0 03:23:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:03 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:03 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 03:23:03 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 03:23:03 INFO - Using env: {'DISPLAY': ':0', 03:23:03 INFO - 'HOME': '/home/cltbld', 03:23:03 INFO - 'LANG': 'en_US.UTF-8', 03:23:03 INFO - 'LANGUAGE': 'en_US:en', 03:23:03 INFO - 'LOGNAME': 'cltbld', 03:23:03 INFO - 'MAIL': '/var/mail/cltbld', 03:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:03 INFO - 'MOZ_NO_REMOTE': '1', 03:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:03 INFO - 'NO_EM_RESTART': '1', 03:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:03 INFO - 'PWD': '/builds/slave/test', 03:23:03 INFO - 'SHELL': '/bin/bash', 03:23:03 INFO - 'SHLVL': '1', 03:23:03 INFO - 'TERM': 'linux', 03:23:03 INFO - 'TMOUT': '86400', 03:23:03 INFO - 'USER': 'cltbld', 03:23:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:03 INFO - '_': '/tools/buildbot/bin/python'} 03:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:23:03 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 03:23:03 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 03:23:03 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 03:23:03 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 03:23:03 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 03:23:03 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 03:23:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:23:05 INFO - Installing collected packages: mozsystemmonitor 03:23:05 INFO - Running setup.py install for mozsystemmonitor 03:23:05 INFO - Successfully installed mozsystemmonitor 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:05 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')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 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')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:05 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 03:23:05 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 03:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:07 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:07 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 03:23:07 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 03:23:07 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 03:23:07 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 03:23:07 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 03:23:07 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 03:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 INFO - Downloading docopt-0.6.1.tar.gz 03:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:08 INFO - Running setup.py install for blobuploader 03:23:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:08 INFO - Running setup.py install for requests 03:23:08 INFO - Running setup.py install for docopt 03:23:08 INFO - Successfully installed blobuploader requests docopt 03:23:08 INFO - Cleaning up... 03:23:09 INFO - Return code: 0 03:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:09 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:09 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 03:23:09 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 03:23:09 INFO - Using env: {'DISPLAY': ':0', 03:23:09 INFO - 'HOME': '/home/cltbld', 03:23:09 INFO - 'LANG': 'en_US.UTF-8', 03:23:09 INFO - 'LANGUAGE': 'en_US:en', 03:23:09 INFO - 'LOGNAME': 'cltbld', 03:23:09 INFO - 'MAIL': '/var/mail/cltbld', 03:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:09 INFO - 'MOZ_NO_REMOTE': '1', 03:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:09 INFO - 'NO_EM_RESTART': '1', 03:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:09 INFO - 'PWD': '/builds/slave/test', 03:23:09 INFO - 'SHELL': '/bin/bash', 03:23:09 INFO - 'SHLVL': '1', 03:23:09 INFO - 'TERM': 'linux', 03:23:09 INFO - 'TMOUT': '86400', 03:23:09 INFO - 'USER': 'cltbld', 03:23:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:09 INFO - '_': '/tools/buildbot/bin/python'} 03:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:09 INFO - Running setup.py (path:/tmp/pip-CG4EFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:09 INFO - Running setup.py (path:/tmp/pip-4LZQsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:09 INFO - Running setup.py (path:/tmp/pip-Sb1hoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:09 INFO - Running setup.py (path:/tmp/pip-eICjGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:09 INFO - Running setup.py (path:/tmp/pip-9V_Pj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:09 INFO - Running setup.py (path:/tmp/pip-0ptg5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:09 INFO - Running setup.py (path:/tmp/pip-A3BaRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:09 INFO - Running setup.py (path:/tmp/pip-pHb2ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:09 INFO - Running setup.py (path:/tmp/pip-_Lgyvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:09 INFO - Running setup.py (path:/tmp/pip-7wJ_8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:09 INFO - Running setup.py (path:/tmp/pip-DcxNxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:10 INFO - Running setup.py (path:/tmp/pip-_oLJ8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:10 INFO - Running setup.py (path:/tmp/pip-boGD26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:10 INFO - Running setup.py (path:/tmp/pip-fU1rPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:10 INFO - Running setup.py (path:/tmp/pip-KRnUiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:10 INFO - Running setup.py (path:/tmp/pip-Br7AgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:10 INFO - Running setup.py (path:/tmp/pip-2qSPcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:10 INFO - Running setup.py install for manifestparser 03:23:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozcrash 03:23:10 INFO - Running setup.py install for mozdebug 03:23:10 INFO - Running setup.py install for mozdevice 03:23:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozfile 03:23:11 INFO - Running setup.py install for mozhttpd 03:23:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozinfo 03:23:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozInstall 03:23:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozleak 03:23:11 INFO - Running setup.py install for mozlog 03:23:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for moznetwork 03:23:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozprocess 03:23:11 INFO - Running setup.py install for mozprofile 03:23:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozrunner 03:23:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:11 INFO - Running setup.py install for mozscreenshot 03:23:12 INFO - Running setup.py install for moztest 03:23:12 INFO - Running setup.py install for mozversion 03:23:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:12 INFO - Cleaning up... 03:23:12 INFO - Return code: 0 03:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:12 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:12 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 03:23:12 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 03:23:12 INFO - Using env: {'DISPLAY': ':0', 03:23:12 INFO - 'HOME': '/home/cltbld', 03:23:12 INFO - 'LANG': 'en_US.UTF-8', 03:23:12 INFO - 'LANGUAGE': 'en_US:en', 03:23:12 INFO - 'LOGNAME': 'cltbld', 03:23:12 INFO - 'MAIL': '/var/mail/cltbld', 03:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:12 INFO - 'MOZ_NO_REMOTE': '1', 03:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:12 INFO - 'NO_EM_RESTART': '1', 03:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:12 INFO - 'PWD': '/builds/slave/test', 03:23:12 INFO - 'SHELL': '/bin/bash', 03:23:12 INFO - 'SHLVL': '1', 03:23:12 INFO - 'TERM': 'linux', 03:23:12 INFO - 'TMOUT': '86400', 03:23:12 INFO - 'USER': 'cltbld', 03:23:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:12 INFO - '_': '/tools/buildbot/bin/python'} 03:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:12 INFO - Running setup.py (path:/tmp/pip-RiHGZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:12 INFO - Running setup.py (path:/tmp/pip-6OIbHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:12 INFO - Running setup.py (path:/tmp/pip-ODAQxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:12 INFO - Running setup.py (path:/tmp/pip-3RMc7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:12 INFO - Running setup.py (path:/tmp/pip-w77S6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:12 INFO - Running setup.py (path:/tmp/pip-L0jm3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:12 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)) 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:12 INFO - Running setup.py (path:/tmp/pip-_KyL5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:13 INFO - Running setup.py (path:/tmp/pip-xZzVsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:13 INFO - Running setup.py (path:/tmp/pip-PhlzV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:13 INFO - Running setup.py (path:/tmp/pip-0pKyWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:13 INFO - Running setup.py (path:/tmp/pip-3BZHLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:13 INFO - Running setup.py (path:/tmp/pip-YteM7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:13 INFO - Running setup.py (path:/tmp/pip-ILQuTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:13 INFO - Running setup.py (path:/tmp/pip-V0OjNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:13 INFO - Running setup.py (path:/tmp/pip-LiJfb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:13 INFO - Running setup.py (path:/tmp/pip-klrZXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:13 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)) 03:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:13 INFO - Running setup.py (path:/tmp/pip-MQrxny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:13 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)) 03:23:13 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)) 03:23:13 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)) 03:23:13 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)) 03:23:13 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)) 03:23:13 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)) 03:23:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:15 INFO - Downloading blessings-1.6.tar.gz 03:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:15 INFO - Installing collected packages: blessings 03:23:15 INFO - Running setup.py install for blessings 03:23:15 INFO - Successfully installed blessings 03:23:15 INFO - Cleaning up... 03:23:15 INFO - Return code: 0 03:23:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:16 INFO - Reading from file tmpfile_stdout 03:23:16 INFO - Current package versions: 03:23:16 INFO - argparse == 1.2.1 03:23:16 INFO - blessings == 1.6 03:23:16 INFO - blobuploader == 1.2.4 03:23:16 INFO - docopt == 0.6.1 03:23:16 INFO - manifestparser == 1.1 03:23:16 INFO - mozInstall == 1.12 03:23:16 INFO - mozcrash == 0.17 03:23:16 INFO - mozdebug == 0.1 03:23:16 INFO - mozdevice == 0.48 03:23:16 INFO - mozfile == 1.2 03:23:16 INFO - mozhttpd == 0.7 03:23:16 INFO - mozinfo == 0.9 03:23:16 INFO - mozleak == 0.1 03:23:16 INFO - mozlog == 3.1 03:23:16 INFO - moznetwork == 0.27 03:23:16 INFO - mozprocess == 0.22 03:23:16 INFO - mozprofile == 0.28 03:23:16 INFO - mozrunner == 6.11 03:23:16 INFO - mozscreenshot == 0.1 03:23:16 INFO - mozsystemmonitor == 0.0 03:23:16 INFO - moztest == 0.7 03:23:16 INFO - mozversion == 1.4 03:23:16 INFO - psutil == 3.1.1 03:23:16 INFO - requests == 1.2.3 03:23:16 INFO - wsgiref == 0.1.2 03:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:16 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:16 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 03:23:16 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 03:23:16 INFO - Using env: {'DISPLAY': ':0', 03:23:16 INFO - 'HOME': '/home/cltbld', 03:23:16 INFO - 'LANG': 'en_US.UTF-8', 03:23:16 INFO - 'LANGUAGE': 'en_US:en', 03:23:16 INFO - 'LOGNAME': 'cltbld', 03:23:16 INFO - 'MAIL': '/var/mail/cltbld', 03:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:16 INFO - 'MOZ_NO_REMOTE': '1', 03:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:16 INFO - 'NO_EM_RESTART': '1', 03:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:16 INFO - 'PWD': '/builds/slave/test', 03:23:16 INFO - 'SHELL': '/bin/bash', 03:23:16 INFO - 'SHLVL': '1', 03:23:16 INFO - 'TERM': 'linux', 03:23:16 INFO - 'TMOUT': '86400', 03:23:16 INFO - 'USER': 'cltbld', 03:23:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:16 INFO - '_': '/tools/buildbot/bin/python'} 03:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 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)) 03:23:16 INFO - Cleaning up... 03:23:16 INFO - Return code: 0 03:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23: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', 'jsonschema'] in /builds/slave/test/build 03:23: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 jsonschema 03:23:16 INFO - Using env: {'DISPLAY': ':0', 03:23:16 INFO - 'HOME': '/home/cltbld', 03:23:16 INFO - 'LANG': 'en_US.UTF-8', 03:23:16 INFO - 'LANGUAGE': 'en_US:en', 03:23:16 INFO - 'LOGNAME': 'cltbld', 03:23:16 INFO - 'MAIL': '/var/mail/cltbld', 03:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:16 INFO - 'MOZ_NO_REMOTE': '1', 03:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:16 INFO - 'NO_EM_RESTART': '1', 03:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:16 INFO - 'PWD': '/builds/slave/test', 03:23:16 INFO - 'SHELL': '/bin/bash', 03:23:16 INFO - 'SHLVL': '1', 03:23:16 INFO - 'TERM': 'linux', 03:23:16 INFO - 'TMOUT': '86400', 03:23:16 INFO - 'USER': 'cltbld', 03:23:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:16 INFO - '_': '/tools/buildbot/bin/python'} 03:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:16 INFO - Downloading/unpacking jsonschema 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:18 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23: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 03:23:18 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:18 INFO - warning: no files found matching '*.txt' 03:23:18 INFO - no previously-included directories found matching 'build' 03:23:18 INFO - no previously-included directories found matching 'dist' 03:23:18 INFO - no previously-included directories found matching '.git*' 03:23:18 INFO - Installing collected packages: jsonschema, functools32 03:23:18 INFO - Running setup.py install for functools32 03:23:18 INFO - warning: no files found matching '*.txt' 03:23:18 INFO - no previously-included directories found matching 'build' 03:23:18 INFO - no previously-included directories found matching 'dist' 03:23:18 INFO - no previously-included directories found matching '.git*' 03:23:18 INFO - Successfully installed jsonschema functools32 03:23:18 INFO - Cleaning up... 03:23:18 INFO - Return code: 0 03:23:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:18 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')]} 03:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 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')]} 03:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 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 0x7f65e2202f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14355a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, '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-1465208560.861517-2052398798', '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 03:23:18 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 03:23:18 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 03:23:18 INFO - Using env: {'DISPLAY': ':0', 03:23:18 INFO - 'HOME': '/home/cltbld', 03:23:18 INFO - 'LANG': 'en_US.UTF-8', 03:23:18 INFO - 'LANGUAGE': 'en_US:en', 03:23:18 INFO - 'LOGNAME': 'cltbld', 03:23:18 INFO - 'MAIL': '/var/mail/cltbld', 03:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:18 INFO - 'MOZ_NO_REMOTE': '1', 03:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:18 INFO - 'NO_EM_RESTART': '1', 03:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:18 INFO - 'PWD': '/builds/slave/test', 03:23:18 INFO - 'SHELL': '/bin/bash', 03:23:18 INFO - 'SHLVL': '1', 03:23:18 INFO - 'TERM': 'linux', 03:23:18 INFO - 'TMOUT': '86400', 03:23:18 INFO - 'USER': 'cltbld', 03:23:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:18 INFO - '_': '/tools/buildbot/bin/python'} 03:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:19 INFO - Downloading/unpacking flake8 03:23:19 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 03:23:19 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 03:23:19 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 03:23:19 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 03:23:19 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 03:23:19 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 03:23:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:21 INFO - no previously-included directories found matching 'docs/_build' 03:23:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:21 INFO - Running setup.py install for pep8 03:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:21 INFO - no previously-included directories found matching 'docs/_build' 03:23:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:23:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:21 INFO - Cleaning up... 03:23:21 INFO - Return code: 0 03:23:21 INFO - Running post-action listener: _resource_record_post_action 03:23:21 INFO - Running post-action listener: _start_resource_monitoring 03:23:21 INFO - Starting resource monitoring. 03:23:22 INFO - ##### 03:23:22 INFO - ##### Running install step. 03:23:22 INFO - ##### 03:23:22 INFO - Running pre-action listener: _resource_record_pre_action 03:23:22 INFO - Running main action method: install 03:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:22 INFO - Reading from file tmpfile_stdout 03:23:22 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:22 INFO - Reading from file tmpfile_stdout 03:23:22 INFO - Output received: 03:23:22 INFO - Usage: mozinstall [options] installer 03:23:22 INFO - Options: 03:23:22 INFO - -h, --help show this help message and exit 03:23:22 INFO - -d DEST, --destination=DEST 03:23:22 INFO - Directory to install application into. [default: 03:23:22 INFO - "/builds/slave/test"] 03:23:22 INFO - --app=APP Application being installed. [default: firefox] 03:23:22 INFO - mkdir: /builds/slave/test/build/application 03:23:22 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'] 03:23:22 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 03:23:37 INFO - Reading from file tmpfile_stdout 03:23:37 INFO - Output received: 03:23:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:37 INFO - Running post-action listener: _resource_record_post_action 03:23:37 INFO - ##### 03:23:37 INFO - ##### Running run-tests step. 03:23:37 INFO - ##### 03:23:37 INFO - Running pre-action listener: _resource_record_pre_action 03:23:37 INFO - Running main action method: run_tests 03:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:37 INFO - Python 2.7.3 03:23:37 INFO - Return code: 0 03:23:37 INFO - grabbing minidump binary from tooltool 03:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:37 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 0x14c4410>, '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 0x14c5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:37 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 03:23:37 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 03:23:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:37 INFO - Return code: 0 03:23:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:38 INFO - Return code: 0 03:23:38 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/PCrdcbm7RC6hLcqoIUXqqQ/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 03:23:38 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/PCrdcbm7RC6hLcqoIUXqqQ/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 03:23:38 INFO - Using env: {'DISPLAY': ':0', 03:23:38 INFO - 'HOME': '/home/cltbld', 03:23:38 INFO - 'LANG': 'en_US.UTF-8', 03:23:38 INFO - 'LANGUAGE': 'en_US:en', 03:23:38 INFO - 'LOGNAME': 'cltbld', 03:23:38 INFO - 'MAIL': '/var/mail/cltbld', 03:23:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:38 INFO - 'MOZ_NO_REMOTE': '1', 03:23:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:38 INFO - 'NO_EM_RESTART': '1', 03:23:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:38 INFO - 'PWD': '/builds/slave/test', 03:23:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:38 INFO - 'SHELL': '/bin/bash', 03:23:38 INFO - 'SHLVL': '1', 03:23:38 INFO - 'TERM': 'linux', 03:23:38 INFO - 'TMOUT': '86400', 03:23:38 INFO - 'USER': 'cltbld', 03:23:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465208560.861517-2052398798', 03:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:38 INFO - '_': '/tools/buildbot/bin/python'} 03:23:38 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/PCrdcbm7RC6hLcqoIUXqqQ/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 03:23:39 INFO - mozversion application_buildid: 20160606003129 03:23:39 INFO - mozversion application_changeset: 8f2c9241267a2b73f55eb366ad20e25c305623e8 03:23:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:23:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:39 INFO - mozversion application_name: Firefox 03:23:39 INFO - mozversion application_remotingname: firefox-dev 03:23:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:39 INFO - mozversion application_vendor: Mozilla 03:23:39 INFO - mozversion application_version: 48.0a2 03:23:39 INFO - mozversion platform_buildid: 20160606003129 03:23:39 INFO - mozversion platform_changeset: 8f2c9241267a2b73f55eb366ad20e25c305623e8 03:23:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:39 INFO - mozversion platform_version: 48.0a2 03:23:39 INFO - using testdate: 1465208619 03:23:39 INFO - actual date: 1465208619 03:23:39 INFO - starting webserver on 'localhost:56930' 03:23:39 INFO - SUITE-START | Running 2 tests 03:23:39 INFO - TEST-START | dromaeo_css 03:23:39 INFO - operating with platform_type : linux_ 03:23:39 INFO - Initialising browser for dromaeo_css test... 03:23:39 INFO - TEST-INFO | started process 23347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5uOS10/profile http://localhost:56930/getInfo.html) 03:23:42 INFO - PROCESS | 23347 | 03:23:42 INFO - PROCESS | 23347 | (process:23424): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:23:43 INFO - PROCESS | 23347 | __metrics Screen width/height:1600/1200 03:23:43 INFO - PROCESS | 23347 | colorDepth:24 03:23:43 INFO - PROCESS | 23347 | Browser inner width/height: 1024/697 03:23:43 INFO - PROCESS | 23347 | __metrics 03:23:43 ERROR - PROCESS | 23347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 03:23:44 INFO - TEST-INFO | 23347: exit 0 03:23:44 INFO - Browser initialized. 03:23:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:44 INFO - TEST-INFO | started process 23475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5uOS10/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:46 INFO - PROCESS | 23475 | 03:23:46 INFO - PROCESS | 23475 | (process:23542): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:23:56 INFO - PROCESS | 23475 | RSS: Main: 152035328 03:23:56 INFO - PROCESS | 23475 | 03:24:45 INFO - PROCESS | 23475 | 1465208685800 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] 03:26:53 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56930/tests/dromaeo/cssquery-ext.html) 03:26:54 INFO - PROCESS | 23475 | RSS: Main: 155611136 03:26:54 INFO - PROCESS | 23475 | 03:29:56 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-ext.html (next: http://localhost:56930/tests/dromaeo/cssquery-jquery.html) 03:29:56 INFO - PROCESS | 23475 | RSS: Main: 153989120 03:29:56 INFO - PROCESS | 23475 | 03:32:58 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56930/tests/dromaeo/cssquery-mootools.html) 03:32:58 INFO - PROCESS | 23475 | RSS: Main: 153673728 03:32:58 INFO - PROCESS | 23475 | 03:36:00 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56930/tests/dromaeo/cssquery-prototype.html) 03:36:01 INFO - PROCESS | 23475 | RSS: Main: 153407488 03:36:01 INFO - PROCESS | 23475 | 03:39:03 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56930/tests/dromaeo/cssquery-yui.html) 03:39:04 INFO - PROCESS | 23475 | RSS: Main: 154644480 03:39:04 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | Cycle 1(1): loaded http://localhost:56930/tests/dromaeo/cssquery-yui.html (next: http://localhost:56930/tests/dromaeo/cssquery-dojo.html) 03:42:06 INFO - PROCESS | 23475 | RSS: Main: 155865088 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | __start_tp_report 03:42:06 INFO - PROCESS | 23475 | _x_x_mozilla_page_load 03:42:06 INFO - PROCESS | 23475 | _x_x_mozilla_page_load_details 03:42:06 INFO - PROCESS | 23475 | |i|pagename|runs| 03:42:06 INFO - PROCESS | 23475 | |0;dojo.html;3324.90025299241;3396.167938854981;3420.2817408344245;3435.742319326048;3483.4774783782445;5567.081431563797;5591.524720398766;5607.887842243153;5625;5629.9999999999945;5533.363663178736;5543.362513310971;5568.192612071247;5597.748101335439;5600.243967064445;5037.874053148664;5071.442141364447;5093.872653183663;5152.458991805844;5175.275461435402;4967.70193788372;5143.665661731994;5215.113430716769;5227.5295223429885;5235.921461178085;5072.9492705073035;5101.617378696594;5104.846854594368;5192.636515443921;5205.583553315726;5192.454792246816;5233.293505376782;5248.8687782805355;5250.369955605313;5254.789808407659;5020.523050310215;5038.093143234217;5056.924146137811;5075.959428317186;5115.258287548285;5291.57667386612;5377.139657654796;5406.378266499363;5416.268803711488;5458.836234912959;6005.519558435315;6013.428724271187;6044.184035155242;6046.365131661156;6048.909266361008;6081.209442772411;6092.847678808021;6105.511559075308;6106.694665266763;6119.602225855349;5550.833474995757;5617;5652.85867853307;5683.3464151622675;5730.197772311922;6209.565330426917;6215.627062376272;6215.81352559424;6226.128342032119;6229.408206220402;5939.07944268639;5978.671173085435;5979.402059794073;5981.342052374235;5997.670128142907;6091.238595175603;6165.445109940127;6186.041163619646;6191.19514463117;6200.193974783249;6106.023036314257;6118.571699980958;6119;6122.20411346531;6127.417895299939;5694.487496125369;5893.5874488785375;5976.163337132805;6101.308708231456;6144.969275153685;4499.572540608637;4504.842330518416;4511.413516242867;4519.118771839526;4534.229181039232;4059.04612416082;4059.1818973020017;4066.8576599818866;4086.4279000939296;4086.4891888513935;5530.198121272393;5596.608237423341;5624.887502250014;5670.971645141831;5709.05800542914;5860.882782344329;5943.108533719977;5994.970025149846;6006.579539432285;6024.698765061729;5683.829485115453;5711.029125048752;5720;5736.856578585569;5739.62692424991;4900.411950565884;4947.134251505972;4996.825111121093;5079.593632509391;5091.847244582668;6102.298235702862;6154.261488621394;6155.384461553898;6166.660833654102;6169.907451388232;5950.166976623363;5950.404959504015;5959.195508606283;5985.40145985398;5988.101784732325;6039.849003774941;6159.29168145669;6223.595466294676;6265.8746825062335;6275.811725648238;6005.189299444519;6052.182955300978;6052.818415447544;6056.06131049688;6098.11577321277;5816.70916454184;6118.449339559461;6160.507159427146;6164.876702466016;6170;5977.521798256216;5979.701014949148;5996.1005849122985;6041.818745437644;6079.118527813531;5762.250907382014;5819.5344372450945;5827.388124246893;5829.912551311649;5855.268091488564;5667.149927510906;5684.71576421169;5728.283964504437;5735.426457354398;5747.8563035924435;5843.532517398513;5882.441168089024;5887.4406931341455;5898.675572843363;5929.0513517836935;5689.8862022758485;5769.59612827098;5776.9133462998925;5779.8555036124435;5798.768049277982 03:42:06 INFO - PROCESS | 23475 | |1;ext.html;683.0983102304956;685.3728838113127;685.9657017149141;721.2030706069796;754.6528596845451;32728.509072363933;37520.81239593802;38688.419673704884;38831.22337553247;38991.41512877309;41048.58951410485;41869;41901.371479427835;42139;42157.367639485434;8793.2965362771;8923.241524470428;8943.865842012376;8955.37312388133;8967.417117887317;8751.781205469882;8911.287097032222;8916.197542221198;8952.373333866632;9163.266938644925;9136.908630913673;9144.634214631407;9166.770830729218;9226.215771659383;9241.399309044924;9050.1854833065;9081.137291957253;9118.452892826452;9173.403728757676;9184.632614695403;8873.334499912533;8996.505192214425;8998.460092394478;9017.323700722407;9035.186833185046;41540.79229603863;41911.1617767643;42083;42135.7893210532;42200.36699449511;3705.5368078990127;4340.283853164224;4400.933985990213;4452.28763397858;4607.17070927233;31508.21229469259;31512.527312090337;32183.678163218538;32373.676263237303;34036.82981585101;4154.771487568182;4186.895327616803;4234.30134027885;4258.403823464718;4303.311470164758;297175;297782.99999999785;298092;298196;298627;38105.047373815876;38779.61220387816;38811.41782873259;57948.4205157943;59184.408155918754;37084.62915370866;37108;37166.44250336247;37180.62819371772;37219.62780372162;15720.135392553519;15769.68460630804;15777.526674199793;15835.68328633421;15855.841441585437;14414.42342306296;14449.49426770058;14470.131792092508;14503.782443263359;14510.492132775302;9219.585118669676;9238.722838314861;9266.258699304039;9329.580168892417;9329.580168892417;3637.727170462226;3665.9266814664093;3671.889843304705;3673.8714145005333;3705.6850167735506;1085.2728671789919;1138.9829152562718;1203.8615559210627;1220.7619514194823;1299.1685321394316;31860.681393186234;31918.202044949063;32395.838020809744;32874;33134.17164570857;1257.1388598809845;1266.2972050512055;1285.1903300920546;1292.928888911119;1341.222091187109;16817.66364672724;17081.743773843402;17138.914305428392;17158.227879745442;17272.877262977865;482599;490623;539682;858791;875824;58796;60117.39882601118;60152.39847601468;60272.09591856126;60606.090908636404;1533.6472611299241;1543.3826469412325;1550.5115888495088;1555.36230145642;1555.6110972256936;32018.51972220372;32437;32514.674853251163;32758.836205818818;33023.174420639676;51220.487795121575;51873.22190167226;51888.74055629698;51985;52322;412118;413192;413282;415550;415756;30553;30640.540391893694;30828.845855770578;30878.38243235168;30945.226369340045;46723.29915051345;47128;47321;47549.049019018734;48082;39811.40282895817;39961.40057899075;40096.39855402229;40728.3890741645;41490.37764433596;39734.40398393969;39930;39948;40625.59374406218;40993.38509922294;40513.59486405098;41118;41609.58390416057;41640.79179604204;42024.789876050425;34993.47509787406;35705.82147089248;35724.821375892956;35868.64131358653;36155;27810;27876.16371508858;27933.720662793112;27958.161255162377;28179.43641127207 03:42:06 INFO - PROCESS | 23475 | |2;jquery.html;427.4400535298759;435.27309393313163;439.5648308174907;443.5054913771146;443.54536599985016;18242.726359104625;19011.33460328887;19165.904170479145;19637.803621963776;20483.590328193426;19549.21803127873;19879.304224352152;19920.203191872308;20246.392608221777;20387.08258128384;5639.577031722617;5734.254546908896;5847;5855.736491857877;5857.121431785224;5504.779808807642;5764.682942438164;5776.508996735282;5790.623609465371;5832.912506312408;5680.772769089232;5695.715214239292;5704.34400043994;5705.172749951254;5760.135979603072;5917.319508256563;5925.20009798676;5928.258967629046;5939.049752039675;5941.940580594182;5787.363390027093;5796.681182534959;5801.419858014207;5808.390119037483;5832.416758324176;13802.240876751775;14108.506202282872;14319.14085154894;14375.784363234456;14935.775963360558;2406.049610403898;2471.295680730983;2526.2800101971034;2672.4521473097966;3042.1025797389825;9941.155001824853;10286.794264114676;10346.172306215485;10410.479476026245;10854.45727713611;1994.1923520973883;2089.477630592352;2107.262458139654;2115.1962254343407;2117.9304451252174;79176;79626.60186699088;79791;81839.59080204621;82023.17976820216;11176.329420234812;11668.824967625493;11683.824742628867;11728.413579321;11745.88254117465;16220.918895405448;16277;16397.934134281233;16403.343866245454;16442.342306307615;8914.910850891538;9296.72109836706;9303.906960930304;9312.301577381588;9324.673636422693;8463.534505602127;8465.873011904827;8621.353398495137;8635.740927772176;9016.278697704169;4827.468978412372;5074.517920797518;5090.77091530882;5128.794848206105;5142.61430392722;1912.2351059576004;2046.19175425709;2111.4721319670084;2111.4932416219995;2171.4028642123544;1019.3323373190572;1025.8563801067855;1028.100412139378;1030.474897152219;1065.8561094252332;16854.325826966782;18359.541011474554;19135.90432047831;19388.12753426099;19480.902595486932;1063.6224140430036;1069.657709532942;1087.3149915553308;1139.3107170162098;1143.5482984221187;10574.894251057545;10847.40339281347;10887;10973.670789876316;11048.889511104786;511770;516151;518805;522386;522461;91579;91675;92638.53680731553;92772;93498.53250733839;1084.0839490630406;1105.5688281570194;1125.2854437432127;1149.1783374886995;1155.5320095361392;16873.662526749642;17125;17173.484795456156;17205.39781107705;17442.738358924373;39066;39482.21035579215;39842.60157398505;40447;40827.38758918678;58965.11552326805;58977;59194;59671;59697;8591.140885911358;8939.821203576023;9172.35793494449;9298.442093474414;9322.673706420243;11964.46159922823;12928.935355323163;13529;13575.185488870698;13689.383977720827;11611;11715.941420292844;11914.463849126636;11969.521219151136;12377.876221237673;11449.370284634091;11844.466998984894;11973.820392693942;12060.75878482443;12084.154109212623;12249;12258.570950016707;12266.632001039983;12298.692532686755;12448.81326780081;8950.14973577509;9084.273258139465;9206.079392061009;9208.953955230181;9267.953660231655;9766.75583110428;12182.451789669309;12200.14598978063;12204.938975305067;12243.265404075784 03:42:06 INFO - PROCESS | 23475 | |3;mootools.html;1561.3832536148223;1563.3199558192184;1751.7810273715786;1881.9811801881976;1891.7919028906808;7311.634418279092;7819.765407037798;8323.41736078474;8529.616167272472;8547.957260213698;8342.874856877152;8369.497830130182;8377.874331885012;8389.37079719022;8419.452735572198;2289.942751431211;2295.437617783641;2320.3271051395077;2324.500232450023;2337.836351455399;2346.718393792747;2367.8579285242854;2393.3896856301617;2395.101836811196;2397.3167647220544;2305.8616483011074;2310.4685922237895;2312.4450131968374;2341.648752687102;2343.3321503371544;2355.658429527709;2360.6577046328184;2369.6919400477914;2370.12305446984;2377.8335516513853;2335.859848409101;2379.238643634038;2379.773921477457;2382.463945612241;2398.8920498577604;8585.18440748128;8628.22345988864;8639.049704532496;8647.394682372236;8659.826803463895;5154.613403994678;5236.502532259429;5237.188235823453;5276.103062479349;5277.419483856773;3312.360381611118;3332.450145725952;3382.0699307690584;3426.7087297579737;3451.0854623524788;1172.2029020266216;1221.2733423612935;1223.6757259326287;1237.4369661803858;1238.5726924211133;11884.227525210834;11926;12009.519619215222;12080.758384832343;12087.818682719766;4635.490096089427;4656.348111264426;4660.883477913011;4712.081144176853;4838.225883858566;10387.94806025965;10431.634892778717;10468.895311046945;10479.633212837514;10481.423521706227;5255.737213139328;5273.34083239595;5284.682919024871;5304.549113325411;5327.200919861974;4243.575642435793;4769.761511924459;4803.735794531264;4869.440014398318;4880.511948805091;4010.8997275068355;4048.3117869962175;4057.6753859691153;4120.75275483472;4135.627793498599;1317.8879795217322;1354.2010213973606;1366.3987845348213;1376.3049659921676;1379.751644703943;1063.3938654966748;1106.286445242814;1107.413071072333;1116.6761639124725;1117.201201141188;6120.265568131764;6215.81352559424;6229.0967809667345;6302.023186406114;6318.936810631927;465.7438408875105;497.56960229401307;498.718224203324;504;506.7896822818563;4288.035192081757;4311.978440107842;4331.696781225284;4343.1747967886;4345.30475123985;10062.597496100074;10495.632652857113;10652.57389704403;10781.137508999262;10869.510872010778;10331.121854642439;10518.105960993402;10548.947255263827;10587.84118238227;10618.256722029384;7818.257265559762;8106.837863242702;8156.755297341089;8178.5092894426525;8193.50838949665;5628.352739434854;5814.709264536672;5930.733117009831;5933.436323549256;5945.613535120204;8755.605997730245;8816.911830881609;8834.779130521789;9045.909540904508;9086.091390860862;8709.303255739398;8743.562821859008;8856.335774816785;8857.867131993155;8859.11408859109;6684.665766711742;7245.5652660840515;7442;7470.775876723707;7621.847563048819;8118.188181181835;8146.185381461806;8167.591620419074;8201.58992050407;8221.917780822116;7339.155997060407;7367.963160184165;7517.060367454068;7618.162002179866;7619.580923049064;7455.366293865082;7478.140013898471;7581.393488521016;7591.506552074097;7653.846923061619;6913.965430173018;6940.722371105301;7005.22942476317;7006.649667516705;7020.333068358498;5174.7153906533995;5205.271262023244;5329.960657671717;5382.4886635769535;5382.73086345689;5033.622478314214;5075.847724568269;5161.535461808456;5191.351081114861;5308 03:42:06 INFO - PROCESS | 23475 | |4;prototype.html;363.4149020077675;363.6036719975227;365.1018494503521;369.3757549740936;371.25933762144507;6618.635975021371;6625.204975402952;6644.966775166129;6696.129503164581;6751.257361690223;6641.203055633331;6645.302243264448;6654.3345665433435;6654.534182607207;6662.167229096363;4821.710697358152;4924.852254432355;5026.924596131061;5039.092963266628;5046.873828154307;5005.774740136702;5023.773930173133;5027.220780778966;5031.094403007457;5033.11920413928;4978.452370239271;5000.399952005764;5005.949940500603;5006.599472042246;5017.347744793172;4999.775010124535;5055.4186268579215;5055.69665820052;5056.317397151411;5070.3915530136255;4454.532274111204;4459.843905463294;4461.464624245112;4462.085272519126;4483.237849565582;6194.225721784777;6383.808485745435;6390.488760899163;6391.360863913618;6402.519811014146;5803.854903627401;5803.941960580424;5821.388754180793;5824.592278540504;5836;7012.439004879649;7035.085438892962;7040;7040.507164498487;7050.189228238715;4769.523047695237;4777.689450185727;4780.856574302777;4782.0914026334885;4794.041191761662;7188.20929697738;7266.200717921024;7275.236100209508;7287.489875708702;7354.117505899273;4909.975450122726;4932.53140951609;4933.851984440473;4937.432195297515;4938.82691615688;4944.431390390079;4984.950150498448;4988.301637770643;4990.051890140861;5003.199488081889;5781.248437703071;5795.826125216166;5817.592768506249;5820.505257053113;5829.271341082364;7074;7075.575465472089;7083.610401427971;7098.716051357991;7109.040279562297;1746.493516880116;1767.8143794901607;1769.2303847826238;1769.8672599555084;1770.4246120011048;1130.1015692524463;1148.8506494155706;1150.0626989003936;1159.5767544846071;1162.4885050577718;6767;6786.76246331376;6789.830254243683;6812.625305608239;6813.454923606099;7172.533785303938;7207.855842883113;7236.240194779472;7254.96372518134;7371.741989030358;6822.556533825285;6828.351306625863;6860.176778786477;6870.3473170048765;6879.208890977501;3939.5075615548058;3966.4050392441363;3969.603039696065;3971.5631280559114;3973.344398174269;7661.310482056641;7676.53940763556;7676.884846727304;7684.923150768421;7694.807629809187;7356.1540422850985;7551.358134558514;7555;7562.357199637982;7564.357029652431;7602.277783610659;7607.35337496319;7610.124835643972;7616.3906887448875;7640.885386719204;7295.270472952662;7309.671064802203;7309.707611695472;7318.3047610476915;7319.926800731924;7230.313120253568;7246.565206087652;7248.238934911969;7249.746258880914;7259.891101633374;7404.777856664308;7561.886571701319;7589.962050189713;7594.430417718582;7656.464047516621;4938;4958.851234462972;4961.454240033666;4969.229769385751;4970.8757281068265;7255.52839065459;7271.3455788979245;7282.927170728437;7286.016387787581;7321.926780732338;7077.150741911004;7080;7118.110236220473;7121.323474269936;7125.786226413215;6835.282295358916;7070.8232294191;7082.929170708227;7114.50198486101;7116.644167791694;6959.617221052688;6980.441564674712;6992.3357281058215;6992.580445173306;6992.930070699228;7170.569765814068;7177.389921856492;7178.605176715122;7181.210066892533;7190.496665233383;6831.829204269734;6842.93157068423;6896.551724137915;6926.480513961373;6975.372216500539 03:42:06 INFO - PROCESS | 23475 | |5;yui.html;843.3084870406269;911.7674992876815;918.2929144558685;930.3487558708904;933.906609339066;15385.92307038466;16582;16871.325146994106;17011.064391458465;17037.318507259726;15573.688526229469;15706.921465392687;15708.371665133409;15738.606534836606;15818.130002849839;869.9913000870005;885.6723012485389;887.104024934814;903.0969030969031;919.2783664823115;915.7619019055027;917.1149840404008;922.6078916460511;925.4863550729342;926.8841394825647;937.4422218779815;939.492673956063;939.7227817793768;943.3726571829725;944.6127087893965;937.7280588629324;938.7840796616782;938.7840796616816;941.6186444489992;945.0691069296771;685.9211190713032;687.9759208427731;688.1707542411382;689.4966674327719;690.1580072311822;14084.718305633933;14118.647033824134;14199.432022719182;14212.147271163763;14220.786688199685;14754.48359307419;14906.552803415914;14948.775768363483;15034;15058.698826023417;11955.402229888557;12066.396680165957;12143.149979501439;12302.261864288083;12319.445624946899;4006.559278479365;4017.7589344639414;4064.227796718614;4203.684723645739;4226.619604235633;55901;55976.44023559753;56230;56857;57037.42962570404;11495.597654082067;11667.708307292216;11736.237144585575;11771.705707357214;11886.881131188577;20300.796992030188;20380.184792608427;20462.07920643545;20561.280355187497;20620.69068963967;9028.09719028092;9038.774030649287;9202.35583509148;9289;9432.669856555125;4499.280115181556;4520.321951707205;4920.852374428773;5028.17035189197;5028.396592408934;3445.2937147885123;3481.599616044137;3509.508668786372;3510.438329867209;3516.40221162403;651.4267444648774;652.5790864892213;701.8561194955022;708.3129364516411;719.2950908110081;704.8555046215514;734.1630541183056;770.3721467004374;784.4587234807964;791.3352783661752;9771.657991970247;9790.951045244728;10003.2997690161;10079.798404031879;10084.092431681183;750.5421692767408;797.2665148063795;810.6878851642042;840.8864803251605;846.6782622603495;4538.2738761797955;4638.652101092364;4698.248280275139;4717.080169366941;4842.564169224786;66542.66728666326;67025.6648716763;67662.66168669125;68676.65661671759;68914;56053.43946560564;56087.15869261965;59002.70498647479;59061;61293.69353153206;53980.19029714557;54123.458765411844;54315.18527222095;54501;54825.45174548283;9904.752381190528;9927.602895884083;10070.899291007288;10255.794884102126;10354.482275886327;38349.61650383461;39502.60497394989;39861;40250.39624405577;40376.79811600923;47457.28814067861;50863.74568127136;50979;53402.73298633482;53827.730861345444;12859.871401285867;13027.08810383264;13091.607251782461;13146.34268286601;13368.331583420984;13859.237741924291;14076.929615351857;14284.28997298092;14502.274886255434;14866.925665371604;12683.365831708563;12988.220706757626;13725.245111518563;13846.169229846242;14348.210848403438;12372.381380931098;13311.26788026629;13413.463461461432;14077.366518506487;14239.288035597972;13080.411381487665;13467.797983030066;13562.601609798616;13757.449702012207;13944;11052.834207487054;11306.208565400342;11822.039780276686;11942.761144776881;11950.581729639422;10980.945095274472;11126.88873111291;11329.71675708114;11390.25963312382;11422.31466112036 03:42:06 INFO - PROCESS | 23475 | __end_tp_report 03:42:06 INFO - PROCESS | 23475 | __start_cc_report 03:42:06 INFO - PROCESS | 23475 | _x_x_mozilla_cycle_collect,336 03:42:06 INFO - PROCESS | 23475 | __end_cc_report 03:42:06 INFO - PROCESS | 23475 | __startTimestamp1465209726649__endTimestamp 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | ------- Summary: start ------- 03:42:06 INFO - PROCESS | 23475 | Number of tests: 6 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#0] dojo.html Cycles:165 Average:5589.06 Median:5762.25 stddev:636.46 (11.0%) stddev-sans-first:613.13 03:42:06 INFO - PROCESS | 23475 | Values: 3324.9 3396.2 3420.3 3435.7 3483.5 5567.1 5591.5 5607.9 5625.0 5630.0 5533.4 5543.4 5568.2 5597.7 5600.2 5037.9 5071.4 5093.9 5152.5 5175.3 4967.7 5143.7 5215.1 5227.5 5235.9 5072.9 5101.6 5104.8 5192.6 5205.6 5192.5 5233.3 5248.9 5250.4 5254.8 5020.5 5038.1 5056.9 5076.0 5115.3 5291.6 5377.1 5406.4 5416.3 5458.8 6005.5 6013.4 6044.2 6046.4 6048.9 6081.2 6092.8 6105.5 6106.7 6119.6 5550.8 5617.0 5652.9 5683.3 5730.2 6209.6 6215.6 6215.8 6226.1 6229.4 5939.1 5978.7 5979.4 5981.3 5997.7 6091.2 6165.4 6186.0 6191.2 6200.2 6106.0 6118.6 6119.0 6122.2 6127.4 5694.5 5893.6 5976.2 6101.3 6145.0 4499.6 4504.8 4511.4 4519.1 4534.2 4059.0 4059.2 4066.9 4086.4 4086.5 5530.2 5596.6 5624.9 5671.0 5709.1 5860.9 5943.1 5995.0 6006.6 6024.7 5683.8 5711.0 5720.0 5736.9 5739.6 4900.4 4947.1 4996.8 5079.6 5091.8 6102.3 6154.3 6155.4 6166.7 6169.9 5950.2 5950.4 5959.2 5985.4 5988.1 6039.8 6159.3 6223.6 6265.9 6275.8 6005.2 6052.2 6052.8 6056.1 6098.1 5816.7 6118.4 6160.5 6164.9 6170.0 5977.5 5979.7 5996.1 6041.8 6079.1 5762.3 5819.5 5827.4 5829.9 5855.3 5667.1 5684.7 5728.3 5735.4 5747.9 5843.5 5882.4 5887.4 5898.7 5929.1 5689.9 5769.6 5776.9 5779.9 5798.8 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#1] ext.html Cycles:180 Average:59944.62 Median:40569.59 stddev:130984.31 (322.9%) stddev-sans-first:131276.18 03:42:06 INFO - PROCESS | 23475 | Values: 683.1 685.4 686.0 721.2 754.7 32728.5 37520.8 38688.4 38831.2 38991.4 41048.6 41869.0 41901.4 42139.0 42157.4 8793.3 8923.2 8943.9 8955.4 8967.4 8751.8 8911.3 8916.2 8952.4 9163.3 9136.9 9144.6 9166.8 9226.2 9241.4 9050.2 9081.1 9118.5 9173.4 9184.6 8873.3 8996.5 8998.5 9017.3 9035.2 41540.8 41911.2 42083.0 42135.8 42200.4 3705.5 4340.3 4400.9 4452.3 4607.2 31508.2 31512.5 32183.7 32373.7 34036.8 4154.8 4186.9 4234.3 4258.4 4303.3 297175.0 297783.0 298092.0 298196.0 298627.0 38105.0 38779.6 38811.4 57948.4 59184.4 37084.6 37108.0 37166.4 37180.6 37219.6 15720.1 15769.7 15777.5 15835.7 15855.8 14414.4 14449.5 14470.1 14503.8 14510.5 9219.6 9238.7 9266.3 9329.6 9329.6 3637.7 3665.9 3671.9 3673.9 3705.7 1085.3 1139.0 1203.9 1220.8 1299.2 31860.7 31918.2 32395.8 32874.0 33134.2 1257.1 1266.3 1285.2 1292.9 1341.2 16817.7 17081.7 17138.9 17158.2 17272.9 482599.0 490623.0 539682.0 858791.0 875824.0 58796.0 60117.4 60152.4 60272.1 60606.1 1533.6 1543.4 1550.5 1555.4 1555.6 32018.5 32437.0 32514.7 32758.8 33023.2 51220.5 51873.2 51888.7 51985.0 52322.0 412118.0 413192.0 413282.0 415550.0 415756.0 30553.0 30640.5 30828.8 30878.4 30945.2 46723.3 47128.0 47321.0 47549.0 48082.0 39811.4 39961.4 40096.4 40728.4 41490.4 39734.4 39930.0 39948.0 40625.6 40993.4 40513.6 41118.0 41609.6 41640.8 42024.8 34993.5 35705.8 35724.8 35868.6 36155.0 27810.0 27876.2 27933.7 27958.2 28179.4 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#2] jquery.html Cycles:180 Average:29739.19 Median:2116.56 stddev:85302.13 (4030.2%) stddev-sans-first:85513.03 03:42:06 INFO - PROCESS | 23475 | Values: 427.4 435.3 439.6 443.5 443.5 18242.7 19011.3 19165.9 19637.8 20483.6 19549.2 19879.3 19920.2 20246.4 20387.1 5639.6 5734.3 5847.0 5855.7 5857.1 5504.8 5764.7 5776.5 5790.6 5832.9 5680.8 5695.7 5704.3 5705.2 5760.1 5917.3 5925.2 5928.3 5939.0 5941.9 5787.4 5796.7 5801.4 5808.4 5832.4 13802.2 14108.5 14319.1 14375.8 14935.8 2406.0 2471.3 2526.3 2672.5 3042.1 9941.2 10286.8 10346.2 10410.5 10854.5 1994.2 2089.5 2107.3 2115.2 2117.9 79176.0 79626.6 79791.0 81839.6 82023.2 11176.3 11668.8 11683.8 11728.4 11745.9 16220.9 16277.0 16397.9 16403.3 16442.3 8914.9 9296.7 9303.9 9312.3 9324.7 8463.5 8465.9 8621.4 8635.7 9016.3 4827.5 5074.5 5090.8 5128.8 5142.6 1912.2 2046.2 2111.5 2111.5 2171.4 1019.3 1025.9 1028.1 1030.5 1065.9 16854.3 18359.5 19135.9 19388.1 19480.9 1063.6 1069.7 1087.3 1139.3 1143.5 10574.9 10847.4 10887.0 10973.7 11048.9 511770.0 516151.0 518805.0 522386.0 522461.0 91579.0 91675.0 92638.5 92772.0 93498.5 1084.1 1105.6 1125.3 1149.2 1155.5 16873.7 17125.0 17173.5 17205.4 17442.7 39066.0 39482.2 39842.6 40447.0 40827.4 58965.1 58977.0 59194.0 59671.0 59697.0 8591.1 8939.8 9172.4 9298.4 9322.7 11964.5 12928.9 13529.0 13575.2 13689.4 11611.0 11715.9 11914.5 11969.5 12377.9 11449.4 11844.5 11973.8 12060.8 12084.2 12249.0 12258.6 12266.6 12298.7 12448.8 8950.1 9084.3 9206.1 9209.0 9268.0 9766.8 12182.5 12200.1 12204.9 12243.3 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#3] mootools.html Cycles:180 Average:5662.99 Median:2689.04 stddev:3108.58 (115.6%) stddev-sans-first:3102.02 03:42:06 INFO - PROCESS | 23475 | Values: 1561.4 1563.3 1751.8 1882.0 1891.8 7311.6 7819.8 8323.4 8529.6 8548.0 8342.9 8369.5 8377.9 8389.4 8419.5 2289.9 2295.4 2320.3 2324.5 2337.8 2346.7 2367.9 2393.4 2395.1 2397.3 2305.9 2310.5 2312.4 2341.6 2343.3 2355.7 2360.7 2369.7 2370.1 2377.8 2335.9 2379.2 2379.8 2382.5 2398.9 8585.2 8628.2 8639.0 8647.4 8659.8 5154.6 5236.5 5237.2 5276.1 5277.4 3312.4 3332.5 3382.1 3426.7 3451.1 1172.2 1221.3 1223.7 1237.4 1238.6 11884.2 11926.0 12009.5 12080.8 12087.8 4635.5 4656.3 4660.9 4712.1 4838.2 10387.9 10431.6 10468.9 10479.6 10481.4 5255.7 5273.3 5284.7 5304.5 5327.2 4243.6 4769.8 4803.7 4869.4 4880.5 4010.9 4048.3 4057.7 4120.8 4135.6 1317.9 1354.2 1366.4 1376.3 1379.8 1063.4 1106.3 1107.4 1116.7 1117.2 6120.3 6215.8 6229.1 6302.0 6318.9 465.7 497.6 498.7 504.0 506.8 4288.0 4312.0 4331.7 4343.2 4345.3 10062.6 10495.6 10652.6 10781.1 10869.5 10331.1 10518.1 10548.9 10587.8 10618.3 7818.3 8106.8 8156.8 8178.5 8193.5 5628.4 5814.7 5930.7 5933.4 5945.6 8755.6 8816.9 8834.8 9045.9 9086.1 8709.3 8743.6 8856.3 8857.9 8859.1 6684.7 7245.6 7442.0 7470.8 7621.8 8118.2 8146.2 8167.6 8201.6 8221.9 7339.2 7368.0 7517.1 7618.2 7619.6 7455.4 7478.1 7581.4 7591.5 7653.8 6914.0 6940.7 7005.2 7006.6 7020.3 5174.7 5205.3 5330.0 5382.5 5382.7 5033.6 5075.8 5161.5 5191.4 5308.0 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#4] prototype.html Cycles:180 Average:5900.57 Median:6776.88 stddev:1803.77 (26.6%) stddev-sans-first:1760.30 03:42:06 INFO - PROCESS | 23475 | Values: 363.4 363.6 365.1 369.4 371.3 6618.6 6625.2 6645.0 6696.1 6751.3 6641.2 6645.3 6654.3 6654.5 6662.2 4821.7 4924.9 5026.9 5039.1 5046.9 5005.8 5023.8 5027.2 5031.1 5033.1 4978.5 5000.4 5005.9 5006.6 5017.3 4999.8 5055.4 5055.7 5056.3 5070.4 4454.5 4459.8 4461.5 4462.1 4483.2 6194.2 6383.8 6390.5 6391.4 6402.5 5803.9 5803.9 5821.4 5824.6 5836.0 7012.4 7035.1 7040.0 7040.5 7050.2 4769.5 4777.7 4780.9 4782.1 4794.0 7188.2 7266.2 7275.2 7287.5 7354.1 4910.0 4932.5 4933.9 4937.4 4938.8 4944.4 4985.0 4988.3 4990.1 5003.2 5781.2 5795.8 5817.6 5820.5 5829.3 7074.0 7075.6 7083.6 7098.7 7109.0 1746.5 1767.8 1769.2 1769.9 1770.4 1130.1 1148.9 1150.1 1159.6 1162.5 6767.0 6786.8 6789.8 6812.6 6813.5 7172.5 7207.9 7236.2 7255.0 7371.7 6822.6 6828.4 6860.2 6870.3 6879.2 3939.5 3966.4 3969.6 3971.6 3973.3 7661.3 7676.5 7676.9 7684.9 7694.8 7356.2 7551.4 7555.0 7562.4 7564.4 7602.3 7607.4 7610.1 7616.4 7640.9 7295.3 7309.7 7309.7 7318.3 7319.9 7230.3 7246.6 7248.2 7249.7 7259.9 7404.8 7561.9 7590.0 7594.4 7656.5 4938.0 4958.9 4961.5 4969.2 4970.9 7255.5 7271.3 7282.9 7286.0 7321.9 7077.2 7080.0 7118.1 7121.3 7125.8 6835.3 7070.8 7082.9 7114.5 7116.6 6959.6 6980.4 6992.3 6992.6 6992.9 7170.6 7177.4 7178.6 7181.2 7190.5 6831.8 6842.9 6896.6 6926.5 6975.4 03:42:06 INFO - PROCESS | 23475 | 03:42:06 INFO - PROCESS | 23475 | [#5] yui.html Cycles:180 Average:16062.09 Median:4362.95 stddev:18504.41 (424.1%) stddev-sans-first:18521.02 03:42:06 INFO - PROCESS | 23475 | Values: 843.3 911.8 918.3 930.3 933.9 15385.9 16582.0 16871.3 17011.1 17037.3 15573.7 15706.9 15708.4 15738.6 15818.1 870.0 885.7 887.1 903.1 919.3 915.8 917.1 922.6 925.5 926.9 937.4 939.5 939.7 943.4 944.6 937.7 938.8 938.8 941.6 945.1 685.9 688.0 688.2 689.5 690.2 14084.7 14118.6 14199.4 14212.1 14220.8 14754.5 14906.6 14948.8 15034.0 15058.7 11955.4 12066.4 12143.1 12302.3 12319.4 4006.6 4017.8 4064.2 4203.7 4226.6 55901.0 55976.4 56230.0 56857.0 57037.4 11495.6 11667.7 11736.2 11771.7 11886.9 20300.8 20380.2 20462.1 20561.3 20620.7 9028.1 9038.8 9202.4 9289.0 9432.7 4499.3 4520.3 4920.9 5028.2 5028.4 3445.3 3481.6 3509.5 3510.4 3516.4 651.4 652.6 701.9 708.3 719.3 704.9 734.2 770.4 784.5 791.3 9771.7 9791.0 10003.3 10079.8 10084.1 750.5 797.3 810.7 840.9 846.7 4538.3 4638.7 4698.2 4717.1 4842.6 66542.7 67025.7 67662.7 68676.7 68914.0 56053.4 56087.2 59002.7 59061.0 61293.7 53980.2 54123.5 54315.2 54501.0 54825.5 9904.8 9927.6 10070.9 10255.8 10354.5 38349.6 39502.6 39861.0 40250.4 40376.8 47457.3 50863.7 50979.0 53402.7 53827.7 12859.9 13027.1 13091.6 13146.3 13368.3 13859.2 14076.9 14284.3 14502.3 14866.9 12683.4 12988.2 13725.2 13846.2 14348.2 12372.4 13311.3 13413.5 14077.4 14239.3 13080.4 13467.8 13562.6 13757.4 13944.0 11052.8 11306.2 11822.0 11942.8 11950.6 10980.9 11126.9 11329.7 11390.3 11422.3 03:42:06 INFO - PROCESS | 23475 | -------- Summary: end -------- 03:42:06 INFO - PROCESS | 23475 | 03:42:07 INFO - TEST-INFO | 23475: exit 0 03:42:07 INFO - TEST-OK | dromaeo_css | took 1108205ms 03:42:07 INFO - TEST-START | kraken 03:42:07 INFO - operating with platform_type : linux_ 03:42:07 INFO - Initialising browser for kraken test... 03:42:07 INFO - TEST-INFO | started process 23717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNb69t/profile http://localhost:56930/getInfo.html) 03:42:10 INFO - PROCESS | 23717 | 03:42:10 INFO - PROCESS | 23717 | (process:23797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:42:11 INFO - PROCESS | 23717 | __metrics Screen width/height:1600/1200 03:42:11 INFO - PROCESS | 23717 | colorDepth:24 03:42:11 INFO - PROCESS | 23717 | Browser inner width/height: 1024/697 03:42:11 INFO - PROCESS | 23717 | __metrics 03:42:11 ERROR - PROCESS | 23717 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 03:42:12 INFO - TEST-INFO | 23717: exit 0 03:42:12 INFO - Browser initialized. 03:42:12 INFO - Running cycle 1/1 for kraken test... 03:42:12 INFO - TEST-INFO | started process 23848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNb69t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:14 INFO - PROCESS | 23848 | 03:42:14 INFO - PROCESS | 23848 | (process:23918): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:42:24 INFO - PROCESS | 23848 | RSS: Main: 151789568 03:42:24 INFO - PROCESS | 23848 | 03:42:26 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56930/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:27 INFO - PROCESS | 23848 | RSS: Main: 156897280 03:42:27 INFO - PROCESS | 23848 | 03:42:30 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56930/tests/kraken/driver.html?testName=audio-dft) 03:42:30 INFO - PROCESS | 23848 | RSS: Main: 156782592 03:42:30 INFO - PROCESS | 23848 | 03:42:33 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56930/tests/kraken/driver.html?testName=audio-fft) 03:42:34 INFO - PROCESS | 23848 | RSS: Main: 156897280 03:42:34 INFO - PROCESS | 23848 | 03:42:36 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56930/tests/kraken/driver.html?testName=audio-oscillator) 03:42:36 INFO - PROCESS | 23848 | RSS: Main: 156647424 03:42:36 INFO - PROCESS | 23848 | 03:42:39 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56930/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:39 INFO - PROCESS | 23848 | RSS: Main: 156606464 03:42:39 INFO - PROCESS | 23848 | 03:42:42 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56930/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:43 INFO - PROCESS | 23848 | RSS: Main: 157343744 03:42:43 INFO - PROCESS | 23848 | 03:42:46 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56930/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:47 INFO - PROCESS | 23848 | RSS: Main: 156962816 03:42:47 INFO - PROCESS | 23848 | 03:42:50 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56930/tests/kraken/driver.html?testName=json-parse-financial) 03:42:50 INFO - PROCESS | 23848 | RSS: Main: 157618176 03:42:50 INFO - PROCESS | 23848 | 03:42:52 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56930/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:52 INFO - PROCESS | 23848 | RSS: Main: 157728768 03:42:52 INFO - PROCESS | 23848 | 03:42:54 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:55 INFO - PROCESS | 23848 | RSS: Main: 157319168 03:42:55 INFO - PROCESS | 23848 | 03:42:57 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:57 INFO - PROCESS | 23848 | RSS: Main: 157339648 03:42:57 INFO - PROCESS | 23848 | 03:43:00 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:00 INFO - PROCESS | 23848 | RSS: Main: 158302208 03:43:00 INFO - PROCESS | 23848 | 03:43:03 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:04 INFO - PROCESS | 23848 | RSS: Main: 158281728 03:43:04 INFO - PROCESS | 23848 | 03:43:05 INFO - PROCESS | 23848 | Cycle 1(1): loaded http://localhost:56930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56930/tests/kraken/driver.html?testName=ai-astar) 03:43:06 INFO - PROCESS | 23848 | RSS: Main: 159424512 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | __start_tp_report 03:43:06 INFO - PROCESS | 23848 | _x_x_mozilla_page_load 03:43:06 INFO - PROCESS | 23848 | _x_x_mozilla_page_load_details 03:43:06 INFO - PROCESS | 23848 | |i|pagename|runs| 03:43:06 INFO - PROCESS | 23848 | |0;ai-astar;108;112;104;111;114;110;102;110;110;111 03:43:06 INFO - PROCESS | 23848 | |1;audio-beat-detection;150;126;167;176;131;154;151;126;179;127 03:43:06 INFO - PROCESS | 23848 | |2;audio-dft;163;161;165;160;162;161;162;162;161;160 03:43:06 INFO - PROCESS | 23848 | |3;audio-fft;77;76;74;177;74;78;76;75;182;75 03:43:06 INFO - PROCESS | 23848 | |4;audio-oscillator;96;94;153;92;91;92;158;106;94;139 03:43:06 INFO - PROCESS | 23848 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;118;117;117 03:43:06 INFO - PROCESS | 23848 | |6;imaging-darkroom;148;147;148;147;147;149;148;147;150;147 03:43:06 INFO - PROCESS | 23848 | |7;imaging-desaturate;96;95;95;96;95;95;95;96;95;95 03:43:06 INFO - PROCESS | 23848 | |8;json-parse-financial;56;55;55;55;57;55;59;71;54;53 03:43:06 INFO - PROCESS | 23848 | |9;json-stringify-tinderbox;60;59;58;59;59;59;59;59;59;58 03:43:06 INFO - PROCESS | 23848 | |10;stanford-crypto-aes;74;74;72;72;73;74;75;77;76;75 03:43:06 INFO - PROCESS | 23848 | |11;stanford-crypto-ccm;113;121;113;115;112;114;119;113;128;128 03:43:06 INFO - PROCESS | 23848 | |12;stanford-crypto-pbkdf2;156;154;158;157;163;159;156;155;167;157 03:43:06 INFO - PROCESS | 23848 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;66;64;65;65;66 03:43:06 INFO - PROCESS | 23848 | __end_tp_report 03:43:06 INFO - PROCESS | 23848 | __start_cc_report 03:43:06 INFO - PROCESS | 23848 | _x_x_mozilla_cycle_collect,843 03:43:06 INFO - PROCESS | 23848 | __end_cc_report 03:43:06 INFO - PROCESS | 23848 | __startTimestamp1465209786003__endTimestamp 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | ------- Summary: start ------- 03:43:06 INFO - PROCESS | 23848 | Number of tests: 14 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.65 (3.3%) stddev-sans-first:3.84 03:43:06 INFO - PROCESS | 23848 | Values: 108.0 112.0 104.0 111.0 114.0 110.0 102.0 110.0 110.0 111.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.50 stddev:20.68 (13.6%) stddev-sans-first:21.93 03:43:06 INFO - PROCESS | 23848 | Values: 150.0 126.0 167.0 176.0 131.0 154.0 151.0 126.0 179.0 127.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.51 03:43:06 INFO - PROCESS | 23848 | Values: 163.0 161.0 165.0 160.0 162.0 161.0 162.0 162.0 161.0 160.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#3] audio-fft Cycles:10 Average:96.40 Median:75.50 stddev:43.83 (58.1%) stddev-sans-first:45.92 03:43:06 INFO - PROCESS | 23848 | Values: 77.0 76.0 74.0 177.0 74.0 78.0 76.0 75.0 182.0 75.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:92.00 stddev:27.29 (29.7%) stddev-sans-first:28.37 03:43:06 INFO - PROCESS | 23848 | Values: 96.0 94.0 153.0 92.0 91.0 92.0 158.0 106.0 94.0 139.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:43:06 INFO - PROCESS | 23848 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 03:43:06 INFO - PROCESS | 23848 | Values: 148.0 147.0 148.0 147.0 147.0 149.0 148.0 147.0 150.0 147.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:43:06 INFO - PROCESS | 23848 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.50 stddev:5.19 (9.3%) stddev-sans-first:5.49 03:43:06 INFO - PROCESS | 23848 | Values: 56.0 55.0 55.0 55.0 57.0 55.0 59.0 71.0 54.0 53.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 03:43:06 INFO - PROCESS | 23848 | Values: 60.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.50 stddev:1.62 (2.2%) stddev-sans-first:1.72 03:43:06 INFO - PROCESS | 23848 | Values: 74.0 74.0 72.0 72.0 73.0 74.0 75.0 77.0 76.0 75.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:117.00 stddev:6.19 (5.3%) stddev-sans-first:6.33 03:43:06 INFO - PROCESS | 23848 | Values: 113.0 121.0 113.0 115.0 112.0 114.0 119.0 113.0 128.0 128.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:157.50 stddev:3.97 (2.5%) stddev-sans-first:4.13 03:43:06 INFO - PROCESS | 23848 | Values: 156.0 154.0 158.0 157.0 163.0 159.0 156.0 155.0 167.0 157.0 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - PROCESS | 23848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 03:43:06 INFO - PROCESS | 23848 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 64.0 65.0 65.0 66.0 03:43:06 INFO - PROCESS | 23848 | -------- Summary: end -------- 03:43:06 INFO - PROCESS | 23848 | 03:43:06 INFO - TEST-INFO | 23848: exit 0 03:43:06 INFO - TEST-OK | kraken | took 59566ms 03:43:06 INFO - SUITE-END | took 1167s 03:43:07 INFO - Completed test suite (00:19:28) 03:43:07 INFO - javascript benchmark 03:43:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.90025299241, 3396.167938854981, 3420.2817408344245, 3435.742319326048, 3483.4774783782445, 5567.081431563797, 5591.524720398766, 5607.887842243153, 5625.0, 5629.9999999999945, 5533.363663178736, 5543.362513310971, 5568.192612071247, 5597.748101335439, 5600.243967064445, 5037.874053148664, 5071.442141364447, 5093.872653183663, 5152.458991805844, 5175.275461435402, 4967.70193788372, 5143.665661731994, 5215.113430716769, 5227.5295223429885, 5235.921461178085, 5072.9492705073035, 5101.617378696594, 5104.846854594368, 5192.636515443921, 5205.583553315726, 5192.454792246816, 5233.293505376782, 5248.8687782805355, 5250.369955605313, 5254.789808407659, 5020.523050310215, 5038.093143234217, 5056.924146137811, 5075.959428317186, 5115.258287548285, 5291.57667386612, 5377.139657654796, 5406.378266499363, 5416.268803711488, 5458.836234912959, 6005.519558435315, 6013.428724271187, 6044.184035155242, 6046.365131661156, 6048.909266361008, 6081.209442772411, 6092.847678808021, 6105.511559075308, 6106.694665266763, 6119.602225855349, 5550.833474995757, 5617.0, 5652.85867853307, 5683.3464151622675, 5730.197772311922, 6209.565330426917, 6215.627062376272, 6215.81352559424, 6226.128342032119, 6229.408206220402, 5939.07944268639, 5978.671173085435, 5979.402059794073, 5981.342052374235, 5997.670128142907, 6091.238595175603, 6165.445109940127, 6186.041163619646, 6191.19514463117, 6200.193974783249, 6106.023036314257, 6118.571699980958, 6119.0, 6122.20411346531, 6127.417895299939, 5694.487496125369, 5893.5874488785375, 5976.163337132805, 6101.308708231456, 6144.969275153685, 4499.572540608637, 4504.842330518416, 4511.413516242867, 4519.118771839526, 4534.229181039232, 4059.04612416082, 4059.1818973020017, 4066.8576599818866, 4086.4279000939296, 4086.4891888513935, 5530.198121272393, 5596.608237423341, 5624.887502250014, 5670.971645141831, 5709.05800542914, 5860.882782344329, 5943.108533719977, 5994.970025149846, 6006.579539432285, 6024.698765061729, 5683.829485115453, 5711.029125048752, 5720.0, 5736.856578585569, 5739.62692424991, 4900.411950565884, 4947.134251505972, 4996.825111121093, 5079.593632509391, 5091.847244582668, 6102.298235702862, 6154.261488621394, 6155.384461553898, 6166.660833654102, 6169.907451388232, 5950.166976623363, 5950.404959504015, 5959.195508606283, 5985.40145985398, 5988.101784732325, 6039.849003774941, 6159.29168145669, 6223.595466294676, 6265.8746825062335, 6275.811725648238, 6005.189299444519, 6052.182955300978, 6052.818415447544, 6056.06131049688, 6098.11577321277, 5816.70916454184, 6118.449339559461, 6160.507159427146, 6164.876702466016, 6170.0, 5977.521798256216, 5979.701014949148, 5996.1005849122985, 6041.818745437644, 6079.118527813531, 5762.250907382014, 5819.5344372450945, 5827.388124246893, 5829.912551311649, 5855.268091488564, 5667.149927510906, 5684.71576421169, 5728.283964504437, 5735.426457354398, 5747.8563035924435, 5843.532517398513, 5882.441168089024, 5887.4406931341455, 5898.675572843363, 5929.0513517836935, 5689.8862022758485, 5769.59612827098, 5776.9133462998925, 5779.8555036124435, 5798.768049277982], "value": 5547.127806709288, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.0983102304956, 685.3728838113127, 685.9657017149141, 721.2030706069796, 754.6528596845451, 32728.509072363933, 37520.81239593802, 38688.419673704884, 38831.22337553247, 38991.41512877309, 41048.58951410485, 41869.0, 41901.371479427835, 42139.0, 42157.367639485434, 8793.2965362771, 8923.241524470428, 8943.865842012376, 8955.37312388133, 8967.417117887317, 8751.781205469882, 8911.287097032222, 8916.197542221198, 8952.373333866632, 9163.266938644925, 9136.908630913673, 9144.634214631407, 9166.770830729218, 9226.215771659383, 9241.399309044924, 9050.1854833065, 9081.137291957253, 9118.452892826452, 9173.403728757676, 9184.632614695403, 8873.334499912533, 8996.505192214425, 8998.460092394478, 9017.323700722407, 9035.186833185046, 41540.79229603863, 41911.1617767643, 42083.0, 42135.7893210532, 42200.36699449511, 3705.5368078990127, 4340.283853164224, 4400.933985990213, 4452.28763397858, 4607.17070927233, 31508.21229469259, 31512.527312090337, 32183.678163218538, 32373.676263237303, 34036.82981585101, 4154.771487568182, 4186.895327616803, 4234.30134027885, 4258.403823464718, 4303.311470164758, 297175.0, 297782.99999999785, 298092.0, 298196.0, 298627.0, 38105.047373815876, 38779.61220387816, 38811.41782873259, 57948.4205157943, 59184.408155918754, 37084.62915370866, 37108.0, 37166.44250336247, 37180.62819371772, 37219.62780372162, 15720.135392553519, 15769.68460630804, 15777.526674199793, 15835.68328633421, 15855.841441585437, 14414.42342306296, 14449.49426770058, 14470.131792092508, 14503.782443263359, 14510.492132775302, 9219.585118669676, 9238.722838314861, 9266.258699304039, 9329.580168892417, 9329.580168892417, 3637.727170462226, 3665.9266814664093, 3671.889843304705, 3673.8714145005333, 3705.6850167735506, 1085.2728671789919, 1138.9829152562718, 1203.8615559210627, 1220.7619514194823, 1299.1685321394316, 31860.681393186234, 31918.202044949063, 32395.838020809744, 32874.0, 33134.17164570857, 1257.1388598809845, 1266.2972050512055, 1285.1903300920546, 1292.928888911119, 1341.222091187109, 16817.66364672724, 17081.743773843402, 17138.914305428392, 17158.227879745442, 17272.877262977865, 482599.0, 490623.0, 539682.0, 858791.0, 875824.0, 58796.0, 60117.39882601118, 60152.39847601468, 60272.09591856126, 60606.090908636404, 1533.6472611299241, 1543.3826469412325, 1550.5115888495088, 1555.36230145642, 1555.6110972256936, 32018.51972220372, 32437.0, 32514.674853251163, 32758.836205818818, 33023.174420639676, 51220.487795121575, 51873.22190167226, 51888.74055629698, 51985.0, 52322.0, 412118.0, 413192.0, 413282.0, 415550.0, 415756.0, 30553.0, 30640.540391893694, 30828.845855770578, 30878.38243235168, 30945.226369340045, 46723.29915051345, 47128.0, 47321.0, 47549.049019018734, 48082.0, 39811.40282895817, 39961.40057899075, 40096.39855402229, 40728.3890741645, 41490.37764433596, 39734.40398393969, 39930.0, 39948.0, 40625.59374406218, 40993.38509922294, 40513.59486405098, 41118.0, 41609.58390416057, 41640.79179604204, 42024.789876050425, 34993.47509787406, 35705.82147089248, 35724.821375892956, 35868.64131358653, 36155.0, 27810.0, 27876.16371508858, 27933.720662793112, 27958.161255162377, 28179.43641127207], "value": 19401.918102871092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.4400535298759, 435.27309393313163, 439.5648308174907, 443.5054913771146, 443.54536599985016, 18242.726359104625, 19011.33460328887, 19165.904170479145, 19637.803621963776, 20483.590328193426, 19549.21803127873, 19879.304224352152, 19920.203191872308, 20246.392608221777, 20387.08258128384, 5639.577031722617, 5734.254546908896, 5847.0, 5855.736491857877, 5857.121431785224, 5504.779808807642, 5764.682942438164, 5776.508996735282, 5790.623609465371, 5832.912506312408, 5680.772769089232, 5695.715214239292, 5704.34400043994, 5705.172749951254, 5760.135979603072, 5917.319508256563, 5925.20009798676, 5928.258967629046, 5939.049752039675, 5941.940580594182, 5787.363390027093, 5796.681182534959, 5801.419858014207, 5808.390119037483, 5832.416758324176, 13802.240876751775, 14108.506202282872, 14319.14085154894, 14375.784363234456, 14935.775963360558, 2406.049610403898, 2471.295680730983, 2526.2800101971034, 2672.4521473097966, 3042.1025797389825, 9941.155001824853, 10286.794264114676, 10346.172306215485, 10410.479476026245, 10854.45727713611, 1994.1923520973883, 2089.477630592352, 2107.262458139654, 2115.1962254343407, 2117.9304451252174, 79176.0, 79626.60186699088, 79791.0, 81839.59080204621, 82023.17976820216, 11176.329420234812, 11668.824967625493, 11683.824742628867, 11728.413579321, 11745.88254117465, 16220.918895405448, 16277.0, 16397.934134281233, 16403.343866245454, 16442.342306307615, 8914.910850891538, 9296.72109836706, 9303.906960930304, 9312.301577381588, 9324.673636422693, 8463.534505602127, 8465.873011904827, 8621.353398495137, 8635.740927772176, 9016.278697704169, 4827.468978412372, 5074.517920797518, 5090.77091530882, 5128.794848206105, 5142.61430392722, 1912.2351059576004, 2046.19175425709, 2111.4721319670084, 2111.4932416219995, 2171.4028642123544, 1019.3323373190572, 1025.8563801067855, 1028.100412139378, 1030.474897152219, 1065.8561094252332, 16854.325826966782, 18359.541011474554, 19135.90432047831, 19388.12753426099, 19480.902595486932, 1063.6224140430036, 1069.657709532942, 1087.3149915553308, 1139.3107170162098, 1143.5482984221187, 10574.894251057545, 10847.40339281347, 10887.0, 10973.670789876316, 11048.889511104786, 511770.0, 516151.0, 518805.0, 522386.0, 522461.0, 91579.0, 91675.0, 92638.53680731553, 92772.0, 93498.53250733839, 1084.0839490630406, 1105.5688281570194, 1125.2854437432127, 1149.1783374886995, 1155.5320095361392, 16873.662526749642, 17125.0, 17173.484795456156, 17205.39781107705, 17442.738358924373, 39066.0, 39482.21035579215, 39842.60157398505, 40447.0, 40827.38758918678, 58965.11552326805, 58977.0, 59194.0, 59671.0, 59697.0, 8591.140885911358, 8939.821203576023, 9172.35793494449, 9298.442093474414, 9322.673706420243, 11964.46159922823, 12928.935355323163, 13529.0, 13575.185488870698, 13689.383977720827, 11611.0, 11715.941420292844, 11914.463849126636, 11969.521219151136, 12377.876221237673, 11449.370284634091, 11844.466998984894, 11973.820392693942, 12060.75878482443, 12084.154109212623, 12249.0, 12258.570950016707, 12266.632001039983, 12298.692532686755, 12448.81326780081, 8950.14973577509, 9084.273258139465, 9206.079392061009, 9208.953955230181, 9267.953660231655, 9766.75583110428, 12182.451789669309, 12200.14598978063, 12204.938975305067, 12243.265404075784], "value": 9446.03635312303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.3832536148223, 1563.3199558192184, 1751.7810273715786, 1881.9811801881976, 1891.7919028906808, 7311.634418279092, 7819.765407037798, 8323.41736078474, 8529.616167272472, 8547.957260213698, 8342.874856877152, 8369.497830130182, 8377.874331885012, 8389.37079719022, 8419.452735572198, 2289.942751431211, 2295.437617783641, 2320.3271051395077, 2324.500232450023, 2337.836351455399, 2346.718393792747, 2367.8579285242854, 2393.3896856301617, 2395.101836811196, 2397.3167647220544, 2305.8616483011074, 2310.4685922237895, 2312.4450131968374, 2341.648752687102, 2343.3321503371544, 2355.658429527709, 2360.6577046328184, 2369.6919400477914, 2370.12305446984, 2377.8335516513853, 2335.859848409101, 2379.238643634038, 2379.773921477457, 2382.463945612241, 2398.8920498577604, 8585.18440748128, 8628.22345988864, 8639.049704532496, 8647.394682372236, 8659.826803463895, 5154.613403994678, 5236.502532259429, 5237.188235823453, 5276.103062479349, 5277.419483856773, 3312.360381611118, 3332.450145725952, 3382.0699307690584, 3426.7087297579737, 3451.0854623524788, 1172.2029020266216, 1221.2733423612935, 1223.6757259326287, 1237.4369661803858, 1238.5726924211133, 11884.227525210834, 11926.0, 12009.519619215222, 12080.758384832343, 12087.818682719766, 4635.490096089427, 4656.348111264426, 4660.883477913011, 4712.081144176853, 4838.225883858566, 10387.94806025965, 10431.634892778717, 10468.895311046945, 10479.633212837514, 10481.423521706227, 5255.737213139328, 5273.34083239595, 5284.682919024871, 5304.549113325411, 5327.200919861974, 4243.575642435793, 4769.761511924459, 4803.735794531264, 4869.440014398318, 4880.511948805091, 4010.8997275068355, 4048.3117869962175, 4057.6753859691153, 4120.75275483472, 4135.627793498599, 1317.8879795217322, 1354.2010213973606, 1366.3987845348213, 1376.3049659921676, 1379.751644703943, 1063.3938654966748, 1106.286445242814, 1107.413071072333, 1116.6761639124725, 1117.201201141188, 6120.265568131764, 6215.81352559424, 6229.0967809667345, 6302.023186406114, 6318.936810631927, 465.7438408875105, 497.56960229401307, 498.718224203324, 504.0, 506.7896822818563, 4288.035192081757, 4311.978440107842, 4331.696781225284, 4343.1747967886, 4345.30475123985, 10062.597496100074, 10495.632652857113, 10652.57389704403, 10781.137508999262, 10869.510872010778, 10331.121854642439, 10518.105960993402, 10548.947255263827, 10587.84118238227, 10618.256722029384, 7818.257265559762, 8106.837863242702, 8156.755297341089, 8178.5092894426525, 8193.50838949665, 5628.352739434854, 5814.709264536672, 5930.733117009831, 5933.436323549256, 5945.613535120204, 8755.605997730245, 8816.911830881609, 8834.779130521789, 9045.909540904508, 9086.091390860862, 8709.303255739398, 8743.562821859008, 8856.335774816785, 8857.867131993155, 8859.11408859109, 6684.665766711742, 7245.5652660840515, 7442.0, 7470.775876723707, 7621.847563048819, 8118.188181181835, 8146.185381461806, 8167.591620419074, 8201.58992050407, 8221.917780822116, 7339.155997060407, 7367.963160184165, 7517.060367454068, 7618.162002179866, 7619.580923049064, 7455.366293865082, 7478.140013898471, 7581.393488521016, 7591.506552074097, 7653.846923061619, 6913.965430173018, 6940.722371105301, 7005.22942476317, 7006.649667516705, 7020.333068358498, 5174.7153906533995, 5205.271262023244, 5329.960657671717, 5382.4886635769535, 5382.73086345689, 5033.622478314214, 5075.847724568269, 5161.535461808456, 5191.351081114861, 5308.0], "value": 4553.255541593218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4149020077675, 363.6036719975227, 365.1018494503521, 369.3757549740936, 371.25933762144507, 6618.635975021371, 6625.204975402952, 6644.966775166129, 6696.129503164581, 6751.257361690223, 6641.203055633331, 6645.302243264448, 6654.3345665433435, 6654.534182607207, 6662.167229096363, 4821.710697358152, 4924.852254432355, 5026.924596131061, 5039.092963266628, 5046.873828154307, 5005.774740136702, 5023.773930173133, 5027.220780778966, 5031.094403007457, 5033.11920413928, 4978.452370239271, 5000.399952005764, 5005.949940500603, 5006.599472042246, 5017.347744793172, 4999.775010124535, 5055.4186268579215, 5055.69665820052, 5056.317397151411, 5070.3915530136255, 4454.532274111204, 4459.843905463294, 4461.464624245112, 4462.085272519126, 4483.237849565582, 6194.225721784777, 6383.808485745435, 6390.488760899163, 6391.360863913618, 6402.519811014146, 5803.854903627401, 5803.941960580424, 5821.388754180793, 5824.592278540504, 5836.0, 7012.439004879649, 7035.085438892962, 7040.0, 7040.507164498487, 7050.189228238715, 4769.523047695237, 4777.689450185727, 4780.856574302777, 4782.0914026334885, 4794.041191761662, 7188.20929697738, 7266.200717921024, 7275.236100209508, 7287.489875708702, 7354.117505899273, 4909.975450122726, 4932.53140951609, 4933.851984440473, 4937.432195297515, 4938.82691615688, 4944.431390390079, 4984.950150498448, 4988.301637770643, 4990.051890140861, 5003.199488081889, 5781.248437703071, 5795.826125216166, 5817.592768506249, 5820.505257053113, 5829.271341082364, 7074.0, 7075.575465472089, 7083.610401427971, 7098.716051357991, 7109.040279562297, 1746.493516880116, 1767.8143794901607, 1769.2303847826238, 1769.8672599555084, 1770.4246120011048, 1130.1015692524463, 1148.8506494155706, 1150.0626989003936, 1159.5767544846071, 1162.4885050577718, 6767.0, 6786.76246331376, 6789.830254243683, 6812.625305608239, 6813.454923606099, 7172.533785303938, 7207.855842883113, 7236.240194779472, 7254.96372518134, 7371.741989030358, 6822.556533825285, 6828.351306625863, 6860.176778786477, 6870.3473170048765, 6879.208890977501, 3939.5075615548058, 3966.4050392441363, 3969.603039696065, 3971.5631280559114, 3973.344398174269, 7661.310482056641, 7676.53940763556, 7676.884846727304, 7684.923150768421, 7694.807629809187, 7356.1540422850985, 7551.358134558514, 7555.0, 7562.357199637982, 7564.357029652431, 7602.277783610659, 7607.35337496319, 7610.124835643972, 7616.3906887448875, 7640.885386719204, 7295.270472952662, 7309.671064802203, 7309.707611695472, 7318.3047610476915, 7319.926800731924, 7230.313120253568, 7246.565206087652, 7248.238934911969, 7249.746258880914, 7259.891101633374, 7404.777856664308, 7561.886571701319, 7589.962050189713, 7594.430417718582, 7656.464047516621, 4938.0, 4958.851234462972, 4961.454240033666, 4969.229769385751, 4970.8757281068265, 7255.52839065459, 7271.3455788979245, 7282.927170728437, 7286.016387787581, 7321.926780732338, 7077.150741911004, 7080.0, 7118.110236220473, 7121.323474269936, 7125.786226413215, 6835.282295358916, 7070.8232294191, 7082.929170708227, 7114.50198486101, 7116.644167791694, 6959.617221052688, 6980.441564674712, 6992.3357281058215, 6992.580445173306, 6992.930070699228, 7170.569765814068, 7177.389921856492, 7178.605176715122, 7181.210066892533, 7190.496665233383, 6831.829204269734, 6842.93157068423, 6896.551724137915, 6926.480513961373, 6975.372216500539], "value": 5308.317503938178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.3084870406269, 911.7674992876815, 918.2929144558685, 930.3487558708904, 933.906609339066, 15385.92307038466, 16582.0, 16871.325146994106, 17011.064391458465, 17037.318507259726, 15573.688526229469, 15706.921465392687, 15708.371665133409, 15738.606534836606, 15818.130002849839, 869.9913000870005, 885.6723012485389, 887.104024934814, 903.0969030969031, 919.2783664823115, 915.7619019055027, 917.1149840404008, 922.6078916460511, 925.4863550729342, 926.8841394825647, 937.4422218779815, 939.492673956063, 939.7227817793768, 943.3726571829725, 944.6127087893965, 937.7280588629324, 938.7840796616782, 938.7840796616816, 941.6186444489992, 945.0691069296771, 685.9211190713032, 687.9759208427731, 688.1707542411382, 689.4966674327719, 690.1580072311822, 14084.718305633933, 14118.647033824134, 14199.432022719182, 14212.147271163763, 14220.786688199685, 14754.48359307419, 14906.552803415914, 14948.775768363483, 15034.0, 15058.698826023417, 11955.402229888557, 12066.396680165957, 12143.149979501439, 12302.261864288083, 12319.445624946899, 4006.559278479365, 4017.7589344639414, 4064.227796718614, 4203.684723645739, 4226.619604235633, 55901.0, 55976.44023559753, 56230.0, 56857.0, 57037.42962570404, 11495.597654082067, 11667.708307292216, 11736.237144585575, 11771.705707357214, 11886.881131188577, 20300.796992030188, 20380.184792608427, 20462.07920643545, 20561.280355187497, 20620.69068963967, 9028.09719028092, 9038.774030649287, 9202.35583509148, 9289.0, 9432.669856555125, 4499.280115181556, 4520.321951707205, 4920.852374428773, 5028.17035189197, 5028.396592408934, 3445.2937147885123, 3481.599616044137, 3509.508668786372, 3510.438329867209, 3516.40221162403, 651.4267444648774, 652.5790864892213, 701.8561194955022, 708.3129364516411, 719.2950908110081, 704.8555046215514, 734.1630541183056, 770.3721467004374, 784.4587234807964, 791.3352783661752, 9771.657991970247, 9790.951045244728, 10003.2997690161, 10079.798404031879, 10084.092431681183, 750.5421692767408, 797.2665148063795, 810.6878851642042, 840.8864803251605, 846.6782622603495, 4538.2738761797955, 4638.652101092364, 4698.248280275139, 4717.080169366941, 4842.564169224786, 66542.66728666326, 67025.6648716763, 67662.66168669125, 68676.65661671759, 68914.0, 56053.43946560564, 56087.15869261965, 59002.70498647479, 59061.0, 61293.69353153206, 53980.19029714557, 54123.458765411844, 54315.18527222095, 54501.0, 54825.45174548283, 9904.752381190528, 9927.602895884083, 10070.899291007288, 10255.794884102126, 10354.482275886327, 38349.61650383461, 39502.60497394989, 39861.0, 40250.39624405577, 40376.79811600923, 47457.28814067861, 50863.74568127136, 50979.0, 53402.73298633482, 53827.730861345444, 12859.871401285867, 13027.08810383264, 13091.607251782461, 13146.34268286601, 13368.331583420984, 13859.237741924291, 14076.929615351857, 14284.28997298092, 14502.274886255434, 14866.925665371604, 12683.365831708563, 12988.220706757626, 13725.245111518563, 13846.169229846242, 14348.210848403438, 12372.381380931098, 13311.26788026629, 13413.463461461432, 14077.366518506487, 14239.288035597972, 13080.411381487665, 13467.797983030066, 13562.601609798616, 13757.449702012207, 13944.0, 11052.834207487054, 11306.208565400342, 11822.039780276686, 11942.761144776881, 11950.581729639422, 10980.945095274472, 11126.88873111291, 11329.71675708114, 11390.25963312382, 11422.31466112036], "value": 7328.038633027687, "unit": "score"}], "name": "dromaeo_css", "value": 7514.6872523578795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 104.0, 111.0, 114.0, 110.0, 102.0, 110.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 167.0, 176.0, 131.0, 154.0, 151.0, 126.0, 179.0, 127.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 177.0, 74.0, 78.0, 76.0, 75.0, 182.0, 75.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 153.0, 92.0, 91.0, 92.0, 158.0, 106.0, 94.0, 139.0], "value": 111.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 149.0, 148.0, 147.0, 150.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 57.0, 55.0, 59.0, 71.0, 54.0, 53.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 72.0, 73.0, 74.0, 75.0, 77.0, 76.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 121.0, 113.0, 115.0, 112.0, 114.0, 119.0, 113.0, 128.0, 128.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 158.0, 157.0, 163.0, 159.0, 156.0, 155.0, 167.0, 157.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 64.0, 65.0, 65.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1519.3, "alertThreshold": 2.0}]} 03:43:07 INFO - Return code: 0 03:43:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:07 ERROR - # TBPL SUCCESS # 03:43:07 INFO - Running post-action listener: _resource_record_post_action 03:43:07 INFO - Running post-run listener: _resource_record_post_run 03:43:08 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 270336; Write bytes: 446455808; Read time: 24; Write time: 331668 03:43:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 196804608; Read time: 0; Write time: 207292 03:43:08 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 270336; Write bytes: 249651200; Read time: 24; Write time: 124376 03:43:08 INFO - Running post-run listener: _upload_blobber_files 03:43:08 INFO - Blob upload gear active. 03:43:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:08 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 03:43:08 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'] 03:43:08 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 03:43:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:09 INFO - (blobuploader) - INFO - Done attempting. 03:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:10 INFO - (blobuploader) - INFO - Done attempting. 03:43:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:10 INFO - Return code: 0 03:43:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7b4e3429799ce047160fd5fe7dc9613628d7e47ab991093c2e0b17238748a1c95bef13ec8fc26e83be24dc773c118e8b63241a3a88d466eb92822349c4e5c2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af12512f864fd2202b9e42cd7fb404a918ff64a81ef4af97a8f198314a91f5c54bdab93bdcdcc5388733624073a17b3b6dfb5a903141acd298a85fecdd6c0e71"} 03:43:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:10 INFO - Contents: 03:43:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7b4e3429799ce047160fd5fe7dc9613628d7e47ab991093c2e0b17238748a1c95bef13ec8fc26e83be24dc773c118e8b63241a3a88d466eb92822349c4e5c2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af12512f864fd2202b9e42cd7fb404a918ff64a81ef4af97a8f198314a91f5c54bdab93bdcdcc5388733624073a17b3b6dfb5a903141acd298a85fecdd6c0e71"} 03:43:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:10 INFO - Copying logs to upload dir... 03:43:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.792842 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-06 03:43:09.046714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 03:43:09.050198) ========= 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-1465208560.861517-2052398798 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/c7b4e3429799ce047160fd5fe7dc9613628d7e47ab991093c2e0b17238748a1c95bef13ec8fc26e83be24dc773c118e8b63241a3a88d466eb92822349c4e5c2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af12512f864fd2202b9e42cd7fb404a918ff64a81ef4af97a8f198314a91f5c54bdab93bdcdcc5388733624073a17b3b6dfb5a903141acd298a85fecdd6c0e71"} build_url:https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011553 build_url: 'https://queue.taskcluster.net/v1/task/PCrdcbm7RC6hLcqoIUXqqQ/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/c7b4e3429799ce047160fd5fe7dc9613628d7e47ab991093c2e0b17238748a1c95bef13ec8fc26e83be24dc773c118e8b63241a3a88d466eb92822349c4e5c2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af12512f864fd2202b9e42cd7fb404a918ff64a81ef4af97a8f198314a91f5c54bdab93bdcdcc5388733624073a17b3b6dfb5a903141acd298a85fecdd6c0e71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 03:43:09.076885) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:43:09.077248) ========= 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-1465208560.861517-2052398798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 03:43:09.164218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 03:43:09.164853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 03:43:09.165182) ========= ========= Total master_lag: 0.18 =========