builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1462800085.9 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:25.895297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:25.895707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:25.895975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:25.912201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:25.912466) ========= 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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:21:25-- 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% 43.2M=0s 2016-05-09 06:21:26 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:26.019634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:26.019943) ========= 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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:26.069105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:26.069455) ========= 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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:21:26,142 truncating revision to first 12 chars 2016-05-09 06:21:26,142 Setting DEBUG logging. 2016-05-09 06:21:26,142 attempt 1/10 2016-05-09 06:21:26,142 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:26,969 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.129214 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:27.272164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:27.272503) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:27.272884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:27.273140) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:27.527956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 06:21:27.528232) ========= /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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:27 INFO - MultiFileLogger online at 20160509 06:21:27 in /builds/slave/test 06:21:27 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:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:27 INFO - {'append_to_log': False, 06:21:27 INFO - 'base_work_dir': '/builds/slave/test', 06:21:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:21:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:27 INFO - 'branch': 'Mozilla-Aurora', 06:21:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:27 INFO - 'config_files': ('talos/linux_config.py',), 06:21:27 INFO - 'default_actions': ('clobber', 06:21:27 INFO - 'read-buildbot-config', 06:21:27 INFO - 'download-and-extract', 06:21:27 INFO - 'populate-webroot', 06:21:27 INFO - 'create-virtualenv', 06:21:27 INFO - 'install', 06:21:27 INFO - 'run-tests'), 06:21:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:27 INFO - 'download_minidump_stackwalk': True, 06:21:27 INFO - 'download_symbols': 'ondemand', 06:21:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:27 INFO - 'installer_path': 'installer.exe', 06:21:27 INFO - 'log_level': 'info', 06:21:27 INFO - 'log_name': 'talos', 06:21:27 INFO - 'log_to_console': True, 06:21:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:27 INFO - 'opt_config_files': (), 06:21:27 INFO - 'pip_index': False, 06:21:27 INFO - 'sps_profile': False, 06:21:27 INFO - 'sps_profile_interval': 0, 06:21:27 INFO - 'suite': 'dromaeojs-e10s', 06:21:27 INFO - 'system_bits': '32', 06:21:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:27 INFO - 'title': 'talos-linux64-ix-053', 06:21:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:27 INFO - 'use_talos_json': True, 06:21:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:27 INFO - 'work_dir': 'build'} 06:21:27 INFO - ##### 06:21:27 INFO - ##### Running clobber step. 06:21:27 INFO - ##### 06:21:27 INFO - Running pre-action listener: _resource_record_pre_action 06:21:27 INFO - Running main action method: clobber 06:21:27 INFO - rmtree: /builds/slave/test/build 06:21:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:28 INFO - Running post-action listener: _resource_record_post_action 06:21:28 INFO - ##### 06:21:28 INFO - ##### Running read-buildbot-config step. 06:21:28 INFO - ##### 06:21:28 INFO - Running pre-action listener: _resource_record_pre_action 06:21:28 INFO - Running main action method: read_buildbot_config 06:21:28 INFO - Using buildbot properties: 06:21:28 INFO - { 06:21:28 INFO - "project": "", 06:21:28 INFO - "product": "firefox", 06:21:28 INFO - "script_repo_revision": "production", 06:21:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:21:28 INFO - "repository": "", 06:21:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:21:28 INFO - "buildid": "20160509005049", 06:21:28 INFO - "pgo_build": "True", 06:21:28 INFO - "basedir": "/builds/slave/test", 06:21:28 INFO - "buildnumber": 302, 06:21:28 INFO - "slavename": "talos-linux64-ix-053", 06:21:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:21:28 INFO - "platform": "ubuntu64_hw", 06:21:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:21:28 INFO - "branch": "mozilla-aurora", 06:21:28 INFO - "repo_path": "releases/mozilla-aurora", 06:21:28 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 06:21:28 INFO - "stage_platform": "linux64-pgo", 06:21:28 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 06:21:28 INFO - "slavebuilddir": "test" 06:21:28 INFO - } 06:21:28 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:28 INFO - Running post-action listener: _resource_record_post_action 06:21:28 INFO - ##### 06:21:28 INFO - ##### Running download-and-extract step. 06:21:28 INFO - ##### 06:21:28 INFO - Running pre-action listener: _resource_record_pre_action 06:21:28 INFO - Running main action method: download_and_extract 06:21:28 INFO - mkdir: /builds/slave/test/build/tests 06:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:28 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:28 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:28 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:28 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:28 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:29 INFO - Downloaded 1361 bytes. 06:21:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:29 INFO - Using the following test package requirements: 06:21:29 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:29 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:29 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:21:29 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'jsshell-linux-x86_64.zip'], 06:21:29 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:29 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:29 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:21:29 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:21:29 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:29 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:29 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21:29 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:29 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:29 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:29 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:29 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:29 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:30 INFO - Downloaded 23798585 bytes. 06:21:30 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:30 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:31 INFO - Return code: 0 06:21:31 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: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 - 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:31 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:31 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:31 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:31 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:33 INFO - Downloaded 23798585 bytes. 06:21:33 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:33 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:34 INFO - Return code: 0 06:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 10840145 bytes. 06:21:35 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:35 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:35 INFO - Return code: 0 06:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:35 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:35 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:35 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:35 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:35 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:36 INFO - Downloaded 62704189 bytes. 06:21:36 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:36 INFO - mkdir: /builds/slave/test/properties 06:21:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:36 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:36 INFO - Contents: 06:21:36 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:37 INFO - Running post-action listener: _resource_record_post_action 06:21:37 INFO - Running post-action listener: set_extra_try_arguments 06:21:37 INFO - ##### 06:21:37 INFO - ##### Running populate-webroot step. 06:21:37 INFO - ##### 06:21:37 INFO - Running pre-action listener: _resource_record_pre_action 06:21:37 INFO - Running main action method: populate_webroot 06:21:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:37 INFO - '--tppagecycles', 06:21:37 INFO - '7'], 06:21:37 INFO - 'tests': ['tsvgm']}}, 06:21:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['damp', 'tps']}, 06:21:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'tests': ['damp', 'tps']}, 06:21:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['dromaeo_dom']}, 06:21:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['a11yr', 06:21:37 INFO - 'ts_paint', 06:21:37 INFO - 'tpaint', 06:21:37 INFO - 'sessionrestore', 06:21:37 INFO - 'sessionrestore_no_auto_restore', 06:21:37 INFO - 'tabpaint']}, 06:21:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['tsvgx', 06:21:37 INFO - 'tsvgr_opacity', 06:21:37 INFO - 'tart', 06:21:37 INFO - 'tscrollx', 06:21:37 INFO - 'cart']}, 06:21:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:37 INFO - 'tsvgr_opacity', 06:21:37 INFO - 'tart', 06:21:37 INFO - 'tscrollx', 06:21:37 INFO - 'cart']}, 06:21:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'talos_options': ['--disable-e10s'], 06:21:37 INFO - 'tests': ['tp5o']}, 06:21:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'tests': ['tp5o']}, 06:21:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'talos_options': ['--disable-e10s', 06:21:37 INFO - '--xperf_path', 06:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:37 INFO - 'tests': ['tp5n']}, 06:21:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:37 INFO - 'talos_options': ['--xperf_path', 06:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:37 INFO - 'tests': ['tp5n']}}, 06:21:37 INFO - 'talos.zip': {'path': '', 06:21:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:37 INFO - Running post-action listener: _resource_record_post_action 06:21:37 INFO - ##### 06:21:37 INFO - ##### Running create-virtualenv step. 06:21:37 INFO - ##### 06:21:37 INFO - Running pre-action listener: _resource_record_pre_action 06:21:37 INFO - Running main action method: create_virtualenv 06:21:37 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:37 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:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:37 INFO - Using real prefix '/usr' 06:21:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:38 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:40 INFO - Installing pip.................done. 06:21:40 INFO - Return code: 0 06:21:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 06:21:40 INFO - 'HOME': '/home/cltbld', 06:21:40 INFO - 'LANG': 'en_US.UTF-8', 06:21:40 INFO - 'LANGUAGE': 'en_US:en', 06:21:40 INFO - 'LOGNAME': 'cltbld', 06:21:40 INFO - 'MAIL': '/var/mail/cltbld', 06:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:40 INFO - 'MOZ_NO_REMOTE': '1', 06:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:40 INFO - 'NO_EM_RESTART': '1', 06:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:40 INFO - 'PWD': '/builds/slave/test', 06:21:40 INFO - 'SHELL': '/bin/bash', 06:21:40 INFO - 'SHLVL': '1', 06:21:40 INFO - 'TERM': 'linux', 06:21:40 INFO - 'TMOUT': '86400', 06:21:40 INFO - 'USER': 'cltbld', 06:21:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:40 INFO - '_': '/tools/buildbot/bin/python'} 06:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:40 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:40 INFO - Cleaning up... 06:21:40 INFO - Return code: 0 06:21:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 06:21:40 INFO - 'HOME': '/home/cltbld', 06:21:40 INFO - 'LANG': 'en_US.UTF-8', 06:21:40 INFO - 'LANGUAGE': 'en_US:en', 06:21:40 INFO - 'LOGNAME': 'cltbld', 06:21:40 INFO - 'MAIL': '/var/mail/cltbld', 06:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:40 INFO - 'MOZ_NO_REMOTE': '1', 06:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:40 INFO - 'NO_EM_RESTART': '1', 06:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:40 INFO - 'PWD': '/builds/slave/test', 06:21:40 INFO - 'SHELL': '/bin/bash', 06:21:40 INFO - 'SHLVL': '1', 06:21:40 INFO - 'TERM': 'linux', 06:21:40 INFO - 'TMOUT': '86400', 06:21:40 INFO - 'USER': 'cltbld', 06:21:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:40 INFO - '_': '/tools/buildbot/bin/python'} 06:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:40 INFO - Downloading/unpacking psutil>=0.7.1 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:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:42 INFO - Installing collected packages: psutil 06:21:42 INFO - Running setup.py install for psutil 06:21:42 INFO - building 'psutil._psutil_linux' extension 06:21:42 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:42 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:42 INFO - building 'psutil._psutil_posix' extension 06:21:42 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:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:21:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:43 INFO - Successfully installed psutil 06:21:43 INFO - Cleaning up... 06:21:43 INFO - Return code: 0 06:21:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:43 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 06:21:43 INFO - 'HOME': '/home/cltbld', 06:21:43 INFO - 'LANG': 'en_US.UTF-8', 06:21:43 INFO - 'LANGUAGE': 'en_US:en', 06:21:43 INFO - 'LOGNAME': 'cltbld', 06:21:43 INFO - 'MAIL': '/var/mail/cltbld', 06:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:43 INFO - 'MOZ_NO_REMOTE': '1', 06:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:43 INFO - 'NO_EM_RESTART': '1', 06:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:43 INFO - 'PWD': '/builds/slave/test', 06:21:43 INFO - 'SHELL': '/bin/bash', 06:21:43 INFO - 'SHLVL': '1', 06:21:43 INFO - 'TERM': 'linux', 06:21:43 INFO - 'TMOUT': '86400', 06:21:43 INFO - 'USER': 'cltbld', 06:21:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:43 INFO - '_': '/tools/buildbot/bin/python'} 06:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:21:45 INFO - Installing collected packages: mozsystemmonitor 06:21:45 INFO - Running setup.py install for mozsystemmonitor 06:21:45 INFO - Successfully installed mozsystemmonitor 06:21:45 INFO - Cleaning up... 06:21:45 INFO - Return code: 0 06:21:45 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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', '--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:45 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: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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 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 - Downloading/unpacking blobuploader==1.2.4 06:21:45 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:45 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:45 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:45 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:45 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:45 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:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:48 INFO - Downloading docopt-0.6.1.tar.gz 06:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:48 INFO - Running setup.py install for blobuploader 06:21:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:48 INFO - Running setup.py install for requests 06:21:48 INFO - Running setup.py install for docopt 06:21:48 INFO - Successfully installed blobuploader requests docopt 06:21:48 INFO - Cleaning up... 06:21:48 INFO - Return code: 0 06:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:48 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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:48 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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:48 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 06:21:48 INFO - 'HOME': '/home/cltbld', 06:21:48 INFO - 'LANG': 'en_US.UTF-8', 06:21:48 INFO - 'LANGUAGE': 'en_US:en', 06:21:48 INFO - 'LOGNAME': 'cltbld', 06:21:48 INFO - 'MAIL': '/var/mail/cltbld', 06:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:48 INFO - 'MOZ_NO_REMOTE': '1', 06:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:48 INFO - 'NO_EM_RESTART': '1', 06:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:48 INFO - 'PWD': '/builds/slave/test', 06:21:48 INFO - 'SHELL': '/bin/bash', 06:21:48 INFO - 'SHLVL': '1', 06:21:48 INFO - 'TERM': 'linux', 06:21:48 INFO - 'TMOUT': '86400', 06:21:48 INFO - 'USER': 'cltbld', 06:21:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:48 INFO - '_': '/tools/buildbot/bin/python'} 06:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:49 INFO - Running setup.py (path:/tmp/pip-DqsWRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:49 INFO - Running setup.py (path:/tmp/pip-KjeGZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:49 INFO - Running setup.py (path:/tmp/pip-At0zTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:49 INFO - Running setup.py (path:/tmp/pip-wORr8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:49 INFO - Running setup.py (path:/tmp/pip-9EbyGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:49 INFO - Running setup.py (path:/tmp/pip-qgq3Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:49 INFO - Running setup.py (path:/tmp/pip-gUYHha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:49 INFO - Running setup.py (path:/tmp/pip-S1vBzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:49 INFO - Running setup.py (path:/tmp/pip-ENqhuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:49 INFO - Running setup.py (path:/tmp/pip-6KzMRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:49 INFO - Running setup.py (path:/tmp/pip-TEQJoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:49 INFO - Running setup.py (path:/tmp/pip-NeAjlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:50 INFO - Running setup.py (path:/tmp/pip-NZzWln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:50 INFO - Running setup.py (path:/tmp/pip-PnPK90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:50 INFO - Running setup.py (path:/tmp/pip-U_M9ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:50 INFO - Running setup.py (path:/tmp/pip-Qe_UDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:50 INFO - Running setup.py (path:/tmp/pip-PxsUyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:50 INFO - Running setup.py install for manifestparser 06:21:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozcrash 06:21:50 INFO - Running setup.py install for mozdebug 06:21:50 INFO - Running setup.py install for mozdevice 06:21:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:50 INFO - Running setup.py install for mozfile 06:21:50 INFO - Running setup.py install for mozhttpd 06:21:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozinfo 06:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozInstall 06:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozleak 06:21:51 INFO - Running setup.py install for mozlog 06:21:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for moznetwork 06:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozprocess 06:21:51 INFO - Running setup.py install for mozprofile 06:21:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozrunner 06:21:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:51 INFO - Running setup.py install for mozscreenshot 06:21:51 INFO - Running setup.py install for moztest 06:21:52 INFO - Running setup.py install for mozversion 06:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:52 INFO - Cleaning up... 06:21:52 INFO - Return code: 0 06:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:52 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 06:21:52 INFO - 'HOME': '/home/cltbld', 06:21:52 INFO - 'LANG': 'en_US.UTF-8', 06:21:52 INFO - 'LANGUAGE': 'en_US:en', 06:21:52 INFO - 'LOGNAME': 'cltbld', 06:21:52 INFO - 'MAIL': '/var/mail/cltbld', 06:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:52 INFO - 'MOZ_NO_REMOTE': '1', 06:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:52 INFO - 'NO_EM_RESTART': '1', 06:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:52 INFO - 'PWD': '/builds/slave/test', 06:21:52 INFO - 'SHELL': '/bin/bash', 06:21:52 INFO - 'SHLVL': '1', 06:21:52 INFO - 'TERM': 'linux', 06:21:52 INFO - 'TMOUT': '86400', 06:21:52 INFO - 'USER': 'cltbld', 06:21:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:52 INFO - '_': '/tools/buildbot/bin/python'} 06:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 INFO - Running setup.py (path:/tmp/pip-JOm9Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 INFO - Running setup.py (path:/tmp/pip-y3yZAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 INFO - Running setup.py (path:/tmp/pip-t98YZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:52 INFO - Running setup.py (path:/tmp/pip-FxlhmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:52 INFO - Running setup.py (path:/tmp/pip-ykk_3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:52 INFO - Running setup.py (path:/tmp/pip-sbndNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:52 INFO - Running setup.py (path:/tmp/pip-djiVNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:52 INFO - Running setup.py (path:/tmp/pip-NdOErk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:52 INFO - Running setup.py (path:/tmp/pip-lPnNJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:53 INFO - Running setup.py (path:/tmp/pip-cTEPnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 INFO - Running setup.py (path:/tmp/pip-PNACtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 INFO - Running setup.py (path:/tmp/pip-RnCh24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 INFO - Running setup.py (path:/tmp/pip-v6iDDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 INFO - Running setup.py (path:/tmp/pip-iwq0It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 INFO - Running setup.py (path:/tmp/pip-h1GtqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:53 INFO - Running setup.py (path:/tmp/pip-AfV61Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:53 INFO - Running setup.py (path:/tmp/pip-blPAk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:55 INFO - Downloading blessings-1.6.tar.gz 06:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:55 INFO - Installing collected packages: blessings 06:21:55 INFO - Running setup.py install for blessings 06:21:55 INFO - Successfully installed blessings 06:21:55 INFO - Cleaning up... 06:21:55 INFO - Return code: 0 06:21:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:55 INFO - Reading from file tmpfile_stdout 06:21:55 INFO - Current package versions: 06:21:55 INFO - argparse == 1.2.1 06:21:55 INFO - blessings == 1.6 06:21:55 INFO - blobuploader == 1.2.4 06:21:55 INFO - docopt == 0.6.1 06:21:55 INFO - manifestparser == 1.1 06:21:55 INFO - mozInstall == 1.12 06:21:55 INFO - mozcrash == 0.17 06:21:55 INFO - mozdebug == 0.1 06:21:55 INFO - mozdevice == 0.48 06:21:55 INFO - mozfile == 1.2 06:21:55 INFO - mozhttpd == 0.7 06:21:55 INFO - mozinfo == 0.9 06:21:55 INFO - mozleak == 0.1 06:21:55 INFO - mozlog == 3.1 06:21:55 INFO - moznetwork == 0.27 06:21:55 INFO - mozprocess == 0.22 06:21:55 INFO - mozprofile == 0.28 06:21:55 INFO - mozrunner == 6.11 06:21:55 INFO - mozscreenshot == 0.1 06:21:55 INFO - mozsystemmonitor == 0.0 06:21:55 INFO - moztest == 0.7 06:21:55 INFO - mozversion == 1.4 06:21:55 INFO - psutil == 3.1.1 06:21:55 INFO - requests == 1.2.3 06:21:55 INFO - wsgiref == 0.1.2 06:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:55 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 06:21:55 INFO - 'HOME': '/home/cltbld', 06:21:55 INFO - 'LANG': 'en_US.UTF-8', 06:21:55 INFO - 'LANGUAGE': 'en_US:en', 06:21:55 INFO - 'LOGNAME': 'cltbld', 06:21:55 INFO - 'MAIL': '/var/mail/cltbld', 06:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:55 INFO - 'MOZ_NO_REMOTE': '1', 06:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:55 INFO - 'NO_EM_RESTART': '1', 06:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:55 INFO - 'PWD': '/builds/slave/test', 06:21:55 INFO - 'SHELL': '/bin/bash', 06:21:55 INFO - 'SHLVL': '1', 06:21:55 INFO - 'TERM': 'linux', 06:21:55 INFO - 'TMOUT': '86400', 06:21:55 INFO - 'USER': 'cltbld', 06:21:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:55 INFO - '_': '/tools/buildbot/bin/python'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 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:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:56 INFO - Cleaning up... 06:21:56 INFO - Return code: 0 06:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:56 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 06:21:56 INFO - 'HOME': '/home/cltbld', 06:21:56 INFO - 'LANG': 'en_US.UTF-8', 06:21:56 INFO - 'LANGUAGE': 'en_US:en', 06:21:56 INFO - 'LOGNAME': 'cltbld', 06:21:56 INFO - 'MAIL': '/var/mail/cltbld', 06:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:56 INFO - 'MOZ_NO_REMOTE': '1', 06:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:56 INFO - 'NO_EM_RESTART': '1', 06:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:56 INFO - 'PWD': '/builds/slave/test', 06:21:56 INFO - 'SHELL': '/bin/bash', 06:21:56 INFO - 'SHLVL': '1', 06:21:56 INFO - 'TERM': 'linux', 06:21:56 INFO - 'TMOUT': '86400', 06:21:56 INFO - 'USER': 'cltbld', 06:21:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:56 INFO - '_': '/tools/buildbot/bin/python'} 06:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:56 INFO - Downloading/unpacking jsonschema 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:58 INFO - Downloading/unpacking functools32 (from jsonschema) 06:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:58 INFO - warning: no files found matching '*.txt' 06:21:58 INFO - no previously-included directories found matching 'build' 06:21:58 INFO - no previously-included directories found matching 'dist' 06:21:58 INFO - no previously-included directories found matching '.git*' 06:21:58 INFO - Installing collected packages: jsonschema, functools32 06:21:58 INFO - Running setup.py install for functools32 06:21:58 INFO - warning: no files found matching '*.txt' 06:21:58 INFO - no previously-included directories found matching 'build' 06:21:58 INFO - no previously-included directories found matching 'dist' 06:21:58 INFO - no previously-included directories found matching '.git*' 06:21:58 INFO - Successfully installed jsonschema functools32 06:21:58 INFO - Cleaning up... 06:21:58 INFO - Return code: 0 06:21:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:58 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 0x7f3a0df46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29497d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, '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': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 06:21:58 INFO - 'HOME': '/home/cltbld', 06:21:58 INFO - 'LANG': 'en_US.UTF-8', 06:21:58 INFO - 'LANGUAGE': 'en_US:en', 06:21:58 INFO - 'LOGNAME': 'cltbld', 06:21:58 INFO - 'MAIL': '/var/mail/cltbld', 06:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:58 INFO - 'MOZ_NO_REMOTE': '1', 06:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:58 INFO - 'NO_EM_RESTART': '1', 06:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:58 INFO - 'PWD': '/builds/slave/test', 06:21:58 INFO - 'SHELL': '/bin/bash', 06:21:58 INFO - 'SHLVL': '1', 06:21:58 INFO - 'TERM': 'linux', 06:21:58 INFO - 'TMOUT': '86400', 06:21:58 INFO - 'USER': 'cltbld', 06:21:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:58 INFO - '_': '/tools/buildbot/bin/python'} 06:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:58 INFO - Downloading/unpacking flake8 06:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:22:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:22:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:01 INFO - no previously-included directories found matching 'docs/_build' 06:22:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:22:01 INFO - Running setup.py install for pep8 06:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:22:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:22:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:22:01 INFO - no previously-included directories found matching 'docs/_build' 06:22:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:22:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:22:01 INFO - Cleaning up... 06:22:01 INFO - Return code: 0 06:22:01 INFO - Running post-action listener: _resource_record_post_action 06:22:01 INFO - Running post-action listener: _start_resource_monitoring 06:22:01 INFO - Starting resource monitoring. 06:22:01 INFO - ##### 06:22:01 INFO - ##### Running install step. 06:22:01 INFO - ##### 06:22:01 INFO - Running pre-action listener: _resource_record_pre_action 06:22:01 INFO - Running main action method: install 06:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:02 INFO - Reading from file tmpfile_stdout 06:22:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:22:02 INFO - Reading from file tmpfile_stdout 06:22:02 INFO - Output received: 06:22:02 INFO - Usage: mozinstall [options] installer 06:22:02 INFO - Options: 06:22:02 INFO - -h, --help show this help message and exit 06:22:02 INFO - -d DEST, --destination=DEST 06:22:02 INFO - Directory to install application into. [default: 06:22:02 INFO - "/builds/slave/test"] 06:22:02 INFO - --app=APP Application being installed. [default: firefox] 06:22:02 INFO - mkdir: /builds/slave/test/build/application 06:22:02 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:22:02 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:17 INFO - Reading from file tmpfile_stdout 06:22:17 INFO - Output received: 06:22:17 INFO - /builds/slave/test/build/application/firefox/firefox 06:22:17 INFO - Running post-action listener: _resource_record_post_action 06:22:17 INFO - ##### 06:22:17 INFO - ##### Running run-tests step. 06:22:17 INFO - ##### 06:22:17 INFO - Running pre-action listener: _resource_record_pre_action 06:22:17 INFO - Running main action method: run_tests 06:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:17 INFO - Python 2.7.3 06:22:17 INFO - Return code: 0 06:22:17 INFO - grabbing minidump binary from tooltool 06:22: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:22:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8640>, '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 0x29d9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d99d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:22:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:22:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:17 INFO - Return code: 0 06:22:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:22:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:22:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:18 INFO - Return code: 0 06:22:18 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-053', '--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:18 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-053 --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:18 INFO - Using env: {'DISPLAY': ':0', 06:22:18 INFO - 'HOME': '/home/cltbld', 06:22:18 INFO - 'LANG': 'en_US.UTF-8', 06:22:18 INFO - 'LANGUAGE': 'en_US:en', 06:22:18 INFO - 'LOGNAME': 'cltbld', 06:22:18 INFO - 'MAIL': '/var/mail/cltbld', 06:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:18 INFO - 'MOZ_NO_REMOTE': '1', 06:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:18 INFO - 'NO_EM_RESTART': '1', 06:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:18 INFO - 'PWD': '/builds/slave/test', 06:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:18 INFO - 'SHELL': '/bin/bash', 06:22:18 INFO - 'SHLVL': '1', 06:22:18 INFO - 'TERM': 'linux', 06:22:18 INFO - 'TMOUT': '86400', 06:22:18 INFO - 'USER': 'cltbld', 06:22:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172', 06:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:18 INFO - '_': '/tools/buildbot/bin/python'} 06:22:18 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-053', '--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:18 INFO - mozversion application_buildid: 20160509005049 06:22:18 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:18 INFO - mozversion application_name: Firefox 06:22:18 INFO - mozversion application_remotingname: firefox-dev 06:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:18 INFO - mozversion application_vendor: Mozilla 06:22:18 INFO - mozversion application_version: 48.0a2 06:22:18 INFO - mozversion platform_buildid: 20160509005049 06:22:18 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:18 INFO - mozversion platform_version: 48.0a2 06:22:18 INFO - using testdate: 1462800138 06:22:18 INFO - actual date: 1462800138 06:22:18 INFO - starting webserver on 'localhost:36470' 06:22:18 INFO - SUITE-START | Running 2 tests 06:22:18 INFO - TEST-START | dromaeo_css 06:22:18 INFO - operating with platform_type : linux_ 06:22:18 INFO - Initialising browser for dromaeo_css test... 06:22:18 INFO - TEST-INFO | started process 28480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXrSstn/profile http://localhost:36470/getInfo.html) 06:22:22 INFO - PROCESS | 28480 | 06:22:22 INFO - PROCESS | 28480 | (process:28559): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:22:23 INFO - PROCESS | 28480 | __metrics Screen width/height:1600/1200 06:22:23 INFO - PROCESS | 28480 | colorDepth:24 06:22:23 INFO - PROCESS | 28480 | Browser inner width/height: 1024/697 06:22:23 INFO - PROCESS | 28480 | __metrics 06:22:24 ERROR - PROCESS | 28480 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:22:25 INFO - TEST-INFO | 28480: exit 0 06:22:25 INFO - Browser initialized. 06:22:25 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:25 INFO - TEST-INFO | started process 28610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXrSstn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:26 INFO - PROCESS | 28610 | 06:22:26 INFO - PROCESS | 28610 | (process:28678): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:22:36 INFO - PROCESS | 28610 | RSS: Main: 152236032 06:22:36 INFO - PROCESS | 28610 | 06:23:26 INFO - PROCESS | 28610 | 1462800206442 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:34 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36470/tests/dromaeo/cssquery-ext.html) 06:25:35 INFO - PROCESS | 28610 | RSS: Main: 155414528 06:25:35 INFO - PROCESS | 28610 | 06:28:37 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-ext.html (next: http://localhost:36470/tests/dromaeo/cssquery-jquery.html) 06:28:37 INFO - PROCESS | 28610 | RSS: Main: 153600000 06:28:37 INFO - PROCESS | 28610 | 06:31:39 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36470/tests/dromaeo/cssquery-mootools.html) 06:31:40 INFO - PROCESS | 28610 | RSS: Main: 153268224 06:31:40 INFO - PROCESS | 28610 | 06:34:41 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36470/tests/dromaeo/cssquery-prototype.html) 06:34:42 INFO - PROCESS | 28610 | RSS: Main: 152571904 06:34:42 INFO - PROCESS | 28610 | 06:37:44 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36470/tests/dromaeo/cssquery-yui.html) 06:37:45 INFO - PROCESS | 28610 | RSS: Main: 154226688 06:37:45 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-yui.html (next: http://localhost:36470/tests/dromaeo/cssquery-dojo.html) 06:40:47 INFO - PROCESS | 28610 | RSS: Main: 156004352 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | __start_tp_report 06:40:47 INFO - PROCESS | 28610 | _x_x_mozilla_page_load 06:40:47 INFO - PROCESS | 28610 | _x_x_mozilla_page_load_details 06:40:47 INFO - PROCESS | 28610 | |i|pagename|runs| 06:40:47 INFO - PROCESS | 28610 | |0;dojo.html;3403.7277017838574;3454.2573346730446;3458.9135271618206;3488.4418493041103;3495.1786330212394;5736.827895163146;5737.3688894221605;5741.2536370271855;5765.1928729977835;5769.971150144253;5762.827115186541;5772.278465191851;5782.566307526931;5786.508146807516;5802.332731735852;5226.451222621627;5266.92099618506;5317.441668624797;5317.787288508455;5395.487428694268;5153.227015947619;5251.816186433475;5412.83761487156;5434.483724046209;5436.537894278971;5225.216217567377;5233.790648374061;5261.815836445725;5331.973340133294;5350.625456218067;5005.1491246488185;5129.230615407681;5132;5134.691918484866;5221.39953905302;5061.848144555669;5152.92270615941;5159.509846564571;5162.347229783381;5189.455107213764;5433.402325744165;5459.344878614552;5474.37044739856;5509.256250406184;5584.832455026356;6046.909296360558;6051.455369016766;6060.3939606039485;6062.363451837582;6094.756209751605;6079.118527813486;6092.634441933498;6095.847603809896;6098.695065246764;6115.816525504242;5635.154726790973;5647.604667673265;5690.459406356389;5710.229119068914;5733.655980641175;6128.1114238435175;6184.845378865474;6186.226721659793;6190.566660333823;6195.349488303754;5899;5909.261342332208;5938.346781853993;5958.582899197015;5960.970195148997;5818.069108942549;6132.540059495555;6169.907451388232;6204.13142160098;6209.9379006210265;6007.429294217042;6009;6027.758889644453;6061.181740464981;6077.058056001327;5929.110633404937;6018.037114061729;6023.096535519707;6033.698315084228;6037.78867739627;4577.954220457819;4596.862094137181;4602.263637817933;4611.054733779567;4623.352730617717;4089.3457046872954;4102.753834769924;4103.261412945699;4115.444415003996;4131.049858532554;5795.855103622359;5827.892700386913;5838.4453476919625;5850.619709718854;5891.204687367236;6061.424164704346;6122.428649698713;6143.047827586731;6200.906986395207;6230.937690623126;5967.343592204854;5976.312724036705;5978.970105149447;5986.910196347058;5990.191324171268;5109.8722531937;5186.144286192736;5297.5232229099565;5301.5493683037375;5312.335958005249;6255.655938923312;6298.7480500780375;6327.683615819191;6330.525210609223;6344.555881088372;6137.508999280136;6174.135621013152;6179.351168127282;6184.752609895734;6186.350433204449;6113.354685976905;6165.321814600301;6236.282827474898;6329.398707122816;6340.714667839866;6016.789412370546;6115.113308570143;6116.785912493041;6125.234345706786;6125.234345706786;6168.982117950488;6178.752849886134;6184.969075154595;6185.969070154621;6209.937900620936;5886.764529418947;6018.849528761816;6031.788887388921;6040.09398590215;6069.484093852072;5989.071693887455;6012.248468941382;6024.759009639565;6037.818865434044;6040.7583696651645;5913.940860591339;5935.258092738408;5937;5967.612105213321;5969.044952807703;5939.613925094855;6042.486388657014;6095.542834287535;6116.140977845955;6140.201773769381;5927.081302398135;5935.465808077293;5943.673097979653;5950.583459157818;5974.1934838796205 06:40:47 INFO - PROCESS | 28610 | |1;ext.html;615.0436071908184;654.0483596367285;659.637199540253;666.7899611622339;699.1610067918499;39756;40501.79749101258;40537.18925621486;40695.186096278056;40697.593024069785;45001.324980125326;45869.54130458694;45982.310265345965;46079;46218.76890615542;8897.555122243893;9038.18656320931;9055.95472022639;9074.637014519445;9075.319351048665;8841.513716745576;8913.68802091927;8978.551072446384;8984;8988.505632190227;8942.239909607692;8990.595423205972;8990.820183596325;9002.54987250638;9007.549622518847;8891.422057566302;8926.910730892672;8928.37501374904;8956.373053886231;8992.8651070234;8762.737117886474;8815.867761983576;8859.291256699513;8939.865902011476;8946.64213431462;40705.38941915874;41113.1777364454;41152.38271425931;41216.58783412157;41341.79329103365;3861.8455261789495;3947.703922205846;3974.6224108709625;4180.686448516343;4292.785360731982;33917.49123763145;34827.30345393078;34832.47751283733;34998.82500587481;35704.64295357065;4592.357070010201;4626.167289887819;4637.39713837199;4650.51169627191;4653.674242803005;324234;325398;326200;326451;327393.9999999976;39748.20503589912;62943.6852815733;63327.68336158382;63377.36622633807;63425.68287158535;38681.22637547233;38810.417843732364;38896.8055159728;38943.805280973414;39105.21789564193;17402.47792566225;17480.82519174792;17523.38668146634;17525;17618.735718964224;14663.266836658124;14737.11577305365;14803.111813291236;14805.925970370079;14814.629634259014;9402.670906518239;9500.667476638284;9519.143277105093;9562.713118606453;9680.370775899544;2959.1418488638055;2996.4156989387297;3007.278253219212;3017.1551965449707;3040.331127152023;1081.6322450366913;1114.8773634900153;1135.9740008050235;1141.5890279499374;1200.9731679414149;33735.83132084324;34193;34227.82886085554;34259;34353.65646343504;1251.8122281657825;1264.5953294945714;1287.536486864728;1300.382318398772;1308.3981368570373;17473.21370538329;17551.47345579609;17619.38332158394;17708.645827083645;17915.820841791676;467767;501893;537152;543125;547168;61680.69159654173;62553.06170407448;63070;63178.684106579174;63217.683911581065;1510.8564686354998;1555.2845690982274;1562.0159299641152;1572.8584427401588;1614.5156453064035;34289.31421371608;34379;34530.30939381249;34776.30447390988;34892.30215395729;54107.18839217336;54319.18521222264;54345.18482222849;54580.72709636585;54849.45150548444;308220;312593;313354;313490;314281;26539;26906.865465672545;27067.323316917234;27105.915763369245;27134.592981104903;51987.48012519978;52079;52576.15983440714;52952.47047529475;53560.732196338766;42973.35539966966;43299.35050974301;43526;43602;44907.326390103524;42910.57089429191;43150.35274470822;43236.88053163185;43371.13257734891;43785.34321985109;44429.55570444383;44697.55302446934;45135.54864451445;45391.773041134584;45537.77231113823;36089.27821443609;36934.07664808401;37724.62275377321;38138.61861381351;38255;29762;30150.246243844078;30244.395112098075;30359.848200759738;30467 06:40:47 INFO - PROCESS | 28610 | |2;jquery.html;419.9685023623229;420.220490989215;433.34997503744404;435.7080755893551;436.1538615086732;18476.168572414255;19294.807051929478;19304.90347548264;19575.608487830235;20532.48668783281;12233.143679942408;12441.315727634976;12505.874941250584;21223.57552848946;22137.335879923587;6404.295527491972;6513.088167656532;6578.079068930354;6604.57070290432;6870.553414028072;6954.130733658293;7075.433965282791;7130.893036604455;7146.106736657918;7169.6773645186095;7521.511101778394;7543.622818859062;7571.810704732398;7594.430417718666;7599.088109426876;7047.295270472938;7163.498555101145;7200.783976480714;7531.736389226378;7538.962305188494;6925;6933.4106600938985;6956.026156338116;7019.754308599226;7031.50779445439;25947.740522594722;26005.69971501436;26253.868730656417;26365.73634263652;26808.195754127406;2704.148193319118;2820.0693771055708;2985.880564777406;3209.7753157279;3223.629282632504;15663.295151718201;16528.421505247257;16638.58403539909;16662.333506659717;17172.570685732833;2220.4226901005854;2222.4999375140624;2253.8873056347115;2304.1704986204954;2326.232343326698;70154;70732.67878836195;70872.64563677149;76548.61725691392;92130.53934730351;17165.82834171667;18541.258349666132;18542.165602547917;19051;19132.61734765297;35258.118547036014;35382;35518.467222991676;35657.64342356543;35808.28383432369;10386.42874641902;11478.081753459703;11493.597724079616;11528.423578821026;11625.18623696333;9834.409935403899;9880.950595246977;9920.355176913477;9952.850707239253;9961.35251208669;9609.942906280303;9613.423194608346;9619.759506012406;9628.378378378278;9776.729025226676;3662.908427289339;3700.2599480104086;3724.6275372462537;3905.668018218483;3928.46965659638;980.6077568972468;1078.82199437092;1114.765899161169;1178.128185142988;1209.3650833312581;18947.33684321042;19184.13671384791;19594.80405195958;19760;20195.697064544045;1029.4749677664445;1032.9603750440722;1072.420892717939;1109.173665619119;1110.6501452042742;10795.082417994401;10940.716190286263;11266.098712103012;11302.886971130183;11334;530783;534697;541611;553342;561608;86430.56784716163;86891.56554217188;87220.56389718138;88724.33826985201;99085;1137.2550979108696;1147.5065721739566;1167.11882528692;1191.8212268159846;1195.2589394575418;17788.199531021393;17886.5528361792;18087;18110.728339075187;18450.26198952027;25915.48169036571;26796.464070718866;34777.47833782445;39682.40476392799;41394;59400;61671;61703.38296617156;61792.38207617866;62254;8499.362547809063;8772.736817895218;8801.911980880366;8814.382993190415;8955.955220223857;12720.282761827035;13285.269310188032;13668.384922678304;14148.575542733735;14150.009499334948;11604.94197529007;11774.175807693378;11838.763224735629;11940.641780746591;12253.264804111783;12098.939505302416;12105;12170.39148042612;12194.878051219373;12509.43707533145;12121.878781212075;12306.261624302571;12342.259464432163;12409.255444672988;12626.053046021769;8924.955375223082;9005.81988360216;9124.817503649758;9143.725688229364;9383.436993780395;9031.683891063782;11709;11714.472848721998;11949.22330048544;12533.623991280276 06:40:47 INFO - PROCESS | 28610 | |3;mootools.html;1562.1095975294083;1599.704054749871;1750.7811523559556;1862.6181632765285;1886.5377982394316;7435.479516433852;7969.92030079699;8173;8366.121557236485;8380.580970951458;8310.25207731304;8478.025027121883;8522.829543409129;8530.87203691945;8555.401121921452;2386.9880650596724;2393.7606239376096;2406.927792166238;2417.190241269177;2420.1408499982517;2375.3467796355967;2392.7009123859516;2440.04838113136;2453.3498622864954;2456.238566044532;2407.939801504968;2413.8551686898754;2416.226807421626;2426.575349313872;2438.4879175373194;2321.6633588129625;2329.9184528541505;2340.648902664597;2340.6957095577636;2350.236173243694;2316.81465482761;2352.176738141654;2352.3060697094397;2355.328731311568;2366.408397900525;8376.664933402717;8404.705835295736;8410.579471026485;8427.536485493296;8442.451240669337;5167.844964651066;5286.180642000458;5288.2596436498925;5322.893542129135;5323.733813309319;3511.771734837253;3539.150603855082;3589.4795254687924;3712.1462063725226;3713.1088538750773;1244.819501172334;1265.5507294910358;1267.974640507194;1310.4365122997108;2192.123150739701;10392.948035259851;10588.735281617945;10609.522571484302;10615.097716694014;10650.573977040987;4324.13517296542;4385.596609085126;4403.405540252089;4443.37792709021;4465.285554311295;9235.399699019677;9242.3530352876;9244.3528952974;9279.67521136757;9291.58187881547;5137.229415587692;5137.8715532112;5143.074246635641;5165.48345165488;5170.586353091744;4336.262835318003;4685.4143232095985;4748.976255118702;4780.976095119502;4894.779734911937;3794.4118661607495;3797.2025874566098;3854.4218367244575;3858.112634094174;3884.2037382336553;1161.5992482593492;1164.6273192578294;1174.8061569841052;1180.864200616923;1193.3376975778526;928.1785619726455;1027.7944411117805;1032.3805716570148;1037.2428127466992;1051.4112097225577;5612.747426365823;5624.606277560613;5654.971725141348;5850.795222167204;5902.144189092557;963.1379914976197;1038.3873514626407;1049.3913530152493;1061.2783307351076;1082.976587125159;4042.6967977401814;4076.8369265229653;4084.326086195804;4172.4993000840095;4176.686748493815;9818.852717209247;10015;10040.548175332127;10145.594176233015;10159.085682288629;9975.351602145838;10023.899761002442;10031.097201251776;10039.498025098716;10040.79918401628;7863.882041769378;7878.645460954271;8010.879836802453;8120.512769233865;8155.306798922039;5718.914216286676;5768.798092066758;5779.97110014464;5834.795782147605;5906.055031194988;8823.558822058743;8978.281737461119;9085.863712044193;9185.035571264922;9214.861777073484;9053.547322633975;9123.726288211365;9252.583633736363;9281.67514137002;9372.67195648149;6443.7744678936015;7012.5792452453015;7041;7201.3518783309755;7275.272472752682;7855.5286682799215;7862;7884.605769711607;7904.13054564009;7943.880841787493;7001.684924178322;7212.531185472927;7245.5652660840515;7255.238199989136;7361.668724907499;7089.64551772399;7119.2524784898915;7124.715011399486;7198.89201661965;7234.74678386254;6419.518536109717;6589.0116482528;6607;6615.04081908111;6631.900521492085;4786.784594693317;4888.828890988941;4917.655764096479;4930.13722598551;4979.178435558092;4594.2419500783335;4625.861224163281;4666.0901124280435;4691.179043667413;4707.176244157327 06:40:47 INFO - PROCESS | 28610 | |4;prototype.html;353.318096074576;361.97466177367585;362.1182420805338;362.6717820372563;369.2209438085641;6410.262819775728;6663.833404164899;6681.19825620925;6696.799096027121;6781.52529322947;6653.900191497131;6665.866682666344;6676.799696009128;6687.465002799777;6695.263521012685;5120.999999999991;5129.461406552315;5134.897302053957;5140;5150.1759718445055;5151.536361727443;5166.095933211692;5166.767495462713;5171.534561889429;5172.508611681884;5113.258577506278;5122.487751224885;5123.359580052494;5126.948730512703;5127.743612819363;5022.698638081727;5101.770420331057;5104.64267501275;5113.130767769489;5129.1536896412235;4439.75581343026;4460.665450091256;4477.082198149405;4491.348754430622;4508.413906192174;6407.935920640781;6409.134766806468;6412.679366031726;6413.422791948747;6428.550001499897;5933.525317974551;5937.109433584997;5939.1388248704125;5943.3165186003735;5945.405459454063;7012.614306213156;7061.646917654097;7063.540869843444;7064.43484521237;7072.115985501812;4563.520830312803;4724.4330680318235;4732.668713190078;4976.253561965698;4977.825776097856;7193.8201544961275;7296.37980771635;7351.669174887143;7366.815829604249;7381.446391520657;4892.363992680928;4896.167651499253;4896.436909755353;4905.754712264373;4906.58294045003;4952.207646776498;4955.801767929314;4956.553910148104;4958.033183529249;4973.975130124326;5768.682722450221;5786.594938354275;5786.971065144648;5788.102844059177;5800.738966746507;6877.759278425231;7047.365737083687;7062.858742825218;7071.823204419828;7094.574325540484;1729.9135043247786;1737.218251786701;1747.2661482177516;1753.1146770880623;1754.0791084680645;1116.4473585575192;1122.5453691255054;1131.9547218111184;1148.1618418554501;1151.1021403305435;6719.328067193242;6780.898286525706;6858.451323894076;6899.379055884994;6927.099477067949;7216.170140433812;7252.927470725331;7253.1296244451005;7260.891086633705;7270.890936635955;6800.353966373186;6812.080369150101;6813.080234168423;6827.590344579341;6835.624040677811;3854.845806167722;3861.7489863158803;3933.0757272041046;3933.7639741615594;3934.5081864766903;7477.36442402391;7486.513376630502;7488.438367122488;7498.212687667826;7500.174980752113;7231.746888858865;7296.635168241567;7314.780556583311;7326.267373262738;7346.1551921528635;7386;7390.96304518474;7393.371563417062;7461.291177338144;7490.1386340571535;7126.465515086285;7173.10336207974;7191.640417978975;7204.279572042963;7218.458615603746;7191.065161528968;7235.023271858232;7246.746363877239;7255.891161632685;7275.199728030018;7601.885971710318;7628.084629844232;7677.808054798451;7682.116556596063;7683.692652293846;4814.855554333376;4908.042931628441;4912.1158191525865;4912.38595175603;4920.138975679313;7146;7337.963310183415;7354.926450735424;7358.11702595692;7368;7083.68123434457;7112.324329188718;7125.144982602121;7128.750493732695;7133.643317833984;7013.894791578233;7072.115985501812;7092.290770923073;7115.359617634438;7118.572885626879;6971.895421568782;6972.233054363915;6973.79078627642;6974.058502102354;6974.093367862349;6977.267386924503;7143.357097861218;7151.106111736033;7162.820929476805;7171.677274522764;6910.792676219721;7027.543209691354;7032.171635374737;7033.824154396181;7035.894461582978 06:40:47 INFO - PROCESS | 28610 | |5;yui.html;912.6258234124008;917.0416914324535;931.8741969834073;947.7962238118803;954.5179684259448;15137.091774493525;15328;15441.073535587859;15478.69042619147;15534.300956456958;14327.713445731106;14383.065100768468;14480.782788258159;14738.189399583018;14862.925685371585;923.6767131503987;927.3971918253122;929.4934260827865;932.3287233192091;934.8270569944548;920.5535315372039;925.6251218256617;925.6852670092168;926.2312280806914;929.0291645230716;961.2886464016613;962.1244667352711;965.971020869375;966.3815158298695;966.5022513405602;953.2850362228329;956.1442508954516;958.2238386906594;962.6678795815433;962.7641227899139;696.2271878215178;699.1435491522844;700.1073631120312;702.0206811497932;705.6083873450233;13874.306284685827;13886;13930.955178361663;13945;13952.372143253579;12764.936175319064;12874;12934.094613377067;12935.094543381967;13081.86918130816;11095.944520277428;11172.273802202832;11192.552297908074;11252.831207531894;11282.041026512756;3945.151792364655;3994.400839874013;3996.0409501719378;4012.4181993611055;4065.3901914712733;49476.752616236685;52500.73749631227;54965.450345496436;55844.99999999959;56631.71684141553;11453.828192577119;11700;11706.239094458833;12340;12458.875411245952;19964.70052949207;20073.899630501754;20151.899240503702;20327.491812704506;20339.8983005087;9029.63881444748;9063.410878293022;9117.908820911838;9221.123993220768;9418.011108833474;5115.335006449138;5228.764705588258;5321.787128514893;5340.359156901197;5457.154141108134;3588.748787584844;3620.4931309616672;3622.927541449209;3634.273145370936;3638.7816730996224;646.9029645553111;649.3344322069917;656.7012009535746;659.0937460991137;664.0437769611743;819.4345901328064;826.6528058215443;838.6100463284602;850.7320194138827;853.6030745703154;9937.503124843874;10056.34633748804;10088.344257623232;10138.087572118544;10235.7441063974;686.7356067913889;799.5709134973465;812.622130709223;818.6970820796344;841.9115992820788;4276.807543660543;4554.407926969473;4631;4695.671303008825;4843.370361852936;61036.38963610307;61095.389046109856;65658;65679.67160164264;65705.67147164329;56045.719771401695;57234.42765572291;57255.42744572501;57392;57739.42260577424;52008;57663.42336576664;57744;58763.70618146967;58817;9698;10158.984101589782;10239.590416383262;10259.230557708352;10273.383596984206;38794.6120538791;38992.22015559616;39030.6096939027;40022;40057.399139012356;48265.276020860416;50919.236211457595;50992.74503627458;51677;51784;12290.815637765261;12527.436265367898;12584.685382865502;12600.37553433754;12719.55481558178;14124.293785310489;14483.710325793214;14486;14702;15249.923750381176;13754.518591849237;13935.930320348334;14001.859981400055;14198.219097949299;14661.413543458142;12938.870611293767;13334.733305334034;13422.530211442552;13587.45650173982;14200.715985680023;12913.160644558073;12962.611121666365;13343.466261349826;13398.464061437433;13469.12450690702;10855.511501982272;11175.273607215506;11243;11347.864968699945;11571.942140289244;11103.278286911325;11180.72048198769;11187.32876027441;11338.14963877696;11509.597164099216 06:40:47 INFO - PROCESS | 28610 | __end_tp_report 06:40:47 INFO - PROCESS | 28610 | __start_cc_report 06:40:47 INFO - PROCESS | 28610 | _x_x_mozilla_cycle_collect,356 06:40:47 INFO - PROCESS | 28610 | __end_cc_report 06:40:47 INFO - PROCESS | 28610 | __startTimestamp1462801247832__endTimestamp 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | ------- Summary: start ------- 06:40:47 INFO - PROCESS | 28610 | Number of tests: 6 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#0] dojo.html Cycles:165 Average:5687.90 Median:5943.67 stddev:634.08 (10.7%) stddev-sans-first:610.18 06:40:47 INFO - PROCESS | 28610 | Values: 3403.7 3454.3 3458.9 3488.4 3495.2 5736.8 5737.4 5741.3 5765.2 5770.0 5762.8 5772.3 5782.6 5786.5 5802.3 5226.5 5266.9 5317.4 5317.8 5395.5 5153.2 5251.8 5412.8 5434.5 5436.5 5225.2 5233.8 5261.8 5332.0 5350.6 5005.1 5129.2 5132.0 5134.7 5221.4 5061.8 5152.9 5159.5 5162.3 5189.5 5433.4 5459.3 5474.4 5509.3 5584.8 6046.9 6051.5 6060.4 6062.4 6094.8 6079.1 6092.6 6095.8 6098.7 6115.8 5635.2 5647.6 5690.5 5710.2 5733.7 6128.1 6184.8 6186.2 6190.6 6195.3 5899.0 5909.3 5938.3 5958.6 5961.0 5818.1 6132.5 6169.9 6204.1 6209.9 6007.4 6009.0 6027.8 6061.2 6077.1 5929.1 6018.0 6023.1 6033.7 6037.8 4578.0 4596.9 4602.3 4611.1 4623.4 4089.3 4102.8 4103.3 4115.4 4131.0 5795.9 5827.9 5838.4 5850.6 5891.2 6061.4 6122.4 6143.0 6200.9 6230.9 5967.3 5976.3 5979.0 5986.9 5990.2 5109.9 5186.1 5297.5 5301.5 5312.3 6255.7 6298.7 6327.7 6330.5 6344.6 6137.5 6174.1 6179.4 6184.8 6186.4 6113.4 6165.3 6236.3 6329.4 6340.7 6016.8 6115.1 6116.8 6125.2 6125.2 6169.0 6178.8 6185.0 6186.0 6209.9 5886.8 6018.8 6031.8 6040.1 6069.5 5989.1 6012.2 6024.8 6037.8 6040.8 5913.9 5935.3 5937.0 5967.6 5969.0 5939.6 6042.5 6095.5 6116.1 6140.2 5927.1 5935.5 5943.7 5950.6 5974.2 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#1] ext.html Cycles:180 Average:55641.13 Median:41132.78 stddev:105309.97 (256.0%) stddev-sans-first:105524.35 06:40:47 INFO - PROCESS | 28610 | Values: 615.0 654.0 659.6 666.8 699.2 39756.0 40501.8 40537.2 40695.2 40697.6 45001.3 45869.5 45982.3 46079.0 46218.8 8897.6 9038.2 9056.0 9074.6 9075.3 8841.5 8913.7 8978.6 8984.0 8988.5 8942.2 8990.6 8990.8 9002.5 9007.5 8891.4 8926.9 8928.4 8956.4 8992.9 8762.7 8815.9 8859.3 8939.9 8946.6 40705.4 41113.2 41152.4 41216.6 41341.8 3861.8 3947.7 3974.6 4180.7 4292.8 33917.5 34827.3 34832.5 34998.8 35704.6 4592.4 4626.2 4637.4 4650.5 4653.7 324234.0 325398.0 326200.0 326451.0 327394.0 39748.2 62943.7 63327.7 63377.4 63425.7 38681.2 38810.4 38896.8 38943.8 39105.2 17402.5 17480.8 17523.4 17525.0 17618.7 14663.3 14737.1 14803.1 14805.9 14814.6 9402.7 9500.7 9519.1 9562.7 9680.4 2959.1 2996.4 3007.3 3017.2 3040.3 1081.6 1114.9 1136.0 1141.6 1201.0 33735.8 34193.0 34227.8 34259.0 34353.7 1251.8 1264.6 1287.5 1300.4 1308.4 17473.2 17551.5 17619.4 17708.6 17915.8 467767.0 501893.0 537152.0 543125.0 547168.0 61680.7 62553.1 63070.0 63178.7 63217.7 1510.9 1555.3 1562.0 1572.9 1614.5 34289.3 34379.0 34530.3 34776.3 34892.3 54107.2 54319.2 54345.2 54580.7 54849.5 308220.0 312593.0 313354.0 313490.0 314281.0 26539.0 26906.9 27067.3 27105.9 27134.6 51987.5 52079.0 52576.2 52952.5 53560.7 42973.4 43299.4 43526.0 43602.0 44907.3 42910.6 43150.4 43236.9 43371.1 43785.3 44429.6 44697.6 45135.5 45391.8 45537.8 36089.3 36934.1 37724.6 38138.6 38255.0 29762.0 30150.2 30244.4 30359.8 30467.0 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#2] jquery.html Cycles:180 Average:31801.96 Median:2762.11 stddev:89153.97 (3227.8%) stddev-sans-first:89372.93 06:40:47 INFO - PROCESS | 28610 | Values: 420.0 420.2 433.3 435.7 436.2 18476.2 19294.8 19304.9 19575.6 20532.5 12233.1 12441.3 12505.9 21223.6 22137.3 6404.3 6513.1 6578.1 6604.6 6870.6 6954.1 7075.4 7130.9 7146.1 7169.7 7521.5 7543.6 7571.8 7594.4 7599.1 7047.3 7163.5 7200.8 7531.7 7539.0 6925.0 6933.4 6956.0 7019.8 7031.5 25947.7 26005.7 26253.9 26365.7 26808.2 2704.1 2820.1 2985.9 3209.8 3223.6 15663.3 16528.4 16638.6 16662.3 17172.6 2220.4 2222.5 2253.9 2304.2 2326.2 70154.0 70732.7 70872.6 76548.6 92130.5 17165.8 18541.3 18542.2 19051.0 19132.6 35258.1 35382.0 35518.5 35657.6 35808.3 10386.4 11478.1 11493.6 11528.4 11625.2 9834.4 9881.0 9920.4 9952.9 9961.4 9609.9 9613.4 9619.8 9628.4 9776.7 3662.9 3700.3 3724.6 3905.7 3928.5 980.6 1078.8 1114.8 1178.1 1209.4 18947.3 19184.1 19594.8 19760.0 20195.7 1029.5 1033.0 1072.4 1109.2 1110.7 10795.1 10940.7 11266.1 11302.9 11334.0 530783.0 534697.0 541611.0 553342.0 561608.0 86430.6 86891.6 87220.6 88724.3 99085.0 1137.3 1147.5 1167.1 1191.8 1195.3 17788.2 17886.6 18087.0 18110.7 18450.3 25915.5 26796.5 34777.5 39682.4 41394.0 59400.0 61671.0 61703.4 61792.4 62254.0 8499.4 8772.7 8801.9 8814.4 8956.0 12720.3 13285.3 13668.4 14148.6 14150.0 11604.9 11774.2 11838.8 11940.6 12253.3 12098.9 12105.0 12170.4 12194.9 12509.4 12121.9 12306.3 12342.3 12409.3 12626.1 8925.0 9005.8 9124.8 9143.7 9383.4 9031.7 11709.0 11714.5 11949.2 12533.6 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#3] mootools.html Cycles:180 Average:5485.43 Median:4837.81 stddev:2904.91 (60.0%) stddev-sans-first:2898.09 06:40:47 INFO - PROCESS | 28610 | Values: 1562.1 1599.7 1750.8 1862.6 1886.5 7435.5 7969.9 8173.0 8366.1 8380.6 8310.3 8478.0 8522.8 8530.9 8555.4 2387.0 2393.8 2406.9 2417.2 2420.1 2375.3 2392.7 2440.0 2453.3 2456.2 2407.9 2413.9 2416.2 2426.6 2438.5 2321.7 2329.9 2340.6 2340.7 2350.2 2316.8 2352.2 2352.3 2355.3 2366.4 8376.7 8404.7 8410.6 8427.5 8442.5 5167.8 5286.2 5288.3 5322.9 5323.7 3511.8 3539.2 3589.5 3712.1 3713.1 1244.8 1265.6 1268.0 1310.4 2192.1 10392.9 10588.7 10609.5 10615.1 10650.6 4324.1 4385.6 4403.4 4443.4 4465.3 9235.4 9242.4 9244.4 9279.7 9291.6 5137.2 5137.9 5143.1 5165.5 5170.6 4336.3 4685.4 4749.0 4781.0 4894.8 3794.4 3797.2 3854.4 3858.1 3884.2 1161.6 1164.6 1174.8 1180.9 1193.3 928.2 1027.8 1032.4 1037.2 1051.4 5612.7 5624.6 5655.0 5850.8 5902.1 963.1 1038.4 1049.4 1061.3 1083.0 4042.7 4076.8 4084.3 4172.5 4176.7 9818.9 10015.0 10040.5 10145.6 10159.1 9975.4 10023.9 10031.1 10039.5 10040.8 7863.9 7878.6 8010.9 8120.5 8155.3 5718.9 5768.8 5780.0 5834.8 5906.1 8823.6 8978.3 9085.9 9185.0 9214.9 9053.5 9123.7 9252.6 9281.7 9372.7 6443.8 7012.6 7041.0 7201.4 7275.3 7855.5 7862.0 7884.6 7904.1 7943.9 7001.7 7212.5 7245.6 7255.2 7361.7 7089.6 7119.3 7124.7 7198.9 7234.7 6419.5 6589.0 6607.0 6615.0 6631.9 4786.8 4888.8 4917.7 4930.1 4979.2 4594.2 4625.9 4666.1 4691.2 4707.2 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#4] prototype.html Cycles:180 Average:5899.09 Median:6781.21 stddev:1791.91 (26.4%) stddev-sans-first:1747.92 06:40:47 INFO - PROCESS | 28610 | Values: 353.3 362.0 362.1 362.7 369.2 6410.3 6663.8 6681.2 6696.8 6781.5 6653.9 6665.9 6676.8 6687.5 6695.3 5121.0 5129.5 5134.9 5140.0 5150.2 5151.5 5166.1 5166.8 5171.5 5172.5 5113.3 5122.5 5123.4 5126.9 5127.7 5022.7 5101.8 5104.6 5113.1 5129.2 4439.8 4460.7 4477.1 4491.3 4508.4 6407.9 6409.1 6412.7 6413.4 6428.6 5933.5 5937.1 5939.1 5943.3 5945.4 7012.6 7061.6 7063.5 7064.4 7072.1 4563.5 4724.4 4732.7 4976.3 4977.8 7193.8 7296.4 7351.7 7366.8 7381.4 4892.4 4896.2 4896.4 4905.8 4906.6 4952.2 4955.8 4956.6 4958.0 4974.0 5768.7 5786.6 5787.0 5788.1 5800.7 6877.8 7047.4 7062.9 7071.8 7094.6 1729.9 1737.2 1747.3 1753.1 1754.1 1116.4 1122.5 1132.0 1148.2 1151.1 6719.3 6780.9 6858.5 6899.4 6927.1 7216.2 7252.9 7253.1 7260.9 7270.9 6800.4 6812.1 6813.1 6827.6 6835.6 3854.8 3861.7 3933.1 3933.8 3934.5 7477.4 7486.5 7488.4 7498.2 7500.2 7231.7 7296.6 7314.8 7326.3 7346.2 7386.0 7391.0 7393.4 7461.3 7490.1 7126.5 7173.1 7191.6 7204.3 7218.5 7191.1 7235.0 7246.7 7255.9 7275.2 7601.9 7628.1 7677.8 7682.1 7683.7 4814.9 4908.0 4912.1 4912.4 4920.1 7146.0 7338.0 7354.9 7358.1 7368.0 7083.7 7112.3 7125.1 7128.8 7133.6 7013.9 7072.1 7092.3 7115.4 7118.6 6971.9 6972.2 6973.8 6974.1 6974.1 6977.3 7143.4 7151.1 7162.8 7171.7 6910.8 7027.5 7032.2 7033.8 7035.9 06:40:47 INFO - PROCESS | 28610 | 06:40:47 INFO - PROCESS | 28610 | [#5] yui.html Cycles:180 Average:15753.34 Median:22034.91 stddev:18109.19 (82.2%) stddev-sans-first:18125.69 06:40:47 INFO - PROCESS | 28610 | Values: 912.6 917.0 931.9 947.8 954.5 15137.1 15328.0 15441.1 15478.7 15534.3 14327.7 14383.1 14480.8 14738.2 14862.9 923.7 927.4 929.5 932.3 934.8 920.6 925.6 925.7 926.2 929.0 961.3 962.1 966.0 966.4 966.5 953.3 956.1 958.2 962.7 962.8 696.2 699.1 700.1 702.0 705.6 13874.3 13886.0 13931.0 13945.0 13952.4 12764.9 12874.0 12934.1 12935.1 13081.9 11095.9 11172.3 11192.6 11252.8 11282.0 3945.2 3994.4 3996.0 4012.4 4065.4 49476.8 52500.7 54965.5 55845.0 56631.7 11453.8 11700.0 11706.2 12340.0 12458.9 19964.7 20073.9 20151.9 20327.5 20339.9 9029.6 9063.4 9117.9 9221.1 9418.0 5115.3 5228.8 5321.8 5340.4 5457.2 3588.7 3620.5 3622.9 3634.3 3638.8 646.9 649.3 656.7 659.1 664.0 819.4 826.7 838.6 850.7 853.6 9937.5 10056.3 10088.3 10138.1 10235.7 686.7 799.6 812.6 818.7 841.9 4276.8 4554.4 4631.0 4695.7 4843.4 61036.4 61095.4 65658.0 65679.7 65705.7 56045.7 57234.4 57255.4 57392.0 57739.4 52008.0 57663.4 57744.0 58763.7 58817.0 9698.0 10159.0 10239.6 10259.2 10273.4 38794.6 38992.2 39030.6 40022.0 40057.4 48265.3 50919.2 50992.7 51677.0 51784.0 12290.8 12527.4 12584.7 12600.4 12719.6 14124.3 14483.7 14486.0 14702.0 15249.9 13754.5 13935.9 14001.9 14198.2 14661.4 12938.9 13334.7 13422.5 13587.5 14200.7 12913.2 12962.6 13343.5 13398.5 13469.1 10855.5 11175.3 11243.0 11347.9 11571.9 11103.3 11180.7 11187.3 11338.1 11509.6 06:40:47 INFO - PROCESS | 28610 | -------- Summary: end -------- 06:40:47 INFO - PROCESS | 28610 | 06:40:48 INFO - TEST-INFO | 28610: exit 0 06:40:48 INFO - TEST-OK | dromaeo_css | took 1109620ms 06:40:48 INFO - TEST-START | kraken 06:40:48 INFO - operating with platform_type : linux_ 06:40:48 INFO - Initialising browser for kraken test... 06:40:48 INFO - TEST-INFO | started process 28852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCpOVd1/profile http://localhost:36470/getInfo.html) 06:40:52 INFO - PROCESS | 28852 | 06:40:52 INFO - PROCESS | 28852 | (process:28928): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:40:53 INFO - PROCESS | 28852 | __metrics Screen width/height:1600/1200 06:40:53 INFO - PROCESS | 28852 | colorDepth:24 06:40:53 INFO - PROCESS | 28852 | Browser inner width/height: 1024/697 06:40:53 INFO - PROCESS | 28852 | __metrics 06:40:53 ERROR - PROCESS | 28852 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:40:54 INFO - TEST-INFO | 28852: exit 0 06:40:54 INFO - Browser initialized. 06:40:54 INFO - Running cycle 1/1 for kraken test... 06:40:54 INFO - TEST-INFO | started process 28979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCpOVd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:56 INFO - PROCESS | 28979 | 06:40:56 INFO - PROCESS | 28979 | (process:29047): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:41:06 INFO - PROCESS | 28979 | RSS: Main: 152162304 06:41:06 INFO - PROCESS | 28979 | 06:41:09 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-beat-detection) 06:41:09 INFO - PROCESS | 28979 | RSS: Main: 157138944 06:41:09 INFO - PROCESS | 28979 | 06:41:12 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-dft) 06:41:13 INFO - PROCESS | 28979 | RSS: Main: 156762112 06:41:13 INFO - PROCESS | 28979 | 06:41:16 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-fft) 06:41:16 INFO - PROCESS | 28979 | RSS: Main: 157163520 06:41:16 INFO - PROCESS | 28979 | 06:41:18 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-oscillator) 06:41:19 INFO - PROCESS | 28979 | RSS: Main: 157167616 06:41:19 INFO - PROCESS | 28979 | 06:41:21 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:22 INFO - PROCESS | 28979 | RSS: Main: 157761536 06:41:22 INFO - PROCESS | 28979 | 06:41:25 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:25 INFO - PROCESS | 28979 | RSS: Main: 157319168 06:41:25 INFO - PROCESS | 28979 | 06:41:29 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:29 INFO - PROCESS | 28979 | RSS: Main: 157249536 06:41:29 INFO - PROCESS | 28979 | 06:41:32 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36470/tests/kraken/driver.html?testName=json-parse-financial) 06:41:33 INFO - PROCESS | 28979 | RSS: Main: 157110272 06:41:33 INFO - PROCESS | 28979 | 06:41:34 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:35 INFO - PROCESS | 28979 | RSS: Main: 157097984 06:41:35 INFO - PROCESS | 28979 | 06:41:37 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:37 INFO - PROCESS | 28979 | RSS: Main: 156987392 06:41:37 INFO - PROCESS | 28979 | 06:41:39 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:40 INFO - PROCESS | 28979 | RSS: Main: 157048832 06:41:40 INFO - PROCESS | 28979 | 06:41:42 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:43 INFO - PROCESS | 28979 | RSS: Main: 157769728 06:41:43 INFO - PROCESS | 28979 | 06:41:46 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:46 INFO - PROCESS | 28979 | RSS: Main: 157671424 06:41:46 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36470/tests/kraken/driver.html?testName=ai-astar) 06:41:48 INFO - PROCESS | 28979 | RSS: Main: 159109120 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | __start_tp_report 06:41:48 INFO - PROCESS | 28979 | _x_x_mozilla_page_load 06:41:48 INFO - PROCESS | 28979 | _x_x_mozilla_page_load_details 06:41:48 INFO - PROCESS | 28979 | |i|pagename|runs| 06:41:48 INFO - PROCESS | 28979 | |0;ai-astar;110;113;104;111;113;115;103;111;112;111 06:41:48 INFO - PROCESS | 28979 | |1;audio-beat-detection;160;128;155;185;128;156;153;134;185;129 06:41:48 INFO - PROCESS | 28979 | |2;audio-dft;161;163;161;165;167;171;161;162;162;162 06:41:48 INFO - PROCESS | 28979 | |3;audio-fft;75;74;75;173;73;76;75;73;164;74 06:41:48 INFO - PROCESS | 28979 | |4;audio-oscillator;93;92;148;94;93;93;156;93;92;143 06:41:48 INFO - PROCESS | 28979 | |5;imaging-gaussian-blur;118;117;119;117;117;117;117;118;117;118 06:41:48 INFO - PROCESS | 28979 | |6;imaging-darkroom;146;147;147;146;151;146;146;148;146;146 06:41:48 INFO - PROCESS | 28979 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;95;95 06:41:48 INFO - PROCESS | 28979 | |8;json-parse-financial;53;55;55;55;58;54;54;73;53;55 06:41:48 INFO - PROCESS | 28979 | |9;json-stringify-tinderbox;56;57;57;58;57;56;56;57;58;57 06:41:48 INFO - PROCESS | 28979 | |10;stanford-crypto-aes;74;72;73;73;74;72;75;75;78;75 06:41:48 INFO - PROCESS | 28979 | |11;stanford-crypto-ccm;119;114;117;113;113;115;115;119;126;128 06:41:48 INFO - PROCESS | 28979 | |12;stanford-crypto-pbkdf2;160;173;164;163;159;159;158;160;162;162 06:41:48 INFO - PROCESS | 28979 | |13;stanford-crypto-sha256-iterative;68;68;65;67;67;72;69;67;68;66 06:41:48 INFO - PROCESS | 28979 | __end_tp_report 06:41:48 INFO - PROCESS | 28979 | __start_cc_report 06:41:48 INFO - PROCESS | 28979 | _x_x_mozilla_cycle_collect,852 06:41:48 INFO - PROCESS | 28979 | __end_cc_report 06:41:48 INFO - PROCESS | 28979 | __startTimestamp1462801308630__endTimestamp 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | ------- Summary: start ------- 06:41:48 INFO - PROCESS | 28979 | Number of tests: 14 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.86 (3.5%) stddev-sans-first:4.09 06:41:48 INFO - PROCESS | 28979 | Values: 110.0 113.0 104.0 111.0 113.0 115.0 103.0 111.0 112.0 111.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:155.50 stddev:21.78 (14.0%) stddev-sans-first:22.87 06:41:48 INFO - PROCESS | 28979 | Values: 160.0 128.0 155.0 185.0 128.0 156.0 153.0 134.0 185.0 129.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.35 06:41:48 INFO - PROCESS | 28979 | Values: 161.0 163.0 161.0 165.0 167.0 171.0 161.0 162.0 162.0 162.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#3] audio-fft Cycles:10 Average:93.20 Median:74.50 stddev:39.75 (53.4%) stddev-sans-first:41.62 06:41:48 INFO - PROCESS | 28979 | Values: 75.0 74.0 75.0 173.0 73.0 76.0 75.0 73.0 164.0 74.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:27.30 (29.4%) stddev-sans-first:28.28 06:41:48 INFO - PROCESS | 28979 | Values: 93.0 92.0 148.0 94.0 93.0 93.0 156.0 93.0 92.0 143.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:41:48 INFO - PROCESS | 28979 | Values: 118.0 117.0 119.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.50 stddev:1.60 (1.1%) stddev-sans-first:1.66 06:41:48 INFO - PROCESS | 28979 | Values: 146.0 147.0 147.0 146.0 151.0 146.0 146.0 148.0 146.0 146.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:41:48 INFO - PROCESS | 28979 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:5.97 (10.9%) stddev-sans-first:6.19 06:41:48 INFO - PROCESS | 28979 | Values: 53.0 55.0 55.0 55.0 58.0 54.0 54.0 73.0 53.0 55.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 06:41:48 INFO - PROCESS | 28979 | Values: 56.0 57.0 57.0 58.0 57.0 56.0 56.0 57.0 58.0 57.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.50 stddev:1.79 (2.4%) stddev-sans-first:1.90 06:41:48 INFO - PROCESS | 28979 | Values: 74.0 72.0 73.0 73.0 74.0 72.0 75.0 75.0 78.0 75.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:5.28 (4.5%) stddev-sans-first:5.59 06:41:48 INFO - PROCESS | 28979 | Values: 119.0 114.0 117.0 113.0 113.0 115.0 115.0 119.0 126.0 128.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:4.32 (2.7%) stddev-sans-first:4.52 06:41:48 INFO - PROCESS | 28979 | Values: 160.0 173.0 164.0 163.0 159.0 159.0 158.0 160.0 162.0 162.0 06:41:48 INFO - PROCESS | 28979 | 06:41:48 INFO - PROCESS | 28979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:2.00 06:41:48 INFO - PROCESS | 28979 | Values: 68.0 68.0 65.0 67.0 67.0 72.0 69.0 67.0 68.0 66.0 06:41:48 INFO - PROCESS | 28979 | -------- Summary: end -------- 06:41:48 INFO - PROCESS | 28979 | 06:41:49 INFO - TEST-INFO | 28979: exit 0 06:41:49 INFO - TEST-OK | kraken | took 61065ms 06:41:49 INFO - SUITE-END | took 1170s 06:41:49 INFO - Completed test suite (00:19:30) 06:41:49 INFO - javascript benchmark 06:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.7277017838574, 3454.2573346730446, 3458.9135271618206, 3488.4418493041103, 3495.1786330212394, 5736.827895163146, 5737.3688894221605, 5741.2536370271855, 5765.1928729977835, 5769.971150144253, 5762.827115186541, 5772.278465191851, 5782.566307526931, 5786.508146807516, 5802.332731735852, 5226.451222621627, 5266.92099618506, 5317.441668624797, 5317.787288508455, 5395.487428694268, 5153.227015947619, 5251.816186433475, 5412.83761487156, 5434.483724046209, 5436.537894278971, 5225.216217567377, 5233.790648374061, 5261.815836445725, 5331.973340133294, 5350.625456218067, 5005.1491246488185, 5129.230615407681, 5132.0, 5134.691918484866, 5221.39953905302, 5061.848144555669, 5152.92270615941, 5159.509846564571, 5162.347229783381, 5189.455107213764, 5433.402325744165, 5459.344878614552, 5474.37044739856, 5509.256250406184, 5584.832455026356, 6046.909296360558, 6051.455369016766, 6060.3939606039485, 6062.363451837582, 6094.756209751605, 6079.118527813486, 6092.634441933498, 6095.847603809896, 6098.695065246764, 6115.816525504242, 5635.154726790973, 5647.604667673265, 5690.459406356389, 5710.229119068914, 5733.655980641175, 6128.1114238435175, 6184.845378865474, 6186.226721659793, 6190.566660333823, 6195.349488303754, 5899.0, 5909.261342332208, 5938.346781853993, 5958.582899197015, 5960.970195148997, 5818.069108942549, 6132.540059495555, 6169.907451388232, 6204.13142160098, 6209.9379006210265, 6007.429294217042, 6009.0, 6027.758889644453, 6061.181740464981, 6077.058056001327, 5929.110633404937, 6018.037114061729, 6023.096535519707, 6033.698315084228, 6037.78867739627, 4577.954220457819, 4596.862094137181, 4602.263637817933, 4611.054733779567, 4623.352730617717, 4089.3457046872954, 4102.753834769924, 4103.261412945699, 4115.444415003996, 4131.049858532554, 5795.855103622359, 5827.892700386913, 5838.4453476919625, 5850.619709718854, 5891.204687367236, 6061.424164704346, 6122.428649698713, 6143.047827586731, 6200.906986395207, 6230.937690623126, 5967.343592204854, 5976.312724036705, 5978.970105149447, 5986.910196347058, 5990.191324171268, 5109.8722531937, 5186.144286192736, 5297.5232229099565, 5301.5493683037375, 5312.335958005249, 6255.655938923312, 6298.7480500780375, 6327.683615819191, 6330.525210609223, 6344.555881088372, 6137.508999280136, 6174.135621013152, 6179.351168127282, 6184.752609895734, 6186.350433204449, 6113.354685976905, 6165.321814600301, 6236.282827474898, 6329.398707122816, 6340.714667839866, 6016.789412370546, 6115.113308570143, 6116.785912493041, 6125.234345706786, 6125.234345706786, 6168.982117950488, 6178.752849886134, 6184.969075154595, 6185.969070154621, 6209.937900620936, 5886.764529418947, 6018.849528761816, 6031.788887388921, 6040.09398590215, 6069.484093852072, 5989.071693887455, 6012.248468941382, 6024.759009639565, 6037.818865434044, 6040.7583696651645, 5913.940860591339, 5935.258092738408, 5937.0, 5967.612105213321, 5969.044952807703, 5939.613925094855, 6042.486388657014, 6095.542834287535, 6116.140977845955, 6140.201773769381, 5927.081302398135, 5935.465808077293, 5943.673097979653, 5950.583459157818, 5974.1934838796205], "value": 5646.4166150408255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.0436071908184, 654.0483596367285, 659.637199540253, 666.7899611622339, 699.1610067918499, 39756.0, 40501.79749101258, 40537.18925621486, 40695.186096278056, 40697.593024069785, 45001.324980125326, 45869.54130458694, 45982.310265345965, 46079.0, 46218.76890615542, 8897.555122243893, 9038.18656320931, 9055.95472022639, 9074.637014519445, 9075.319351048665, 8841.513716745576, 8913.68802091927, 8978.551072446384, 8984.0, 8988.505632190227, 8942.239909607692, 8990.595423205972, 8990.820183596325, 9002.54987250638, 9007.549622518847, 8891.422057566302, 8926.910730892672, 8928.37501374904, 8956.373053886231, 8992.8651070234, 8762.737117886474, 8815.867761983576, 8859.291256699513, 8939.865902011476, 8946.64213431462, 40705.38941915874, 41113.1777364454, 41152.38271425931, 41216.58783412157, 41341.79329103365, 3861.8455261789495, 3947.703922205846, 3974.6224108709625, 4180.686448516343, 4292.785360731982, 33917.49123763145, 34827.30345393078, 34832.47751283733, 34998.82500587481, 35704.64295357065, 4592.357070010201, 4626.167289887819, 4637.39713837199, 4650.51169627191, 4653.674242803005, 324234.0, 325398.0, 326200.0, 326451.0, 327393.9999999976, 39748.20503589912, 62943.6852815733, 63327.68336158382, 63377.36622633807, 63425.68287158535, 38681.22637547233, 38810.417843732364, 38896.8055159728, 38943.805280973414, 39105.21789564193, 17402.47792566225, 17480.82519174792, 17523.38668146634, 17525.0, 17618.735718964224, 14663.266836658124, 14737.11577305365, 14803.111813291236, 14805.925970370079, 14814.629634259014, 9402.670906518239, 9500.667476638284, 9519.143277105093, 9562.713118606453, 9680.370775899544, 2959.1418488638055, 2996.4156989387297, 3007.278253219212, 3017.1551965449707, 3040.331127152023, 1081.6322450366913, 1114.8773634900153, 1135.9740008050235, 1141.5890279499374, 1200.9731679414149, 33735.83132084324, 34193.0, 34227.82886085554, 34259.0, 34353.65646343504, 1251.8122281657825, 1264.5953294945714, 1287.536486864728, 1300.382318398772, 1308.3981368570373, 17473.21370538329, 17551.47345579609, 17619.38332158394, 17708.645827083645, 17915.820841791676, 467767.0, 501893.0, 537152.0, 543125.0, 547168.0, 61680.69159654173, 62553.06170407448, 63070.0, 63178.684106579174, 63217.683911581065, 1510.8564686354998, 1555.2845690982274, 1562.0159299641152, 1572.8584427401588, 1614.5156453064035, 34289.31421371608, 34379.0, 34530.30939381249, 34776.30447390988, 34892.30215395729, 54107.18839217336, 54319.18521222264, 54345.18482222849, 54580.72709636585, 54849.45150548444, 308220.0, 312593.0, 313354.0, 313490.0, 314281.0, 26539.0, 26906.865465672545, 27067.323316917234, 27105.915763369245, 27134.592981104903, 51987.48012519978, 52079.0, 52576.15983440714, 52952.47047529475, 53560.732196338766, 42973.35539966966, 43299.35050974301, 43526.0, 43602.0, 44907.326390103524, 42910.57089429191, 43150.35274470822, 43236.88053163185, 43371.13257734891, 43785.34321985109, 44429.55570444383, 44697.55302446934, 45135.54864451445, 45391.773041134584, 45537.77231113823, 36089.27821443609, 36934.07664808401, 37724.62275377321, 38138.61861381351, 38255.0, 29762.0, 30150.246243844078, 30244.395112098075, 30359.848200759738, 30467.0], "value": 19664.442272258337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.9685023623229, 420.220490989215, 433.34997503744404, 435.7080755893551, 436.1538615086732, 18476.168572414255, 19294.807051929478, 19304.90347548264, 19575.608487830235, 20532.48668783281, 12233.143679942408, 12441.315727634976, 12505.874941250584, 21223.57552848946, 22137.335879923587, 6404.295527491972, 6513.088167656532, 6578.079068930354, 6604.57070290432, 6870.553414028072, 6954.130733658293, 7075.433965282791, 7130.893036604455, 7146.106736657918, 7169.6773645186095, 7521.511101778394, 7543.622818859062, 7571.810704732398, 7594.430417718666, 7599.088109426876, 7047.295270472938, 7163.498555101145, 7200.783976480714, 7531.736389226378, 7538.962305188494, 6925.0, 6933.4106600938985, 6956.026156338116, 7019.754308599226, 7031.50779445439, 25947.740522594722, 26005.69971501436, 26253.868730656417, 26365.73634263652, 26808.195754127406, 2704.148193319118, 2820.0693771055708, 2985.880564777406, 3209.7753157279, 3223.629282632504, 15663.295151718201, 16528.421505247257, 16638.58403539909, 16662.333506659717, 17172.570685732833, 2220.4226901005854, 2222.4999375140624, 2253.8873056347115, 2304.1704986204954, 2326.232343326698, 70154.0, 70732.67878836195, 70872.64563677149, 76548.61725691392, 92130.53934730351, 17165.82834171667, 18541.258349666132, 18542.165602547917, 19051.0, 19132.61734765297, 35258.118547036014, 35382.0, 35518.467222991676, 35657.64342356543, 35808.28383432369, 10386.42874641902, 11478.081753459703, 11493.597724079616, 11528.423578821026, 11625.18623696333, 9834.409935403899, 9880.950595246977, 9920.355176913477, 9952.850707239253, 9961.35251208669, 9609.942906280303, 9613.423194608346, 9619.759506012406, 9628.378378378278, 9776.729025226676, 3662.908427289339, 3700.2599480104086, 3724.6275372462537, 3905.668018218483, 3928.46965659638, 980.6077568972468, 1078.82199437092, 1114.765899161169, 1178.128185142988, 1209.3650833312581, 18947.33684321042, 19184.13671384791, 19594.80405195958, 19760.0, 20195.697064544045, 1029.4749677664445, 1032.9603750440722, 1072.420892717939, 1109.173665619119, 1110.6501452042742, 10795.082417994401, 10940.716190286263, 11266.098712103012, 11302.886971130183, 11334.0, 530783.0, 534697.0, 541611.0, 553342.0, 561608.0, 86430.56784716163, 86891.56554217188, 87220.56389718138, 88724.33826985201, 99085.0, 1137.2550979108696, 1147.5065721739566, 1167.11882528692, 1191.8212268159846, 1195.2589394575418, 17788.199531021393, 17886.5528361792, 18087.0, 18110.728339075187, 18450.26198952027, 25915.48169036571, 26796.464070718866, 34777.47833782445, 39682.40476392799, 41394.0, 59400.0, 61671.0, 61703.38296617156, 61792.38207617866, 62254.0, 8499.362547809063, 8772.736817895218, 8801.911980880366, 8814.382993190415, 8955.955220223857, 12720.282761827035, 13285.269310188032, 13668.384922678304, 14148.575542733735, 14150.009499334948, 11604.94197529007, 11774.175807693378, 11838.763224735629, 11940.641780746591, 12253.264804111783, 12098.939505302416, 12105.0, 12170.39148042612, 12194.878051219373, 12509.43707533145, 12121.878781212075, 12306.261624302571, 12342.259464432163, 12409.255444672988, 12626.053046021769, 8924.955375223082, 9005.81988360216, 9124.817503649758, 9143.725688229364, 9383.436993780395, 9031.683891063782, 11709.0, 11714.472848721998, 11949.22330048544, 12533.623991280276], "value": 10834.468623490317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.1095975294083, 1599.704054749871, 1750.7811523559556, 1862.6181632765285, 1886.5377982394316, 7435.479516433852, 7969.92030079699, 8173.0, 8366.121557236485, 8380.580970951458, 8310.25207731304, 8478.025027121883, 8522.829543409129, 8530.87203691945, 8555.401121921452, 2386.9880650596724, 2393.7606239376096, 2406.927792166238, 2417.190241269177, 2420.1408499982517, 2375.3467796355967, 2392.7009123859516, 2440.04838113136, 2453.3498622864954, 2456.238566044532, 2407.939801504968, 2413.8551686898754, 2416.226807421626, 2426.575349313872, 2438.4879175373194, 2321.6633588129625, 2329.9184528541505, 2340.648902664597, 2340.6957095577636, 2350.236173243694, 2316.81465482761, 2352.176738141654, 2352.3060697094397, 2355.328731311568, 2366.408397900525, 8376.664933402717, 8404.705835295736, 8410.579471026485, 8427.536485493296, 8442.451240669337, 5167.844964651066, 5286.180642000458, 5288.2596436498925, 5322.893542129135, 5323.733813309319, 3511.771734837253, 3539.150603855082, 3589.4795254687924, 3712.1462063725226, 3713.1088538750773, 1244.819501172334, 1265.5507294910358, 1267.974640507194, 1310.4365122997108, 2192.123150739701, 10392.948035259851, 10588.735281617945, 10609.522571484302, 10615.097716694014, 10650.573977040987, 4324.13517296542, 4385.596609085126, 4403.405540252089, 4443.37792709021, 4465.285554311295, 9235.399699019677, 9242.3530352876, 9244.3528952974, 9279.67521136757, 9291.58187881547, 5137.229415587692, 5137.8715532112, 5143.074246635641, 5165.48345165488, 5170.586353091744, 4336.262835318003, 4685.4143232095985, 4748.976255118702, 4780.976095119502, 4894.779734911937, 3794.4118661607495, 3797.2025874566098, 3854.4218367244575, 3858.112634094174, 3884.2037382336553, 1161.5992482593492, 1164.6273192578294, 1174.8061569841052, 1180.864200616923, 1193.3376975778526, 928.1785619726455, 1027.7944411117805, 1032.3805716570148, 1037.2428127466992, 1051.4112097225577, 5612.747426365823, 5624.606277560613, 5654.971725141348, 5850.795222167204, 5902.144189092557, 963.1379914976197, 1038.3873514626407, 1049.3913530152493, 1061.2783307351076, 1082.976587125159, 4042.6967977401814, 4076.8369265229653, 4084.326086195804, 4172.4993000840095, 4176.686748493815, 9818.852717209247, 10015.0, 10040.548175332127, 10145.594176233015, 10159.085682288629, 9975.351602145838, 10023.899761002442, 10031.097201251776, 10039.498025098716, 10040.79918401628, 7863.882041769378, 7878.645460954271, 8010.879836802453, 8120.512769233865, 8155.306798922039, 5718.914216286676, 5768.798092066758, 5779.97110014464, 5834.795782147605, 5906.055031194988, 8823.558822058743, 8978.281737461119, 9085.863712044193, 9185.035571264922, 9214.861777073484, 9053.547322633975, 9123.726288211365, 9252.583633736363, 9281.67514137002, 9372.67195648149, 6443.7744678936015, 7012.5792452453015, 7041.0, 7201.3518783309755, 7275.272472752682, 7855.5286682799215, 7862.0, 7884.605769711607, 7904.13054564009, 7943.880841787493, 7001.684924178322, 7212.531185472927, 7245.5652660840515, 7255.238199989136, 7361.668724907499, 7089.64551772399, 7119.2524784898915, 7124.715011399486, 7198.89201661965, 7234.74678386254, 6419.518536109717, 6589.0116482528, 6607.0, 6615.04081908111, 6631.900521492085, 4786.784594693317, 4888.828890988941, 4917.655764096479, 4930.13722598551, 4979.178435558092, 4594.2419500783335, 4625.861224163281, 4666.0901124280435, 4691.179043667413, 4707.176244157327], "value": 4530.337203771332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.318096074576, 361.97466177367585, 362.1182420805338, 362.6717820372563, 369.2209438085641, 6410.262819775728, 6663.833404164899, 6681.19825620925, 6696.799096027121, 6781.52529322947, 6653.900191497131, 6665.866682666344, 6676.799696009128, 6687.465002799777, 6695.263521012685, 5120.999999999991, 5129.461406552315, 5134.897302053957, 5140.0, 5150.1759718445055, 5151.536361727443, 5166.095933211692, 5166.767495462713, 5171.534561889429, 5172.508611681884, 5113.258577506278, 5122.487751224885, 5123.359580052494, 5126.948730512703, 5127.743612819363, 5022.698638081727, 5101.770420331057, 5104.64267501275, 5113.130767769489, 5129.1536896412235, 4439.75581343026, 4460.665450091256, 4477.082198149405, 4491.348754430622, 4508.413906192174, 6407.935920640781, 6409.134766806468, 6412.679366031726, 6413.422791948747, 6428.550001499897, 5933.525317974551, 5937.109433584997, 5939.1388248704125, 5943.3165186003735, 5945.405459454063, 7012.614306213156, 7061.646917654097, 7063.540869843444, 7064.43484521237, 7072.115985501812, 4563.520830312803, 4724.4330680318235, 4732.668713190078, 4976.253561965698, 4977.825776097856, 7193.8201544961275, 7296.37980771635, 7351.669174887143, 7366.815829604249, 7381.446391520657, 4892.363992680928, 4896.167651499253, 4896.436909755353, 4905.754712264373, 4906.58294045003, 4952.207646776498, 4955.801767929314, 4956.553910148104, 4958.033183529249, 4973.975130124326, 5768.682722450221, 5786.594938354275, 5786.971065144648, 5788.102844059177, 5800.738966746507, 6877.759278425231, 7047.365737083687, 7062.858742825218, 7071.823204419828, 7094.574325540484, 1729.9135043247786, 1737.218251786701, 1747.2661482177516, 1753.1146770880623, 1754.0791084680645, 1116.4473585575192, 1122.5453691255054, 1131.9547218111184, 1148.1618418554501, 1151.1021403305435, 6719.328067193242, 6780.898286525706, 6858.451323894076, 6899.379055884994, 6927.099477067949, 7216.170140433812, 7252.927470725331, 7253.1296244451005, 7260.891086633705, 7270.890936635955, 6800.353966373186, 6812.080369150101, 6813.080234168423, 6827.590344579341, 6835.624040677811, 3854.845806167722, 3861.7489863158803, 3933.0757272041046, 3933.7639741615594, 3934.5081864766903, 7477.36442402391, 7486.513376630502, 7488.438367122488, 7498.212687667826, 7500.174980752113, 7231.746888858865, 7296.635168241567, 7314.780556583311, 7326.267373262738, 7346.1551921528635, 7386.0, 7390.96304518474, 7393.371563417062, 7461.291177338144, 7490.1386340571535, 7126.465515086285, 7173.10336207974, 7191.640417978975, 7204.279572042963, 7218.458615603746, 7191.065161528968, 7235.023271858232, 7246.746363877239, 7255.891161632685, 7275.199728030018, 7601.885971710318, 7628.084629844232, 7677.808054798451, 7682.116556596063, 7683.692652293846, 4814.855554333376, 4908.042931628441, 4912.1158191525865, 4912.38595175603, 4920.138975679313, 7146.0, 7337.963310183415, 7354.926450735424, 7358.11702595692, 7368.0, 7083.68123434457, 7112.324329188718, 7125.144982602121, 7128.750493732695, 7133.643317833984, 7013.894791578233, 7072.115985501812, 7092.290770923073, 7115.359617634438, 7118.572885626879, 6971.895421568782, 6972.233054363915, 6973.79078627642, 6974.058502102354, 6974.093367862349, 6977.267386924503, 7143.357097861218, 7151.106111736033, 7162.820929476805, 7171.677274522764, 6910.792676219721, 7027.543209691354, 7032.171635374737, 7033.824154396181, 7035.894461582978], "value": 5305.646660960486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.6258234124008, 917.0416914324535, 931.8741969834073, 947.7962238118803, 954.5179684259448, 15137.091774493525, 15328.0, 15441.073535587859, 15478.69042619147, 15534.300956456958, 14327.713445731106, 14383.065100768468, 14480.782788258159, 14738.189399583018, 14862.925685371585, 923.6767131503987, 927.3971918253122, 929.4934260827865, 932.3287233192091, 934.8270569944548, 920.5535315372039, 925.6251218256617, 925.6852670092168, 926.2312280806914, 929.0291645230716, 961.2886464016613, 962.1244667352711, 965.971020869375, 966.3815158298695, 966.5022513405602, 953.2850362228329, 956.1442508954516, 958.2238386906594, 962.6678795815433, 962.7641227899139, 696.2271878215178, 699.1435491522844, 700.1073631120312, 702.0206811497932, 705.6083873450233, 13874.306284685827, 13886.0, 13930.955178361663, 13945.0, 13952.372143253579, 12764.936175319064, 12874.0, 12934.094613377067, 12935.094543381967, 13081.86918130816, 11095.944520277428, 11172.273802202832, 11192.552297908074, 11252.831207531894, 11282.041026512756, 3945.151792364655, 3994.400839874013, 3996.0409501719378, 4012.4181993611055, 4065.3901914712733, 49476.752616236685, 52500.73749631227, 54965.450345496436, 55844.99999999959, 56631.71684141553, 11453.828192577119, 11700.0, 11706.239094458833, 12340.0, 12458.875411245952, 19964.70052949207, 20073.899630501754, 20151.899240503702, 20327.491812704506, 20339.8983005087, 9029.63881444748, 9063.410878293022, 9117.908820911838, 9221.123993220768, 9418.011108833474, 5115.335006449138, 5228.764705588258, 5321.787128514893, 5340.359156901197, 5457.154141108134, 3588.748787584844, 3620.4931309616672, 3622.927541449209, 3634.273145370936, 3638.7816730996224, 646.9029645553111, 649.3344322069917, 656.7012009535746, 659.0937460991137, 664.0437769611743, 819.4345901328064, 826.6528058215443, 838.6100463284602, 850.7320194138827, 853.6030745703154, 9937.503124843874, 10056.34633748804, 10088.344257623232, 10138.087572118544, 10235.7441063974, 686.7356067913889, 799.5709134973465, 812.622130709223, 818.6970820796344, 841.9115992820788, 4276.807543660543, 4554.407926969473, 4631.0, 4695.671303008825, 4843.370361852936, 61036.38963610307, 61095.389046109856, 65658.0, 65679.67160164264, 65705.67147164329, 56045.719771401695, 57234.42765572291, 57255.42744572501, 57392.0, 57739.42260577424, 52008.0, 57663.42336576664, 57744.0, 58763.70618146967, 58817.0, 9698.0, 10158.984101589782, 10239.590416383262, 10259.230557708352, 10273.383596984206, 38794.6120538791, 38992.22015559616, 39030.6096939027, 40022.0, 40057.399139012356, 48265.276020860416, 50919.236211457595, 50992.74503627458, 51677.0, 51784.0, 12290.815637765261, 12527.436265367898, 12584.685382865502, 12600.37553433754, 12719.55481558178, 14124.293785310489, 14483.710325793214, 14486.0, 14702.0, 15249.923750381176, 13754.518591849237, 13935.930320348334, 14001.859981400055, 14198.219097949299, 14661.413543458142, 12938.870611293767, 13334.733305334034, 13422.530211442552, 13587.45650173982, 14200.715985680023, 12913.160644558073, 12962.611121666365, 13343.466261349826, 13398.464061437433, 13469.12450690702, 10855.511501982272, 11175.273607215506, 11243.0, 11347.864968699945, 11571.942140289244, 11103.278286911325, 11180.72048198769, 11187.32876027441, 11338.14963877696, 11509.597164099216], "value": 7276.262148803211, "unit": "score"}], "name": "dromaeo_css", "value": 7712.224455107719, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 104.0, 111.0, 113.0, 115.0, 103.0, 111.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 155.0, 185.0, 128.0, 156.0, 153.0, 134.0, 185.0, 129.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 165.0, 167.0, 171.0, 161.0, 162.0, 162.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 173.0, 73.0, 76.0, 75.0, 73.0, 164.0, 74.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 148.0, 94.0, 93.0, 93.0, 156.0, 93.0, 92.0, 143.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 151.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 55.0, 58.0, 54.0, 54.0, 73.0, 53.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 57.0, 58.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 73.0, 74.0, 72.0, 75.0, 75.0, 78.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 117.0, 113.0, 113.0, 115.0, 115.0, 119.0, 126.0, 128.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 173.0, 164.0, 163.0, 159.0, 159.0, 158.0, 160.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 67.0, 67.0, 72.0, 69.0, 67.0, 68.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1522.8000000000002, "alertThreshold": 2.0}]} 06:41:49 INFO - Return code: 0 06:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:49 ERROR - # TBPL SUCCESS # 06:41:49 INFO - Running post-action listener: _resource_record_post_action 06:41:49 INFO - Running post-run listener: _resource_record_post_run 06:41:50 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 270336; Write bytes: 509607936; Read time: 48; Write time: 565720 06:41:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 261480448; Read time: 0; Write time: 329372 06:41:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 270336; Write bytes: 248127488; Read time: 48; Write time: 236348 06:41:51 INFO - Running post-run listener: _upload_blobber_files 06:41:51 INFO - Blob upload gear active. 06:41:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:51 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:51 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:51 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:52 INFO - (blobuploader) - INFO - Done attempting. 06:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:53 INFO - (blobuploader) - INFO - Done attempting. 06:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:53 INFO - Return code: 0 06:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b6a0cc36bd005bbff3dc9418d1128ec66a6549b6c32d8f4910fa24951f0d600ccc3b20c932e2bfcdbcb3be9d8d0e0944e7e567a1b469ea70b932ab09ad72169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8de4b60db20c18b48d87db523217aa96eb160916c187e3144236e86c0a9a4cb4b5c1fd086f0a117f034d986807375bfcc6f8c2158622403e1c114d4e7f33863f"} 06:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:53 INFO - Contents: 06:41:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b6a0cc36bd005bbff3dc9418d1128ec66a6549b6c32d8f4910fa24951f0d600ccc3b20c932e2bfcdbcb3be9d8d0e0944e7e567a1b469ea70b932ab09ad72169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8de4b60db20c18b48d87db523217aa96eb160916c187e3144236e86c0a9a4cb4b5c1fd086f0a117f034d986807375bfcc6f8c2158622403e1c114d4e7f33863f"} 06:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:53 INFO - Copying logs to upload dir... 06:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.554564 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-09 06:41:53.090244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:53.093852) ========= 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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 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/7b6a0cc36bd005bbff3dc9418d1128ec66a6549b6c32d8f4910fa24951f0d600ccc3b20c932e2bfcdbcb3be9d8d0e0944e7e567a1b469ea70b932ab09ad72169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8de4b60db20c18b48d87db523217aa96eb160916c187e3144236e86c0a9a4cb4b5c1fd086f0a117f034d986807375bfcc6f8c2158622403e1c114d4e7f33863f"} 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.011411 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/7b6a0cc36bd005bbff3dc9418d1128ec66a6549b6c32d8f4910fa24951f0d600ccc3b20c932e2bfcdbcb3be9d8d0e0944e7e567a1b469ea70b932ab09ad72169", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8de4b60db20c18b48d87db523217aa96eb160916c187e3144236e86c0a9a4cb4b5c1fd086f0a117f034d986807375bfcc6f8c2158622403e1c114d4e7f33863f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:53.118129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:53.118423) ========= 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=920470bf432669ad7e3a5387000001ca-1462800085.302514-3083172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:53.205485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:53.205839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:53.206232) ========= ========= Total master_lag: 0.22 =========