builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1462800075.04 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.045045) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.045547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.045852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.062409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.062747) ========= 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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:21:15-- 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% 207M=0s 2016-05-09 06:21:15 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.154473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.154811) ========= 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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:15.201851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:15.202263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:21:15,242 truncating revision to first 12 chars 2016-05-09 06:21:15,242 Setting DEBUG logging. 2016-05-09 06:21:15,242 attempt 1/10 2016-05-09 06:21:15,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:21:16,614 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.659759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:16.875450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:16.875802) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:16.876199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:16.876475) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:16.885225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-09 06:21:16.885562) ========= /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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:16 INFO - MultiFileLogger online at 20160509 06:21:16 in /builds/slave/test 06:21:16 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 06:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:17 INFO - {'append_to_log': False, 06:21:17 INFO - 'base_work_dir': '/builds/slave/test', 06:21:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:21:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:17 INFO - 'branch': 'Mozilla-Aurora', 06:21:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:17 INFO - 'config_files': ('talos/linux_config.py',), 06:21:17 INFO - 'default_actions': ('clobber', 06:21:17 INFO - 'read-buildbot-config', 06:21:17 INFO - 'download-and-extract', 06:21:17 INFO - 'populate-webroot', 06:21:17 INFO - 'create-virtualenv', 06:21:17 INFO - 'install', 06:21:17 INFO - 'run-tests'), 06:21:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:17 INFO - 'download_minidump_stackwalk': True, 06:21:17 INFO - 'download_symbols': 'ondemand', 06:21:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:17 INFO - 'installer_path': 'installer.exe', 06:21:17 INFO - 'log_level': 'info', 06:21:17 INFO - 'log_name': 'talos', 06:21:17 INFO - 'log_to_console': True, 06:21:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:17 INFO - 'opt_config_files': (), 06:21:17 INFO - 'pip_index': False, 06:21:17 INFO - 'sps_profile': False, 06:21:17 INFO - 'sps_profile_interval': 0, 06:21:17 INFO - 'suite': 'dromaeojs-e10s', 06:21:17 INFO - 'system_bits': '32', 06:21:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:17 INFO - 'title': 'talos-linux64-ix-069', 06:21:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:17 INFO - 'use_talos_json': True, 06:21:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:17 INFO - 'work_dir': 'build'} 06:21:17 INFO - ##### 06:21:17 INFO - ##### Running clobber step. 06:21:17 INFO - ##### 06:21:17 INFO - Running pre-action listener: _resource_record_pre_action 06:21:17 INFO - Running main action method: clobber 06:21:17 INFO - rmtree: /builds/slave/test/build 06:21:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:17 INFO - Running post-action listener: _resource_record_post_action 06:21:17 INFO - ##### 06:21:17 INFO - ##### Running read-buildbot-config step. 06:21:17 INFO - ##### 06:21:17 INFO - Running pre-action listener: _resource_record_pre_action 06:21:17 INFO - Running main action method: read_buildbot_config 06:21:17 INFO - Using buildbot properties: 06:21:17 INFO - { 06:21:17 INFO - "project": "", 06:21:17 INFO - "product": "firefox", 06:21:17 INFO - "script_repo_revision": "production", 06:21:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:21:17 INFO - "repository": "", 06:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:21:17 INFO - "buildid": "20160509005049", 06:21:17 INFO - "pgo_build": "True", 06:21:17 INFO - "basedir": "/builds/slave/test", 06:21:17 INFO - "buildnumber": 350, 06:21:17 INFO - "slavename": "talos-linux64-ix-069", 06:21:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:21:17 INFO - "platform": "ubuntu64_hw", 06:21:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:21:17 INFO - "branch": "mozilla-aurora", 06:21:17 INFO - "repo_path": "releases/mozilla-aurora", 06:21:17 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 06:21:17 INFO - "stage_platform": "linux64-pgo", 06:21:17 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 06:21:17 INFO - "slavebuilddir": "test" 06:21:17 INFO - } 06:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:21:17 INFO - Running post-action listener: _resource_record_post_action 06:21:17 INFO - ##### 06:21:17 INFO - ##### Running download-and-extract step. 06:21:17 INFO - ##### 06:21:17 INFO - Running pre-action listener: _resource_record_pre_action 06:21:17 INFO - Running main action method: download_and_extract 06:21:17 INFO - mkdir: /builds/slave/test/build/tests 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:17 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:18 INFO - Downloaded 1361 bytes. 06:21:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:18 INFO - Using the following test package requirements: 06:21:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:21:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'jsshell-linux-x86_64.zip'], 06:21:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:21:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:21:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21: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')]} 06:21:18 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:19 INFO - Downloaded 23798585 bytes. 06:21:19 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'] 06:21:19 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 06:21:20 INFO - Return code: 0 06:21:20 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 06:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:20 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:22 INFO - Downloaded 23798585 bytes. 06:21:22 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'] 06:21:22 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 06:21:23 INFO - Return code: 0 06:21:23 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')]} 06:21:23 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:24 INFO - Downloaded 10840145 bytes. 06:21:24 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'] 06:21:24 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 06:21:24 INFO - Return code: 0 06:21:24 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')]} 06:21:24 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:28 INFO - Downloaded 62704189 bytes. 06:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:28 INFO - mkdir: /builds/slave/test/properties 06:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:28 INFO - Contents: 06:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:29 INFO - Running post-action listener: _resource_record_post_action 06:21:29 INFO - Running post-action listener: set_extra_try_arguments 06:21:29 INFO - ##### 06:21:29 INFO - ##### Running populate-webroot step. 06:21:29 INFO - ##### 06:21:29 INFO - Running pre-action listener: _resource_record_pre_action 06:21:29 INFO - Running main action method: populate_webroot 06:21:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:29 INFO - '--tppagecycles', 06:21:29 INFO - '7'], 06:21:29 INFO - 'tests': ['tsvgm']}}, 06:21:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['damp', 'tps']}, 06:21:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'tests': ['damp', 'tps']}, 06:21:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['dromaeo_dom']}, 06:21:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['a11yr', 06:21:29 INFO - 'ts_paint', 06:21:29 INFO - 'tpaint', 06:21:29 INFO - 'sessionrestore', 06:21:29 INFO - 'sessionrestore_no_auto_restore', 06:21:29 INFO - 'tabpaint']}, 06:21:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['tsvgx', 06:21:29 INFO - 'tsvgr_opacity', 06:21:29 INFO - 'tart', 06:21:29 INFO - 'tscrollx', 06:21:29 INFO - 'cart']}, 06:21:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:29 INFO - 'tsvgr_opacity', 06:21:29 INFO - 'tart', 06:21:29 INFO - 'tscrollx', 06:21:29 INFO - 'cart']}, 06:21:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'talos_options': ['--disable-e10s'], 06:21:29 INFO - 'tests': ['tp5o']}, 06:21:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'tests': ['tp5o']}, 06:21:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'talos_options': ['--disable-e10s', 06:21:29 INFO - '--xperf_path', 06:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:29 INFO - 'tests': ['tp5n']}, 06:21:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:29 INFO - 'talos_options': ['--xperf_path', 06:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:29 INFO - 'tests': ['tp5n']}}, 06:21:29 INFO - 'talos.zip': {'path': '', 06:21:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:29 INFO - Running post-action listener: _resource_record_post_action 06:21:29 INFO - ##### 06:21:29 INFO - ##### Running create-virtualenv step. 06:21:29 INFO - ##### 06:21:29 INFO - Running pre-action listener: _resource_record_pre_action 06:21:29 INFO - Running main action method: create_virtualenv 06:21:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:29 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 06:21:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:29 INFO - Using real prefix '/usr' 06:21:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:31 INFO - Installing pip.................done. 06:21:31 INFO - Return code: 0 06:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:31 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:31 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 06:21:31 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 06:21:31 INFO - Using env: {'DISPLAY': ':0', 06:21:31 INFO - 'HOME': '/home/cltbld', 06:21:31 INFO - 'LANG': 'en_US.UTF-8', 06:21:31 INFO - 'LANGUAGE': 'en_US:en', 06:21:31 INFO - 'LOGNAME': 'cltbld', 06:21:31 INFO - 'MAIL': '/var/mail/cltbld', 06:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:31 INFO - 'MOZ_NO_REMOTE': '1', 06:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:31 INFO - 'NO_EM_RESTART': '1', 06:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:31 INFO - 'PWD': '/builds/slave/test', 06:21:31 INFO - 'SHELL': '/bin/bash', 06:21:31 INFO - 'SHLVL': '1', 06:21:31 INFO - 'TERM': 'linux', 06:21:31 INFO - 'TMOUT': '86400', 06:21:31 INFO - 'USER': 'cltbld', 06:21:31 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:31 INFO - '_': '/tools/buildbot/bin/python'} 06:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:32 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 06:21:32 INFO - Cleaning up... 06:21:32 INFO - Return code: 0 06:21:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:32 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 06:21:32 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 06:21:32 INFO - Using env: {'DISPLAY': ':0', 06:21:32 INFO - 'HOME': '/home/cltbld', 06:21:32 INFO - 'LANG': 'en_US.UTF-8', 06:21:32 INFO - 'LANGUAGE': 'en_US:en', 06:21:32 INFO - 'LOGNAME': 'cltbld', 06:21:32 INFO - 'MAIL': '/var/mail/cltbld', 06:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:32 INFO - 'MOZ_NO_REMOTE': '1', 06:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:32 INFO - 'NO_EM_RESTART': '1', 06:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:32 INFO - 'PWD': '/builds/slave/test', 06:21:32 INFO - 'SHELL': '/bin/bash', 06:21:32 INFO - 'SHLVL': '1', 06:21:32 INFO - 'TERM': 'linux', 06:21:32 INFO - 'TMOUT': '86400', 06:21:32 INFO - 'USER': 'cltbld', 06:21:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:32 INFO - '_': '/tools/buildbot/bin/python'} 06:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:32 INFO - Downloading/unpacking psutil>=0.7.1 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:35 INFO - Installing collected packages: psutil 06:21:35 INFO - Running setup.py install for psutil 06:21:35 INFO - building 'psutil._psutil_linux' extension 06:21:35 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 06:21:35 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 06:21:35 INFO - building 'psutil._psutil_posix' extension 06:21:35 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 06:21:35 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 06:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:35 INFO - Successfully installed psutil 06:21:35 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:36 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 06:21:36 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 06:21:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:21:38 INFO - Installing collected packages: mozsystemmonitor 06:21:38 INFO - Running setup.py install for mozsystemmonitor 06:21:38 INFO - Successfully installed mozsystemmonitor 06:21:38 INFO - Cleaning up... 06:21:38 INFO - Return code: 0 06:21:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:38 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:38 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 06:21:38 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 06:21:38 INFO - Using env: {'DISPLAY': ':0', 06:21:38 INFO - 'HOME': '/home/cltbld', 06:21:38 INFO - 'LANG': 'en_US.UTF-8', 06:21:38 INFO - 'LANGUAGE': 'en_US:en', 06:21:38 INFO - 'LOGNAME': 'cltbld', 06:21:38 INFO - 'MAIL': '/var/mail/cltbld', 06:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:38 INFO - 'MOZ_NO_REMOTE': '1', 06:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:38 INFO - 'NO_EM_RESTART': '1', 06:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:38 INFO - 'PWD': '/builds/slave/test', 06:21:38 INFO - 'SHELL': '/bin/bash', 06:21:38 INFO - 'SHLVL': '1', 06:21:38 INFO - 'TERM': 'linux', 06:21:38 INFO - 'TMOUT': '86400', 06:21:38 INFO - 'USER': 'cltbld', 06:21:38 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:38 INFO - '_': '/tools/buildbot/bin/python'} 06:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:38 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:38 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 06:21:40 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:40 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 06:21:40 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 06:21:40 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 06:21:40 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 06:21:40 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 06:21:40 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 06:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - Downloading docopt-0.6.1.tar.gz 06:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:41 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:41 INFO - Running setup.py install for blobuploader 06:21:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:41 INFO - Running setup.py install for requests 06:21:41 INFO - Running setup.py install for docopt 06:21:42 INFO - Successfully installed blobuploader requests docopt 06:21:42 INFO - Cleaning up... 06:21:42 INFO - Return code: 0 06:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:42 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:42 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 06:21:42 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 06:21:42 INFO - Using env: {'DISPLAY': ':0', 06:21:42 INFO - 'HOME': '/home/cltbld', 06:21:42 INFO - 'LANG': 'en_US.UTF-8', 06:21:42 INFO - 'LANGUAGE': 'en_US:en', 06:21:42 INFO - 'LOGNAME': 'cltbld', 06:21:42 INFO - 'MAIL': '/var/mail/cltbld', 06:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:42 INFO - 'MOZ_NO_REMOTE': '1', 06:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:42 INFO - 'NO_EM_RESTART': '1', 06:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:42 INFO - 'PWD': '/builds/slave/test', 06:21:42 INFO - 'SHELL': '/bin/bash', 06:21:42 INFO - 'SHLVL': '1', 06:21:42 INFO - 'TERM': 'linux', 06:21:42 INFO - 'TMOUT': '86400', 06:21:42 INFO - 'USER': 'cltbld', 06:21:42 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:42 INFO - '_': '/tools/buildbot/bin/python'} 06:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:42 INFO - Running setup.py (path:/tmp/pip-UYCwiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:42 INFO - Running setup.py (path:/tmp/pip-tXQ4fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:42 INFO - Running setup.py (path:/tmp/pip-X_rIw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:42 INFO - Running setup.py (path:/tmp/pip-C0ONwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:42 INFO - Running setup.py (path:/tmp/pip-TxQZ2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:42 INFO - Running setup.py (path:/tmp/pip-o0loMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:42 INFO - Running setup.py (path:/tmp/pip-C2txsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:42 INFO - Running setup.py (path:/tmp/pip-pZXcc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:42 INFO - Running setup.py (path:/tmp/pip-M_s4xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:42 INFO - Running setup.py (path:/tmp/pip-cjHee2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:43 INFO - Running setup.py (path:/tmp/pip-ZMGnIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:43 INFO - Running setup.py (path:/tmp/pip-6eUYtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:43 INFO - Running setup.py (path:/tmp/pip-26wesR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:43 INFO - Running setup.py (path:/tmp/pip-DoO2bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:43 INFO - Running setup.py (path:/tmp/pip-Q65Lwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:43 INFO - Running setup.py (path:/tmp/pip-u1t0Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:43 INFO - Running setup.py (path:/tmp/pip-z5Uk4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:43 INFO - Running setup.py install for manifestparser 06:21:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:43 INFO - Running setup.py install for mozcrash 06:21:43 INFO - Running setup.py install for mozdebug 06:21:43 INFO - Running setup.py install for mozdevice 06:21:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:43 INFO - Running setup.py install for mozfile 06:21:44 INFO - Running setup.py install for mozhttpd 06:21:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozinfo 06:21:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozInstall 06:21:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozleak 06:21:44 INFO - Running setup.py install for mozlog 06:21:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for moznetwork 06:21:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozprocess 06:21:44 INFO - Running setup.py install for mozprofile 06:21:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozrunner 06:21:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:44 INFO - Running setup.py install for mozscreenshot 06:21:45 INFO - Running setup.py install for moztest 06:21:45 INFO - Running setup.py install for mozversion 06:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:45 INFO - Cleaning up... 06:21:45 INFO - Return code: 0 06:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:45 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:45 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 06:21:45 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 06:21:45 INFO - Using env: {'DISPLAY': ':0', 06:21:45 INFO - 'HOME': '/home/cltbld', 06:21:45 INFO - 'LANG': 'en_US.UTF-8', 06:21:45 INFO - 'LANGUAGE': 'en_US:en', 06:21:45 INFO - 'LOGNAME': 'cltbld', 06:21:45 INFO - 'MAIL': '/var/mail/cltbld', 06:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:45 INFO - 'MOZ_NO_REMOTE': '1', 06:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:45 INFO - 'NO_EM_RESTART': '1', 06:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:45 INFO - 'PWD': '/builds/slave/test', 06:21:45 INFO - 'SHELL': '/bin/bash', 06:21:45 INFO - 'SHLVL': '1', 06:21:45 INFO - 'TERM': 'linux', 06:21:45 INFO - 'TMOUT': '86400', 06:21:45 INFO - 'USER': 'cltbld', 06:21:45 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:45 INFO - '_': '/tools/buildbot/bin/python'} 06:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:45 INFO - Running setup.py (path:/tmp/pip-uuYble-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:45 INFO - Running setup.py (path:/tmp/pip-AVCQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:45 INFO - Running setup.py (path:/tmp/pip-LDArEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:45 INFO - Running setup.py (path:/tmp/pip-zXSLdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:45 INFO - Running setup.py (path:/tmp/pip-dMGKKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:45 INFO - Running setup.py (path:/tmp/pip-XoRuEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:45 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)) 06:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:45 INFO - Running setup.py (path:/tmp/pip-Ia_bRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:46 INFO - Running setup.py (path:/tmp/pip-1yzDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:46 INFO - Running setup.py (path:/tmp/pip-RkrDoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:46 INFO - Running setup.py (path:/tmp/pip-HXMA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:46 INFO - Running setup.py (path:/tmp/pip-1Q2iJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:46 INFO - Running setup.py (path:/tmp/pip-dC33Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:46 INFO - Running setup.py (path:/tmp/pip-B3ICsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:46 INFO - Running setup.py (path:/tmp/pip-6nlN0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:46 INFO - Running setup.py (path:/tmp/pip-udpMZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:46 INFO - Running setup.py (path:/tmp/pip-b9RwAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:46 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)) 06:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:46 INFO - Running setup.py (path:/tmp/pip-7C9lJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:46 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)) 06:21:46 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)) 06:21:46 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)) 06:21:46 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)) 06:21:46 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)) 06:21:46 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)) 06:21:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:48 INFO - Downloading blessings-1.6.tar.gz 06:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:48 INFO - Installing collected packages: blessings 06:21:48 INFO - Running setup.py install for blessings 06:21:48 INFO - Successfully installed blessings 06:21:48 INFO - Cleaning up... 06:21:48 INFO - Return code: 0 06:21:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:49 INFO - Reading from file tmpfile_stdout 06:21:49 INFO - Current package versions: 06:21:49 INFO - argparse == 1.2.1 06:21:49 INFO - blessings == 1.6 06:21:49 INFO - blobuploader == 1.2.4 06:21:49 INFO - docopt == 0.6.1 06:21:49 INFO - manifestparser == 1.1 06:21:49 INFO - mozInstall == 1.12 06:21:49 INFO - mozcrash == 0.17 06:21:49 INFO - mozdebug == 0.1 06:21:49 INFO - mozdevice == 0.48 06:21:49 INFO - mozfile == 1.2 06:21:49 INFO - mozhttpd == 0.7 06:21:49 INFO - mozinfo == 0.9 06:21:49 INFO - mozleak == 0.1 06:21:49 INFO - mozlog == 3.1 06:21:49 INFO - moznetwork == 0.27 06:21:49 INFO - mozprocess == 0.22 06:21:49 INFO - mozprofile == 0.28 06:21:49 INFO - mozrunner == 6.11 06:21:49 INFO - mozscreenshot == 0.1 06:21:49 INFO - mozsystemmonitor == 0.0 06:21:49 INFO - moztest == 0.7 06:21:49 INFO - mozversion == 1.4 06:21:49 INFO - psutil == 3.1.1 06:21:49 INFO - requests == 1.2.3 06:21:49 INFO - wsgiref == 0.1.2 06:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:49 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 06:21:49 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 06:21:49 INFO - Using env: {'DISPLAY': ':0', 06:21:49 INFO - 'HOME': '/home/cltbld', 06:21:49 INFO - 'LANG': 'en_US.UTF-8', 06:21:49 INFO - 'LANGUAGE': 'en_US:en', 06:21:49 INFO - 'LOGNAME': 'cltbld', 06:21:49 INFO - 'MAIL': '/var/mail/cltbld', 06:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:49 INFO - 'MOZ_NO_REMOTE': '1', 06:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:49 INFO - 'NO_EM_RESTART': '1', 06:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:49 INFO - 'PWD': '/builds/slave/test', 06:21:49 INFO - 'SHELL': '/bin/bash', 06:21:49 INFO - 'SHLVL': '1', 06:21:49 INFO - 'TERM': 'linux', 06:21:49 INFO - 'TMOUT': '86400', 06:21:49 INFO - 'USER': 'cltbld', 06:21:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:49 INFO - '_': '/tools/buildbot/bin/python'} 06:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 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)) 06:21:49 INFO - Cleaning up... 06:21:49 INFO - Return code: 0 06:21:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:49 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:49 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 06:21:49 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 06:21:49 INFO - Using env: {'DISPLAY': ':0', 06:21:49 INFO - 'HOME': '/home/cltbld', 06:21:49 INFO - 'LANG': 'en_US.UTF-8', 06:21:49 INFO - 'LANGUAGE': 'en_US:en', 06:21:49 INFO - 'LOGNAME': 'cltbld', 06:21:49 INFO - 'MAIL': '/var/mail/cltbld', 06:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:49 INFO - 'MOZ_NO_REMOTE': '1', 06:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:49 INFO - 'NO_EM_RESTART': '1', 06:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:49 INFO - 'PWD': '/builds/slave/test', 06:21:49 INFO - 'SHELL': '/bin/bash', 06:21:49 INFO - 'SHLVL': '1', 06:21:49 INFO - 'TERM': 'linux', 06:21:49 INFO - 'TMOUT': '86400', 06:21:49 INFO - 'USER': 'cltbld', 06:21:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:49 INFO - '_': '/tools/buildbot/bin/python'} 06:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:49 INFO - Downloading/unpacking jsonschema 06:21:49 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 06:21:49 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 06:21:49 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 06:21:49 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 06:21:49 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 06:21:49 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 06:21:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:51 INFO - Downloading/unpacking functools32 (from jsonschema) 06:21:51 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 06:21:51 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 06:21:51 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 06:21:51 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 06:21:51 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 06:21:51 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 06:21:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:51 INFO - warning: no files found matching '*.txt' 06:21:51 INFO - no previously-included directories found matching 'build' 06:21:51 INFO - no previously-included directories found matching 'dist' 06:21:51 INFO - no previously-included directories found matching '.git*' 06:21:51 INFO - Installing collected packages: jsonschema, functools32 06:21:51 INFO - Running setup.py install for functools32 06:21:51 INFO - warning: no files found matching '*.txt' 06:21:51 INFO - no previously-included directories found matching 'build' 06:21:51 INFO - no previously-included directories found matching 'dist' 06:21:51 INFO - no previously-included directories found matching '.git*' 06:21:51 INFO - Successfully installed jsonschema functools32 06:21:51 INFO - Cleaning up... 06:21:51 INFO - Return code: 0 06:21:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21: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')]} 06:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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')]} 06:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:51 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 0x7f9c04180f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, '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': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', '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 06:21:51 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 06:21:51 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 06:21:51 INFO - Using env: {'DISPLAY': ':0', 06:21:51 INFO - 'HOME': '/home/cltbld', 06:21:51 INFO - 'LANG': 'en_US.UTF-8', 06:21:51 INFO - 'LANGUAGE': 'en_US:en', 06:21:51 INFO - 'LOGNAME': 'cltbld', 06:21:51 INFO - 'MAIL': '/var/mail/cltbld', 06:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:51 INFO - 'MOZ_NO_REMOTE': '1', 06:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:51 INFO - 'NO_EM_RESTART': '1', 06:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:51 INFO - 'PWD': '/builds/slave/test', 06:21:51 INFO - 'SHELL': '/bin/bash', 06:21:51 INFO - 'SHLVL': '1', 06:21:51 INFO - 'TERM': 'linux', 06:21:51 INFO - 'TMOUT': '86400', 06:21:51 INFO - 'USER': 'cltbld', 06:21:51 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:51 INFO - '_': '/tools/buildbot/bin/python'} 06:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:52 INFO - Downloading/unpacking flake8 06:21:52 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 06:21:52 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 06:21:52 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 06:21:52 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 06:21:52 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 06:21:52 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 06:21:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:21:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:21:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:54 INFO - no previously-included directories found matching 'docs/_build' 06:21:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:54 INFO - Running setup.py install for pep8 06:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:54 INFO - no previously-included directories found matching 'docs/_build' 06:21:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:54 INFO - Cleaning up... 06:21:54 INFO - Return code: 0 06:21:54 INFO - Running post-action listener: _resource_record_post_action 06:21:54 INFO - Running post-action listener: _start_resource_monitoring 06:21:54 INFO - Starting resource monitoring. 06:21:54 INFO - ##### 06:21:54 INFO - ##### Running install step. 06:21:54 INFO - ##### 06:21:54 INFO - Running pre-action listener: _resource_record_pre_action 06:21:54 INFO - Running main action method: install 06:21:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:55 INFO - Reading from file tmpfile_stdout 06:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:55 INFO - Reading from file tmpfile_stdout 06:21:55 INFO - Output received: 06:21:55 INFO - Usage: mozinstall [options] installer 06:21:55 INFO - Options: 06:21:55 INFO - -h, --help show this help message and exit 06:21:55 INFO - -d DEST, --destination=DEST 06:21:55 INFO - Directory to install application into. [default: 06:21:55 INFO - "/builds/slave/test"] 06:21:55 INFO - --app=APP Application being installed. [default: firefox] 06:21:55 INFO - mkdir: /builds/slave/test/build/application 06:21:55 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'] 06:21:55 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 06:22:10 INFO - Reading from file tmpfile_stdout 06:22:10 INFO - Output received: 06:22:10 INFO - /builds/slave/test/build/application/firefox/firefox 06:22:10 INFO - Running post-action listener: _resource_record_post_action 06:22:10 INFO - ##### 06:22:10 INFO - ##### Running run-tests step. 06:22:10 INFO - ##### 06:22:10 INFO - Running pre-action listener: _resource_record_pre_action 06:22:10 INFO - Running main action method: run_tests 06:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:10 INFO - Python 2.7.3 06:22:10 INFO - Return code: 0 06:22:10 INFO - grabbing minidump binary from tooltool 06:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:10 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 0x29ae410>, '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 0x29af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:10 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 06:22:10 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 06:22:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:10 INFO - Return code: 0 06:22:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:22:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:22:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:11 INFO - Return code: 0 06:22:11 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 06:22:11 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 06:22:11 INFO - Using env: {'DISPLAY': ':0', 06:22:11 INFO - 'HOME': '/home/cltbld', 06:22:11 INFO - 'LANG': 'en_US.UTF-8', 06:22:11 INFO - 'LANGUAGE': 'en_US:en', 06:22:11 INFO - 'LOGNAME': 'cltbld', 06:22:11 INFO - 'MAIL': '/var/mail/cltbld', 06:22:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:11 INFO - 'MOZ_NO_REMOTE': '1', 06:22:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:11 INFO - 'NO_EM_RESTART': '1', 06:22:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:11 INFO - 'PWD': '/builds/slave/test', 06:22:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:11 INFO - 'SHELL': '/bin/bash', 06:22:11 INFO - 'SHLVL': '1', 06:22:11 INFO - 'TERM': 'linux', 06:22:11 INFO - 'TMOUT': '86400', 06:22:11 INFO - 'USER': 'cltbld', 06:22:11 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381', 06:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:11 INFO - '_': '/tools/buildbot/bin/python'} 06:22:11 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 06:22:12 INFO - mozversion application_buildid: 20160509005049 06:22:12 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:22:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:12 INFO - mozversion application_name: Firefox 06:22:12 INFO - mozversion application_remotingname: firefox-dev 06:22:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:12 INFO - mozversion application_vendor: Mozilla 06:22:12 INFO - mozversion application_version: 48.0a2 06:22:12 INFO - mozversion platform_buildid: 20160509005049 06:22:12 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:12 INFO - mozversion platform_version: 48.0a2 06:22:12 INFO - using testdate: 1462800132 06:22:12 INFO - actual date: 1462800132 06:22:12 INFO - starting webserver on 'localhost:49472' 06:22:12 INFO - SUITE-START | Running 2 tests 06:22:12 INFO - TEST-START | dromaeo_css 06:22:12 INFO - operating with platform_type : linux_ 06:22:12 INFO - Initialising browser for dromaeo_css test... 06:22:12 INFO - TEST-INFO | started process 6071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYybRJf/profile http://localhost:49472/getInfo.html) 06:22:16 INFO - PROCESS | 6071 | 06:22:16 INFO - PROCESS | 6071 | (process:6147): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:22:17 INFO - PROCESS | 6071 | __metrics Screen width/height:1600/1200 06:22:17 INFO - PROCESS | 6071 | colorDepth:24 06:22:17 INFO - PROCESS | 6071 | Browser inner width/height: 1024/697 06:22:17 INFO - PROCESS | 6071 | __metrics 06:22:18 ERROR - PROCESS | 6071 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:22:19 INFO - TEST-INFO | 6071: exit 0 06:22:19 INFO - Browser initialized. 06:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:19 INFO - TEST-INFO | started process 6198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYybRJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:20 INFO - PROCESS | 6198 | 06:22:20 INFO - PROCESS | 6198 | (process:6264): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:22:30 INFO - PROCESS | 6198 | RSS: Main: 152936448 06:22:30 INFO - PROCESS | 6198 | 06:23:20 INFO - PROCESS | 6198 | 1462800200404 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:25:28 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49472/tests/dromaeo/cssquery-ext.html) 06:25:29 INFO - PROCESS | 6198 | RSS: Main: 155852800 06:25:29 INFO - PROCESS | 6198 | 06:28:31 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-ext.html (next: http://localhost:49472/tests/dromaeo/cssquery-jquery.html) 06:28:31 INFO - PROCESS | 6198 | RSS: Main: 154337280 06:28:31 INFO - PROCESS | 6198 | 06:31:33 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49472/tests/dromaeo/cssquery-mootools.html) 06:31:34 INFO - PROCESS | 6198 | RSS: Main: 153632768 06:31:34 INFO - PROCESS | 6198 | 06:34:35 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49472/tests/dromaeo/cssquery-prototype.html) 06:34:36 INFO - PROCESS | 6198 | RSS: Main: 153300992 06:34:36 INFO - PROCESS | 6198 | 06:37:38 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49472/tests/dromaeo/cssquery-yui.html) 06:37:39 INFO - PROCESS | 6198 | RSS: Main: 155058176 06:37:39 INFO - PROCESS | 6198 | 06:40:41 INFO - PROCESS | 6198 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-yui.html (next: http://localhost:49472/tests/dromaeo/cssquery-dojo.html) 06:40:42 INFO - PROCESS | 6198 | RSS: Main: 156213248 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | __start_tp_report 06:40:42 INFO - PROCESS | 6198 | _x_x_mozilla_page_load 06:40:42 INFO - PROCESS | 6198 | _x_x_mozilla_page_load_details 06:40:42 INFO - PROCESS | 6198 | |i|pagename|runs| 06:40:42 INFO - PROCESS | 6198 | |0;dojo.html;3325.1022223999516;3357.3788849062926;3404.3701915145716;3428.520007198991;3430.279641275332;5671.517920976717;5673.375928647845;5690.487856092951;5714.51426628737;5727.513161381283;5699.74351154198;5711.8000869969555;5712.685802280873;5718.228039214705;5758.992176369129;5186.507281808223;5210.088234558937;5252.658577192489;5280.630355875091;5308.124159513675;5118.206677964921;5194.870128246786;5230.73846307685;5326.973365133169;5398.028354896117;5278.973605131969;5285.075111855429;5303.124984377573;5333.226682131089;5341.679499230039;5219.582433405319;5283.709395983219;5308.8141915033175;5315.813946511854;5328.0675881720545;5056.898862022776;5070.923936140961;5128.640995130342;5199.220116982483;5216.58267338612;5533.03171944908;5568.582356323252;5619.887602247973;5623.437656234385;5627.043402621564;6065.878682426371;6095.695215239265;6125.908111378333;6126.23422072241;6135.509159267248;5840.445157710011;6038.728257228435;6103.23709536308;6149.385061493859;6182.907256391158;5787.73955172014;5793.13103034544;5796.246487956539;5804.854878628026;5810.535157187415;6244.594101383395;6244.937550624527;6305.8108256752375;6312.715927783261;6314.463270621956;5805.216295800013;5915.615484993462;5977.432143946318;5995.820125396158;6029.487493563096;6084.209052823105;6097.664628445389;6110.327863934964;6115.205023347025;6116.204893363834;5886.117082437669;6020.819375418744;6044.395560443921;6070.150178974947;6091.908621370683;6065.059915713072;6120.204373431426;6124.38756124384;6128.117037561489;6143.938560614337;4551.886202844889;4555.180067587866;4569.611583015481;4573.954260457353;4579.587837094611;4068.16602596467;4082.3468245080644;4106.917861642751;4114.238865809834;4134.421181034658;5765.4811067004175;5838.5329173666005;5839.153322768259;5866.501347385435;5980.192673989043;6089.5737298388685;6118.235220597426;6119.502553941512;6134.386561343919;6134.9079763803575;5694.487496125285;5853.64878107315;5860;5873;5873.089671100986;5202.635815492879;5235.874287028307;5238.030964271546;5245.186996015624;5292.576593872481;6245.812625621148;6247.062940558862;6252.499800015988;6261.7182226799905;6268.247810262797;5958.40415958418;6071.605345652519;6082.60463069899;6086.908696369646;6129.019356902785;6191.721372538156;6235.064740288993;6239.251289845066;6273.905891411724;6277.340879207617;5943.821685349447;5945.435183657545;5948.940510594839;5958.791442299499;5975.701214939322;5877.118432235199;6007.189029480965;6062.878742425039;6084.847878803065;6112.898653789679;5932.673702946379;5938.762449501972;5959.284885813557;5962.731677074456;5972.790952316648;5912.67480288571;5938.8218353449465;5942.881142377042;5943.554233432596;5948.8810223796145;5707.828765137053;5860.15027820955;5876.147958546072;5941.673207973603;5956.285245770535;5968.045112781934;6008.399160084132;6015.608985415934;6016.518678505621;6039.909401359071;5858.004139296245;5877.118432235199;5878.441548052928;5897.262842144732;5920.111983202554 06:40:42 INFO - PROCESS | 6198 | |1;ext.html;623.130732627984;658.5752189837555;676.1311714446937;677;687.577140058864;38571.421428678594;38912.61087389125;39052.023699407495;39067.41398879012;39441.80279098604;42689.57310426895;43521;43572;43577.564224357746;43595.128097438035;8826.779330516723;8903.643854245822;8913.732588022338;8935.865962010575;8956.596953137092;8746.081661425555;8833.734987950373;8852.424592401505;8864.980527239386;8895.243904268145;9156.587953542074;9173.908260917373;9192.264618830512;9206.723798286062;9266.675666351679;9097.408668436598;9115.179633832953;9169.862452063191;9191.540422978824;9196.954015229949;9029.819403611957;9175.58709858058;9187.954060229722;9194.632214711404;9207.401518901317;43071.138577228594;43227;43291.35062974058;43509.782451087856;43766.34350484745;3830.7701537907537;3920.921581568381;3958.0896393829294;3973.0861901762755;4365.3272260392605;34438.65561344379;34773.4783978238;34891.65108348935;34906;35020.12449688778;4590.42619672541;4605.631549476034;4705.082508910764;4723.622110231207;4727.338172655831;229590;230438;230454;232064;232432;56479;56658.71670641703;57282.427175728546;57336.42663573311;64145.35854641394;66525.33474665288;70310;71074.64462677654;71459.28540714631;71667;19216.135273912707;19224.519387015436;19414.70877936832;19477.61044779125;19484.610307793766;14320.713585728436;14430.711385772225;14454;14492.565223043326;14533;20256.392308230777;20473.48816279605;20577;20639.277625283044;20660.27689030907;7719.536827790238;7877.645505952246;7969.362451003905;7972.760817175494;8183.549904755177;1156.0866915137115;1165.0639989254735;1197.4491733802374;1205.2105870654734;1211.5335595795682;33431.83284083564;33607.83196084004;33788.324233515195;33836.49245261323;34797.1300717479;1192.8687844337117;1263.9368031598383;1285.5372066056211;1311.2001678975817;1328.1632571479906;17241.482755517354;17547.298108075534;17563.225719679627;17654.735178972325;17984.730229046574;480814;854832;974443;994824;995609;62877.68561157165;64041.67979160167;64464;64594.67702661457;64842;1541.352631894607;1561.0243597751405;1561.1725785333792;1562.414094714482;1575.4643421236835;32987.67012329846;33536.66463335336;33729.15677108092;33992.320153597284;34011.14972125716;53784.46215537794;54163.72918135384;54269.72865135649;54475;54746;348933;348997;350706;352708;353773;30994.535081973336;50306.2454063182;50378.748106259234;50652;50817.491825082754;49823.501764981884;50710.23934640909;50868.49131508637;51147.232791508904;51830.74084629553;42676;43007;44022.33966490441;44739;44826.327605085295;41644.791776040925;42049.36925946052;42429;43245.3513197296;43899.34150987802;42696.57303426926;43227.78386108049;43454;43974.560254398326;44163.54882466082;36639.816800915825;36945.213942642746;37316.813415932746;37586;37768.433473498466;28711.712882870903;29451.705482944897;29661.25846853846;29908;30074.548881766354 06:40:42 INFO - PROCESS | 6198 | |2;jquery.html;418.0593664255425;422.4233920698246;423.4474011415102;424.29143330637834;435.48612637088235;18398.90800545997;18892.622147557056;18925.337613183543;18992.905035474836;19925.80074199261;19383.70924436131;19582;19603.313884014027;20626;20626.38120856373;5571.749271282802;5836.737346819404;5863.999999999989;5981.940180598203;6049.48579370754;5736.311642602894;5747.856303592402;5748.425157484239;5767.423257674241;5772.3361813391575;5542;5679.460451257145;5740.8851822963725;5744.79893203738;5790.073588225885;5663.5186009189065;5703.9714801425935;5724.5992780505385;5735.627184233012;5786.103154011135;5541.445855414427;5553;5632.662040277596;5679.772809087632;5701;12491.12562120652;12681.809772853414;12724.109312348139;12754.298513581749;13755.656108597264;2594.532984062868;2599.7270286619823;2623.527765002299;2647.9602805957925;2701.716319786414;10276.94861525695;10284.228682848741;10394.63618773347;10582.259241853073;10801.83797243042;2023.8482113841374;2029.6143732690741;2103.24283258027;2113.2075471698113;2122.0875023739786;80707.19292807115;80846.59576702138;83382.58308708417;84030;85522;11189.496472658588;11193.608223712132;11394.601188958346;11422.771544569063;11441.771164576661;15530.534083977498;15615.687686246212;15652;15659.843401566066;15749.921250393674;8652.78368040804;8800.383973121949;8837;9017.413868098683;9085.682001129928;9101.362904596746;9227.354085214105;9240.630374785067;9268.443893366419;9374;4793.32893394925;4933.112039832793;4947.134251505972;4976.353074100344;5004;2046.8567200296134;2055.5159005485857;2063.772984971652;2084.5726626041624;2129.914803407877;1019.6125472320471;1034.1468288661883;1062.3307316390624;1071.8820929697727;1112.3993043756443;19105.904470477835;19480.220791168478;19635.920024398794;19727.11227994715;19992.700109498368;1096.7203363142348;1112.2881355932209;1158.9420528973517;1163.1276542593055;1193.8806119388166;10926.344419334866;11146.665600032013;11167.553297867995;11194.10447164225;11268.774624507463;539432;546027;555820;560162;586281;69701.65149174222;84136;86693;95680;99611.50194248982;1003.789204267112;1021.9029192226726;1026.153423425662;1026.9127124194379;1030.4744580263969;17375.652486950443;17578;17582.296708131533;17709.114544272477;18048;38626.2274754509;39452.80273598614;40903.59096408998;41703;42280.154396912505;56143;60496.69751651213;60832;61010.694946524985;61220.69389653023;8873.245774109273;8891.64433422656;8927.419717718327;8992.55037248148;9059.094090590888;9891.901080989386;12892;13605;13782.310884455537;13814.447422103003;11806.645800625995;11873.881261187278;11899.226550274205;12048.698782530508;12256.448459819152;7981.840363192588;11809;11925.463354148911;12021.038316934799;12149.75700486003;12188.634340969786;12386.938065309616;12414.441350139085;12512.124151309321;12534.122611417479;8703;8784.78038049054;8892.243404544612;8914.821703565764;8970.730878073668;12023.338716370683;12071.879281207075;12078.698032549257;12191.817122743343;12193.634190974284 06:40:42 INFO - PROCESS | 6198 | |3;mootools.html;1585.1598652714058;1595.5536042148956;1804.5308219862832;1892.1390767200926;1901.391554702494;6965.338292862182;7878.803029924255;7964.681412743498;8098.230668086537;8150.633221505024;7946.880796788038;8041.477303975237;8056.516609003464;8288.875666865002;8315.41792074555;2374.6438034294906;2377.940551486218;2410.8915098820507;2410.963835542468;2413.734489206186;2448.4735781806908;2467.5311690778785;2482.441450673602;2483.950320993579;2484.62730590412;2341.285907798121;2408.3617841272076;2410.5781488239577;2416.35966468885;2426.9757302427015;2379.4884099918513;2393.282015395383;2393.712754469457;2401.5677178107935;2419.3104965085045;2460.753924607525;2468.617364308535;2473.295110893405;2494.8503089814667;2501.499700059977;8241.629126689313;8268.875966860502;8282.751517454486;8347.248747612683;8352.540610266493;5094.414142373637;5196.428392876781;5215.58275337972;5233.581313494911;5267.446918073585;3520.4895290183035;3529.5705239378094;3588.372034893909;3599.748017638766;3604.7296452766145;1233.1922590703105;1262.9747405051849;1270.3457719274581;1283.8331016967827;1285;11094.833577496343;11127.777444451227;11139.610113646064;11184.273022253528;11191.608293709762;4342.218400687906;4393.231184542692;4400.73595584266;4427.092446048552;4431.1137772445;8958.05940376251;8983.236424903957;9001.954990225007;9033.05152958943;9063.003069662333;4952.4057113146655;4980.850574482772;4983.725895075733;5016.949830501721;5019.447860735316;4247.8088486018205;4625.653076019312;4628.4445866496235;4687.1328804171335;4725.8582242532775;3772.5850156482766;3834.6357096075826;3863.555691095504;3872.6514613684903;3954.426608141803;1156.7397335599424;1171.4084387384487;1182.9231099978474;1191.362620997762;1194.9163558550817;903.9005709371963;989.4805227255605;995.6452988681716;1002.5187909803335;1021.4841505040056;5440.265564148868;5503.834884953458;5604.523615492647;5621.975731407776;5645.463680950385;473.20501557383926;484.6946423753013;485.10013924170863;491.34160225298274;492.53455484567456;3789.450529673182;3797.050737315671;3800.410936304877;3815.809209539512;3817.484639573622;9314.906850931404;9443.527823608792;9547.188488978514;9547.2839537035;9575.952120239353;9198.724038278862;9352.625894964262;9396.295277854188;9446.669366572138;9451.385659932082;7646.694132234759;7702.576358300347;7721.884171737428;7724.420668449777;7818.569978651115;5327.547158491417;5331.813386531608;5396.83809485716;5453.700046497481;5472.616916815944;8546.658133674584;8605.311575074104;8618.655253789779;8656.091110433314;8715.607797648994;8507.276881465144;8772.56137193125;8842.336824738299;8865.379423440298;8964.820703586021;6156.29202641702;6745.763898263537;6943.236244013256;6992.02111704372;7015.158181018311;7769.7669069928;7780.961095194488;7783.532988020737;7789.61051947389;7853.568053757098;7021.568382994639;7202.171750248788;7219.6029218391395;7223.963880180566;7316.9634151828905;7096.964515177391;7123.7506687265695;7192.31672991065;7227.602481863548;7319.158296795724;6806.76176333826;6904.1024666795;6931.861362772817;6939.826504337432;6951.582905025714;5091.974540127276;5130;5137.794488220429;5153.6907785532985;5181.922271166011;5038.370203724535;5082.618803589671;5103;5123.077845987758;5141.074606570854 06:40:42 INFO - PROCESS | 6198 | |4;prototype.html;351.55177149134863;360.8231966336495;360.86467574659497;366.1213088587388;371.75278439837524;6425.67871606419;6592.274849766522;6619;6632.966835165829;6685.164354455693;6534.117894084297;6613.239477460093;6621.139251897259;6629.171353580802;6638.23660279068;5037.49625037497;5051.065552872712;5052.393712754475;5058.0895438821;5065.290859279704;5068.138416469209;5070.949290507085;5071.492850714936;5079.873003174932;5082.1360368737405;4990.176620857555;5026.145555255597;5035.874103147432;5035.949640503603;5043.218301163325;4907.9263811042865;4955.033768415178;5014.699118052892;5035.874103147432;5040.899182016357;4317.0934103838235;4369.3009118541195;4372.650187984954;4377.824887004516;4383.75889326087;6258.123862659231;6259.655718935457;6267.686615669244;6278.30938596754;6282.591631543935;5801.419858014207;5806.361300256968;5808.448197421239;5810.448007439287;5836.737346819361;6955.93044069563;6957.1651401832105;6962.721491140348;6968.616726080064;6976.093107895992;4591.288350305708;4695.483496815347;4847.345608342899;4849.636277279218;4852.320675105488;7210.387117095053;7229.710811567531;7249.855002899965;7288;7292;4885.120678277873;4887.022595480918;4891.804327826918;4896.608271338285;4903.26451032348;4964.280179373971;4966.180580204298;4967;4967.3542439482635;4972.229304457815;5751.166080918327;5755.539556835443;5761.884762304814;5764.164196191528;5780.450857168562;6854.485913556503;6976.825579360455;6993.6503174841055;7002.124734408199;7002.194747603989;1724.8706347024024;1741.2512619573452;1748.825117488241;1752.7721396218665;1754.140471169118;1042.7653777899911;1120.467777805536;1127.2109523333536;1132.9010859466305;1135.7047167736448;6686.5653732507235;6761.797146085625;6819.795406137824;6872.965635171892;6897.62063086525;7242.493025488166;7286.125664920243;7291.380232680282;7298.343149116605;7331.74338898136;6800.965995169992;6850.349216824394;6865.244823069558;6870.7595234166565;6870.793876183722;3870.322693528621;3888.202918401721;3930.508686414198;3955;3958.148997965451;7546.509476883985;7564.848703025908;7573.394128469709;7575.204603516661;7580;7303.780886573411;7379.483436159418;7434.256574342522;7447.739329123455;7450.105987281452;7527.698892044366;7534.246575342422;7549.358304544176;7550.433717471212;7557.5465472071855;7054.294570542905;7280.126384833854;7287.672054757655;7293.161286452126;7295.306945840137;7104.254053324326;7161.355478007004;7169.139703235645;7176.174739904769;7217.206107328085;7490.250974902684;7523.172451030273;7524.2851929066655;7550.924490755022;7556.924430755622;4796.664233503621;4798.616110711065;4801.615870730403;4804.447488538723;4846.273059041172;7031.648417578998;7231.963840180765;7246.239144889711;7249.05762250904;7259.38295244889;6979.441644668516;7033.542819716702;7053.400460960671;7054.188768291712;7062.8234294141;6992.300769922967;6994.510384273052;6998.650067496503;7011.964940175267;7023.859522809413;6830.726770929107;6891.931080689329;6893.689783959834;6898.344657257552;6898.620575868375;6880.547024856746;7020.894686579808;7058.682359293947;7077.787666370017;7097.858042839218;6727.495437842279;6872.969054641644;6928.861422771415;6946.062281592122;6961.79114626562 06:40:42 INFO - PROCESS | 6198 | |5;yui.html;870.5473153959939;920.8894932608088;926.0264776440622;937.5171786529943;963.4893506441584;15383.230838458074;17493.912530437345;17603.29586816529;17631.38290159843;17649.20578573964;15663.295151718172;15755.763663545056;15857.36570537177;15968.441104561343;15998.040117592924;922.4880191493735;930.2557953637097;930.3394589841221;931.4318265857821;937.9953100234524;908.7773495493614;911.3574929674596;914.4650379527984;914.9980771055683;955.2071780422233;952.9952350238274;955.3980991975046;962.7352478068517;967.3905439573094;992.846108853129;949.7862980829327;952.9475878826662;953.2993249961273;956.5886668732443;989.4607438945756;723.971041158353;731.9817004574875;732.1141418883158;733.050699344345;735.1472292141091;15505.224738763129;15582.298796554069;15589.922050389789;15608.29762660683;15638.687226255524;14848;14852.554423367315;14892.329845156994;14899.255037248095;14950.775738363824;12240.204386714835;12423.93788031063;12489.437975291134;12505.249685018927;12781.297028663419;4088.12105397341;4093.263212621727;4109.137081212949;4249.383839343278;4251.489821221473;55741.72129139369;56229.43770562324;56555.999999999585;59634;61210.69394653043;11643.53425862956;11702.941485292518;11829.704257393461;11844.644660660195;11978.401079946143;19766.70349944752;19911.800881990996;19978;19995;19997.300094496914;8827.735167944971;8902.376833621714;8945.418547794372;9000.954995225113;9292.90707092934;5188.429272779991;5316.175992721134;5316.601254905898;5433.483819037185;5449.5640348772;3579.302036102935;3612.1692010837655;3614.8734794282072;3621.9818900905325;3626.655467730614;683.5078743304813;684.4558575932145;695.8956156576554;696.3315217391361;696.585531608692;725.1189804387694;764.6291548598925;775.0196002057402;809.8137428391503;820.8932838730926;9246.214071803837;9853.211743060538;9949.900500995042;9992.200623950066;10117.797644047077;704.457567672889;769.1654554807984;809.1463506001226;876.5399009301489;900.9189172974463;4870.245112007645;4923.581495572845;5035.571976382049;5090.389153301628;5115.283860259492;65773.671131645;67102;67103.66448167728;67147.66426167838;67154.32845671481;56721;57535;58474.7076264616;58532;59643;54065;54906.17640735392;55337.44662553323;55882.72058639762;56082;9979.550920208463;10370.22223333268;10477;10538.104261137889;10538.8419173714;40572;40814.1837163261;41422.1715565681;42179.1564168721;42556;47925.76037119792;47973.76013120051;49376.25935611041;53335.733321333144;54897.725511373785;13752.243626600633;13816.378262978391;13871.167729936236;14134.363953621905;14137.717245655234;14516.491922782652;14959.92520037393;15205.771913421086;15470.071795692294;15800.051996880224;13927.721445571235;14377.9281103598;14744.705105897607;14836.851631483547;14897.627559311104;12808.6797830055;13216.405261763051;13855.515056972958;13927.23400212998;14162.716745665235;12856.357182141042;13811.240381779098;13843;13850.307484625528;13878.722425551634;11298.887011130113;11435.828462573234;11534.365609891202;11643.88356116428;11851.881481185423;11541.769164616828;11740.823887641864;12007.339596322287;12104.713715578871;12114 06:40:42 INFO - PROCESS | 6198 | __end_tp_report 06:40:42 INFO - PROCESS | 6198 | __start_cc_report 06:40:42 INFO - PROCESS | 6198 | _x_x_mozilla_cycle_collect,327 06:40:42 INFO - PROCESS | 6198 | __end_cc_report 06:40:42 INFO - PROCESS | 6198 | __startTimestamp1462801242039__endTimestamp 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | ------- Summary: start ------- 06:40:42 INFO - PROCESS | 6198 | Number of tests: 6 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#0] dojo.html Cycles:165 Average:5666.66 Median:5878.44 stddev:630.83 (10.7%) stddev-sans-first:605.43 06:40:42 INFO - PROCESS | 6198 | Values: 3325.1 3357.4 3404.4 3428.5 3430.3 5671.5 5673.4 5690.5 5714.5 5727.5 5699.7 5711.8 5712.7 5718.2 5759.0 5186.5 5210.1 5252.7 5280.6 5308.1 5118.2 5194.9 5230.7 5327.0 5398.0 5279.0 5285.1 5303.1 5333.2 5341.7 5219.6 5283.7 5308.8 5315.8 5328.1 5056.9 5070.9 5128.6 5199.2 5216.6 5533.0 5568.6 5619.9 5623.4 5627.0 6065.9 6095.7 6125.9 6126.2 6135.5 5840.4 6038.7 6103.2 6149.4 6182.9 5787.7 5793.1 5796.2 5804.9 5810.5 6244.6 6244.9 6305.8 6312.7 6314.5 5805.2 5915.6 5977.4 5995.8 6029.5 6084.2 6097.7 6110.3 6115.2 6116.2 5886.1 6020.8 6044.4 6070.2 6091.9 6065.1 6120.2 6124.4 6128.1 6143.9 4551.9 4555.2 4569.6 4574.0 4579.6 4068.2 4082.3 4106.9 4114.2 4134.4 5765.5 5838.5 5839.2 5866.5 5980.2 6089.6 6118.2 6119.5 6134.4 6134.9 5694.5 5853.6 5860.0 5873.0 5873.1 5202.6 5235.9 5238.0 5245.2 5292.6 6245.8 6247.1 6252.5 6261.7 6268.2 5958.4 6071.6 6082.6 6086.9 6129.0 6191.7 6235.1 6239.3 6273.9 6277.3 5943.8 5945.4 5948.9 5958.8 5975.7 5877.1 6007.2 6062.9 6084.8 6112.9 5932.7 5938.8 5959.3 5962.7 5972.8 5912.7 5938.8 5942.9 5943.6 5948.9 5707.8 5860.2 5876.1 5941.7 5956.3 5968.0 6008.4 6015.6 6016.5 6039.9 5858.0 5877.1 5878.4 5897.3 5920.1 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#1] ext.html Cycles:180 Average:65280.99 Median:43268.35 stddev:153213.72 (354.1%) stddev-sans-first:153566.61 06:40:42 INFO - PROCESS | 6198 | Values: 623.1 658.6 676.1 677.0 687.6 38571.4 38912.6 39052.0 39067.4 39441.8 42689.6 43521.0 43572.0 43577.6 43595.1 8826.8 8903.6 8913.7 8935.9 8956.6 8746.1 8833.7 8852.4 8865.0 8895.2 9156.6 9173.9 9192.3 9206.7 9266.7 9097.4 9115.2 9169.9 9191.5 9197.0 9029.8 9175.6 9188.0 9194.6 9207.4 43071.1 43227.0 43291.4 43509.8 43766.3 3830.8 3920.9 3958.1 3973.1 4365.3 34438.7 34773.5 34891.7 34906.0 35020.1 4590.4 4605.6 4705.1 4723.6 4727.3 229590.0 230438.0 230454.0 232064.0 232432.0 56479.0 56658.7 57282.4 57336.4 64145.4 66525.3 70310.0 71074.6 71459.3 71667.0 19216.1 19224.5 19414.7 19477.6 19484.6 14320.7 14430.7 14454.0 14492.6 14533.0 20256.4 20473.5 20577.0 20639.3 20660.3 7719.5 7877.6 7969.4 7972.8 8183.5 1156.1 1165.1 1197.4 1205.2 1211.5 33431.8 33607.8 33788.3 33836.5 34797.1 1192.9 1263.9 1285.5 1311.2 1328.2 17241.5 17547.3 17563.2 17654.7 17984.7 480814.0 854832.0 974443.0 994824.0 995609.0 62877.7 64041.7 64464.0 64594.7 64842.0 1541.4 1561.0 1561.2 1562.4 1575.5 32987.7 33536.7 33729.2 33992.3 34011.1 53784.5 54163.7 54269.7 54475.0 54746.0 348933.0 348997.0 350706.0 352708.0 353773.0 30994.5 50306.2 50378.7 50652.0 50817.5 49823.5 50710.2 50868.5 51147.2 51830.7 42676.0 43007.0 44022.3 44739.0 44826.3 41644.8 42049.4 42429.0 43245.4 43899.3 42696.6 43227.8 43454.0 43974.6 44163.5 36639.8 36945.2 37316.8 37586.0 37768.4 28711.7 29451.7 29661.3 29908.0 30074.5 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#2] jquery.html Cycles:180 Average:30729.50 Median:2117.65 stddev:91609.73 (4326.0%) stddev-sans-first:91838.44 06:40:42 INFO - PROCESS | 6198 | Values: 418.1 422.4 423.4 424.3 435.5 18398.9 18892.6 18925.3 18992.9 19925.8 19383.7 19582.0 19603.3 20626.0 20626.4 5571.7 5836.7 5864.0 5981.9 6049.5 5736.3 5747.9 5748.4 5767.4 5772.3 5542.0 5679.5 5740.9 5744.8 5790.1 5663.5 5704.0 5724.6 5735.6 5786.1 5541.4 5553.0 5632.7 5679.8 5701.0 12491.1 12681.8 12724.1 12754.3 13755.7 2594.5 2599.7 2623.5 2648.0 2701.7 10276.9 10284.2 10394.6 10582.3 10801.8 2023.8 2029.6 2103.2 2113.2 2122.1 80707.2 80846.6 83382.6 84030.0 85522.0 11189.5 11193.6 11394.6 11422.8 11441.8 15530.5 15615.7 15652.0 15659.8 15749.9 8652.8 8800.4 8837.0 9017.4 9085.7 9101.4 9227.4 9240.6 9268.4 9374.0 4793.3 4933.1 4947.1 4976.4 5004.0 2046.9 2055.5 2063.8 2084.6 2129.9 1019.6 1034.1 1062.3 1071.9 1112.4 19105.9 19480.2 19635.9 19727.1 19992.7 1096.7 1112.3 1158.9 1163.1 1193.9 10926.3 11146.7 11167.6 11194.1 11268.8 539432.0 546027.0 555820.0 560162.0 586281.0 69701.7 84136.0 86693.0 95680.0 99611.5 1003.8 1021.9 1026.2 1026.9 1030.5 17375.7 17578.0 17582.3 17709.1 18048.0 38626.2 39452.8 40903.6 41703.0 42280.2 56143.0 60496.7 60832.0 61010.7 61220.7 8873.2 8891.6 8927.4 8992.6 9059.1 9891.9 12892.0 13605.0 13782.3 13814.4 11806.6 11873.9 11899.2 12048.7 12256.4 7981.8 11809.0 11925.5 12021.0 12149.8 12188.6 12386.9 12414.4 12512.1 12534.1 8703.0 8784.8 8892.2 8914.8 8970.7 12023.3 12071.9 12078.7 12191.8 12193.6 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#3] mootools.html Cycles:180 Average:5379.88 Median:5147.38 stddev:2848.85 (55.3%) stddev-sans-first:2842.57 06:40:42 INFO - PROCESS | 6198 | Values: 1585.2 1595.6 1804.5 1892.1 1901.4 6965.3 7878.8 7964.7 8098.2 8150.6 7946.9 8041.5 8056.5 8288.9 8315.4 2374.6 2377.9 2410.9 2411.0 2413.7 2448.5 2467.5 2482.4 2484.0 2484.6 2341.3 2408.4 2410.6 2416.4 2427.0 2379.5 2393.3 2393.7 2401.6 2419.3 2460.8 2468.6 2473.3 2494.9 2501.5 8241.6 8268.9 8282.8 8347.2 8352.5 5094.4 5196.4 5215.6 5233.6 5267.4 3520.5 3529.6 3588.4 3599.7 3604.7 1233.2 1263.0 1270.3 1283.8 1285.0 11094.8 11127.8 11139.6 11184.3 11191.6 4342.2 4393.2 4400.7 4427.1 4431.1 8958.1 8983.2 9002.0 9033.1 9063.0 4952.4 4980.9 4983.7 5016.9 5019.4 4247.8 4625.7 4628.4 4687.1 4725.9 3772.6 3834.6 3863.6 3872.7 3954.4 1156.7 1171.4 1182.9 1191.4 1194.9 903.9 989.5 995.6 1002.5 1021.5 5440.3 5503.8 5604.5 5622.0 5645.5 473.2 484.7 485.1 491.3 492.5 3789.5 3797.1 3800.4 3815.8 3817.5 9314.9 9443.5 9547.2 9547.3 9576.0 9198.7 9352.6 9396.3 9446.7 9451.4 7646.7 7702.6 7721.9 7724.4 7818.6 5327.5 5331.8 5396.8 5453.7 5472.6 8546.7 8605.3 8618.7 8656.1 8715.6 8507.3 8772.6 8842.3 8865.4 8964.8 6156.3 6745.8 6943.2 6992.0 7015.2 7769.8 7781.0 7783.5 7789.6 7853.6 7021.6 7202.2 7219.6 7224.0 7317.0 7097.0 7123.8 7192.3 7227.6 7319.2 6806.8 6904.1 6931.9 6939.8 6951.6 5092.0 5130.0 5137.8 5153.7 5181.9 5038.4 5082.6 5103.0 5123.1 5141.1 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#4] prototype.html Cycles:180 Average:5854.28 Median:6707.03 stddev:1789.27 (26.7%) stddev-sans-first:1745.97 06:40:42 INFO - PROCESS | 6198 | Values: 351.6 360.8 360.9 366.1 371.8 6425.7 6592.3 6619.0 6633.0 6685.2 6534.1 6613.2 6621.1 6629.2 6638.2 5037.5 5051.1 5052.4 5058.1 5065.3 5068.1 5070.9 5071.5 5079.9 5082.1 4990.2 5026.1 5035.9 5035.9 5043.2 4907.9 4955.0 5014.7 5035.9 5040.9 4317.1 4369.3 4372.7 4377.8 4383.8 6258.1 6259.7 6267.7 6278.3 6282.6 5801.4 5806.4 5808.4 5810.4 5836.7 6955.9 6957.2 6962.7 6968.6 6976.1 4591.3 4695.5 4847.3 4849.6 4852.3 7210.4 7229.7 7249.9 7288.0 7292.0 4885.1 4887.0 4891.8 4896.6 4903.3 4964.3 4966.2 4967.0 4967.4 4972.2 5751.2 5755.5 5761.9 5764.2 5780.5 6854.5 6976.8 6993.7 7002.1 7002.2 1724.9 1741.3 1748.8 1752.8 1754.1 1042.8 1120.5 1127.2 1132.9 1135.7 6686.6 6761.8 6819.8 6873.0 6897.6 7242.5 7286.1 7291.4 7298.3 7331.7 6801.0 6850.3 6865.2 6870.8 6870.8 3870.3 3888.2 3930.5 3955.0 3958.1 7546.5 7564.8 7573.4 7575.2 7580.0 7303.8 7379.5 7434.3 7447.7 7450.1 7527.7 7534.2 7549.4 7550.4 7557.5 7054.3 7280.1 7287.7 7293.2 7295.3 7104.3 7161.4 7169.1 7176.2 7217.2 7490.3 7523.2 7524.3 7550.9 7556.9 4796.7 4798.6 4801.6 4804.4 4846.3 7031.6 7232.0 7246.2 7249.1 7259.4 6979.4 7033.5 7053.4 7054.2 7062.8 6992.3 6994.5 6998.7 7012.0 7023.9 6830.7 6891.9 6893.7 6898.3 6898.6 6880.5 7020.9 7058.7 7077.8 7097.9 6727.5 6873.0 6928.9 6946.1 6961.8 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - PROCESS | 6198 | [#5] yui.html Cycles:180 Average:16319.30 Median:47949.76 stddev:18567.54 (38.7%) stddev-sans-first:18583.38 06:40:42 INFO - PROCESS | 6198 | Values: 870.5 920.9 926.0 937.5 963.5 15383.2 17493.9 17603.3 17631.4 17649.2 15663.3 15755.8 15857.4 15968.4 15998.0 922.5 930.3 930.3 931.4 938.0 908.8 911.4 914.5 915.0 955.2 953.0 955.4 962.7 967.4 992.8 949.8 952.9 953.3 956.6 989.5 724.0 732.0 732.1 733.1 735.1 15505.2 15582.3 15589.9 15608.3 15638.7 14848.0 14852.6 14892.3 14899.3 14950.8 12240.2 12423.9 12489.4 12505.2 12781.3 4088.1 4093.3 4109.1 4249.4 4251.5 55741.7 56229.4 56556.0 59634.0 61210.7 11643.5 11702.9 11829.7 11844.6 11978.4 19766.7 19911.8 19978.0 19995.0 19997.3 8827.7 8902.4 8945.4 9001.0 9292.9 5188.4 5316.2 5316.6 5433.5 5449.6 3579.3 3612.2 3614.9 3622.0 3626.7 683.5 684.5 695.9 696.3 696.6 725.1 764.6 775.0 809.8 820.9 9246.2 9853.2 9949.9 9992.2 10117.8 704.5 769.2 809.1 876.5 900.9 4870.2 4923.6 5035.6 5090.4 5115.3 65773.7 67102.0 67103.7 67147.7 67154.3 56721.0 57535.0 58474.7 58532.0 59643.0 54065.0 54906.2 55337.4 55882.7 56082.0 9979.6 10370.2 10477.0 10538.1 10538.8 40572.0 40814.2 41422.2 42179.2 42556.0 47925.8 47973.8 49376.3 53335.7 54897.7 13752.2 13816.4 13871.2 14134.4 14137.7 14516.5 14959.9 15205.8 15470.1 15800.1 13927.7 14377.9 14744.7 14836.9 14897.6 12808.7 13216.4 13855.5 13927.2 14162.7 12856.4 13811.2 13843.0 13850.3 13878.7 11298.9 11435.8 11534.4 11643.9 11851.9 11541.8 11740.8 12007.3 12104.7 12114.0 06:40:42 INFO - PROCESS | 6198 | -------- Summary: end -------- 06:40:42 INFO - PROCESS | 6198 | 06:40:42 INFO - TEST-INFO | 6198: exit 0 06:40:42 INFO - TEST-OK | dromaeo_css | took 1110717ms 06:40:42 INFO - TEST-START | kraken 06:40:42 INFO - operating with platform_type : linux_ 06:40:42 INFO - Initialising browser for kraken test... 06:40:42 INFO - TEST-INFO | started process 6437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4nvnQ/profile http://localhost:49472/getInfo.html) 06:40:46 INFO - PROCESS | 6437 | 06:40:46 INFO - PROCESS | 6437 | (process:6516): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:40:47 INFO - PROCESS | 6437 | __metrics Screen width/height:1600/1200 06:40:47 INFO - PROCESS | 6437 | colorDepth:24 06:40:47 INFO - PROCESS | 6437 | Browser inner width/height: 1024/697 06:40:47 INFO - PROCESS | 6437 | __metrics 06:40:48 ERROR - PROCESS | 6437 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:40:49 INFO - TEST-INFO | 6437: exit 0 06:40:49 INFO - Browser initialized. 06:40:49 INFO - Running cycle 1/1 for kraken test... 06:40:49 INFO - TEST-INFO | started process 6567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4nvnQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:51 INFO - PROCESS | 6567 | 06:40:51 INFO - PROCESS | 6567 | (process:6637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:01 INFO - PROCESS | 6567 | RSS: Main: 152170496 06:41:01 INFO - PROCESS | 6567 | 06:41:03 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:04 INFO - PROCESS | 6567 | RSS: Main: 156823552 06:41:04 INFO - PROCESS | 6567 | 06:41:07 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-dft) 06:41:07 INFO - PROCESS | 6567 | RSS: Main: 156950528 06:41:07 INFO - PROCESS | 6567 | 06:41:10 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-fft) 06:41:11 INFO - PROCESS | 6567 | RSS: Main: 157175808 06:41:11 INFO - PROCESS | 6567 | 06:41:13 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator) 06:41:13 INFO - PROCESS | 6567 | RSS: Main: 157319168 06:41:13 INFO - PROCESS | 6567 | 06:41:16 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:16 INFO - PROCESS | 6567 | RSS: Main: 157175808 06:41:16 INFO - PROCESS | 6567 | 06:41:19 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:20 INFO - PROCESS | 6567 | RSS: Main: 157335552 06:41:20 INFO - PROCESS | 6567 | 06:41:23 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:24 INFO - PROCESS | 6567 | RSS: Main: 157433856 06:41:24 INFO - PROCESS | 6567 | 06:41:27 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial) 06:41:27 INFO - PROCESS | 6567 | RSS: Main: 157810688 06:41:27 INFO - PROCESS | 6567 | 06:41:29 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:30 INFO - PROCESS | 6567 | RSS: Main: 157425664 06:41:30 INFO - PROCESS | 6567 | 06:41:31 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:32 INFO - PROCESS | 6567 | RSS: Main: 157392896 06:41:32 INFO - PROCESS | 6567 | 06:41:34 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:35 INFO - PROCESS | 6567 | RSS: Main: 157683712 06:41:35 INFO - PROCESS | 6567 | 06:41:37 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:38 INFO - PROCESS | 6567 | RSS: Main: 157798400 06:41:38 INFO - PROCESS | 6567 | 06:41:40 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:41 INFO - PROCESS | 6567 | RSS: Main: 157847552 06:41:41 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49472/tests/kraken/driver.html?testName=ai-astar) 06:41:43 INFO - PROCESS | 6567 | RSS: Main: 159043584 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | __start_tp_report 06:41:43 INFO - PROCESS | 6567 | _x_x_mozilla_page_load 06:41:43 INFO - PROCESS | 6567 | _x_x_mozilla_page_load_details 06:41:43 INFO - PROCESS | 6567 | |i|pagename|runs| 06:41:43 INFO - PROCESS | 6567 | |0;ai-astar;111;112;106;113;111;112;101;110;110;111 06:41:43 INFO - PROCESS | 6567 | |1;audio-beat-detection;158;127;159;180;134;158;160;128;196;129 06:41:43 INFO - PROCESS | 6567 | |2;audio-dft;162;161;162;159;160;161;162;160;162;160 06:41:43 INFO - PROCESS | 6567 | |3;audio-fft;77;75;76;187;77;74;77;76;156;73 06:41:43 INFO - PROCESS | 6567 | |4;audio-oscillator;92;92;148;93;93;91;139;93;92;140 06:41:43 INFO - PROCESS | 6567 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;118;117;117 06:41:43 INFO - PROCESS | 6567 | |6;imaging-darkroom;146;147;148;146;147;147;146;147;146;146 06:41:43 INFO - PROCESS | 6567 | |7;imaging-desaturate;95;95;97;96;96;95;95;95;96;95 06:41:43 INFO - PROCESS | 6567 | |8;json-parse-financial;60;60;60;55;56;59;56;90;53;54 06:41:43 INFO - PROCESS | 6567 | |9;json-stringify-tinderbox;57;58;57;57;57;57;57;57;57;58 06:41:43 INFO - PROCESS | 6567 | |10;stanford-crypto-aes;74;78;75;74;75;74;74;75;76;81 06:41:43 INFO - PROCESS | 6567 | |11;stanford-crypto-ccm;117;115;117;115;116;124;112;129;129;127 06:41:43 INFO - PROCESS | 6567 | |12;stanford-crypto-pbkdf2;165;163;163;162;162;160;159;161;160;159 06:41:43 INFO - PROCESS | 6567 | |13;stanford-crypto-sha256-iterative;66;69;68;69;68;66;67;67;66;69 06:41:43 INFO - PROCESS | 6567 | __end_tp_report 06:41:43 INFO - PROCESS | 6567 | __start_cc_report 06:41:43 INFO - PROCESS | 6567 | _x_x_mozilla_cycle_collect,850 06:41:43 INFO - PROCESS | 6567 | __end_cc_report 06:41:43 INFO - PROCESS | 6567 | __startTimestamp1462801303425__endTimestamp 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | ------- Summary: start ------- 06:41:43 INFO - PROCESS | 6567 | Number of tests: 14 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.59 (3.2%) stddev-sans-first:3.78 06:41:43 INFO - PROCESS | 6567 | Values: 111.0 112.0 106.0 113.0 111.0 112.0 101.0 110.0 110.0 111.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:158.50 stddev:23.45 (14.8%) stddev-sans-first:24.80 06:41:43 INFO - PROCESS | 6567 | Values: 158.0 127.0 159.0 180.0 134.0 158.0 160.0 128.0 196.0 129.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 06:41:43 INFO - PROCESS | 6567 | Values: 162.0 161.0 162.0 159.0 160.0 161.0 162.0 160.0 162.0 160.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:41.10 (54.1%) stddev-sans-first:43.09 06:41:43 INFO - PROCESS | 6567 | Values: 77.0 75.0 76.0 187.0 77.0 74.0 77.0 76.0 156.0 73.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:92.00 stddev:24.29 (26.4%) stddev-sans-first:25.13 06:41:43 INFO - PROCESS | 6567 | Values: 92.0 92.0 148.0 93.0 93.0 91.0 139.0 93.0 92.0 140.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:41:43 INFO - PROCESS | 6567 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:41:43 INFO - PROCESS | 6567 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:41:43 INFO - PROCESS | 6567 | Values: 95.0 95.0 97.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:10.76 (18.1%) stddev-sans-first:11.41 06:41:43 INFO - PROCESS | 6567 | Values: 60.0 60.0 60.0 55.0 56.0 59.0 56.0 90.0 53.0 54.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:41:43 INFO - PROCESS | 6567 | Values: 57.0 58.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 58.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:2.27 (3.0%) stddev-sans-first:2.33 06:41:43 INFO - PROCESS | 6567 | Values: 74.0 78.0 75.0 74.0 75.0 74.0 74.0 75.0 76.0 81.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:120.50 stddev:6.45 (5.4%) stddev-sans-first:6.75 06:41:43 INFO - PROCESS | 6567 | Values: 117.0 115.0 117.0 115.0 116.0 124.0 112.0 129.0 129.0 127.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:1.96 (1.2%) stddev-sans-first:1.58 06:41:43 INFO - PROCESS | 6567 | Values: 165.0 163.0 163.0 162.0 162.0 160.0 159.0 161.0 160.0 159.0 06:41:43 INFO - PROCESS | 6567 | 06:41:43 INFO - PROCESS | 6567 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.27 (1.9%) stddev-sans-first:1.22 06:41:43 INFO - PROCESS | 6567 | Values: 66.0 69.0 68.0 69.0 68.0 66.0 67.0 67.0 66.0 69.0 06:41:43 INFO - PROCESS | 6567 | -------- Summary: end -------- 06:41:43 INFO - PROCESS | 6567 | 06:41:44 INFO - TEST-INFO | 6567: exit 0 06:41:44 INFO - TEST-OK | kraken | took 61631ms 06:41:44 INFO - SUITE-END | took 1172s 06:41:44 INFO - Completed test suite (00:19:32) 06:41:44 INFO - javascript benchmark 06:41:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.1022223999516, 3357.3788849062926, 3404.3701915145716, 3428.520007198991, 3430.279641275332, 5671.517920976717, 5673.375928647845, 5690.487856092951, 5714.51426628737, 5727.513161381283, 5699.74351154198, 5711.8000869969555, 5712.685802280873, 5718.228039214705, 5758.992176369129, 5186.507281808223, 5210.088234558937, 5252.658577192489, 5280.630355875091, 5308.124159513675, 5118.206677964921, 5194.870128246786, 5230.73846307685, 5326.973365133169, 5398.028354896117, 5278.973605131969, 5285.075111855429, 5303.124984377573, 5333.226682131089, 5341.679499230039, 5219.582433405319, 5283.709395983219, 5308.8141915033175, 5315.813946511854, 5328.0675881720545, 5056.898862022776, 5070.923936140961, 5128.640995130342, 5199.220116982483, 5216.58267338612, 5533.03171944908, 5568.582356323252, 5619.887602247973, 5623.437656234385, 5627.043402621564, 6065.878682426371, 6095.695215239265, 6125.908111378333, 6126.23422072241, 6135.509159267248, 5840.445157710011, 6038.728257228435, 6103.23709536308, 6149.385061493859, 6182.907256391158, 5787.73955172014, 5793.13103034544, 5796.246487956539, 5804.854878628026, 5810.535157187415, 6244.594101383395, 6244.937550624527, 6305.8108256752375, 6312.715927783261, 6314.463270621956, 5805.216295800013, 5915.615484993462, 5977.432143946318, 5995.820125396158, 6029.487493563096, 6084.209052823105, 6097.664628445389, 6110.327863934964, 6115.205023347025, 6116.204893363834, 5886.117082437669, 6020.819375418744, 6044.395560443921, 6070.150178974947, 6091.908621370683, 6065.059915713072, 6120.204373431426, 6124.38756124384, 6128.117037561489, 6143.938560614337, 4551.886202844889, 4555.180067587866, 4569.611583015481, 4573.954260457353, 4579.587837094611, 4068.16602596467, 4082.3468245080644, 4106.917861642751, 4114.238865809834, 4134.421181034658, 5765.4811067004175, 5838.5329173666005, 5839.153322768259, 5866.501347385435, 5980.192673989043, 6089.5737298388685, 6118.235220597426, 6119.502553941512, 6134.386561343919, 6134.9079763803575, 5694.487496125285, 5853.64878107315, 5860.0, 5873.0, 5873.089671100986, 5202.635815492879, 5235.874287028307, 5238.030964271546, 5245.186996015624, 5292.576593872481, 6245.812625621148, 6247.062940558862, 6252.499800015988, 6261.7182226799905, 6268.247810262797, 5958.40415958418, 6071.605345652519, 6082.60463069899, 6086.908696369646, 6129.019356902785, 6191.721372538156, 6235.064740288993, 6239.251289845066, 6273.905891411724, 6277.340879207617, 5943.821685349447, 5945.435183657545, 5948.940510594839, 5958.791442299499, 5975.701214939322, 5877.118432235199, 6007.189029480965, 6062.878742425039, 6084.847878803065, 6112.898653789679, 5932.673702946379, 5938.762449501972, 5959.284885813557, 5962.731677074456, 5972.790952316648, 5912.67480288571, 5938.8218353449465, 5942.881142377042, 5943.554233432596, 5948.8810223796145, 5707.828765137053, 5860.15027820955, 5876.147958546072, 5941.673207973603, 5956.285245770535, 5968.045112781934, 6008.399160084132, 6015.608985415934, 6016.518678505621, 6039.909401359071, 5858.004139296245, 5877.118432235199, 5878.441548052928, 5897.262842144732, 5920.111983202554], "value": 5624.993145791057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.130732627984, 658.5752189837555, 676.1311714446937, 677.0, 687.577140058864, 38571.421428678594, 38912.61087389125, 39052.023699407495, 39067.41398879012, 39441.80279098604, 42689.57310426895, 43521.0, 43572.0, 43577.564224357746, 43595.128097438035, 8826.779330516723, 8903.643854245822, 8913.732588022338, 8935.865962010575, 8956.596953137092, 8746.081661425555, 8833.734987950373, 8852.424592401505, 8864.980527239386, 8895.243904268145, 9156.587953542074, 9173.908260917373, 9192.264618830512, 9206.723798286062, 9266.675666351679, 9097.408668436598, 9115.179633832953, 9169.862452063191, 9191.540422978824, 9196.954015229949, 9029.819403611957, 9175.58709858058, 9187.954060229722, 9194.632214711404, 9207.401518901317, 43071.138577228594, 43227.0, 43291.35062974058, 43509.782451087856, 43766.34350484745, 3830.7701537907537, 3920.921581568381, 3958.0896393829294, 3973.0861901762755, 4365.3272260392605, 34438.65561344379, 34773.4783978238, 34891.65108348935, 34906.0, 35020.12449688778, 4590.42619672541, 4605.631549476034, 4705.082508910764, 4723.622110231207, 4727.338172655831, 229590.0, 230438.0, 230454.0, 232064.0, 232432.0, 56479.0, 56658.71670641703, 57282.427175728546, 57336.42663573311, 64145.35854641394, 66525.33474665288, 70310.0, 71074.64462677654, 71459.28540714631, 71667.0, 19216.135273912707, 19224.519387015436, 19414.70877936832, 19477.61044779125, 19484.610307793766, 14320.713585728436, 14430.711385772225, 14454.0, 14492.565223043326, 14533.0, 20256.392308230777, 20473.48816279605, 20577.0, 20639.277625283044, 20660.27689030907, 7719.536827790238, 7877.645505952246, 7969.362451003905, 7972.760817175494, 8183.549904755177, 1156.0866915137115, 1165.0639989254735, 1197.4491733802374, 1205.2105870654734, 1211.5335595795682, 33431.83284083564, 33607.83196084004, 33788.324233515195, 33836.49245261323, 34797.1300717479, 1192.8687844337117, 1263.9368031598383, 1285.5372066056211, 1311.2001678975817, 1328.1632571479906, 17241.482755517354, 17547.298108075534, 17563.225719679627, 17654.735178972325, 17984.730229046574, 480814.0, 854832.0, 974443.0, 994824.0, 995609.0, 62877.68561157165, 64041.67979160167, 64464.0, 64594.67702661457, 64842.0, 1541.352631894607, 1561.0243597751405, 1561.1725785333792, 1562.414094714482, 1575.4643421236835, 32987.67012329846, 33536.66463335336, 33729.15677108092, 33992.320153597284, 34011.14972125716, 53784.46215537794, 54163.72918135384, 54269.72865135649, 54475.0, 54746.0, 348933.0, 348997.0, 350706.0, 352708.0, 353773.0, 30994.535081973336, 50306.2454063182, 50378.748106259234, 50652.0, 50817.491825082754, 49823.501764981884, 50710.23934640909, 50868.49131508637, 51147.232791508904, 51830.74084629553, 42676.0, 43007.0, 44022.33966490441, 44739.0, 44826.327605085295, 41644.791776040925, 42049.36925946052, 42429.0, 43245.3513197296, 43899.34150987802, 42696.57303426926, 43227.78386108049, 43454.0, 43974.560254398326, 44163.54882466082, 36639.816800915825, 36945.213942642746, 37316.813415932746, 37586.0, 37768.433473498466, 28711.712882870903, 29451.705482944897, 29661.25846853846, 29908.0, 30074.548881766354], "value": 21473.23954232547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.0593664255425, 422.4233920698246, 423.4474011415102, 424.29143330637834, 435.48612637088235, 18398.90800545997, 18892.622147557056, 18925.337613183543, 18992.905035474836, 19925.80074199261, 19383.70924436131, 19582.0, 19603.313884014027, 20626.0, 20626.38120856373, 5571.749271282802, 5836.737346819404, 5863.999999999989, 5981.940180598203, 6049.48579370754, 5736.311642602894, 5747.856303592402, 5748.425157484239, 5767.423257674241, 5772.3361813391575, 5542.0, 5679.460451257145, 5740.8851822963725, 5744.79893203738, 5790.073588225885, 5663.5186009189065, 5703.9714801425935, 5724.5992780505385, 5735.627184233012, 5786.103154011135, 5541.445855414427, 5553.0, 5632.662040277596, 5679.772809087632, 5701.0, 12491.12562120652, 12681.809772853414, 12724.109312348139, 12754.298513581749, 13755.656108597264, 2594.532984062868, 2599.7270286619823, 2623.527765002299, 2647.9602805957925, 2701.716319786414, 10276.94861525695, 10284.228682848741, 10394.63618773347, 10582.259241853073, 10801.83797243042, 2023.8482113841374, 2029.6143732690741, 2103.24283258027, 2113.2075471698113, 2122.0875023739786, 80707.19292807115, 80846.59576702138, 83382.58308708417, 84030.0, 85522.0, 11189.496472658588, 11193.608223712132, 11394.601188958346, 11422.771544569063, 11441.771164576661, 15530.534083977498, 15615.687686246212, 15652.0, 15659.843401566066, 15749.921250393674, 8652.78368040804, 8800.383973121949, 8837.0, 9017.413868098683, 9085.682001129928, 9101.362904596746, 9227.354085214105, 9240.630374785067, 9268.443893366419, 9374.0, 4793.32893394925, 4933.112039832793, 4947.134251505972, 4976.353074100344, 5004.0, 2046.8567200296134, 2055.5159005485857, 2063.772984971652, 2084.5726626041624, 2129.914803407877, 1019.6125472320471, 1034.1468288661883, 1062.3307316390624, 1071.8820929697727, 1112.3993043756443, 19105.904470477835, 19480.220791168478, 19635.920024398794, 19727.11227994715, 19992.700109498368, 1096.7203363142348, 1112.2881355932209, 1158.9420528973517, 1163.1276542593055, 1193.8806119388166, 10926.344419334866, 11146.665600032013, 11167.553297867995, 11194.10447164225, 11268.774624507463, 539432.0, 546027.0, 555820.0, 560162.0, 586281.0, 69701.65149174222, 84136.0, 86693.0, 95680.0, 99611.50194248982, 1003.789204267112, 1021.9029192226726, 1026.153423425662, 1026.9127124194379, 1030.4744580263969, 17375.652486950443, 17578.0, 17582.296708131533, 17709.114544272477, 18048.0, 38626.2274754509, 39452.80273598614, 40903.59096408998, 41703.0, 42280.154396912505, 56143.0, 60496.69751651213, 60832.0, 61010.694946524985, 61220.69389653023, 8873.245774109273, 8891.64433422656, 8927.419717718327, 8992.55037248148, 9059.094090590888, 9891.901080989386, 12892.0, 13605.0, 13782.310884455537, 13814.447422103003, 11806.645800625995, 11873.881261187278, 11899.226550274205, 12048.698782530508, 12256.448459819152, 7981.840363192588, 11809.0, 11925.463354148911, 12021.038316934799, 12149.75700486003, 12188.634340969786, 12386.938065309616, 12414.441350139085, 12512.124151309321, 12534.122611417479, 8703.0, 8784.78038049054, 8892.243404544612, 8914.821703565764, 8970.730878073668, 12023.338716370683, 12071.879281207075, 12078.698032549257, 12191.817122743343, 12193.634190974284], "value": 9393.878088855921, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1585.1598652714058, 1595.5536042148956, 1804.5308219862832, 1892.1390767200926, 1901.391554702494, 6965.338292862182, 7878.803029924255, 7964.681412743498, 8098.230668086537, 8150.633221505024, 7946.880796788038, 8041.477303975237, 8056.516609003464, 8288.875666865002, 8315.41792074555, 2374.6438034294906, 2377.940551486218, 2410.8915098820507, 2410.963835542468, 2413.734489206186, 2448.4735781806908, 2467.5311690778785, 2482.441450673602, 2483.950320993579, 2484.62730590412, 2341.285907798121, 2408.3617841272076, 2410.5781488239577, 2416.35966468885, 2426.9757302427015, 2379.4884099918513, 2393.282015395383, 2393.712754469457, 2401.5677178107935, 2419.3104965085045, 2460.753924607525, 2468.617364308535, 2473.295110893405, 2494.8503089814667, 2501.499700059977, 8241.629126689313, 8268.875966860502, 8282.751517454486, 8347.248747612683, 8352.540610266493, 5094.414142373637, 5196.428392876781, 5215.58275337972, 5233.581313494911, 5267.446918073585, 3520.4895290183035, 3529.5705239378094, 3588.372034893909, 3599.748017638766, 3604.7296452766145, 1233.1922590703105, 1262.9747405051849, 1270.3457719274581, 1283.8331016967827, 1285.0, 11094.833577496343, 11127.777444451227, 11139.610113646064, 11184.273022253528, 11191.608293709762, 4342.218400687906, 4393.231184542692, 4400.73595584266, 4427.092446048552, 4431.1137772445, 8958.05940376251, 8983.236424903957, 9001.954990225007, 9033.05152958943, 9063.003069662333, 4952.4057113146655, 4980.850574482772, 4983.725895075733, 5016.949830501721, 5019.447860735316, 4247.8088486018205, 4625.653076019312, 4628.4445866496235, 4687.1328804171335, 4725.8582242532775, 3772.5850156482766, 3834.6357096075826, 3863.555691095504, 3872.6514613684903, 3954.426608141803, 1156.7397335599424, 1171.4084387384487, 1182.9231099978474, 1191.362620997762, 1194.9163558550817, 903.9005709371963, 989.4805227255605, 995.6452988681716, 1002.5187909803335, 1021.4841505040056, 5440.265564148868, 5503.834884953458, 5604.523615492647, 5621.975731407776, 5645.463680950385, 473.20501557383926, 484.6946423753013, 485.10013924170863, 491.34160225298274, 492.53455484567456, 3789.450529673182, 3797.050737315671, 3800.410936304877, 3815.809209539512, 3817.484639573622, 9314.906850931404, 9443.527823608792, 9547.188488978514, 9547.2839537035, 9575.952120239353, 9198.724038278862, 9352.625894964262, 9396.295277854188, 9446.669366572138, 9451.385659932082, 7646.694132234759, 7702.576358300347, 7721.884171737428, 7724.420668449777, 7818.569978651115, 5327.547158491417, 5331.813386531608, 5396.83809485716, 5453.700046497481, 5472.616916815944, 8546.658133674584, 8605.311575074104, 8618.655253789779, 8656.091110433314, 8715.607797648994, 8507.276881465144, 8772.56137193125, 8842.336824738299, 8865.379423440298, 8964.820703586021, 6156.29202641702, 6745.763898263537, 6943.236244013256, 6992.02111704372, 7015.158181018311, 7769.7669069928, 7780.961095194488, 7783.532988020737, 7789.61051947389, 7853.568053757098, 7021.568382994639, 7202.171750248788, 7219.6029218391395, 7223.963880180566, 7316.9634151828905, 7096.964515177391, 7123.7506687265695, 7192.31672991065, 7227.602481863548, 7319.158296795724, 6806.76176333826, 6904.1024666795, 6931.861362772817, 6939.826504337432, 6951.582905025714, 5091.974540127276, 5130.0, 5137.794488220429, 5153.6907785532985, 5181.922271166011, 5038.370203724535, 5082.618803589671, 5103.0, 5123.077845987758, 5141.074606570854], "value": 4375.236320932638, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.55177149134863, 360.8231966336495, 360.86467574659497, 366.1213088587388, 371.75278439837524, 6425.67871606419, 6592.274849766522, 6619.0, 6632.966835165829, 6685.164354455693, 6534.117894084297, 6613.239477460093, 6621.139251897259, 6629.171353580802, 6638.23660279068, 5037.49625037497, 5051.065552872712, 5052.393712754475, 5058.0895438821, 5065.290859279704, 5068.138416469209, 5070.949290507085, 5071.492850714936, 5079.873003174932, 5082.1360368737405, 4990.176620857555, 5026.145555255597, 5035.874103147432, 5035.949640503603, 5043.218301163325, 4907.9263811042865, 4955.033768415178, 5014.699118052892, 5035.874103147432, 5040.899182016357, 4317.0934103838235, 4369.3009118541195, 4372.650187984954, 4377.824887004516, 4383.75889326087, 6258.123862659231, 6259.655718935457, 6267.686615669244, 6278.30938596754, 6282.591631543935, 5801.419858014207, 5806.361300256968, 5808.448197421239, 5810.448007439287, 5836.737346819361, 6955.93044069563, 6957.1651401832105, 6962.721491140348, 6968.616726080064, 6976.093107895992, 4591.288350305708, 4695.483496815347, 4847.345608342899, 4849.636277279218, 4852.320675105488, 7210.387117095053, 7229.710811567531, 7249.855002899965, 7288.0, 7292.0, 4885.120678277873, 4887.022595480918, 4891.804327826918, 4896.608271338285, 4903.26451032348, 4964.280179373971, 4966.180580204298, 4967.0, 4967.3542439482635, 4972.229304457815, 5751.166080918327, 5755.539556835443, 5761.884762304814, 5764.164196191528, 5780.450857168562, 6854.485913556503, 6976.825579360455, 6993.6503174841055, 7002.124734408199, 7002.194747603989, 1724.8706347024024, 1741.2512619573452, 1748.825117488241, 1752.7721396218665, 1754.140471169118, 1042.7653777899911, 1120.467777805536, 1127.2109523333536, 1132.9010859466305, 1135.7047167736448, 6686.5653732507235, 6761.797146085625, 6819.795406137824, 6872.965635171892, 6897.62063086525, 7242.493025488166, 7286.125664920243, 7291.380232680282, 7298.343149116605, 7331.74338898136, 6800.965995169992, 6850.349216824394, 6865.244823069558, 6870.7595234166565, 6870.793876183722, 3870.322693528621, 3888.202918401721, 3930.508686414198, 3955.0, 3958.148997965451, 7546.509476883985, 7564.848703025908, 7573.394128469709, 7575.204603516661, 7580.0, 7303.780886573411, 7379.483436159418, 7434.256574342522, 7447.739329123455, 7450.105987281452, 7527.698892044366, 7534.246575342422, 7549.358304544176, 7550.433717471212, 7557.5465472071855, 7054.294570542905, 7280.126384833854, 7287.672054757655, 7293.161286452126, 7295.306945840137, 7104.254053324326, 7161.355478007004, 7169.139703235645, 7176.174739904769, 7217.206107328085, 7490.250974902684, 7523.172451030273, 7524.2851929066655, 7550.924490755022, 7556.924430755622, 4796.664233503621, 4798.616110711065, 4801.615870730403, 4804.447488538723, 4846.273059041172, 7031.648417578998, 7231.963840180765, 7246.239144889711, 7249.05762250904, 7259.38295244889, 6979.441644668516, 7033.542819716702, 7053.400460960671, 7054.188768291712, 7062.8234294141, 6992.300769922967, 6994.510384273052, 6998.650067496503, 7011.964940175267, 7023.859522809413, 6830.726770929107, 6891.931080689329, 6893.689783959834, 6898.344657257552, 6898.620575868375, 6880.547024856746, 7020.894686579808, 7058.682359293947, 7077.787666370017, 7097.858042839218, 6727.495437842279, 6872.969054641644, 6928.861422771415, 6946.062281592122, 6961.79114626562], "value": 5263.323325338456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.5473153959939, 920.8894932608088, 926.0264776440622, 937.5171786529943, 963.4893506441584, 15383.230838458074, 17493.912530437345, 17603.29586816529, 17631.38290159843, 17649.20578573964, 15663.295151718172, 15755.763663545056, 15857.36570537177, 15968.441104561343, 15998.040117592924, 922.4880191493735, 930.2557953637097, 930.3394589841221, 931.4318265857821, 937.9953100234524, 908.7773495493614, 911.3574929674596, 914.4650379527984, 914.9980771055683, 955.2071780422233, 952.9952350238274, 955.3980991975046, 962.7352478068517, 967.3905439573094, 992.846108853129, 949.7862980829327, 952.9475878826662, 953.2993249961273, 956.5886668732443, 989.4607438945756, 723.971041158353, 731.9817004574875, 732.1141418883158, 733.050699344345, 735.1472292141091, 15505.224738763129, 15582.298796554069, 15589.922050389789, 15608.29762660683, 15638.687226255524, 14848.0, 14852.554423367315, 14892.329845156994, 14899.255037248095, 14950.775738363824, 12240.204386714835, 12423.93788031063, 12489.437975291134, 12505.249685018927, 12781.297028663419, 4088.12105397341, 4093.263212621727, 4109.137081212949, 4249.383839343278, 4251.489821221473, 55741.72129139369, 56229.43770562324, 56555.999999999585, 59634.0, 61210.69394653043, 11643.53425862956, 11702.941485292518, 11829.704257393461, 11844.644660660195, 11978.401079946143, 19766.70349944752, 19911.800881990996, 19978.0, 19995.0, 19997.300094496914, 8827.735167944971, 8902.376833621714, 8945.418547794372, 9000.954995225113, 9292.90707092934, 5188.429272779991, 5316.175992721134, 5316.601254905898, 5433.483819037185, 5449.5640348772, 3579.302036102935, 3612.1692010837655, 3614.8734794282072, 3621.9818900905325, 3626.655467730614, 683.5078743304813, 684.4558575932145, 695.8956156576554, 696.3315217391361, 696.585531608692, 725.1189804387694, 764.6291548598925, 775.0196002057402, 809.8137428391503, 820.8932838730926, 9246.214071803837, 9853.211743060538, 9949.900500995042, 9992.200623950066, 10117.797644047077, 704.457567672889, 769.1654554807984, 809.1463506001226, 876.5399009301489, 900.9189172974463, 4870.245112007645, 4923.581495572845, 5035.571976382049, 5090.389153301628, 5115.283860259492, 65773.671131645, 67102.0, 67103.66448167728, 67147.66426167838, 67154.32845671481, 56721.0, 57535.0, 58474.7076264616, 58532.0, 59643.0, 54065.0, 54906.17640735392, 55337.44662553323, 55882.72058639762, 56082.0, 9979.550920208463, 10370.22223333268, 10477.0, 10538.104261137889, 10538.8419173714, 40572.0, 40814.1837163261, 41422.1715565681, 42179.1564168721, 42556.0, 47925.76037119792, 47973.76013120051, 49376.25935611041, 53335.733321333144, 54897.725511373785, 13752.243626600633, 13816.378262978391, 13871.167729936236, 14134.363953621905, 14137.717245655234, 14516.491922782652, 14959.92520037393, 15205.771913421086, 15470.071795692294, 15800.051996880224, 13927.721445571235, 14377.9281103598, 14744.705105897607, 14836.851631483547, 14897.627559311104, 12808.6797830055, 13216.405261763051, 13855.515056972958, 13927.23400212998, 14162.716745665235, 12856.357182141042, 13811.240381779098, 13843.0, 13850.307484625528, 13878.722425551634, 11298.887011130113, 11435.828462573234, 11534.365609891202, 11643.88356116428, 11851.881481185423, 11541.769164616828, 11740.823887641864, 12007.339596322287, 12104.713715578871, 12114.0], "value": 7509.720059235858, "unit": "score"}], "name": "dromaeo_css", "value": 7623.1044864794685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 113.0, 111.0, 112.0, 101.0, 110.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 159.0, 180.0, 134.0, 158.0, 160.0, 128.0, 196.0, 129.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 159.0, 160.0, 161.0, 162.0, 160.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 187.0, 77.0, 74.0, 77.0, 76.0, 156.0, 73.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 93.0, 93.0, 91.0, 139.0, 93.0, 92.0, 140.0], "value": 107.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 55.0, 56.0, 59.0, 56.0, 90.0, 53.0, 54.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 74.0, 75.0, 74.0, 74.0, 75.0, 76.0, 81.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 117.0, 115.0, 116.0, 124.0, 112.0, 129.0, 129.0, 127.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 162.0, 160.0, 159.0, 161.0, 160.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 69.0, 68.0, 66.0, 67.0, 67.0, 66.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1527.1999999999998, "alertThreshold": 2.0}]} 06:41:44 INFO - Return code: 0 06:41:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:44 ERROR - # TBPL SUCCESS # 06:41:44 INFO - Running post-action listener: _resource_record_post_action 06:41:44 INFO - Running post-run listener: _resource_record_post_run 06:41:45 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 684032; Write bytes: 258990080; Read time: 64; Write time: 245980 06:41:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17072128; Read time: 0; Write time: 15448 06:41:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 684032; Write bytes: 241917952; Read time: 64; Write time: 230532 06:41:45 INFO - Running post-run listener: _upload_blobber_files 06:41:45 INFO - Blob upload gear active. 06:41:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:41:46 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:41:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:47 INFO - (blobuploader) - INFO - Done attempting. 06:41:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:41:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:47 INFO - (blobuploader) - INFO - Done attempting. 06:41:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:47 INFO - Return code: 0 06:41:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aad68721f46dbb40fde90c33784c08179c61376e7b45db1cebe8a0244a25b1a8e492eda5545985dcaa9d074c8fa3393a27cd58742cb865b95f0292b726b4c11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34a21e60d3f7582781f74092f94a3dd38280cbcc9c0097cf5890a41a97bec5826fad3b6af55df97b12ba1c2333f84bece6b31e4d385f27f268b8b9e47ef5094a"} 06:41:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:47 INFO - Contents: 06:41:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aad68721f46dbb40fde90c33784c08179c61376e7b45db1cebe8a0244a25b1a8e492eda5545985dcaa9d074c8fa3393a27cd58742cb865b95f0292b726b4c11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34a21e60d3f7582781f74092f94a3dd38280cbcc9c0097cf5890a41a97bec5826fad3b6af55df97b12ba1c2333f84bece6b31e4d385f27f268b8b9e47ef5094a"} 06:41:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:47 INFO - Copying logs to upload dir... 06:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.991784 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-09 06:41:47.874817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:47.878116) ========= 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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 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/2aad68721f46dbb40fde90c33784c08179c61376e7b45db1cebe8a0244a25b1a8e492eda5545985dcaa9d074c8fa3393a27cd58742cb865b95f0292b726b4c11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34a21e60d3f7582781f74092f94a3dd38280cbcc9c0097cf5890a41a97bec5826fad3b6af55df97b12ba1c2333f84bece6b31e4d385f27f268b8b9e47ef5094a"} build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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/2aad68721f46dbb40fde90c33784c08179c61376e7b45db1cebe8a0244a25b1a8e492eda5545985dcaa9d074c8fa3393a27cd58742cb865b95f0292b726b4c11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34a21e60d3f7582781f74092f94a3dd38280cbcc9c0097cf5890a41a97bec5826fad3b6af55df97b12ba1c2333f84bece6b31e4d385f27f268b8b9e47ef5094a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:47.907447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:47.908048) ========= 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=1861a34ebfea852630dec091000001fa-1462800074.136103-1525843381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:47.991530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:47.992382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:47.993101) ========= ========= Total master_lag: 0.15 =========