builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1460733679.57 results: success (0) buildid: 20160415053237 builduid: 75586b6181bd47ce84a9b384daca7d23 revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.570648) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.572755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.573293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.591216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.591640) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 08:21:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-04-15 08:21:19 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.700827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.701181) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.751100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:19.751488) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0260dd297a25b97b11dfa208c3d556cb7b62542c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0260dd297a25b97b11dfa208c3d556cb7b62542c --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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 08:21:19,893 truncating revision to first 12 chars 2016-04-15 08:21:19,893 Setting DEBUG logging. 2016-04-15 08:21:19,893 attempt 1/10 2016-04-15 08:21:19,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0260dd297a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 08:21:20,145 unpacking tar archive at: fx-team-0260dd297a25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:20.289076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:20.289465) ========= script_repo_revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:20.289887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:20.290189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:21:20.299727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-15 08:21:20.300094) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:20 INFO - MultiFileLogger online at 20160415 08:21:20 in /builds/slave/test 08:21:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:21:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:20 INFO - {'append_to_log': False, 08:21:20 INFO - 'base_work_dir': '/builds/slave/test', 08:21:20 INFO - 'blob_upload_branch': 'Fx-Team', 08:21:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:20 INFO - 'branch': 'Fx-Team', 08:21:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:20 INFO - 'config_files': ('talos/linux_config.py',), 08:21:20 INFO - 'default_actions': ('clobber', 08:21:20 INFO - 'read-buildbot-config', 08:21:20 INFO - 'download-and-extract', 08:21:20 INFO - 'populate-webroot', 08:21:20 INFO - 'create-virtualenv', 08:21:20 INFO - 'install', 08:21:20 INFO - 'run-tests'), 08:21:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:20 INFO - 'download_minidump_stackwalk': True, 08:21:20 INFO - 'download_symbols': 'ondemand', 08:21:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:20 INFO - 'installer_path': 'installer.exe', 08:21:20 INFO - 'log_level': 'info', 08:21:20 INFO - 'log_name': 'talos', 08:21:20 INFO - 'log_to_console': True, 08:21:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:20 INFO - 'opt_config_files': (), 08:21:20 INFO - 'pip_index': False, 08:21:20 INFO - 'sps_profile': False, 08:21:20 INFO - 'sps_profile_interval': 0, 08:21:20 INFO - 'suite': 'dromaeojs-e10s', 08:21:20 INFO - 'system_bits': '32', 08:21:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:20 INFO - 'title': 'talos-linux64-ix-049', 08:21:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:20 INFO - 'use_talos_json': True, 08:21:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:20 INFO - 'work_dir': 'build'} 08:21:20 INFO - ##### 08:21:20 INFO - ##### Running clobber step. 08:21:20 INFO - ##### 08:21:20 INFO - Running pre-action listener: _resource_record_pre_action 08:21:20 INFO - Running main action method: clobber 08:21:20 INFO - rmtree: /builds/slave/test/build 08:21:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:20 INFO - Running post-action listener: _resource_record_post_action 08:21:20 INFO - ##### 08:21:20 INFO - ##### Running read-buildbot-config step. 08:21:20 INFO - ##### 08:21:20 INFO - Running pre-action listener: _resource_record_pre_action 08:21:20 INFO - Running main action method: read_buildbot_config 08:21:20 INFO - Using buildbot properties: 08:21:20 INFO - { 08:21:20 INFO - "project": "", 08:21:20 INFO - "product": "firefox", 08:21:20 INFO - "script_repo_revision": "production", 08:21:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:21:20 INFO - "repository": "", 08:21:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:21:20 INFO - "buildid": "20160415053237", 08:21:20 INFO - "pgo_build": "True", 08:21:20 INFO - "basedir": "/builds/slave/test", 08:21:20 INFO - "buildnumber": 656, 08:21:20 INFO - "slavename": "talos-linux64-ix-049", 08:21:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:21:20 INFO - "platform": "ubuntu64_hw", 08:21:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:21:20 INFO - "branch": "fx-team", 08:21:20 INFO - "repo_path": "integration/fx-team", 08:21:20 INFO - "revision": "0260dd297a25b97b11dfa208c3d556cb7b62542c", 08:21:20 INFO - "stage_platform": "linux64-pgo", 08:21:20 INFO - "builduid": "75586b6181bd47ce84a9b384daca7d23", 08:21:20 INFO - "slavebuilddir": "test" 08:21:20 INFO - } 08:21:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:21:20 INFO - Running post-action listener: _resource_record_post_action 08:21:20 INFO - ##### 08:21:20 INFO - ##### Running download-and-extract step. 08:21:20 INFO - ##### 08:21:20 INFO - Running pre-action listener: _resource_record_pre_action 08:21:20 INFO - Running main action method: download_and_extract 08:21:20 INFO - mkdir: /builds/slave/test/build/tests 08:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:20 INFO - https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:21:30 INFO - Downloaded 1361 bytes. 08:21:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:30 INFO - Using the following test package requirements: 08:21:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'jsshell-linux-x86_64.zip'], 08:21:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:30 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')]} 08:21:30 INFO - https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:46 INFO - Downloaded 23776862 bytes. 08:21:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:47 INFO - Return code: 0 08:21:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:47 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')]} 08:21:47 INFO - https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:49 INFO - Downloaded 23776862 bytes. 08:21:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:50 INFO - Return code: 0 08:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:50 INFO - https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:51 INFO - Downloaded 10841076 bytes. 08:21:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:51 INFO - Return code: 0 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 INFO - https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:54 INFO - Downloaded 58240049 bytes. 08:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:54 INFO - mkdir: /builds/slave/test/properties 08:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:54 INFO - Contents: 08:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:55 INFO - Running post-action listener: _resource_record_post_action 08:21:55 INFO - Running post-action listener: set_extra_try_arguments 08:21:55 INFO - ##### 08:21:55 INFO - ##### Running populate-webroot step. 08:21:55 INFO - ##### 08:21:55 INFO - Running pre-action listener: _resource_record_pre_action 08:21:55 INFO - Running main action method: populate_webroot 08:21:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:55 INFO - '--tppagecycles', 08:21:55 INFO - '7'], 08:21:55 INFO - 'tests': ['tsvgm']}}, 08:21:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['damp', 'tps']}, 08:21:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'tests': ['damp', 'tps']}, 08:21:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['dromaeo_dom']}, 08:21:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['a11yr', 08:21:55 INFO - 'ts_paint', 08:21:55 INFO - 'tpaint', 08:21:55 INFO - 'sessionrestore', 08:21:55 INFO - 'sessionrestore_no_auto_restore', 08:21:55 INFO - 'tabpaint']}, 08:21:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['tsvgx', 08:21:55 INFO - 'tsvgr_opacity', 08:21:55 INFO - 'tart', 08:21:55 INFO - 'tscrollx', 08:21:55 INFO - 'cart']}, 08:21:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:55 INFO - 'tsvgr_opacity', 08:21:55 INFO - 'tart', 08:21:55 INFO - 'tscrollx', 08:21:55 INFO - 'cart']}, 08:21:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'talos_options': ['--disable-e10s'], 08:21:55 INFO - 'tests': ['tp5o']}, 08:21:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'tests': ['tp5o']}, 08:21:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'talos_options': ['--disable-e10s', 08:21:55 INFO - '--xperf_path', 08:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:55 INFO - 'tests': ['tp5n']}, 08:21:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:55 INFO - 'talos_options': ['--xperf_path', 08:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:55 INFO - 'tests': ['tp5n']}}, 08:21:55 INFO - 'talos.zip': {'path': '', 08:21:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:55 INFO - Running post-action listener: _resource_record_post_action 08:21:55 INFO - ##### 08:21:55 INFO - ##### Running create-virtualenv step. 08:21:55 INFO - ##### 08:21:55 INFO - Running pre-action listener: _resource_record_pre_action 08:21:55 INFO - Running main action method: create_virtualenv 08:21:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:55 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 08:21:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:55 INFO - Using real prefix '/usr' 08:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:58 INFO - Installing pip.................done. 08:21:58 INFO - Return code: 0 08:21:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08: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', 'pip>=1.5'] in /builds/slave/test/build 08: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 pip>=1.5 08:21:58 INFO - Using env: {'DISPLAY': ':0', 08:21:58 INFO - 'HOME': '/home/cltbld', 08:21:58 INFO - 'LANG': 'en_US.UTF-8', 08:21:58 INFO - 'LANGUAGE': 'en_US:en', 08:21:58 INFO - 'LOGNAME': 'cltbld', 08:21:58 INFO - 'MAIL': '/var/mail/cltbld', 08:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:58 INFO - 'MOZ_NO_REMOTE': '1', 08:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:58 INFO - 'NO_EM_RESTART': '1', 08:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:58 INFO - 'PWD': '/builds/slave/test', 08:21:58 INFO - 'SHELL': '/bin/bash', 08:21:58 INFO - 'SHLVL': '1', 08:21:58 INFO - 'TERM': 'linux', 08:21:58 INFO - 'TMOUT': '86400', 08:21:58 INFO - 'USER': 'cltbld', 08:21:58 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:58 INFO - '_': '/tools/buildbot/bin/python'} 08:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:58 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 08:21:58 INFO - Cleaning up... 08:21:58 INFO - Return code: 0 08:21:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', '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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08: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 psutil>=0.7.1 08:21:58 INFO - Using env: {'DISPLAY': ':0', 08:21:58 INFO - 'HOME': '/home/cltbld', 08:21:58 INFO - 'LANG': 'en_US.UTF-8', 08:21:58 INFO - 'LANGUAGE': 'en_US:en', 08:21:58 INFO - 'LOGNAME': 'cltbld', 08:21:58 INFO - 'MAIL': '/var/mail/cltbld', 08:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:58 INFO - 'MOZ_NO_REMOTE': '1', 08:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:58 INFO - 'NO_EM_RESTART': '1', 08:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:58 INFO - 'PWD': '/builds/slave/test', 08:21:58 INFO - 'SHELL': '/bin/bash', 08:21:58 INFO - 'SHLVL': '1', 08:21:58 INFO - 'TERM': 'linux', 08:21:58 INFO - 'TMOUT': '86400', 08:21:58 INFO - 'USER': 'cltbld', 08:21:58 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:58 INFO - '_': '/tools/buildbot/bin/python'} 08:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:58 INFO - Downloading/unpacking psutil>=0.7.1 08: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 08: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 08: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 08: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 08: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 08: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 08:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:00 INFO - Installing collected packages: psutil 08:22:00 INFO - Running setup.py install for psutil 08:22:00 INFO - building 'psutil._psutil_linux' extension 08:22:01 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 08:22:01 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 08:22:01 INFO - building 'psutil._psutil_posix' extension 08:22:01 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 08:22:01 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 08:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:01 INFO - Successfully installed psutil 08:22:01 INFO - Cleaning up... 08:22:02 INFO - Return code: 0 08:22:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:22:02 INFO - Using env: {'DISPLAY': ':0', 08:22:02 INFO - 'HOME': '/home/cltbld', 08:22:02 INFO - 'LANG': 'en_US.UTF-8', 08:22:02 INFO - 'LANGUAGE': 'en_US:en', 08:22:02 INFO - 'LOGNAME': 'cltbld', 08:22:02 INFO - 'MAIL': '/var/mail/cltbld', 08:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:02 INFO - 'MOZ_NO_REMOTE': '1', 08:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:02 INFO - 'NO_EM_RESTART': '1', 08:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:02 INFO - 'PWD': '/builds/slave/test', 08:22:02 INFO - 'SHELL': '/bin/bash', 08:22:02 INFO - 'SHLVL': '1', 08:22:02 INFO - 'TERM': 'linux', 08:22:02 INFO - 'TMOUT': '86400', 08:22:02 INFO - 'USER': 'cltbld', 08:22:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:02 INFO - '_': '/tools/buildbot/bin/python'} 08:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:22:04 INFO - Installing collected packages: mozsystemmonitor 08:22:04 INFO - Running setup.py install for mozsystemmonitor 08:22:05 INFO - Successfully installed mozsystemmonitor 08:22:05 INFO - Cleaning up... 08:22:05 INFO - Return code: 0 08:22:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:22:05 INFO - Using env: {'DISPLAY': ':0', 08:22:05 INFO - 'HOME': '/home/cltbld', 08:22:05 INFO - 'LANG': 'en_US.UTF-8', 08:22:05 INFO - 'LANGUAGE': 'en_US:en', 08:22:05 INFO - 'LOGNAME': 'cltbld', 08:22:05 INFO - 'MAIL': '/var/mail/cltbld', 08:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:05 INFO - 'MOZ_NO_REMOTE': '1', 08:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:05 INFO - 'NO_EM_RESTART': '1', 08:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:05 INFO - 'PWD': '/builds/slave/test', 08:22:05 INFO - 'SHELL': '/bin/bash', 08:22:05 INFO - 'SHLVL': '1', 08:22:05 INFO - 'TERM': 'linux', 08:22:05 INFO - 'TMOUT': '86400', 08:22:05 INFO - 'USER': 'cltbld', 08:22:05 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:05 INFO - '_': '/tools/buildbot/bin/python'} 08:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:07 INFO - Downloading docopt-0.6.1.tar.gz 08:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:07 INFO - Running setup.py install for blobuploader 08:22:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:08 INFO - Running setup.py install for requests 08:22:08 INFO - Running setup.py install for docopt 08:22:08 INFO - Successfully installed blobuploader requests docopt 08:22:08 INFO - Cleaning up... 08:22:08 INFO - Return code: 0 08:22:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:08 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')]} 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:08 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')]} 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:08 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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:08 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 08:22:08 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 08:22:08 INFO - Using env: {'DISPLAY': ':0', 08:22:08 INFO - 'HOME': '/home/cltbld', 08:22:08 INFO - 'LANG': 'en_US.UTF-8', 08:22:08 INFO - 'LANGUAGE': 'en_US:en', 08:22:08 INFO - 'LOGNAME': 'cltbld', 08:22:08 INFO - 'MAIL': '/var/mail/cltbld', 08:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:08 INFO - 'MOZ_NO_REMOTE': '1', 08:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:08 INFO - 'NO_EM_RESTART': '1', 08:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:08 INFO - 'PWD': '/builds/slave/test', 08:22:08 INFO - 'SHELL': '/bin/bash', 08:22:08 INFO - 'SHLVL': '1', 08:22:08 INFO - 'TERM': 'linux', 08:22:08 INFO - 'TMOUT': '86400', 08:22:08 INFO - 'USER': 'cltbld', 08:22:08 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:08 INFO - '_': '/tools/buildbot/bin/python'} 08:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:08 INFO - Running setup.py (path:/tmp/pip-yxLtv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:08 INFO - Running setup.py (path:/tmp/pip-Y6oREZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:08 INFO - Running setup.py (path:/tmp/pip-xyNYKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:09 INFO - Running setup.py (path:/tmp/pip-nZD_jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:09 INFO - Running setup.py (path:/tmp/pip-eACY_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:09 INFO - Running setup.py (path:/tmp/pip-nU3aI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:09 INFO - Running setup.py (path:/tmp/pip-oK9pww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:09 INFO - Running setup.py (path:/tmp/pip-KSjl3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:09 INFO - Running setup.py (path:/tmp/pip-XnCz79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:09 INFO - Running setup.py (path:/tmp/pip-zR2SGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:09 INFO - Running setup.py (path:/tmp/pip-tSjlLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:09 INFO - Running setup.py (path:/tmp/pip-R1T8gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:09 INFO - Running setup.py (path:/tmp/pip-HXuScD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:09 INFO - Running setup.py (path:/tmp/pip-dxlty_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:09 INFO - Running setup.py (path:/tmp/pip-Jx1Dsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:09 INFO - Running setup.py (path:/tmp/pip-PCiPE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:09 INFO - Running setup.py (path:/tmp/pip-YI7jIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:09 INFO - Running setup.py install for manifestparser 08:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Running setup.py install for mozcrash 08:22:10 INFO - Running setup.py install for mozdebug 08:22:10 INFO - Running setup.py install for mozdevice 08:22:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Running setup.py install for mozfile 08:22:10 INFO - Running setup.py install for mozhttpd 08:22:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Running setup.py install for mozinfo 08:22:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Running setup.py install for mozInstall 08:22:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:10 INFO - Running setup.py install for mozleak 08:22:10 INFO - Running setup.py install for mozlog 08:22:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Running setup.py install for moznetwork 08:22:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Running setup.py install for mozprocess 08:22:11 INFO - Running setup.py install for mozprofile 08:22:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Running setup.py install for mozrunner 08:22:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Running setup.py install for mozscreenshot 08:22:11 INFO - Running setup.py install for moztest 08:22:11 INFO - Running setup.py install for mozversion 08:22:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:11 INFO - Cleaning up... 08:22:11 INFO - Return code: 0 08:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:11 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')]} 08:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:11 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')]} 08:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:11 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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:11 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 08:22:11 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 08:22:11 INFO - Using env: {'DISPLAY': ':0', 08:22:11 INFO - 'HOME': '/home/cltbld', 08:22:11 INFO - 'LANG': 'en_US.UTF-8', 08:22:11 INFO - 'LANGUAGE': 'en_US:en', 08:22:11 INFO - 'LOGNAME': 'cltbld', 08:22:11 INFO - 'MAIL': '/var/mail/cltbld', 08:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:11 INFO - 'MOZ_NO_REMOTE': '1', 08:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:11 INFO - 'NO_EM_RESTART': '1', 08:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:11 INFO - 'PWD': '/builds/slave/test', 08:22:11 INFO - 'SHELL': '/bin/bash', 08:22:11 INFO - 'SHLVL': '1', 08:22:11 INFO - 'TERM': 'linux', 08:22:11 INFO - 'TMOUT': '86400', 08:22:11 INFO - 'USER': 'cltbld', 08:22:11 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:11 INFO - '_': '/tools/buildbot/bin/python'} 08:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:11 INFO - Running setup.py (path:/tmp/pip-3F2K1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:12 INFO - Running setup.py (path:/tmp/pip-dB4NSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:12 INFO - Running setup.py (path:/tmp/pip-4J03AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:12 INFO - Running setup.py (path:/tmp/pip-2rwBNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:12 INFO - Running setup.py (path:/tmp/pip-TnpElL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:12 INFO - Running setup.py (path:/tmp/pip-FNOYPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:12 INFO - Running setup.py (path:/tmp/pip-2B16Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:12 INFO - Running setup.py (path:/tmp/pip-bk0pJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:12 INFO - Running setup.py (path:/tmp/pip-LRj9Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:12 INFO - Running setup.py (path:/tmp/pip-lHdmbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:12 INFO - Running setup.py (path:/tmp/pip-oribAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:12 INFO - Running setup.py (path:/tmp/pip-4GroAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:12 INFO - Running setup.py (path:/tmp/pip-3ZovNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:12 INFO - Running setup.py (path:/tmp/pip-0CcTJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:12 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)) 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:12 INFO - Running setup.py (path:/tmp/pip-_G9vOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:13 INFO - Running setup.py (path:/tmp/pip-hIdQcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:13 INFO - Running setup.py (path:/tmp/pip-tEprRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:15 INFO - Downloading blessings-1.6.tar.gz 08:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:15 INFO - Installing collected packages: blessings 08:22:15 INFO - Running setup.py install for blessings 08:22:15 INFO - Successfully installed blessings 08:22:15 INFO - Cleaning up... 08:22:15 INFO - Return code: 0 08:22:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:15 INFO - Reading from file tmpfile_stdout 08:22:15 INFO - Current package versions: 08:22:15 INFO - argparse == 1.2.1 08:22:15 INFO - blessings == 1.6 08:22:15 INFO - blobuploader == 1.2.4 08:22:15 INFO - docopt == 0.6.1 08:22:15 INFO - manifestparser == 1.1 08:22:15 INFO - mozInstall == 1.12 08:22:15 INFO - mozcrash == 0.17 08:22:15 INFO - mozdebug == 0.1 08:22:15 INFO - mozdevice == 0.48 08:22:15 INFO - mozfile == 1.2 08:22:15 INFO - mozhttpd == 0.7 08:22:15 INFO - mozinfo == 0.9 08:22:15 INFO - mozleak == 0.1 08:22:15 INFO - mozlog == 3.1 08:22:15 INFO - moznetwork == 0.27 08:22:15 INFO - mozprocess == 0.22 08:22:15 INFO - mozprofile == 0.28 08:22:15 INFO - mozrunner == 6.11 08:22:15 INFO - mozscreenshot == 0.1 08:22:15 INFO - mozsystemmonitor == 0.0 08:22:15 INFO - moztest == 0.7 08:22:15 INFO - mozversion == 1.4 08:22:15 INFO - psutil == 3.1.1 08:22:15 INFO - requests == 1.2.3 08:22:15 INFO - wsgiref == 0.1.2 08:22:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:15 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')]} 08:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 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')]} 08:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:15 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 08:22:15 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 08:22:15 INFO - Using env: {'DISPLAY': ':0', 08:22:15 INFO - 'HOME': '/home/cltbld', 08:22:15 INFO - 'LANG': 'en_US.UTF-8', 08:22:15 INFO - 'LANGUAGE': 'en_US:en', 08:22:15 INFO - 'LOGNAME': 'cltbld', 08:22:15 INFO - 'MAIL': '/var/mail/cltbld', 08:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:15 INFO - 'MOZ_NO_REMOTE': '1', 08:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:15 INFO - 'NO_EM_RESTART': '1', 08:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:15 INFO - 'PWD': '/builds/slave/test', 08:22:15 INFO - 'SHELL': '/bin/bash', 08:22:15 INFO - 'SHLVL': '1', 08:22:15 INFO - 'TERM': 'linux', 08:22:15 INFO - 'TMOUT': '86400', 08:22:15 INFO - 'USER': 'cltbld', 08:22:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:15 INFO - '_': '/tools/buildbot/bin/python'} 08:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 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)) 08:22:15 INFO - Cleaning up... 08:22:15 INFO - Return code: 0 08:22:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:15 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')]} 08:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 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')]} 08:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 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 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:15 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 08:22:15 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 08:22:15 INFO - Using env: {'DISPLAY': ':0', 08:22:15 INFO - 'HOME': '/home/cltbld', 08:22:15 INFO - 'LANG': 'en_US.UTF-8', 08:22:15 INFO - 'LANGUAGE': 'en_US:en', 08:22:15 INFO - 'LOGNAME': 'cltbld', 08:22:15 INFO - 'MAIL': '/var/mail/cltbld', 08:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:15 INFO - 'MOZ_NO_REMOTE': '1', 08:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:15 INFO - 'NO_EM_RESTART': '1', 08:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:15 INFO - 'PWD': '/builds/slave/test', 08:22:15 INFO - 'SHELL': '/bin/bash', 08:22:15 INFO - 'SHLVL': '1', 08:22:15 INFO - 'TERM': 'linux', 08:22:15 INFO - 'TMOUT': '86400', 08:22:15 INFO - 'USER': 'cltbld', 08:22:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:15 INFO - '_': '/tools/buildbot/bin/python'} 08:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:15 INFO - Downloading/unpacking jsonschema 08:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:17 INFO - Downloading/unpacking functools32 (from jsonschema) 08:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:18 INFO - warning: no files found matching '*.txt' 08:22:18 INFO - no previously-included directories found matching 'build' 08:22:18 INFO - no previously-included directories found matching 'dist' 08:22:18 INFO - no previously-included directories found matching '.git*' 08:22:18 INFO - Installing collected packages: jsonschema, functools32 08:22:18 INFO - Running setup.py install for functools32 08:22:18 INFO - warning: no files found matching '*.txt' 08:22:18 INFO - no previously-included directories found matching 'build' 08:22:18 INFO - no previously-included directories found matching 'dist' 08:22:18 INFO - no previously-included directories found matching '.git*' 08:22:18 INFO - Successfully installed jsonschema functools32 08:22:18 INFO - Cleaning up... 08:22:18 INFO - Return code: 0 08:22:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8adef26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', '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 08:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:22:18 INFO - Using env: {'DISPLAY': ':0', 08:22:18 INFO - 'HOME': '/home/cltbld', 08:22:18 INFO - 'LANG': 'en_US.UTF-8', 08:22:18 INFO - 'LANGUAGE': 'en_US:en', 08:22:18 INFO - 'LOGNAME': 'cltbld', 08:22:18 INFO - 'MAIL': '/var/mail/cltbld', 08:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:18 INFO - 'MOZ_NO_REMOTE': '1', 08:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:18 INFO - 'NO_EM_RESTART': '1', 08:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:18 INFO - 'PWD': '/builds/slave/test', 08:22:18 INFO - 'SHELL': '/bin/bash', 08:22:18 INFO - 'SHLVL': '1', 08:22:18 INFO - 'TERM': 'linux', 08:22:18 INFO - 'TMOUT': '86400', 08:22:18 INFO - 'USER': 'cltbld', 08:22:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:18 INFO - '_': '/tools/buildbot/bin/python'} 08:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:18 INFO - Downloading/unpacking flake8 08:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:22:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:22:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:21 INFO - no previously-included directories found matching 'docs/_build' 08:22:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:22:21 INFO - Running setup.py install for pep8 08:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:21 INFO - no previously-included directories found matching 'docs/_build' 08:22:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:22:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:22:21 INFO - Cleaning up... 08:22:21 INFO - Return code: 0 08:22:21 INFO - Running post-action listener: _resource_record_post_action 08:22:21 INFO - Running post-action listener: _start_resource_monitoring 08:22:21 INFO - Starting resource monitoring. 08:22:21 INFO - ##### 08:22:21 INFO - ##### Running install step. 08:22:21 INFO - ##### 08:22:21 INFO - Running pre-action listener: _resource_record_pre_action 08:22:21 INFO - Running main action method: install 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:21 INFO - Reading from file tmpfile_stdout 08:22:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:21 INFO - Reading from file tmpfile_stdout 08:22:21 INFO - Output received: 08:22:21 INFO - Usage: mozinstall [options] installer 08:22:21 INFO - Options: 08:22:21 INFO - -h, --help show this help message and exit 08:22:21 INFO - -d DEST, --destination=DEST 08:22:21 INFO - Directory to install application into. [default: 08:22:21 INFO - "/builds/slave/test"] 08:22:21 INFO - --app=APP Application being installed. [default: firefox] 08:22:21 INFO - mkdir: /builds/slave/test/build/application 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:38 INFO - Reading from file tmpfile_stdout 08:22:38 INFO - Output received: 08:22:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:38 INFO - Running post-action listener: _resource_record_post_action 08:22:38 INFO - ##### 08:22:38 INFO - ##### Running run-tests step. 08:22:38 INFO - ##### 08:22:38 INFO - Running pre-action listener: _resource_record_pre_action 08:22:38 INFO - Running main action method: run_tests 08:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:38 INFO - Python 2.7.3 08:22:38 INFO - Return code: 0 08:22:38 INFO - grabbing minidump binary from tooltool 08:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:38 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 0x28ea640>, '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 0x28eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28eb9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:38 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 08:22:38 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 08:22:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:38 INFO - Return code: 0 08:22:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:39 INFO - Return code: 0 08:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 08:22:39 INFO - Using env: {'DISPLAY': ':0', 08:22:39 INFO - 'HOME': '/home/cltbld', 08:22:39 INFO - 'LANG': 'en_US.UTF-8', 08:22:39 INFO - 'LANGUAGE': 'en_US:en', 08:22:39 INFO - 'LOGNAME': 'cltbld', 08:22:39 INFO - 'MAIL': '/var/mail/cltbld', 08:22:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:39 INFO - 'MOZ_NO_REMOTE': '1', 08:22:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:39 INFO - 'NO_EM_RESTART': '1', 08:22:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:39 INFO - 'PWD': '/builds/slave/test', 08:22:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:39 INFO - 'SHELL': '/bin/bash', 08:22:39 INFO - 'SHLVL': '1', 08:22:39 INFO - 'TERM': 'linux', 08:22:39 INFO - 'TMOUT': '86400', 08:22:39 INFO - 'USER': 'cltbld', 08:22:39 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110', 08:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:39 INFO - '_': '/tools/buildbot/bin/python'} 08:22:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:22:39 INFO - mozversion application_buildid: 20160415053237 08:22:39 INFO - mozversion application_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 08:22:39 INFO - mozversion application_display_name: Nightly 08:22:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:39 INFO - mozversion application_name: Firefox 08:22:39 INFO - mozversion application_remotingname: firefox 08:22:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:39 INFO - mozversion application_vendor: Mozilla 08:22:39 INFO - mozversion application_version: 48.0a1 08:22:39 INFO - mozversion platform_buildid: 20160415053237 08:22:39 INFO - mozversion platform_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 08:22:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:39 INFO - mozversion platform_version: 48.0a1 08:22:39 INFO - using testdate: 1460733759 08:22:39 INFO - actual date: 1460733759 08:22:39 INFO - starting webserver on 'localhost:44976' 08:22:39 INFO - SUITE-START | Running 2 tests 08:22:39 INFO - TEST-START | dromaeo_css 08:22:39 INFO - operating with platform_type : linux_ 08:22:39 INFO - Initialising browser for dromaeo_css test... 08:22:39 INFO - TEST-INFO | started process 7058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUP5shY/profile http://localhost:44976/getInfo.html) 08:22:43 INFO - PROCESS | 7058 | 08:22:43 INFO - PROCESS | 7058 | (process:7125): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:43 INFO - PROCESS | 7058 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:22:43 INFO - PROCESS | 7058 | __metrics Screen width/height:1600/1200 08:22:43 INFO - PROCESS | 7058 | colorDepth:24 08:22:43 INFO - PROCESS | 7058 | Browser inner width/height: 1024/697 08:22:43 INFO - PROCESS | 7058 | __metrics 08:22:44 ERROR - PROCESS | 7058 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:22:45 INFO - TEST-INFO | 7058: exit 0 08:22:45 INFO - Browser initialized. 08:22:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:45 INFO - TEST-INFO | started process 7176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUP5shY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:47 INFO - PROCESS | 7176 | 08:22:47 INFO - PROCESS | 7176 | (process:7236): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:57 INFO - PROCESS | 7176 | RSS: Main: 163524608 08:22:57 INFO - PROCESS | 7176 | 08:23:46 INFO - PROCESS | 7176 | 1460733826647 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] 08:25:53 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44976/tests/dromaeo/cssquery-ext.html) 08:25:54 INFO - PROCESS | 7176 | RSS: Main: 168099840 08:25:54 INFO - PROCESS | 7176 | 08:28:56 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-ext.html (next: http://localhost:44976/tests/dromaeo/cssquery-jquery.html) 08:28:57 INFO - PROCESS | 7176 | RSS: Main: 165097472 08:28:57 INFO - PROCESS | 7176 | 08:31:58 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44976/tests/dromaeo/cssquery-mootools.html) 08:31:59 INFO - PROCESS | 7176 | RSS: Main: 166354944 08:31:59 INFO - PROCESS | 7176 | 08:35:01 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44976/tests/dromaeo/cssquery-prototype.html) 08:35:01 INFO - PROCESS | 7176 | RSS: Main: 163905536 08:35:01 INFO - PROCESS | 7176 | 08:38:04 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44976/tests/dromaeo/cssquery-yui.html) 08:38:04 INFO - PROCESS | 7176 | RSS: Main: 165027840 08:38:04 INFO - PROCESS | 7176 | 08:41:06 INFO - PROCESS | 7176 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-yui.html (next: http://localhost:44976/tests/dromaeo/cssquery-dojo.html) 08:41:07 INFO - PROCESS | 7176 | RSS: Main: 167112704 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | __start_tp_report 08:41:07 INFO - PROCESS | 7176 | _x_x_mozilla_page_load 08:41:07 INFO - PROCESS | 7176 | _x_x_mozilla_page_load_details 08:41:07 INFO - PROCESS | 7176 | |i|pagename|runs| 08:41:07 INFO - PROCESS | 7176 | |0;dojo.html;3037.498812695905;3088.4903990841512;3096.5200393938935;3103.75169986401;3120.6879312068795;5292.841214763558;5313.840584782458;5330.147176451768;5351.25082488452;5408.567314614831;5269.65747226431;5339.332583427072;5358.062339090663;5453.863653408666;5473.2063850741615;4878.024395120981;4908.975455122737;4959.727215003173;4993.300937868701;5034.471380505049;351.1153194377277;4774.59415949643;4879;4928.457869634337;4934.4325402578625;4888.755562221892;4889.3399391082285;4909.950900490985;4920.3111564381015;4945.604351651859;4879.756012199411;4930.876728081791;4943.1102401567705;4943.752812359367;4950.702957822542;4832.395950506187;4873.610111191097;4878.219484882437;4896.4124305083615;4919.852404427873;5235.083860324428;5239.397469291042;5286.3392075990505;5286.471352864722;5304.310439642822;5520.392756796749;5560.6941618210985;5740.483356497935;5750.712464376765;5763.366029736726;5741.19623252745;5750.453706897838;5755.654660720328;5781.479666829963;5786.161006654053;5389.67661940281;5396.43337449566;5426.62013659044;5431.755570999315;5435.701036442994;5890.8821823563285;5921.111833224964;5941.940580594225;5953.374895635982;5989.371116032754;5586.776528938878;5627.6904770237215;5630.662160270315;5635.887282254332;5646.040173170571;5736.139579063174;5737.225474560964;5737.799177028784;5739.483446489836;5744.4829965303325;5589.8602534936135;5747.48272655463;5758.942410575841;5763;5824.534037277008;5600.551955843523;5625.38120806711;5635.436456354414;5658.7170641467765;5676.318841739017;4202.033532287591;4279.807408666617;4289.549597292239;4297.957020429756;4299.914001719948;3849.3263678856088;3866.6326698963553;3869.806509674505;3880;3941.3299739044432;5405.324334458192;5452;5548.944510554843;5550.583706221969;5602.775888964477;5676.375598684142;5728.570357223225;5731.140328950691;5732.6847023413275;5734.655920644775;5383.569314454834;5485.945140548623;5522.972385138049;5556.749946252428;5581.609287349927;4723.385959825201;4725.5510726480925;4742.834000809955;4756.9286460703115;4757.666963312535;5862.14998825168;5862.560307976919;5867.647941123546;5902.1146827976145;5925.703714814242;5684.545236381162;5695.231143795535;5713.143028545752;5763.279590051244;5769.336526299529;5919.526437884872;5921.171036055042;5935.673537955454;5939.2575928009;5949.553783466344;5503.697296648723;5611.298587676541;5614.70861701819;5625.015622266005;5629.493345598916;5739.8852022960145;5756.539476841759;5756.740946657326;5758.654480731169;5815.505682017076;5544.528715059265;5567.387587365306;5619.044762390486;5621.269234999588;5637.069883469182;5477.698726570077;5595.580331475075;5598.356189038313;5621.072523033818;5623.690697011703;5506.311711036121;5536.086545719912;5548;5561.277033985556;5579.330480342385;5566.415526369835;5611.57913156523;5637.154426836008;5646.604737668488;5686.744096515584;5461.972690136524;5531.668099914018;5549.084401073777;5588;5600.383957764724 08:41:07 INFO - PROCESS | 7176 | |1;ext.html;598.4793229889997;645.8611398549314;652.7682672651209;669.99665001675;688.1260798785539;35112.297754044936;35834.64165358346;36257.45613815795;36278.818605906934;36344.45483317752;36761;37631.62368376315;37764.62235377645;37805;38014.239715205746;8513.063563008063;8754.343424243176;8760.255378292853;8767.780805479882;8861.601227944759;8695.173958473935;8707.216350528452;8747.300215982737;8786.60460279289;8789.516576588285;8753.343499237551;8796.296296296314;8802.163794439519;8805.20753132218;8816.8677469838;8701.564921753887;8710.912890871074;8740.606672699743;8768.868466973001;8829.470231786048;8657.26413254874;8697.565121743888;8728.956355218246;8760.474371537728;8778.868316975251;31012.22469438282;37998.810005949796;38063.61936380656;38338.80830595857;38434;3274.9345013099605;3377.392069427502;3405.8126803025825;3420.2817408344276;3429.639887811794;30089.398212035856;30279.243018924484;30688;30829.53755693644;31269.218269543217;4224.260754367973;4291.442112525352;4340.58764417383;4353.064091220371;4384;244755;252077;253382;253820;311875.99999999773;60795.392046078974;61757.382426175165;62142.68928655328;62173.37826621766;62475.6876215616;64670;66065.33934660688;66081;66378;66419;15995.440159594591;16410.1794910254;16412.1793910304;16413.097279649493;16424.096674683005;12926.353682315847;12957.287349195885;13021.47914083426;13036.80444793329;13073.673158171121;20187;20248;20264.493387665425;20391.082401291977;20416.489587760127;7602.163761986177;7602.657880395285;7680.4623676343235;7825.908766037383;7960.442769006229;999.8000399919899;1030.8762948446085;1035.7876635289747;1087.505185140759;1171.812509998396;31851.681483185333;32060.198495037344;32150.35699286001;32207.51688724671;32953.17617059593;1061.9309744866714;1119.8880111988735;1125.426032723317;1247.2267194339568;1275.2029981261712;16884.831151688573;16939.745903811454;17123.914380428017;17162.141892905554;17210.39763608268;472227;477598;478484;480828;483183;57418.7129064352;58380.7080964601;58442.41557584455;58589.707051465324;58677.41322586805;1377.9931100344634;1379.0760190672274;1392.78411846164;1423.772196448584;1483.3028476615973;30283.242918927204;30846;30887.382252355277;31739.20651983719;31813.681863182;50193.24710129424;50643.49356506535;50673.493265068355;50953.23570146377;51026.489735103656;333646;335172;335292;335597;336431;28515.572266416435;43383.74621903433;44201.11597768091;44712.32931505965;45265;42821;42837.14325713531;43072.78463607662;43346.566534334255;47790.283145752146;39928.40107398333;39963.80018099891;40095.599044010356;40128.39807402833;40357;37989.430158548195;39130.4130438038;39348.606513935636;39484.802575986934;39974.60025399709;39783.204335913695;41403;41909;42289;42914;29611.851940740158;34154;34175;34401.827990859885;34804.129896752784;26745;27645.58531621987;27655.446891062467;27855.16434506968;28124.578131328457 08:41:07 INFO - PROCESS | 7176 | |2;jquery.html;399.7901101921491;400.6074047433515;404.5913627236491;408.0858876117494;410.7371282379278;12903.16129451585;14399.496017639385;17363.913180434098;17899.910500447495;17909.104544772774;16765.077920714357;17056.23246953887;17186.398476053342;17205.483835484956;17783;4947.653664243504;5368.812091576786;5553.305836770403;5562.443755624446;5613.66318020918;5473.17902314652;5496.80761173359;5533.501984821365;5564.1931919871795;5590.91613625796;5233.241180028894;5415.619017150621;5462;5481.287432633772;5497.065498865182;5509.201165830972;5531.059719847635;5531.142672885689;5544.889102217973;5545.861353466155;4720.693154944917;4893.902121957576;4927.556519913225;4935.679180853233;4940.925886111711;20562.177512899467;21205.045772940255;21310.893445532674;21409.35771926829;21416;2223.4107961390246;2411.2766170148884;2412.0954642009247;2634.3677517395686;2902.1003488918504;8780.473171609723;9476.384035037769;13539.39072741719;13787.793183102161;14150.858491415058;1921.932732354361;1926.9421917342502;1958.5201625601676;1964.0768838645813;1987.2945104487987;69885.3011469884;79201.20798791996;79378.60310698468;79494.20505794926;80018;10274.486275686186;10516.894831051744;10598.523066462029;10755.83866242007;10815.242932994615;14744;14827.40690372373;14925.552233433014;14944.476943306932;15035.646791788573;7891.960540197377;8061.911641928382;8217.753467395987;8280.213379728915;8329.37529685276;7778.611069446505;7868.291853733077;7887.487313324616;7958.243966823143;8010.078840933367;4539.9773001135445;4586.72479651222;4626.907461850744;4660.836870709509;4683.039976804746;1914.1864707499258;1927.8939658318927;1940.4760714606978;1983.454549998733;1984.107151781704;882.1266945723816;908.6320040383655;947.4173383369316;955.5890966884307;957.8419560772534;17081;17734.29062837498;17781.288748450177;17934.461966141036;18266.178021989042;998.2064258914181;1025.3847691385108;1043.8068957242783;1061.2306078093475;1070.1438848920832;9826.017398260117;9876.703698889045;10002.299839011344;10003.299769016245;10016.849747253797;440936;459750;461283;461794;461918;84922.57538712266;88923.11076889148;92840.53579732194;93566;93576.53211734034;1031.9174466042698;1034.6895931220604;1036.896310368972;1050.2123407444417;1060.7666313411037;15898.966567173096;16001.599960001093;16068;16072.598185045468;16082.758758618396;35878;36800.63199367972;37399.813000934824;37614;38647.6135238644;49564;50702.49297506978;50891.74554127206;56458.153127702295;59485;7921.881171782543;7958.681652734057;8078.596070196584;8084.393670474856;8139.79650508742;11408.54365825391;12210.633680989584;12231.510739570673;12335.568255111028;12723.491060357852;10826;10906.727331816768;11085.50115244832;11219.831702524632;11260.324380537195;10450.843237351597;10581.31221470602;10585.9470702646;10725;10860.076893464144;10746.140308775435;10851.891481085087;11029.283096598696;11225.887741122484;11548.191626586058;7855.450118491651;7890.763277101696;7945.48354356965;8240.546769927712;8246.216609422096;10323.019313165238;10478.738031549272;10494.947525262325;10609.8939010612;10733.892661073289 08:41:07 INFO - PROCESS | 7176 | |3;mootools.html;1518.1346632419518;1533.7699345098238;1681.7729606503126;1764.8676349273808;1794.8653850961182;7508.849823003537;8099.959500202491;8109.553974531405;8351.373646976479;8391.370647201455;8067.112617612058;8139.38954578406;8151.959240203791;8170.346372290217;8187.426880118394;2320.21112821641;2333.3816538617193;2341.94145146371;2346.812255019603;2355.882205889707;2232.7655596162413;2256.808171305441;2287.9771202288016;2294.0594356313914;2299.908003679851;2185.7158569385956;2218.911243550256;2223.4552534628956;2226.6882636430914;2242.372135801978;2238.6977758002786;2246.5731511012937;2253.4141123307977;2261.7625149359246;2262.309995451387;2200.207925146946;2215.080741492279;2215.5125872308067;2226.9331920042423;2228.8774117423536;8197.836043279101;8268.586570671443;8318.500889946563;8337.95831020841;8347.83304333916;5047.394312682465;5117.897642047175;5166.9224961625605;5215.530602245778;5224.346956630421;3128.4994400895976;3146.0876345859674;3258.152880251128;3280.0815771583993;3283.5567198428143;1105.7284123258237;1110.5169251375596;1111.6776134920863;1112.7830073135742;1121.0919155484085;11741.706457338549;11784.469698863571;11785.823212651818;11796;11848.46681899308;4296.2911119664905;4478.798454069574;4580.358749775034;4599.264117741212;4636.675432719677;10059.748506287255;10066.798664026679;10072.043155900177;10081.344712593658;10085.193184545218;5154.329937108227;5164.8192313268855;5169.974150129226;5179.093658609729;5182.97408512955;4172.645325147397;4627.583517483443;4729.7398643074275;4733.290006499053;4765.737884416321;3899.590542992945;3916.6083391660604;3972.8609498667406;4010.839566417369;4025.154717509356;1243.8383010208615;1250.8248845161684;1271.0911698135876;1307.6861553227156;1314.6319030671427;896.4755617963565;942;962.9133377996014;972.2222222222194;993.5777294649745;5576.749046292926;5632.3804381518;5769.394213607595;5901.852453688693;5945.970270148621;870.1994165367877;951.2580187453797;990.881094268678;1002.4085789384153;1012.2256473797551;4049.392591111357;4071.246819338432;4080.81636326366;4098.221337945781;4128.504579450485;10372.11836993849;10672.733181670521;10759;10841.728956776144;10849.728756781144;10536.525856336484;10606.204534659777;10667.946660266649;10694.89305106939;10708.411037392862;7907.802304942307;8117;8184.2634162926815;8226.712065077694;8248.670053197804;5675.886482270249;5836.591438599257;5873.588848780544;5895.616784908967;5983.162357269899;9721.076497732704;9724.076212759777;9735.026497350209;9755.804883902425;9868.753281168028;9468.289878259297;9986.500674966368;10071.295009349567;10185.592576296865;10246.282760206714;6571.901421478778;7128.251533588898;7176.461765367514;7247.2390399007345;7314.890276645748;8238;8239.670413183405;8264.090949995616;8269.21442462965;8315.750527484186;7282.563046217244;7386.815329616803;7464.066991626047;7526.924730752622;7701.499402538817;7279.963600181965;7391.556506609621;7408.407327413902;7409.851802963803;7522.5862577558755;6757;6818.727250909908;6820.3861652451515;6869.484788640772;6890.207626122859;4903.117438861039;4914.70511769295;5002.574781143643;5138.100832354397;5232.633715639869;5098.133317335987;5193.584513238856;5223.764930578209;5231.450697676689;5287.68273903567 08:41:07 INFO - PROCESS | 7176 | |4;prototype.html;329.1852664654979;331.3885880550385;336.94103531881916;340.91758666234705;344.3938667944417;5815.73829177687;5831.154482600021;5839.9124013139835;5955.315138759044;5976.252968378958;5792.304923409197;5819.214406055181;5846;5909.409059094089;5939.821805345847;4470.2400591899295;4499.977500112494;4522.819087236515;4555.293929440942;4565.21521871658;4468.419105516295;4516.4806047304655;4577.931331030038;4581.198290299201;4590.42619672541;4511.300748384006;4512.548745125478;4516.390287311204;4527.09458108378;4548.454185497745;4497.325401189815;4534.682572219913;4543.61379282763;4543.931841022388;4552.6130278926;3887.105965627893;4001.3597824347967;4003.539592946819;4011.6389524942897;4014.7992600370158;5681.23303354046;5685.317761868561;5704.258446401983;5710.828675139753;5715.485606295411;5253.553447956928;5259.21111833228;5263.131583288753;5264.605154613381;5266.131088370453;6007.939920600782;6187.16473276111;6198.946179149555;6209.9379006210265;6226.252849658024;4230.259704551691;4258.87223383299;4270.274053410928;4294.377315289296;4306.784660766949;6380.3619638035825;6426.4216220540375;6433.646149461778;6438.25960014595;6451.645159516224;4464.508904020555;4491.955080449219;4503.752293623882;4514.683972121986;4524.6380289576755;4517.412736344254;4533.637309015271;4550.47669518003;4563.726176429424;4565.908681826411;5215.55667768244;5221;5229.084910140787;5235.240890070919;5239.214117882349;5837.562182836305;5914.733836977346;6072.483838873745;6208.9689551551955;6218.502519798405;1515.8938874278695;1531.5175719648275;1542.9537113886602;1543.691261747655;1546.57469195972;1006.5772375602264;1020.2195320579763;1028.0901402258905;1031.6079889641887;1049.103016920522;5941.821745347646;5958.851028724316;6006.189164462829;6017.608855424383;6021.879562408727;6328.272248691367;6355.777547785805;6373.075903993895;6394.9680251599375;6425.228972523327;5861.120831875168;5914.172015917775;5994.860976414468;6010.7677926025935;6038.124471951543;3373.5614370132216;3375.5443015192636;3395.7792743471596;3411.761176717606;3427;6421.3578642136345;6579.80260592183;6585.727923866259;6591.736330546724;6629.237637671729;6415.807525774234;6431.5819471734185;6446.580972236789;6447.161868957006;6471.935280647133;6451.129097571861;6479;6604.900926486107;6618.7021584028835;6631.204255489372;6275.717592708248;6318.368163183645;6357.237131544244;6363.713632886624;6389.424951754364;6169.969662345906;6246.906296405648;6250.593711408744;6273.309935906956;6283.994560870239;6475.125858009297;6593.901091483535;6599.7360105595235;6608.966955165193;6662.133922590032;4313.870583882489;4326.134773045466;4381.5618438155925;4392.231359512009;4394.1870753910625;6236.282827474898;6328.208973878265;6344.333844946399;6355.618662880242;6385.7126429309865;6177.4749146323065;6178.042403427476;6189.752409903554;6192.845178870564;6204.565680402328;6024.186734790923;6118.174046503665;6173.81478555644;6197.690115494297;6258.843528911813;6004.249468816398;6047.818565443044;6053.547148684196;6072.210612620331;6106;6250.343713910156;6259.906101408392;6261.436470717657;6284.402981716729;6291.213598300213;5909.763609455574;6113.877722445615;6235.3452887446165;6255.749770009331;6264.561480696308 08:41:07 INFO - PROCESS | 7176 | |5;yui.html;635.2599221906479;638.7169946475121;653.7287025884258;678.3047376439149;680.5814424129161;13267.33663316834;13554.051216414842;13582.52461163857;13592.660183495418;13606.93196534016;12735.108542402035;12772.68068298293;12822.038347123957;12822.230666160014;12859.871401285984;629.3109045595066;752.5221484357445;753.6005916864057;778.4900889917113;779.6608475313228;761.375671949002;765.387689848122;767.4282659418741;771.3366504805863;773.3156156801243;821.4414198345123;821.6549049399266;822.0176888618104;822.2271065198725;823.3948048184579;810.0401024785648;811.2212276214841;813.3818298093432;814.9918500815005;815.5881279953616;591.8076625096818;593.2999061107892;593.5726277080538;594.2542109652402;594.4738906068118;13491.392887319997;13507.66230844227;13535.187888726708;13546.051776375658;13594.456221751117;13169.670758231025;13251.46994120234;13397.464101435931;13632.318384080756;13906.235157066358;10100.696979090639;10149.543270552844;10198.541065652063;10270;10282.845757313646;3734.869279575229;3758.49260349852;3763.9247215055548;3785.9242815143543;3840.8655697050467;51419.48580514184;52483;52718.47281527212;52984.47015529795;56854.715726421106;9456.243500519942;9543.236541076698;9764.804703906024;9799.363041402286;9806.656767013263;16203.83796162047;16303;16308.347666093223;16321.34714611426;16333.428330008393;7913.248241417056;7941.523508589503;7986.720464783704;8114.188581141839;8234.341252699769;4858.149823780895;4866.31871537985;4895.58047526148;4924.9507504925205;4965.577925876341;3093.8453077346044;3164.098232003868;3172.888948886778;3183.2041989502623;3183.379241047973;624.6938999890112;626.4424662050778;627.2191122052982;630.5617595770896;633.0409429713987;582.959192856496;647.8283254937445;720.679297712513;725.6915810780397;746.1941103608199;7760.844783104306;7921.722739704198;7984.24149705777;8014.679412823421;8047.718329858427;662.2218892800939;702.9789106326818;721.2426951700693;721.4264659595634;726.1141407482862;3980.3034468967817;4008.07814202735;4008.2584721826556;4024.9798751006056;4128.2156390285745;61912;61960.38039619546;62520.687396562724;63253;63517.364826352066;55491.72254138703;55613;56049.159262611094;56368;56853.431465685644;51115.23327150021;51239.231411528854;51568.22647660213;51643;52222;7563.621818909142;7713.074431068308;7802.921970780219;7825.139234684294;7881.9211807883485;32285.51571726473;32950.34099318048;33064.50403243905;33186.17034574155;33205.83397082999;42110.36834447547;45282.773586133175;46397.30404043874;46416.535834641225;46447.53552464432;9834.803303933739;9865.802683946424;10088.596456141671;10167;10200.0819926207;11734.237274577124;11887.346195958959;12018.278903265833;12021.338826364634;12068.396580171131;10555.525001374803;10665.89334106649;10751.13990880712;11027.558897644005;11030.944845275722;10778.13774898022;10840.837387439036;11037.172212083966;11219.55121795119;11298.830517542408;10561.63034293796;10623.309484883457;10715.464226788474;10747.677569672922;10820.945895270474;9413.952930235306;9701.272404569545;9901.851472228067;9906.851397229191;9933.751656208653;8818.647254110021;8923.196912277926;8927.553622318988;9002.864957025518;9059.864102038342 08:41:07 INFO - PROCESS | 7176 | __end_tp_report 08:41:07 INFO - PROCESS | 7176 | __start_cc_report 08:41:07 INFO - PROCESS | 7176 | _x_x_mozilla_cycle_collect,345 08:41:07 INFO - PROCESS | 7176 | __end_cc_report 08:41:07 INFO - PROCESS | 7176 | __startTimestamp1460734867122__endTimestamp 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | ------- Summary: start ------- 08:41:07 INFO - PROCESS | 7176 | Number of tests: 6 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#0] dojo.html Cycles:165 Average:5293.81 Median:5556.75 stddev:724.70 (13.0%) stddev-sans-first:704.97 08:41:07 INFO - PROCESS | 7176 | Values: 3037.5 3088.5 3096.5 3103.8 3120.7 5292.8 5313.8 5330.1 5351.3 5408.6 5269.7 5339.3 5358.1 5453.9 5473.2 4878.0 4909.0 4959.7 4993.3 5034.5 351.1 4774.6 4879.0 4928.5 4934.4 4888.8 4889.3 4910.0 4920.3 4945.6 4879.8 4930.9 4943.1 4943.8 4950.7 4832.4 4873.6 4878.2 4896.4 4919.9 5235.1 5239.4 5286.3 5286.5 5304.3 5520.4 5560.7 5740.5 5750.7 5763.4 5741.2 5750.5 5755.7 5781.5 5786.2 5389.7 5396.4 5426.6 5431.8 5435.7 5890.9 5921.1 5941.9 5953.4 5989.4 5586.8 5627.7 5630.7 5635.9 5646.0 5736.1 5737.2 5737.8 5739.5 5744.5 5589.9 5747.5 5758.9 5763.0 5824.5 5600.6 5625.4 5635.4 5658.7 5676.3 4202.0 4279.8 4289.5 4298.0 4299.9 3849.3 3866.6 3869.8 3880.0 3941.3 5405.3 5452.0 5548.9 5550.6 5602.8 5676.4 5728.6 5731.1 5732.7 5734.7 5383.6 5485.9 5523.0 5556.7 5581.6 4723.4 4725.6 4742.8 4756.9 4757.7 5862.1 5862.6 5867.6 5902.1 5925.7 5684.5 5695.2 5713.1 5763.3 5769.3 5919.5 5921.2 5935.7 5939.3 5949.6 5503.7 5611.3 5614.7 5625.0 5629.5 5739.9 5756.5 5756.7 5758.7 5815.5 5544.5 5567.4 5619.0 5621.3 5637.1 5477.7 5595.6 5598.4 5621.1 5623.7 5506.3 5536.1 5548.0 5561.3 5579.3 5566.4 5611.6 5637.2 5646.6 5686.7 5462.0 5531.7 5549.1 5588.0 5600.4 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#1] ext.html Cycles:180 Average:53203.40 Median:38782.21 stddev:97811.51 (252.2%) stddev-sans-first:98006.15 08:41:07 INFO - PROCESS | 7176 | Values: 598.5 645.9 652.8 670.0 688.1 35112.3 35834.6 36257.5 36278.8 36344.5 36761.0 37631.6 37764.6 37805.0 38014.2 8513.1 8754.3 8760.3 8767.8 8861.6 8695.2 8707.2 8747.3 8786.6 8789.5 8753.3 8796.3 8802.2 8805.2 8816.9 8701.6 8710.9 8740.6 8768.9 8829.5 8657.3 8697.6 8729.0 8760.5 8778.9 31012.2 37998.8 38063.6 38338.8 38434.0 3274.9 3377.4 3405.8 3420.3 3429.6 30089.4 30279.2 30688.0 30829.5 31269.2 4224.3 4291.4 4340.6 4353.1 4384.0 244755.0 252077.0 253382.0 253820.0 311876.0 60795.4 61757.4 62142.7 62173.4 62475.7 64670.0 66065.3 66081.0 66378.0 66419.0 15995.4 16410.2 16412.2 16413.1 16424.1 12926.4 12957.3 13021.5 13036.8 13073.7 20187.0 20248.0 20264.5 20391.1 20416.5 7602.2 7602.7 7680.5 7825.9 7960.4 999.8 1030.9 1035.8 1087.5 1171.8 31851.7 32060.2 32150.4 32207.5 32953.2 1061.9 1119.9 1125.4 1247.2 1275.2 16884.8 16939.7 17123.9 17162.1 17210.4 472227.0 477598.0 478484.0 480828.0 483183.0 57418.7 58380.7 58442.4 58589.7 58677.4 1378.0 1379.1 1392.8 1423.8 1483.3 30283.2 30846.0 30887.4 31739.2 31813.7 50193.2 50643.5 50673.5 50953.2 51026.5 333646.0 335172.0 335292.0 335597.0 336431.0 28515.6 43383.7 44201.1 44712.3 45265.0 42821.0 42837.1 43072.8 43346.6 47790.3 39928.4 39963.8 40095.6 40128.4 40357.0 37989.4 39130.4 39348.6 39484.8 39974.6 39783.2 41403.0 41909.0 42289.0 42914.0 29611.9 34154.0 34175.0 34401.8 34804.1 26745.0 27645.6 27655.4 27855.2 28124.6 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#2] jquery.html Cycles:180 Average:27240.97 Median:36339.32 stddev:75503.76 (207.8%) stddev-sans-first:75688.67 08:41:07 INFO - PROCESS | 7176 | Values: 399.8 400.6 404.6 408.1 410.7 12903.2 14399.5 17363.9 17899.9 17909.1 16765.1 17056.2 17186.4 17205.5 17783.0 4947.7 5368.8 5553.3 5562.4 5613.7 5473.2 5496.8 5533.5 5564.2 5590.9 5233.2 5415.6 5462.0 5481.3 5497.1 5509.2 5531.1 5531.1 5544.9 5545.9 4720.7 4893.9 4927.6 4935.7 4940.9 20562.2 21205.0 21310.9 21409.4 21416.0 2223.4 2411.3 2412.1 2634.4 2902.1 8780.5 9476.4 13539.4 13787.8 14150.9 1921.9 1926.9 1958.5 1964.1 1987.3 69885.3 79201.2 79378.6 79494.2 80018.0 10274.5 10516.9 10598.5 10755.8 10815.2 14744.0 14827.4 14925.6 14944.5 15035.6 7892.0 8061.9 8217.8 8280.2 8329.4 7778.6 7868.3 7887.5 7958.2 8010.1 4540.0 4586.7 4626.9 4660.8 4683.0 1914.2 1927.9 1940.5 1983.5 1984.1 882.1 908.6 947.4 955.6 957.8 17081.0 17734.3 17781.3 17934.5 18266.2 998.2 1025.4 1043.8 1061.2 1070.1 9826.0 9876.7 10002.3 10003.3 10016.8 440936.0 459750.0 461283.0 461794.0 461918.0 84922.6 88923.1 92840.5 93566.0 93576.5 1031.9 1034.7 1036.9 1050.2 1060.8 15899.0 16001.6 16068.0 16072.6 16082.8 35878.0 36800.6 37399.8 37614.0 38647.6 49564.0 50702.5 50891.7 56458.2 59485.0 7921.9 7958.7 8078.6 8084.4 8139.8 11408.5 12210.6 12231.5 12335.6 12723.5 10826.0 10906.7 11085.5 11219.8 11260.3 10450.8 10581.3 10585.9 10725.0 10860.1 10746.1 10851.9 11029.3 11225.9 11548.2 7855.5 7890.8 7945.5 8240.5 8246.2 10323.0 10478.7 10494.9 10609.9 10733.9 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#3] mootools.html Cycles:180 Average:5626.03 Median:4908.91 stddev:3161.03 (64.4%) stddev-sans-first:3154.83 08:41:07 INFO - PROCESS | 7176 | Values: 1518.1 1533.8 1681.8 1764.9 1794.9 7508.8 8100.0 8109.6 8351.4 8391.4 8067.1 8139.4 8152.0 8170.3 8187.4 2320.2 2333.4 2341.9 2346.8 2355.9 2232.8 2256.8 2288.0 2294.1 2299.9 2185.7 2218.9 2223.5 2226.7 2242.4 2238.7 2246.6 2253.4 2261.8 2262.3 2200.2 2215.1 2215.5 2226.9 2228.9 8197.8 8268.6 8318.5 8338.0 8347.8 5047.4 5117.9 5166.9 5215.5 5224.3 3128.5 3146.1 3258.2 3280.1 3283.6 1105.7 1110.5 1111.7 1112.8 1121.1 11741.7 11784.5 11785.8 11796.0 11848.5 4296.3 4478.8 4580.4 4599.3 4636.7 10059.7 10066.8 10072.0 10081.3 10085.2 5154.3 5164.8 5170.0 5179.1 5183.0 4172.6 4627.6 4729.7 4733.3 4765.7 3899.6 3916.6 3972.9 4010.8 4025.2 1243.8 1250.8 1271.1 1307.7 1314.6 896.5 942.0 962.9 972.2 993.6 5576.7 5632.4 5769.4 5901.9 5946.0 870.2 951.3 990.9 1002.4 1012.2 4049.4 4071.2 4080.8 4098.2 4128.5 10372.1 10672.7 10759.0 10841.7 10849.7 10536.5 10606.2 10667.9 10694.9 10708.4 7907.8 8117.0 8184.3 8226.7 8248.7 5675.9 5836.6 5873.6 5895.6 5983.2 9721.1 9724.1 9735.0 9755.8 9868.8 9468.3 9986.5 10071.3 10185.6 10246.3 6571.9 7128.3 7176.5 7247.2 7314.9 8238.0 8239.7 8264.1 8269.2 8315.8 7282.6 7386.8 7464.1 7526.9 7701.5 7280.0 7391.6 7408.4 7409.9 7522.6 6757.0 6818.7 6820.4 6869.5 6890.2 4903.1 4914.7 5002.6 5138.1 5232.6 5098.1 5193.6 5223.8 5231.5 5287.7 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#4] prototype.html Cycles:180 Average:5191.18 Median:5914.45 stddev:1550.01 (26.2%) stddev-sans-first:1510.79 08:41:07 INFO - PROCESS | 7176 | Values: 329.2 331.4 336.9 340.9 344.4 5815.7 5831.2 5839.9 5955.3 5976.3 5792.3 5819.2 5846.0 5909.4 5939.8 4470.2 4500.0 4522.8 4555.3 4565.2 4468.4 4516.5 4577.9 4581.2 4590.4 4511.3 4512.5 4516.4 4527.1 4548.5 4497.3 4534.7 4543.6 4543.9 4552.6 3887.1 4001.4 4003.5 4011.6 4014.8 5681.2 5685.3 5704.3 5710.8 5715.5 5253.6 5259.2 5263.1 5264.6 5266.1 6007.9 6187.2 6198.9 6209.9 6226.3 4230.3 4258.9 4270.3 4294.4 4306.8 6380.4 6426.4 6433.6 6438.3 6451.6 4464.5 4492.0 4503.8 4514.7 4524.6 4517.4 4533.6 4550.5 4563.7 4565.9 5215.6 5221.0 5229.1 5235.2 5239.2 5837.6 5914.7 6072.5 6209.0 6218.5 1515.9 1531.5 1543.0 1543.7 1546.6 1006.6 1020.2 1028.1 1031.6 1049.1 5941.8 5958.9 6006.2 6017.6 6021.9 6328.3 6355.8 6373.1 6395.0 6425.2 5861.1 5914.2 5994.9 6010.8 6038.1 3373.6 3375.5 3395.8 3411.8 3427.0 6421.4 6579.8 6585.7 6591.7 6629.2 6415.8 6431.6 6446.6 6447.2 6471.9 6451.1 6479.0 6604.9 6618.7 6631.2 6275.7 6318.4 6357.2 6363.7 6389.4 6170.0 6246.9 6250.6 6273.3 6284.0 6475.1 6593.9 6599.7 6609.0 6662.1 4313.9 4326.1 4381.6 4392.2 4394.2 6236.3 6328.2 6344.3 6355.6 6385.7 6177.5 6178.0 6189.8 6192.8 6204.6 6024.2 6118.2 6173.8 6197.7 6258.8 6004.2 6047.8 6053.5 6072.2 6106.0 6250.3 6259.9 6261.4 6284.4 6291.2 5909.8 6113.9 6235.3 6255.7 6264.6 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - PROCESS | 7176 | [#5] yui.html Cycles:180 Average:14182.68 Median:52851.47 stddev:17267.88 (32.7%) stddev-sans-first:17286.35 08:41:07 INFO - PROCESS | 7176 | Values: 635.3 638.7 653.7 678.3 680.6 13267.3 13554.1 13582.5 13592.7 13606.9 12735.1 12772.7 12822.0 12822.2 12859.9 629.3 752.5 753.6 778.5 779.7 761.4 765.4 767.4 771.3 773.3 821.4 821.7 822.0 822.2 823.4 810.0 811.2 813.4 815.0 815.6 591.8 593.3 593.6 594.3 594.5 13491.4 13507.7 13535.2 13546.1 13594.5 13169.7 13251.5 13397.5 13632.3 13906.2 10100.7 10149.5 10198.5 10270.0 10282.8 3734.9 3758.5 3763.9 3785.9 3840.9 51419.5 52483.0 52718.5 52984.5 56854.7 9456.2 9543.2 9764.8 9799.4 9806.7 16203.8 16303.0 16308.3 16321.3 16333.4 7913.2 7941.5 7986.7 8114.2 8234.3 4858.1 4866.3 4895.6 4925.0 4965.6 3093.8 3164.1 3172.9 3183.2 3183.4 624.7 626.4 627.2 630.6 633.0 583.0 647.8 720.7 725.7 746.2 7760.8 7921.7 7984.2 8014.7 8047.7 662.2 703.0 721.2 721.4 726.1 3980.3 4008.1 4008.3 4025.0 4128.2 61912.0 61960.4 62520.7 63253.0 63517.4 55491.7 55613.0 56049.2 56368.0 56853.4 51115.2 51239.2 51568.2 51643.0 52222.0 7563.6 7713.1 7802.9 7825.1 7881.9 32285.5 32950.3 33064.5 33186.2 33205.8 42110.4 45282.8 46397.3 46416.5 46447.5 9834.8 9865.8 10088.6 10167.0 10200.1 11734.2 11887.3 12018.3 12021.3 12068.4 10555.5 10665.9 10751.1 11027.6 11030.9 10778.1 10840.8 11037.2 11219.6 11298.8 10561.6 10623.3 10715.5 10747.7 10820.9 9414.0 9701.3 9901.9 9906.9 9933.8 8818.6 8923.2 8927.6 9002.9 9059.9 08:41:07 INFO - PROCESS | 7176 | -------- Summary: end -------- 08:41:07 INFO - PROCESS | 7176 | 08:41:07 INFO - TEST-INFO | 7176: exit 0 08:41:07 INFO - TEST-OK | dromaeo_css | took 1108313ms 08:41:07 INFO - TEST-START | kraken 08:41:07 INFO - operating with platform_type : linux_ 08:41:07 INFO - Initialising browser for kraken test... 08:41:07 INFO - TEST-INFO | started process 7412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjd0VS9/profile http://localhost:44976/getInfo.html) 08:41:11 INFO - PROCESS | 7412 | 08:41:11 INFO - PROCESS | 7412 | (process:7480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:11 INFO - PROCESS | 7412 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:41:11 INFO - PROCESS | 7412 | __metrics Screen width/height:1600/1200 08:41:11 INFO - PROCESS | 7412 | colorDepth:24 08:41:11 INFO - PROCESS | 7412 | Browser inner width/height: 1024/697 08:41:11 INFO - PROCESS | 7412 | __metrics 08:41:12 ERROR - PROCESS | 7412 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:41:13 INFO - TEST-INFO | 7412: exit 0 08:41:13 INFO - Browser initialized. 08:41:13 INFO - Running cycle 1/1 for kraken test... 08:41:13 INFO - TEST-INFO | started process 7531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjd0VS9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:15 INFO - PROCESS | 7531 | 08:41:15 INFO - PROCESS | 7531 | (process:7592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:25 INFO - PROCESS | 7531 | RSS: Main: 163876864 08:41:25 INFO - PROCESS | 7531 | 08:41:27 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:28 INFO - PROCESS | 7531 | RSS: Main: 168214528 08:41:28 INFO - PROCESS | 7531 | 08:41:31 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-dft) 08:41:31 INFO - PROCESS | 7531 | RSS: Main: 171679744 08:41:31 INFO - PROCESS | 7531 | 08:41:34 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-fft) 08:41:35 INFO - PROCESS | 7531 | RSS: Main: 163778560 08:41:35 INFO - PROCESS | 7531 | 08:41:37 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator) 08:41:37 INFO - PROCESS | 7531 | RSS: Main: 163704832 08:41:37 INFO - PROCESS | 7531 | 08:41:40 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:40 INFO - PROCESS | 7531 | RSS: Main: 163835904 08:41:40 INFO - PROCESS | 7531 | 08:41:43 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:44 INFO - PROCESS | 7531 | RSS: Main: 164102144 08:41:44 INFO - PROCESS | 7531 | 08:41:48 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:48 INFO - PROCESS | 7531 | RSS: Main: 164286464 08:41:48 INFO - PROCESS | 7531 | 08:41:51 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial) 08:41:52 INFO - PROCESS | 7531 | RSS: Main: 164200448 08:41:52 INFO - PROCESS | 7531 | 08:41:53 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:54 INFO - PROCESS | 7531 | RSS: Main: 164798464 08:41:54 INFO - PROCESS | 7531 | 08:41:56 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:56 INFO - PROCESS | 7531 | RSS: Main: 164438016 08:41:56 INFO - PROCESS | 7531 | 08:41:58 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:59 INFO - PROCESS | 7531 | RSS: Main: 165138432 08:41:59 INFO - PROCESS | 7531 | 08:42:01 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:02 INFO - PROCESS | 7531 | RSS: Main: 165584896 08:42:02 INFO - PROCESS | 7531 | 08:42:05 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:06 INFO - PROCESS | 7531 | RSS: Main: 165437440 08:42:06 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44976/tests/kraken/driver.html?testName=ai-astar) 08:42:07 INFO - PROCESS | 7531 | RSS: Main: 166817792 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | __start_tp_report 08:42:07 INFO - PROCESS | 7531 | _x_x_mozilla_page_load 08:42:07 INFO - PROCESS | 7531 | _x_x_mozilla_page_load_details 08:42:07 INFO - PROCESS | 7531 | |i|pagename|runs| 08:42:07 INFO - PROCESS | 7531 | |0;ai-astar;116;107;114;114;111;123;111;112;112;111 08:42:07 INFO - PROCESS | 7531 | |1;audio-beat-detection;158;130;155;186;140;157;158;135;197;135 08:42:07 INFO - PROCESS | 7531 | |2;audio-dft;163;162;163;162;162;168;168;161;165;161 08:42:07 INFO - PROCESS | 7531 | |3;audio-fft;76;76;79;152;77;76;77;78;164;78 08:42:07 INFO - PROCESS | 7531 | |4;audio-oscillator;94;93;152;92;93;94;153;93;93;145 08:42:07 INFO - PROCESS | 7531 | |5;imaging-gaussian-blur;117;118;119;117;117;117;117;118;118;118 08:42:07 INFO - PROCESS | 7531 | |6;imaging-darkroom;147;148;146;147;148;149;146;148;146;146 08:42:07 INFO - PROCESS | 7531 | |7;imaging-desaturate;95;96;95;95;96;95;95;96;96;96 08:42:07 INFO - PROCESS | 7531 | |8;json-parse-financial;62;59;59;58;65;59;67;77;59;57 08:42:07 INFO - PROCESS | 7531 | |9;json-stringify-tinderbox;64;64;63;63;63;62;63;63;64;63 08:42:07 INFO - PROCESS | 7531 | |10;stanford-crypto-aes;77;76;75;77;76;78;78;77;77;77 08:42:07 INFO - PROCESS | 7531 | |11;stanford-crypto-ccm;125;125;135;130;126;129;125;127;159;130 08:42:07 INFO - PROCESS | 7531 | |12;stanford-crypto-pbkdf2;166;170;165;169;174;167;164;166;164;168 08:42:07 INFO - PROCESS | 7531 | |13;stanford-crypto-sha256-iterative;70;68;69;71;69;65;66;70;67;67 08:42:07 INFO - PROCESS | 7531 | __end_tp_report 08:42:07 INFO - PROCESS | 7531 | __start_cc_report 08:42:07 INFO - PROCESS | 7531 | _x_x_mozilla_cycle_collect,849 08:42:07 INFO - PROCESS | 7531 | __end_cc_report 08:42:07 INFO - PROCESS | 7531 | __startTimestamp1460734927943__endTimestamp 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | ------- Summary: start ------- 08:42:07 INFO - PROCESS | 7531 | Number of tests: 14 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:4.23 (3.7%) stddev-sans-first:4.35 08:42:07 INFO - PROCESS | 7531 | Values: 116.0 107.0 114.0 114.0 111.0 123.0 111.0 112.0 112.0 111.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:157.50 stddev:22.10 (14.0%) stddev-sans-first:23.42 08:42:07 INFO - PROCESS | 7531 | Values: 158.0 130.0 155.0 186.0 140.0 157.0 158.0 135.0 197.0 135.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.64 (1.6%) stddev-sans-first:2.79 08:42:07 INFO - PROCESS | 7531 | Values: 163.0 162.0 163.0 162.0 162.0 168.0 168.0 161.0 165.0 161.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#3] audio-fft Cycles:10 Average:93.30 Median:77.00 stddev:34.23 (44.5%) stddev-sans-first:35.73 08:42:07 INFO - PROCESS | 7531 | Values: 76.0 76.0 79.0 152.0 77.0 76.0 77.0 78.0 164.0 78.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:93.00 stddev:27.55 (29.6%) stddev-sans-first:28.59 08:42:07 INFO - PROCESS | 7531 | Values: 94.0 93.0 152.0 92.0 93.0 94.0 153.0 93.0 93.0 145.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:42:07 INFO - PROCESS | 7531 | Values: 117.0 118.0 119.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:42:07 INFO - PROCESS | 7531 | Values: 147.0 148.0 146.0 147.0 148.0 149.0 146.0 148.0 146.0 146.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:42:07 INFO - PROCESS | 7531 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:60.50 stddev:6.11 (10.1%) stddev-sans-first:6.48 08:42:07 INFO - PROCESS | 7531 | Values: 62.0 59.0 59.0 58.0 65.0 59.0 67.0 77.0 59.0 57.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 08:42:07 INFO - PROCESS | 7531 | Values: 64.0 64.0 63.0 63.0 63.0 62.0 63.0 63.0 64.0 63.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 08:42:07 INFO - PROCESS | 7531 | Values: 77.0 76.0 75.0 77.0 76.0 78.0 78.0 77.0 77.0 77.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:129.50 stddev:10.30 (8.0%) stddev-sans-first:10.69 08:42:07 INFO - PROCESS | 7531 | Values: 125.0 125.0 135.0 130.0 126.0 129.0 125.0 127.0 159.0 130.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.50 stddev:3.09 (1.8%) stddev-sans-first:3.24 08:42:07 INFO - PROCESS | 7531 | Values: 166.0 170.0 165.0 169.0 174.0 167.0 164.0 166.0 164.0 168.0 08:42:07 INFO - PROCESS | 7531 | 08:42:07 INFO - PROCESS | 7531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:1.94 08:42:07 INFO - PROCESS | 7531 | Values: 70.0 68.0 69.0 71.0 69.0 65.0 66.0 70.0 67.0 67.0 08:42:07 INFO - PROCESS | 7531 | -------- Summary: end -------- 08:42:07 INFO - PROCESS | 7531 | 08:42:08 INFO - TEST-INFO | 7531: exit 0 08:42:08 INFO - TEST-OK | kraken | took 61125ms 08:42:08 INFO - SUITE-END | took 1169s 08:42:09 INFO - Completed test suite (00:19:29) 08:42:09 INFO - javascript benchmark 08:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.498812695905, 3088.4903990841512, 3096.5200393938935, 3103.75169986401, 3120.6879312068795, 5292.841214763558, 5313.840584782458, 5330.147176451768, 5351.25082488452, 5408.567314614831, 5269.65747226431, 5339.332583427072, 5358.062339090663, 5453.863653408666, 5473.2063850741615, 4878.024395120981, 4908.975455122737, 4959.727215003173, 4993.300937868701, 5034.471380505049, 351.1153194377277, 4774.59415949643, 4879.0, 4928.457869634337, 4934.4325402578625, 4888.755562221892, 4889.3399391082285, 4909.950900490985, 4920.3111564381015, 4945.604351651859, 4879.756012199411, 4930.876728081791, 4943.1102401567705, 4943.752812359367, 4950.702957822542, 4832.395950506187, 4873.610111191097, 4878.219484882437, 4896.4124305083615, 4919.852404427873, 5235.083860324428, 5239.397469291042, 5286.3392075990505, 5286.471352864722, 5304.310439642822, 5520.392756796749, 5560.6941618210985, 5740.483356497935, 5750.712464376765, 5763.366029736726, 5741.19623252745, 5750.453706897838, 5755.654660720328, 5781.479666829963, 5786.161006654053, 5389.67661940281, 5396.43337449566, 5426.62013659044, 5431.755570999315, 5435.701036442994, 5890.8821823563285, 5921.111833224964, 5941.940580594225, 5953.374895635982, 5989.371116032754, 5586.776528938878, 5627.6904770237215, 5630.662160270315, 5635.887282254332, 5646.040173170571, 5736.139579063174, 5737.225474560964, 5737.799177028784, 5739.483446489836, 5744.4829965303325, 5589.8602534936135, 5747.48272655463, 5758.942410575841, 5763.0, 5824.534037277008, 5600.551955843523, 5625.38120806711, 5635.436456354414, 5658.7170641467765, 5676.318841739017, 4202.033532287591, 4279.807408666617, 4289.549597292239, 4297.957020429756, 4299.914001719948, 3849.3263678856088, 3866.6326698963553, 3869.806509674505, 3880.0, 3941.3299739044432, 5405.324334458192, 5452.0, 5548.944510554843, 5550.583706221969, 5602.775888964477, 5676.375598684142, 5728.570357223225, 5731.140328950691, 5732.6847023413275, 5734.655920644775, 5383.569314454834, 5485.945140548623, 5522.972385138049, 5556.749946252428, 5581.609287349927, 4723.385959825201, 4725.5510726480925, 4742.834000809955, 4756.9286460703115, 4757.666963312535, 5862.14998825168, 5862.560307976919, 5867.647941123546, 5902.1146827976145, 5925.703714814242, 5684.545236381162, 5695.231143795535, 5713.143028545752, 5763.279590051244, 5769.336526299529, 5919.526437884872, 5921.171036055042, 5935.673537955454, 5939.2575928009, 5949.553783466344, 5503.697296648723, 5611.298587676541, 5614.70861701819, 5625.015622266005, 5629.493345598916, 5739.8852022960145, 5756.539476841759, 5756.740946657326, 5758.654480731169, 5815.505682017076, 5544.528715059265, 5567.387587365306, 5619.044762390486, 5621.269234999588, 5637.069883469182, 5477.698726570077, 5595.580331475075, 5598.356189038313, 5621.072523033818, 5623.690697011703, 5506.311711036121, 5536.086545719912, 5548.0, 5561.277033985556, 5579.330480342385, 5566.415526369835, 5611.57913156523, 5637.154426836008, 5646.604737668488, 5686.744096515584, 5461.972690136524, 5531.668099914018, 5549.084401073777, 5588.0, 5600.383957764724], "value": 5246.259439773072, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4793229889997, 645.8611398549314, 652.7682672651209, 669.99665001675, 688.1260798785539, 35112.297754044936, 35834.64165358346, 36257.45613815795, 36278.818605906934, 36344.45483317752, 36761.0, 37631.62368376315, 37764.62235377645, 37805.0, 38014.239715205746, 8513.063563008063, 8754.343424243176, 8760.255378292853, 8767.780805479882, 8861.601227944759, 8695.173958473935, 8707.216350528452, 8747.300215982737, 8786.60460279289, 8789.516576588285, 8753.343499237551, 8796.296296296314, 8802.163794439519, 8805.20753132218, 8816.8677469838, 8701.564921753887, 8710.912890871074, 8740.606672699743, 8768.868466973001, 8829.470231786048, 8657.26413254874, 8697.565121743888, 8728.956355218246, 8760.474371537728, 8778.868316975251, 31012.22469438282, 37998.810005949796, 38063.61936380656, 38338.80830595857, 38434.0, 3274.9345013099605, 3377.392069427502, 3405.8126803025825, 3420.2817408344276, 3429.639887811794, 30089.398212035856, 30279.243018924484, 30688.0, 30829.53755693644, 31269.218269543217, 4224.260754367973, 4291.442112525352, 4340.58764417383, 4353.064091220371, 4384.0, 244755.0, 252077.0, 253382.0, 253820.0, 311875.99999999773, 60795.392046078974, 61757.382426175165, 62142.68928655328, 62173.37826621766, 62475.6876215616, 64670.0, 66065.33934660688, 66081.0, 66378.0, 66419.0, 15995.440159594591, 16410.1794910254, 16412.1793910304, 16413.097279649493, 16424.096674683005, 12926.353682315847, 12957.287349195885, 13021.47914083426, 13036.80444793329, 13073.673158171121, 20187.0, 20248.0, 20264.493387665425, 20391.082401291977, 20416.489587760127, 7602.163761986177, 7602.657880395285, 7680.4623676343235, 7825.908766037383, 7960.442769006229, 999.8000399919899, 1030.8762948446085, 1035.7876635289747, 1087.505185140759, 1171.812509998396, 31851.681483185333, 32060.198495037344, 32150.35699286001, 32207.51688724671, 32953.17617059593, 1061.9309744866714, 1119.8880111988735, 1125.426032723317, 1247.2267194339568, 1275.2029981261712, 16884.831151688573, 16939.745903811454, 17123.914380428017, 17162.141892905554, 17210.39763608268, 472227.0, 477598.0, 478484.0, 480828.0, 483183.0, 57418.7129064352, 58380.7080964601, 58442.41557584455, 58589.707051465324, 58677.41322586805, 1377.9931100344634, 1379.0760190672274, 1392.78411846164, 1423.772196448584, 1483.3028476615973, 30283.242918927204, 30846.0, 30887.382252355277, 31739.20651983719, 31813.681863182, 50193.24710129424, 50643.49356506535, 50673.493265068355, 50953.23570146377, 51026.489735103656, 333646.0, 335172.0, 335292.0, 335597.0, 336431.0, 28515.572266416435, 43383.74621903433, 44201.11597768091, 44712.32931505965, 45265.0, 42821.0, 42837.14325713531, 43072.78463607662, 43346.566534334255, 47790.283145752146, 39928.40107398333, 39963.80018099891, 40095.599044010356, 40128.39807402833, 40357.0, 37989.430158548195, 39130.4130438038, 39348.606513935636, 39484.802575986934, 39974.60025399709, 39783.204335913695, 41403.0, 41909.0, 42289.0, 42914.0, 29611.851940740158, 34154.0, 34175.0, 34401.827990859885, 34804.129896752784, 26745.0, 27645.58531621987, 27655.446891062467, 27855.16434506968, 28124.578131328457], "value": 19722.409604754357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.7901101921491, 400.6074047433515, 404.5913627236491, 408.0858876117494, 410.7371282379278, 12903.16129451585, 14399.496017639385, 17363.913180434098, 17899.910500447495, 17909.104544772774, 16765.077920714357, 17056.23246953887, 17186.398476053342, 17205.483835484956, 17783.0, 4947.653664243504, 5368.812091576786, 5553.305836770403, 5562.443755624446, 5613.66318020918, 5473.17902314652, 5496.80761173359, 5533.501984821365, 5564.1931919871795, 5590.91613625796, 5233.241180028894, 5415.619017150621, 5462.0, 5481.287432633772, 5497.065498865182, 5509.201165830972, 5531.059719847635, 5531.142672885689, 5544.889102217973, 5545.861353466155, 4720.693154944917, 4893.902121957576, 4927.556519913225, 4935.679180853233, 4940.925886111711, 20562.177512899467, 21205.045772940255, 21310.893445532674, 21409.35771926829, 21416.0, 2223.4107961390246, 2411.2766170148884, 2412.0954642009247, 2634.3677517395686, 2902.1003488918504, 8780.473171609723, 9476.384035037769, 13539.39072741719, 13787.793183102161, 14150.858491415058, 1921.932732354361, 1926.9421917342502, 1958.5201625601676, 1964.0768838645813, 1987.2945104487987, 69885.3011469884, 79201.20798791996, 79378.60310698468, 79494.20505794926, 80018.0, 10274.486275686186, 10516.894831051744, 10598.523066462029, 10755.83866242007, 10815.242932994615, 14744.0, 14827.40690372373, 14925.552233433014, 14944.476943306932, 15035.646791788573, 7891.960540197377, 8061.911641928382, 8217.753467395987, 8280.213379728915, 8329.37529685276, 7778.611069446505, 7868.291853733077, 7887.487313324616, 7958.243966823143, 8010.078840933367, 4539.9773001135445, 4586.72479651222, 4626.907461850744, 4660.836870709509, 4683.039976804746, 1914.1864707499258, 1927.8939658318927, 1940.4760714606978, 1983.454549998733, 1984.107151781704, 882.1266945723816, 908.6320040383655, 947.4173383369316, 955.5890966884307, 957.8419560772534, 17081.0, 17734.29062837498, 17781.288748450177, 17934.461966141036, 18266.178021989042, 998.2064258914181, 1025.3847691385108, 1043.8068957242783, 1061.2306078093475, 1070.1438848920832, 9826.017398260117, 9876.703698889045, 10002.299839011344, 10003.299769016245, 10016.849747253797, 440936.0, 459750.0, 461283.0, 461794.0, 461918.0, 84922.57538712266, 88923.11076889148, 92840.53579732194, 93566.0, 93576.53211734034, 1031.9174466042698, 1034.6895931220604, 1036.896310368972, 1050.2123407444417, 1060.7666313411037, 15898.966567173096, 16001.599960001093, 16068.0, 16072.598185045468, 16082.758758618396, 35878.0, 36800.63199367972, 37399.813000934824, 37614.0, 38647.6135238644, 49564.0, 50702.49297506978, 50891.74554127206, 56458.153127702295, 59485.0, 7921.881171782543, 7958.681652734057, 8078.596070196584, 8084.393670474856, 8139.79650508742, 11408.54365825391, 12210.633680989584, 12231.510739570673, 12335.568255111028, 12723.491060357852, 10826.0, 10906.727331816768, 11085.50115244832, 11219.831702524632, 11260.324380537195, 10450.843237351597, 10581.31221470602, 10585.9470702646, 10725.0, 10860.076893464144, 10746.140308775435, 10851.891481085087, 11029.283096598696, 11225.887741122484, 11548.191626586058, 7855.450118491651, 7890.763277101696, 7945.48354356965, 8240.546769927712, 8246.216609422096, 10323.019313165238, 10478.738031549272, 10494.947525262325, 10609.8939010612, 10733.892661073289], "value": 8824.870119353147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.1346632419518, 1533.7699345098238, 1681.7729606503126, 1764.8676349273808, 1794.8653850961182, 7508.849823003537, 8099.959500202491, 8109.553974531405, 8351.373646976479, 8391.370647201455, 8067.112617612058, 8139.38954578406, 8151.959240203791, 8170.346372290217, 8187.426880118394, 2320.21112821641, 2333.3816538617193, 2341.94145146371, 2346.812255019603, 2355.882205889707, 2232.7655596162413, 2256.808171305441, 2287.9771202288016, 2294.0594356313914, 2299.908003679851, 2185.7158569385956, 2218.911243550256, 2223.4552534628956, 2226.6882636430914, 2242.372135801978, 2238.6977758002786, 2246.5731511012937, 2253.4141123307977, 2261.7625149359246, 2262.309995451387, 2200.207925146946, 2215.080741492279, 2215.5125872308067, 2226.9331920042423, 2228.8774117423536, 8197.836043279101, 8268.586570671443, 8318.500889946563, 8337.95831020841, 8347.83304333916, 5047.394312682465, 5117.897642047175, 5166.9224961625605, 5215.530602245778, 5224.346956630421, 3128.4994400895976, 3146.0876345859674, 3258.152880251128, 3280.0815771583993, 3283.5567198428143, 1105.7284123258237, 1110.5169251375596, 1111.6776134920863, 1112.7830073135742, 1121.0919155484085, 11741.706457338549, 11784.469698863571, 11785.823212651818, 11796.0, 11848.46681899308, 4296.2911119664905, 4478.798454069574, 4580.358749775034, 4599.264117741212, 4636.675432719677, 10059.748506287255, 10066.798664026679, 10072.043155900177, 10081.344712593658, 10085.193184545218, 5154.329937108227, 5164.8192313268855, 5169.974150129226, 5179.093658609729, 5182.97408512955, 4172.645325147397, 4627.583517483443, 4729.7398643074275, 4733.290006499053, 4765.737884416321, 3899.590542992945, 3916.6083391660604, 3972.8609498667406, 4010.839566417369, 4025.154717509356, 1243.8383010208615, 1250.8248845161684, 1271.0911698135876, 1307.6861553227156, 1314.6319030671427, 896.4755617963565, 942.0, 962.9133377996014, 972.2222222222194, 993.5777294649745, 5576.749046292926, 5632.3804381518, 5769.394213607595, 5901.852453688693, 5945.970270148621, 870.1994165367877, 951.2580187453797, 990.881094268678, 1002.4085789384153, 1012.2256473797551, 4049.392591111357, 4071.246819338432, 4080.81636326366, 4098.221337945781, 4128.504579450485, 10372.11836993849, 10672.733181670521, 10759.0, 10841.728956776144, 10849.728756781144, 10536.525856336484, 10606.204534659777, 10667.946660266649, 10694.89305106939, 10708.411037392862, 7907.802304942307, 8117.0, 8184.2634162926815, 8226.712065077694, 8248.670053197804, 5675.886482270249, 5836.591438599257, 5873.588848780544, 5895.616784908967, 5983.162357269899, 9721.076497732704, 9724.076212759777, 9735.026497350209, 9755.804883902425, 9868.753281168028, 9468.289878259297, 9986.500674966368, 10071.295009349567, 10185.592576296865, 10246.282760206714, 6571.901421478778, 7128.251533588898, 7176.461765367514, 7247.2390399007345, 7314.890276645748, 8238.0, 8239.670413183405, 8264.090949995616, 8269.21442462965, 8315.750527484186, 7282.563046217244, 7386.815329616803, 7464.066991626047, 7526.924730752622, 7701.499402538817, 7279.963600181965, 7391.556506609621, 7408.407327413902, 7409.851802963803, 7522.5862577558755, 6757.0, 6818.727250909908, 6820.3861652451515, 6869.484788640772, 6890.207626122859, 4903.117438861039, 4914.70511769295, 5002.574781143643, 5138.100832354397, 5232.633715639869, 5098.133317335987, 5193.584513238856, 5223.764930578209, 5231.450697676689, 5287.68273903567], "value": 4533.053729285966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1852664654979, 331.3885880550385, 336.94103531881916, 340.91758666234705, 344.3938667944417, 5815.73829177687, 5831.154482600021, 5839.9124013139835, 5955.315138759044, 5976.252968378958, 5792.304923409197, 5819.214406055181, 5846.0, 5909.409059094089, 5939.821805345847, 4470.2400591899295, 4499.977500112494, 4522.819087236515, 4555.293929440942, 4565.21521871658, 4468.419105516295, 4516.4806047304655, 4577.931331030038, 4581.198290299201, 4590.42619672541, 4511.300748384006, 4512.548745125478, 4516.390287311204, 4527.09458108378, 4548.454185497745, 4497.325401189815, 4534.682572219913, 4543.61379282763, 4543.931841022388, 4552.6130278926, 3887.105965627893, 4001.3597824347967, 4003.539592946819, 4011.6389524942897, 4014.7992600370158, 5681.23303354046, 5685.317761868561, 5704.258446401983, 5710.828675139753, 5715.485606295411, 5253.553447956928, 5259.21111833228, 5263.131583288753, 5264.605154613381, 5266.131088370453, 6007.939920600782, 6187.16473276111, 6198.946179149555, 6209.9379006210265, 6226.252849658024, 4230.259704551691, 4258.87223383299, 4270.274053410928, 4294.377315289296, 4306.784660766949, 6380.3619638035825, 6426.4216220540375, 6433.646149461778, 6438.25960014595, 6451.645159516224, 4464.508904020555, 4491.955080449219, 4503.752293623882, 4514.683972121986, 4524.6380289576755, 4517.412736344254, 4533.637309015271, 4550.47669518003, 4563.726176429424, 4565.908681826411, 5215.55667768244, 5221.0, 5229.084910140787, 5235.240890070919, 5239.214117882349, 5837.562182836305, 5914.733836977346, 6072.483838873745, 6208.9689551551955, 6218.502519798405, 1515.8938874278695, 1531.5175719648275, 1542.9537113886602, 1543.691261747655, 1546.57469195972, 1006.5772375602264, 1020.2195320579763, 1028.0901402258905, 1031.6079889641887, 1049.103016920522, 5941.821745347646, 5958.851028724316, 6006.189164462829, 6017.608855424383, 6021.879562408727, 6328.272248691367, 6355.777547785805, 6373.075903993895, 6394.9680251599375, 6425.228972523327, 5861.120831875168, 5914.172015917775, 5994.860976414468, 6010.7677926025935, 6038.124471951543, 3373.5614370132216, 3375.5443015192636, 3395.7792743471596, 3411.761176717606, 3427.0, 6421.3578642136345, 6579.80260592183, 6585.727923866259, 6591.736330546724, 6629.237637671729, 6415.807525774234, 6431.5819471734185, 6446.580972236789, 6447.161868957006, 6471.935280647133, 6451.129097571861, 6479.0, 6604.900926486107, 6618.7021584028835, 6631.204255489372, 6275.717592708248, 6318.368163183645, 6357.237131544244, 6363.713632886624, 6389.424951754364, 6169.969662345906, 6246.906296405648, 6250.593711408744, 6273.309935906956, 6283.994560870239, 6475.125858009297, 6593.901091483535, 6599.7360105595235, 6608.966955165193, 6662.133922590032, 4313.870583882489, 4326.134773045466, 4381.5618438155925, 4392.231359512009, 4394.1870753910625, 6236.282827474898, 6328.208973878265, 6344.333844946399, 6355.618662880242, 6385.7126429309865, 6177.4749146323065, 6178.042403427476, 6189.752409903554, 6192.845178870564, 6204.565680402328, 6024.186734790923, 6118.174046503665, 6173.81478555644, 6197.690115494297, 6258.843528911813, 6004.249468816398, 6047.818565443044, 6053.547148684196, 6072.210612620331, 6106.0, 6250.343713910156, 6259.906101408392, 6261.436470717657, 6284.402981716729, 6291.213598300213, 5909.763609455574, 6113.877722445615, 6235.3452887446165, 6255.749770009331, 6264.561480696308], "value": 4684.598831104216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.2599221906479, 638.7169946475121, 653.7287025884258, 678.3047376439149, 680.5814424129161, 13267.33663316834, 13554.051216414842, 13582.52461163857, 13592.660183495418, 13606.93196534016, 12735.108542402035, 12772.68068298293, 12822.038347123957, 12822.230666160014, 12859.871401285984, 629.3109045595066, 752.5221484357445, 753.6005916864057, 778.4900889917113, 779.6608475313228, 761.375671949002, 765.387689848122, 767.4282659418741, 771.3366504805863, 773.3156156801243, 821.4414198345123, 821.6549049399266, 822.0176888618104, 822.2271065198725, 823.3948048184579, 810.0401024785648, 811.2212276214841, 813.3818298093432, 814.9918500815005, 815.5881279953616, 591.8076625096818, 593.2999061107892, 593.5726277080538, 594.2542109652402, 594.4738906068118, 13491.392887319997, 13507.66230844227, 13535.187888726708, 13546.051776375658, 13594.456221751117, 13169.670758231025, 13251.46994120234, 13397.464101435931, 13632.318384080756, 13906.235157066358, 10100.696979090639, 10149.543270552844, 10198.541065652063, 10270.0, 10282.845757313646, 3734.869279575229, 3758.49260349852, 3763.9247215055548, 3785.9242815143543, 3840.8655697050467, 51419.48580514184, 52483.0, 52718.47281527212, 52984.47015529795, 56854.715726421106, 9456.243500519942, 9543.236541076698, 9764.804703906024, 9799.363041402286, 9806.656767013263, 16203.83796162047, 16303.0, 16308.347666093223, 16321.34714611426, 16333.428330008393, 7913.248241417056, 7941.523508589503, 7986.720464783704, 8114.188581141839, 8234.341252699769, 4858.149823780895, 4866.31871537985, 4895.58047526148, 4924.9507504925205, 4965.577925876341, 3093.8453077346044, 3164.098232003868, 3172.888948886778, 3183.2041989502623, 3183.379241047973, 624.6938999890112, 626.4424662050778, 627.2191122052982, 630.5617595770896, 633.0409429713987, 582.959192856496, 647.8283254937445, 720.679297712513, 725.6915810780397, 746.1941103608199, 7760.844783104306, 7921.722739704198, 7984.24149705777, 8014.679412823421, 8047.718329858427, 662.2218892800939, 702.9789106326818, 721.2426951700693, 721.4264659595634, 726.1141407482862, 3980.3034468967817, 4008.07814202735, 4008.2584721826556, 4024.9798751006056, 4128.2156390285745, 61912.0, 61960.38039619546, 62520.687396562724, 63253.0, 63517.364826352066, 55491.72254138703, 55613.0, 56049.159262611094, 56368.0, 56853.431465685644, 51115.23327150021, 51239.231411528854, 51568.22647660213, 51643.0, 52222.0, 7563.621818909142, 7713.074431068308, 7802.921970780219, 7825.139234684294, 7881.9211807883485, 32285.51571726473, 32950.34099318048, 33064.50403243905, 33186.17034574155, 33205.83397082999, 42110.36834447547, 45282.773586133175, 46397.30404043874, 46416.535834641225, 46447.53552464432, 9834.803303933739, 9865.802683946424, 10088.596456141671, 10167.0, 10200.0819926207, 11734.237274577124, 11887.346195958959, 12018.278903265833, 12021.338826364634, 12068.396580171131, 10555.525001374803, 10665.89334106649, 10751.13990880712, 11027.558897644005, 11030.944845275722, 10778.13774898022, 10840.837387439036, 11037.172212083966, 11219.55121795119, 11298.830517542408, 10561.63034293796, 10623.309484883457, 10715.464226788474, 10747.677569672922, 10820.945895270474, 9413.952930235306, 9701.272404569545, 9901.851472228067, 9906.851397229191, 9933.751656208653, 8818.647254110021, 8923.196912277926, 8927.553622318988, 9002.864957025518, 9059.864102038342], "value": 6275.139992578539, "unit": "score"}], "name": "dromaeo_css", "value": 7039.487662715517, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 114.0, 114.0, 111.0, 123.0, 111.0, 112.0, 112.0, 111.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 155.0, 186.0, 140.0, 157.0, 158.0, 135.0, 197.0, 135.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 168.0, 168.0, 161.0, 165.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 152.0, 77.0, 76.0, 77.0, 78.0, 164.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 152.0, 92.0, 93.0, 94.0, 153.0, 93.0, 93.0, 145.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 148.0, 149.0, 146.0, 148.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 58.0, 65.0, 59.0, 67.0, 77.0, 59.0, 57.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 77.0, 76.0, 78.0, 78.0, 77.0, 77.0, 77.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 135.0, 130.0, 126.0, 129.0, 125.0, 127.0, 159.0, 130.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 165.0, 169.0, 174.0, 167.0, 164.0, 166.0, 164.0, 168.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 71.0, 69.0, 65.0, 66.0, 70.0, 67.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1564.2, "alertThreshold": 2.0}]} 08:42:09 INFO - Return code: 0 08:42:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:42:09 ERROR - # TBPL SUCCESS # 08:42:09 INFO - Running post-action listener: _resource_record_post_action 08:42:09 INFO - Running post-run listener: _resource_record_post_run 08:42:10 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 303374336; Read time: 252; Write time: 252664 08:42:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14086144; Read time: 0; Write time: 3244 08:42:10 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 287846400; Read time: 252; Write time: 243184 08:42:10 INFO - Running post-run listener: _upload_blobber_files 08:42:10 INFO - Blob upload gear active. 08:42:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:10 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 08:42:10 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:10 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:11 INFO - (blobuploader) - INFO - Done attempting. 08:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:12 INFO - (blobuploader) - INFO - Done attempting. 08:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:12 INFO - Return code: 0 08:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1aad5f09c238a24273b0d2b15e980ea75271eb4e750b528c47e5ba2dd4424f1c6f05b83b94a96a14aa30684bd0c83e5c64009444e9b63102dee7957ad521e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7e05fa927a0e298e11d07d5f80fec68c62712c0bd3ba5f35e09029377e07e1b6498761efc876cd79d676e1f28dff38b860f320a1d21f7dc4d18f2ef62a6ad4"} 08:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:12 INFO - Contents: 08:42:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1aad5f09c238a24273b0d2b15e980ea75271eb4e750b528c47e5ba2dd4424f1c6f05b83b94a96a14aa30684bd0c83e5c64009444e9b63102dee7957ad521e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7e05fa927a0e298e11d07d5f80fec68c62712c0bd3ba5f35e09029377e07e1b6498761efc876cd79d676e1f28dff38b860f320a1d21f7dc4d18f2ef62a6ad4"} 08:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:12 INFO - Copying logs to upload dir... 08:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.013636 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-15 08:42:12.350042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:12.354549) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 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/Fx-Team/sha512/b1aad5f09c238a24273b0d2b15e980ea75271eb4e750b528c47e5ba2dd4424f1c6f05b83b94a96a14aa30684bd0c83e5c64009444e9b63102dee7957ad521e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7e05fa927a0e298e11d07d5f80fec68c62712c0bd3ba5f35e09029377e07e1b6498761efc876cd79d676e1f28dff38b860f320a1d21f7dc4d18f2ef62a6ad4"} build_url:https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/DuEIW0q7TqC337FLym5mhw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1aad5f09c238a24273b0d2b15e980ea75271eb4e750b528c47e5ba2dd4424f1c6f05b83b94a96a14aa30684bd0c83e5c64009444e9b63102dee7957ad521e23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7e05fa927a0e298e11d07d5f80fec68c62712c0bd3ba5f35e09029377e07e1b6498761efc876cd79d676e1f28dff38b860f320a1d21f7dc4d18f2ef62a6ad4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:12.387076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:12.387514) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460732852.36046-200013110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:12.437315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 08:42:12.437720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 08:42:12.441133) ========= ========= Total master_lag: 0.16 =========