builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1470453314.22 results: success (0) buildid: 20160805173004 builduid: d396da246bc94f43beafd790c741d100 revision: 1646172ac6e709f5abdecbd8edbb53a54392428a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.219809) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.220354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.220663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.253764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.254068) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 20:15:14-- 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% 70.1M=0s 2016-08-05 20:15:14 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.291611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.560255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.560596) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022750 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.609877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:14.610237) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1646172ac6e709f5abdecbd8edbb53a54392428a --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 1646172ac6e709f5abdecbd8edbb53a54392428a --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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 20:15:14,884 truncating revision to first 12 chars 2016-08-05 20:15:14,884 Setting DEBUG logging. 2016-08-05 20:15:14,884 attempt 1/10 2016-08-05 20:15:14,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1646172ac6e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 20:15:15,192 unpacking tar archive at: fx-team-1646172ac6e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641296 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:15.265960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:15.266290) ========= script_repo_revision: 1646172ac6e709f5abdecbd8edbb53a54392428a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:15.266793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:15.267098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 20:15:15.280129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 20:15:15.280416) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:15:15 INFO - MultiFileLogger online at 20160805 20:15:15 in /builds/slave/test 20:15:15 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 20:15:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:15:15 INFO - {'append_to_log': False, 20:15:15 INFO - 'base_work_dir': '/builds/slave/test', 20:15:15 INFO - 'blob_upload_branch': 'Fx-Team', 20:15:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:15:15 INFO - 'branch': 'Fx-Team', 20:15:15 INFO - 'buildbot_json_path': 'buildprops.json', 20:15:15 INFO - 'config_files': ('talos/linux_config.py',), 20:15:15 INFO - 'default_actions': ('clobber', 20:15:15 INFO - 'read-buildbot-config', 20:15:15 INFO - 'download-and-extract', 20:15:15 INFO - 'populate-webroot', 20:15:15 INFO - 'create-virtualenv', 20:15:15 INFO - 'install', 20:15:15 INFO - 'run-tests'), 20:15:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:15:15 INFO - 'download_minidump_stackwalk': True, 20:15:15 INFO - 'download_symbols': 'ondemand', 20:15:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:15:15 INFO - 'tooltool.py': '/tools/tooltool.py', 20:15:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:15:15 INFO - '/tools/misc-python/virtualenv.py')}, 20:15:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:15:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:15:15 INFO - 'installer_path': 'installer.exe', 20:15:15 INFO - 'log_level': 'info', 20:15:15 INFO - 'log_name': 'talos', 20:15:15 INFO - 'log_to_console': True, 20:15:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:15:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:15:15 INFO - 'opt_config_files': (), 20:15:15 INFO - 'pip_index': False, 20:15:15 INFO - 'sps_profile': False, 20:15:15 INFO - 'sps_profile_interval': 0, 20:15:15 INFO - 'suite': 'dromaeojs-e10s', 20:15:15 INFO - 'system_bits': '32', 20:15:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:15:15 INFO - 'title': 'talos-linux64-ix-034', 20:15:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:15:15 INFO - 'use_talos_json': True, 20:15:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:15:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:15:15 INFO - 'work_dir': 'build'} 20:15:15 INFO - [mozharness: 2016-08-06 03:15:15.645195Z] Running clobber step. 20:15:15 INFO - Running pre-action listener: _resource_record_pre_action 20:15:15 INFO - Running main action method: clobber 20:15:15 INFO - rmtree: /builds/slave/test/build 20:15:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:15:16 INFO - Running post-action listener: _resource_record_post_action 20:15:16 INFO - [mozharness: 2016-08-06 03:15:16.614492Z] Finished clobber step (success) 20:15:16 INFO - [mozharness: 2016-08-06 03:15:16.614593Z] Running read-buildbot-config step. 20:15:16 INFO - Running pre-action listener: _resource_record_pre_action 20:15:16 INFO - Running main action method: read_buildbot_config 20:15:16 INFO - Using buildbot properties: 20:15:16 INFO - { 20:15:16 INFO - "project": "", 20:15:16 INFO - "product": "firefox", 20:15:16 INFO - "script_repo_revision": "production", 20:15:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:15:16 INFO - "repository": "", 20:15:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:15:16 INFO - "buildid": "20160805173004", 20:15:16 INFO - "pgo_build": "True", 20:15:16 INFO - "basedir": "/builds/slave/test", 20:15:16 INFO - "buildnumber": 671, 20:15:16 INFO - "slavename": "talos-linux64-ix-034", 20:15:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:15:16 INFO - "platform": "ubuntu64_hw", 20:15:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:15:16 INFO - "branch": "fx-team", 20:15:16 INFO - "repo_path": "integration/fx-team", 20:15:16 INFO - "revision": "1646172ac6e709f5abdecbd8edbb53a54392428a", 20:15:16 INFO - "stage_platform": "linux64-pgo", 20:15:16 INFO - "builduid": "d396da246bc94f43beafd790c741d100", 20:15:16 INFO - "slavebuilddir": "test" 20:15:16 INFO - } 20:15:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:15:16 INFO - Running post-action listener: _resource_record_post_action 20:15:16 INFO - [mozharness: 2016-08-06 03:15:16.617052Z] Finished read-buildbot-config step (success) 20:15:16 INFO - [mozharness: 2016-08-06 03:15:16.617141Z] Running download-and-extract step. 20:15:16 INFO - Running pre-action listener: _resource_record_pre_action 20:15:16 INFO - Running main action method: download_and_extract 20:15:16 INFO - mkdir: /builds/slave/test/build/tests 20:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:16 INFO - trying https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:15:17 INFO - Downloaded 1361 bytes. 20:15:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:15:17 INFO - Using the following test package requirements: 20:15:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:15:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:15:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'jsshell-linux-x86_64.zip'], 20:15:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:15:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:15:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:15:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:15:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:15:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:17 INFO - trying https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:15:17 INFO - Downloading https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:15:18 INFO - Downloaded 21825863 bytes. 20:15:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:15:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:15:19 INFO - Return code: 0 20:15:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:15:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:19 INFO - trying https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:15:19 INFO - Downloading https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:15:20 INFO - Downloaded 21825863 bytes. 20:15:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:15:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:15:21 INFO - Return code: 0 20:15:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:21 INFO - trying https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:21 INFO - Downloading https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:15:22 INFO - Downloaded 14413723 bytes. 20:15:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:15:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:15:22 INFO - Return code: 0 20:15:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:22 INFO - trying https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:15:24 INFO - Downloaded 59968636 bytes. 20:15:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:15:24 INFO - mkdir: /builds/slave/test/properties 20:15:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:15:24 INFO - Writing to file /builds/slave/test/properties/build_url 20:15:24 INFO - Contents: 20:15:24 INFO - build_url:https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:15:25 INFO - Running post-action listener: _resource_record_post_action 20:15:25 INFO - Running post-action listener: set_extra_try_arguments 20:15:25 INFO - [mozharness: 2016-08-06 03:15:25.070011Z] Finished download-and-extract step (success) 20:15:25 INFO - [mozharness: 2016-08-06 03:15:25.070243Z] Running populate-webroot step. 20:15:25 INFO - Running pre-action listener: _resource_record_pre_action 20:15:25 INFO - Running main action method: populate_webroot 20:15:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:15:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:15:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:15:25 INFO - '--tppagecycles', 20:15:25 INFO - '7'], 20:15:25 INFO - 'tests': ['tsvgm']}}, 20:15:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:15:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:15:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:15:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:15:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['damp', 'tps']}, 20:15:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'tests': ['damp', 'tps']}, 20:15:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['dromaeo_dom']}, 20:15:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:15:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['basic_compositor_video']}, 20:15:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:15:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['a11yr', 20:15:25 INFO - 'ts_paint', 20:15:25 INFO - 'tpaint', 20:15:25 INFO - 'sessionrestore', 20:15:25 INFO - 'sessionrestore_no_auto_restore', 20:15:25 INFO - 'tabpaint']}, 20:15:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['tsvgx', 20:15:25 INFO - 'tsvgr_opacity', 20:15:25 INFO - 'tart', 20:15:25 INFO - 'tscrollx', 20:15:25 INFO - 'cart']}, 20:15:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:15:25 INFO - 'tsvgr_opacity', 20:15:25 INFO - 'tart', 20:15:25 INFO - 'tscrollx', 20:15:25 INFO - 'cart']}, 20:15:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'talos_options': ['--disable-e10s'], 20:15:25 INFO - 'tests': ['tp5o']}, 20:15:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'tests': ['tp5o']}, 20:15:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'talos_options': ['--disable-e10s', 20:15:25 INFO - '--xperf_path', 20:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:25 INFO - 'tests': ['tp5n']}, 20:15:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:15:25 INFO - 'talos_options': ['--xperf_path', 20:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:25 INFO - 'tests': ['tp5n']}}, 20:15:25 INFO - 'talos.zip': {'path': '', 20:15:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:15:25 INFO - Running post-action listener: _resource_record_post_action 20:15:25 INFO - [mozharness: 2016-08-06 03:15:25.086899Z] Finished populate-webroot step (success) 20:15:25 INFO - [mozharness: 2016-08-06 03:15:25.086988Z] Running create-virtualenv step. 20:15:25 INFO - Running pre-action listener: _resource_record_pre_action 20:15:25 INFO - Running main action method: create_virtualenv 20:15:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:15:25 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 20:15:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:15:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:15:25 INFO - Using real prefix '/usr' 20:15:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:15:25 INFO - Installing distribute.............................................................................................................................................................................................done. 20:15:27 INFO - Installing pip.................done. 20:15:27 INFO - Return code: 0 20:15:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:15:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:27 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 20:15:27 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 20:15:27 INFO - Using env: {'DISPLAY': ':0', 20:15:27 INFO - 'HOME': '/home/cltbld', 20:15:27 INFO - 'LANG': 'en_US.UTF-8', 20:15:27 INFO - 'LANGUAGE': 'en_US:en', 20:15:27 INFO - 'LOGNAME': 'cltbld', 20:15:27 INFO - 'MAIL': '/var/mail/cltbld', 20:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:27 INFO - 'MOZ_NO_REMOTE': '1', 20:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:27 INFO - 'NO_EM_RESTART': '1', 20:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:27 INFO - 'PWD': '/builds/slave/test', 20:15:27 INFO - 'SHELL': '/bin/bash', 20:15:27 INFO - 'SHLVL': '1', 20:15:27 INFO - 'TERM': 'linux', 20:15:27 INFO - 'TMOUT': '86400', 20:15:27 INFO - 'USER': 'cltbld', 20:15:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:27 INFO - '_': '/tools/buildbot/bin/python'} 20:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:27 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 20:15:27 INFO - Cleaning up... 20:15:27 INFO - Return code: 0 20:15:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:15:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:27 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>=3.1.1'] in /builds/slave/test/build 20:15:27 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>=3.1.1 20:15:27 INFO - Using env: {'DISPLAY': ':0', 20:15:27 INFO - 'HOME': '/home/cltbld', 20:15:27 INFO - 'LANG': 'en_US.UTF-8', 20:15:27 INFO - 'LANGUAGE': 'en_US:en', 20:15:27 INFO - 'LOGNAME': 'cltbld', 20:15:27 INFO - 'MAIL': '/var/mail/cltbld', 20:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:27 INFO - 'MOZ_NO_REMOTE': '1', 20:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:27 INFO - 'NO_EM_RESTART': '1', 20:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:27 INFO - 'PWD': '/builds/slave/test', 20:15:27 INFO - 'SHELL': '/bin/bash', 20:15:27 INFO - 'SHLVL': '1', 20:15:27 INFO - 'TERM': 'linux', 20:15:27 INFO - 'TMOUT': '86400', 20:15:27 INFO - 'USER': 'cltbld', 20:15:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:27 INFO - '_': '/tools/buildbot/bin/python'} 20:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:28 INFO - Downloading/unpacking psutil>=3.1.1 20:15:28 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 20:15:28 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 20:15:28 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 20:15:28 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 20:15:28 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 20:15:28 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 20:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:15:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:30 INFO - Installing collected packages: psutil 20:15:30 INFO - Running setup.py install for psutil 20:15:30 INFO - building 'psutil._psutil_linux' extension 20:15:30 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 20:15:30 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 20:15:30 INFO - building 'psutil._psutil_posix' extension 20:15:30 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 20:15:30 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 20:15:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:30 INFO - Successfully installed psutil 20:15:30 INFO - Cleaning up... 20:15:30 INFO - Return code: 0 20:15:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:30 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:30 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.3'] in /builds/slave/test/build 20:15:30 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.3 20:15:30 INFO - Using env: {'DISPLAY': ':0', 20:15:30 INFO - 'HOME': '/home/cltbld', 20:15:30 INFO - 'LANG': 'en_US.UTF-8', 20:15:30 INFO - 'LANGUAGE': 'en_US:en', 20:15:30 INFO - 'LOGNAME': 'cltbld', 20:15:30 INFO - 'MAIL': '/var/mail/cltbld', 20:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:30 INFO - 'MOZ_NO_REMOTE': '1', 20:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:30 INFO - 'NO_EM_RESTART': '1', 20:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:30 INFO - 'PWD': '/builds/slave/test', 20:15:30 INFO - 'SHELL': '/bin/bash', 20:15:30 INFO - 'SHLVL': '1', 20:15:30 INFO - 'TERM': 'linux', 20:15:30 INFO - 'TMOUT': '86400', 20:15:30 INFO - 'USER': 'cltbld', 20:15:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:30 INFO - '_': '/tools/buildbot/bin/python'} 20:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:30 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 20:15:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:15:32 INFO - Installing collected packages: mozsystemmonitor 20:15:32 INFO - Running setup.py install for mozsystemmonitor 20:15:32 INFO - Successfully installed mozsystemmonitor 20:15:32 INFO - Cleaning up... 20:15:32 INFO - Return code: 0 20:15:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:15:32 INFO - Using env: {'DISPLAY': ':0', 20:15:32 INFO - 'HOME': '/home/cltbld', 20:15:32 INFO - 'LANG': 'en_US.UTF-8', 20:15:32 INFO - 'LANGUAGE': 'en_US:en', 20:15:32 INFO - 'LOGNAME': 'cltbld', 20:15:32 INFO - 'MAIL': '/var/mail/cltbld', 20:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:32 INFO - 'MOZ_NO_REMOTE': '1', 20:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:32 INFO - 'NO_EM_RESTART': '1', 20:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:32 INFO - 'PWD': '/builds/slave/test', 20:15:32 INFO - 'SHELL': '/bin/bash', 20:15:32 INFO - 'SHLVL': '1', 20:15:32 INFO - 'TERM': 'linux', 20:15:32 INFO - 'TMOUT': '86400', 20:15:32 INFO - 'USER': 'cltbld', 20:15:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:32 INFO - '_': '/tools/buildbot/bin/python'} 20:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:33 INFO - Downloading/unpacking jsonschema==2.5.1 20:15:33 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 20:15:33 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 20:15:33 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 20:15:33 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 20:15:33 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 20:15:33 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 20:15:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15:34 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 20:15:34 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 20:15:34 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 20:15:34 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 20:15:34 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 20:15:34 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 20:15:35 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:35 INFO - warning: no files found matching '*.txt' 20:15:35 INFO - no previously-included directories found matching 'build' 20:15:35 INFO - no previously-included directories found matching 'dist' 20:15:35 INFO - no previously-included directories found matching '.git*' 20:15:35 INFO - Installing collected packages: jsonschema, functools32 20:15:35 INFO - Running setup.py install for functools32 20:15:35 INFO - warning: no files found matching '*.txt' 20:15:35 INFO - no previously-included directories found matching 'build' 20:15:35 INFO - no previously-included directories found matching 'dist' 20:15:35 INFO - no previously-included directories found matching '.git*' 20:15:35 INFO - Successfully installed jsonschema functools32 20:15:35 INFO - Cleaning up... 20:15:35 INFO - Return code: 0 20:15:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:35 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:35 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:15:35 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 functools32==3.2.3-2 20:15:35 INFO - Using env: {'DISPLAY': ':0', 20:15:35 INFO - 'HOME': '/home/cltbld', 20:15:35 INFO - 'LANG': 'en_US.UTF-8', 20:15:35 INFO - 'LANGUAGE': 'en_US:en', 20:15:35 INFO - 'LOGNAME': 'cltbld', 20:15:35 INFO - 'MAIL': '/var/mail/cltbld', 20:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:35 INFO - 'MOZ_NO_REMOTE': '1', 20:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:35 INFO - 'NO_EM_RESTART': '1', 20:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:35 INFO - 'PWD': '/builds/slave/test', 20:15:35 INFO - 'SHELL': '/bin/bash', 20:15:35 INFO - 'SHLVL': '1', 20:15:35 INFO - 'TERM': 'linux', 20:15:35 INFO - 'TMOUT': '86400', 20:15:35 INFO - 'USER': 'cltbld', 20:15:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:35 INFO - '_': '/tools/buildbot/bin/python'} 20:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:35 INFO - Cleaning up... 20:15:35 INFO - Return code: 0 20:15:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:35 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:35 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 20:15:35 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 20:15:35 INFO - Using env: {'DISPLAY': ':0', 20:15:35 INFO - 'HOME': '/home/cltbld', 20:15:35 INFO - 'LANG': 'en_US.UTF-8', 20:15:35 INFO - 'LANGUAGE': 'en_US:en', 20:15:35 INFO - 'LOGNAME': 'cltbld', 20:15:35 INFO - 'MAIL': '/var/mail/cltbld', 20:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:35 INFO - 'MOZ_NO_REMOTE': '1', 20:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:35 INFO - 'NO_EM_RESTART': '1', 20:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:35 INFO - 'PWD': '/builds/slave/test', 20:15:35 INFO - 'SHELL': '/bin/bash', 20:15:35 INFO - 'SHLVL': '1', 20:15:35 INFO - 'TERM': 'linux', 20:15:35 INFO - 'TMOUT': '86400', 20:15:35 INFO - 'USER': 'cltbld', 20:15:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:35 INFO - '_': '/tools/buildbot/bin/python'} 20:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:35 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:35 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 20:15:35 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 20:15:35 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 20:15:35 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 20:15:35 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 20:15:35 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 20:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:37 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 20:15:37 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 20:15:37 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 20:15:37 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 20:15:37 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 20:15:37 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 20:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:38 INFO - Downloading docopt-0.6.1.tar.gz 20:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:38 INFO - Running setup.py install for blobuploader 20:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:38 INFO - Running setup.py install for requests 20:15:38 INFO - Running setup.py install for docopt 20:15:39 INFO - Successfully installed blobuploader requests docopt 20:15:39 INFO - Cleaning up... 20:15:39 INFO - Return code: 0 20:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:39 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:39 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 20:15:39 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 20:15:39 INFO - Using env: {'DISPLAY': ':0', 20:15:39 INFO - 'HOME': '/home/cltbld', 20:15:39 INFO - 'LANG': 'en_US.UTF-8', 20:15:39 INFO - 'LANGUAGE': 'en_US:en', 20:15:39 INFO - 'LOGNAME': 'cltbld', 20:15:39 INFO - 'MAIL': '/var/mail/cltbld', 20:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:39 INFO - 'MOZ_NO_REMOTE': '1', 20:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:39 INFO - 'NO_EM_RESTART': '1', 20:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:39 INFO - 'PWD': '/builds/slave/test', 20:15:39 INFO - 'SHELL': '/bin/bash', 20:15:39 INFO - 'SHLVL': '1', 20:15:39 INFO - 'TERM': 'linux', 20:15:39 INFO - 'TMOUT': '86400', 20:15:39 INFO - 'USER': 'cltbld', 20:15:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:39 INFO - '_': '/tools/buildbot/bin/python'} 20:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:39 INFO - Running setup.py (path:/tmp/pip-4xJIda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:39 INFO - Running setup.py (path:/tmp/pip-oTAagv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:39 INFO - Running setup.py (path:/tmp/pip-y4bBwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:39 INFO - Running setup.py (path:/tmp/pip-BDGMnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:39 INFO - Running setup.py (path:/tmp/pip-Eu8TpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:39 INFO - Running setup.py (path:/tmp/pip-zOOh7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:39 INFO - Running setup.py (path:/tmp/pip-RHtRiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:39 INFO - Running setup.py (path:/tmp/pip-9ACZnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:39 INFO - Running setup.py (path:/tmp/pip-gDaVvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:39 INFO - Running setup.py (path:/tmp/pip-b6sH0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:40 INFO - Running setup.py (path:/tmp/pip-RGhCBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:40 INFO - Running setup.py (path:/tmp/pip-CnbO3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:40 INFO - Running setup.py (path:/tmp/pip-sRK2Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:40 INFO - Running setup.py (path:/tmp/pip-tiCOvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:40 INFO - Running setup.py (path:/tmp/pip-U8DIe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:40 INFO - Running setup.py (path:/tmp/pip-B04ufy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:40 INFO - Running setup.py (path:/tmp/pip-2QwEKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:40 INFO - Running setup.py install for manifestparser 20:15:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:40 INFO - Running setup.py install for mozcrash 20:15:40 INFO - Running setup.py install for mozdebug 20:15:40 INFO - Running setup.py install for mozdevice 20:15:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:15:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:40 INFO - Running setup.py install for mozfile 20:15:41 INFO - Running setup.py install for mozhttpd 20:15:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozinfo 20:15:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozInstall 20:15:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozleak 20:15:41 INFO - Running setup.py install for mozlog 20:15:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for moznetwork 20:15:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozprocess 20:15:41 INFO - Running setup.py install for mozprofile 20:15:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozrunner 20:15:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:41 INFO - Running setup.py install for mozscreenshot 20:15:42 INFO - Running setup.py install for moztest 20:15:42 INFO - Running setup.py install for mozversion 20:15:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:42 INFO - Cleaning up... 20:15:42 INFO - Return code: 0 20:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:42 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:42 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 20:15:42 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 20:15:42 INFO - Using env: {'DISPLAY': ':0', 20:15:42 INFO - 'HOME': '/home/cltbld', 20:15:42 INFO - 'LANG': 'en_US.UTF-8', 20:15:42 INFO - 'LANGUAGE': 'en_US:en', 20:15:42 INFO - 'LOGNAME': 'cltbld', 20:15:42 INFO - 'MAIL': '/var/mail/cltbld', 20:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:42 INFO - 'MOZ_NO_REMOTE': '1', 20:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:42 INFO - 'NO_EM_RESTART': '1', 20:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:42 INFO - 'PWD': '/builds/slave/test', 20:15:42 INFO - 'SHELL': '/bin/bash', 20:15:42 INFO - 'SHLVL': '1', 20:15:42 INFO - 'TERM': 'linux', 20:15:42 INFO - 'TMOUT': '86400', 20:15:42 INFO - 'USER': 'cltbld', 20:15:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:42 INFO - '_': '/tools/buildbot/bin/python'} 20:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:42 INFO - Running setup.py (path:/tmp/pip-t4eLCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:42 INFO - Running setup.py (path:/tmp/pip-uJVdyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:42 INFO - Running setup.py (path:/tmp/pip-N8LZ6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:42 INFO - Running setup.py (path:/tmp/pip-1KL5e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:42 INFO - Running setup.py (path:/tmp/pip-g1kaDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:42 INFO - Running setup.py (path:/tmp/pip-b5a_KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:42 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)) 20:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:42 INFO - Running setup.py (path:/tmp/pip-Acfhtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:43 INFO - Running setup.py (path:/tmp/pip-AeAxsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:43 INFO - Running setup.py (path:/tmp/pip-CfnSde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:43 INFO - Running setup.py (path:/tmp/pip-dzhsOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:43 INFO - Running setup.py (path:/tmp/pip-wHhoNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:43 INFO - Running setup.py (path:/tmp/pip-aZnSv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:43 INFO - Running setup.py (path:/tmp/pip-oOz5Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:43 INFO - Running setup.py (path:/tmp/pip-B3s52o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:43 INFO - Running setup.py (path:/tmp/pip-VAP1Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:43 INFO - Running setup.py (path:/tmp/pip-aIHk49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:43 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)) 20:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:43 INFO - Running setup.py (path:/tmp/pip-jcDOsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:43 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)) 20:15:43 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)) 20:15:43 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)) 20:15:43 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)) 20:15:43 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)) 20:15:43 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)) 20:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:45 INFO - Downloading blessings-1.6.tar.gz 20:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:45 INFO - Installing collected packages: blessings 20:15:45 INFO - Running setup.py install for blessings 20:15:45 INFO - Successfully installed blessings 20:15:45 INFO - Cleaning up... 20:15:45 INFO - Return code: 0 20:15:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:46 INFO - Reading from file tmpfile_stdout 20:15:46 INFO - Current package versions: 20:15:46 INFO - argparse == 1.2.1 20:15:46 INFO - blessings == 1.6 20:15:46 INFO - blobuploader == 1.2.4 20:15:46 INFO - docopt == 0.6.1 20:15:46 INFO - functools32 == 3.2.3-2 20:15:46 INFO - jsonschema == 2.5.1 20:15:46 INFO - manifestparser == 1.1 20:15:46 INFO - mozInstall == 1.12 20:15:46 INFO - mozcrash == 0.17 20:15:46 INFO - mozdebug == 0.1 20:15:46 INFO - mozdevice == 0.48 20:15:46 INFO - mozfile == 1.2 20:15:46 INFO - mozhttpd == 0.7 20:15:46 INFO - mozinfo == 0.9 20:15:46 INFO - mozleak == 0.1 20:15:46 INFO - mozlog == 3.3 20:15:46 INFO - moznetwork == 0.27 20:15:46 INFO - mozprocess == 0.23 20:15:46 INFO - mozprofile == 0.28 20:15:46 INFO - mozrunner == 6.12 20:15:46 INFO - mozscreenshot == 0.1 20:15:46 INFO - mozsystemmonitor == 0.3 20:15:46 INFO - moztest == 0.7 20:15:46 INFO - mozversion == 1.4 20:15:46 INFO - psutil == 3.1.1 20:15:46 INFO - requests == 1.2.3 20:15:46 INFO - wsgiref == 0.1.2 20:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:46 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:46 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 20:15:46 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 20:15:46 INFO - Using env: {'DISPLAY': ':0', 20:15:46 INFO - 'HOME': '/home/cltbld', 20:15:46 INFO - 'LANG': 'en_US.UTF-8', 20:15:46 INFO - 'LANGUAGE': 'en_US:en', 20:15:46 INFO - 'LOGNAME': 'cltbld', 20:15:46 INFO - 'MAIL': '/var/mail/cltbld', 20:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:46 INFO - 'MOZ_NO_REMOTE': '1', 20:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:46 INFO - 'NO_EM_RESTART': '1', 20:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:46 INFO - 'PWD': '/builds/slave/test', 20:15:46 INFO - 'SHELL': '/bin/bash', 20:15:46 INFO - 'SHLVL': '1', 20:15:46 INFO - 'TERM': 'linux', 20:15:46 INFO - 'TMOUT': '86400', 20:15:46 INFO - 'USER': 'cltbld', 20:15:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:46 INFO - '_': '/tools/buildbot/bin/python'} 20:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 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)) 20:15:46 INFO - Cleaning up... 20:15:46 INFO - Return code: 0 20:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:46 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', '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 20:15:46 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 20:15:46 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 20:15:46 INFO - Using env: {'DISPLAY': ':0', 20:15:46 INFO - 'HOME': '/home/cltbld', 20:15:46 INFO - 'LANG': 'en_US.UTF-8', 20:15:46 INFO - 'LANGUAGE': 'en_US:en', 20:15:46 INFO - 'LOGNAME': 'cltbld', 20:15:46 INFO - 'MAIL': '/var/mail/cltbld', 20:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:46 INFO - 'MOZ_NO_REMOTE': '1', 20:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:46 INFO - 'NO_EM_RESTART': '1', 20:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:46 INFO - 'PWD': '/builds/slave/test', 20:15:46 INFO - 'SHELL': '/bin/bash', 20:15:46 INFO - 'SHLVL': '1', 20:15:46 INFO - 'TERM': 'linux', 20:15:46 INFO - 'TMOUT': '86400', 20:15:46 INFO - 'USER': 'cltbld', 20:15:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:46 INFO - '_': '/tools/buildbot/bin/python'} 20:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:15:46 INFO - Cleaning up... 20:15:46 INFO - Return code: 0 20:15:46 INFO - Running post-action listener: _resource_record_post_action 20:15:46 INFO - Running post-action listener: _start_resource_monitoring 20:15:46 INFO - Starting resource monitoring. 20:15:46 INFO - [mozharness: 2016-08-06 03:15:46.572552Z] Finished create-virtualenv step (success) 20:15:46 INFO - [mozharness: 2016-08-06 03:15:46.573037Z] Running install step. 20:15:46 INFO - Running pre-action listener: _resource_record_pre_action 20:15:46 INFO - Running main action method: install 20:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:46 INFO - Reading from file tmpfile_stdout 20:15:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:46 INFO - Reading from file tmpfile_stdout 20:15:46 INFO - Output received: 20:15:46 INFO - Usage: mozinstall [options] installer 20:15:46 INFO - Options: 20:15:46 INFO - -h, --help show this help message and exit 20:15:46 INFO - -d DEST, --destination=DEST 20:15:46 INFO - Directory to install application into. [default: 20:15:46 INFO - "/builds/slave/test"] 20:15:46 INFO - --app=APP Application being installed. [default: firefox] 20:15:46 INFO - mkdir: /builds/slave/test/build/application 20:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:16:04 INFO - Reading from file tmpfile_stdout 20:16:04 INFO - Output received: 20:16:04 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:04 INFO - Running post-action listener: _resource_record_post_action 20:16:04 INFO - [mozharness: 2016-08-06 03:16:04.367090Z] Finished install step (success) 20:16:04 INFO - [mozharness: 2016-08-06 03:16:04.367341Z] Running run-tests step. 20:16:04 INFO - Running pre-action listener: _resource_record_pre_action 20:16:04 INFO - Running main action method: run_tests 20:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:04 INFO - Python 2.7.3 20:16:04 INFO - Return code: 0 20:16:04 INFO - grabbing minidump binary from tooltool 20:16:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:04 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:04 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 20:16:04 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 20:16:04 INFO - Calling ['/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'] with output_timeout 600 20:16:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:04 INFO - Return code: 0 20:16:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:04 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/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:16:04 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/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 20:16:04 INFO - Using env: {'DISPLAY': ':0', 20:16:04 INFO - 'HOME': '/home/cltbld', 20:16:04 INFO - 'LANG': 'en_US.UTF-8', 20:16:04 INFO - 'LANGUAGE': 'en_US:en', 20:16:04 INFO - 'LOGNAME': 'cltbld', 20:16:04 INFO - 'MAIL': '/var/mail/cltbld', 20:16:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:04 INFO - 'MOZ_NO_REMOTE': '1', 20:16:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:04 INFO - 'NO_EM_RESTART': '1', 20:16:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:04 INFO - 'PWD': '/builds/slave/test', 20:16:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:04 INFO - 'SHELL': '/bin/bash', 20:16:04 INFO - 'SHLVL': '1', 20:16:04 INFO - 'TERM': 'linux', 20:16:04 INFO - 'TMOUT': '86400', 20:16:04 INFO - 'USER': 'cltbld', 20:16:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547', 20:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:04 INFO - '_': '/tools/buildbot/bin/python'} 20:16:04 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/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 20:16:04 INFO - mozversion application_buildid: 20160805173004 20:16:04 INFO - mozversion application_changeset: 1646172ac6e709f5abdecbd8edbb53a54392428a 20:16:04 INFO - mozversion application_display_name: Nightly 20:16:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:04 INFO - mozversion application_name: Firefox 20:16:04 INFO - mozversion application_remotingname: firefox 20:16:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:16:04 INFO - mozversion application_vendor: Mozilla 20:16:04 INFO - mozversion application_version: 51.0a1 20:16:04 INFO - mozversion platform_buildid: 20160805173004 20:16:04 INFO - mozversion platform_changeset: 1646172ac6e709f5abdecbd8edbb53a54392428a 20:16:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:16:04 INFO - mozversion platform_version: 51.0a1 20:16:04 INFO - using testdate: 1470453364 20:16:04 INFO - actual date: 1470453364 20:16:04 INFO - starting webserver on 'localhost:47377' 20:16:04 INFO - SUITE-START | Running 2 tests 20:16:04 INFO - TEST-START | dromaeo_css 20:16:04 INFO - operating with platform_type : linux_ 20:16:04 INFO - Initialising browser for dromaeo_css test... 20:16:04 INFO - TEST-INFO | started process 5317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDiR84/profile http://localhost:47377/getInfo.html) 20:16:09 INFO - PROCESS | 5317 | __metrics Screen width/height:1600/1200 20:16:09 INFO - PROCESS | 5317 | colorDepth:24 20:16:09 INFO - PROCESS | 5317 | Browser inner width/height: 1024/697 20:16:09 INFO - PROCESS | 5317 | __metrics 20:16:09 ERROR - PROCESS | 5317 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:16:10 INFO - TEST-INFO | 5317: exit 0 20:16:10 INFO - Browser initialized. 20:16:10 INFO - Running cycle 1/1 for dromaeo_css test... 20:16:10 INFO - TEST-INFO | started process 5438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDiR84/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:22 INFO - PROCESS | 5438 | RSS: Main: 164577280 20:16:22 INFO - PROCESS | 5438 | 20:17:12 INFO - PROCESS | 5438 | 1470453432133 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] 20:19:21 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47377/tests/dromaeo/cssquery-ext.html) 20:19:22 INFO - PROCESS | 5438 | RSS: Main: 167043072 20:19:22 INFO - PROCESS | 5438 | 20:22:25 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-ext.html (next: http://localhost:47377/tests/dromaeo/cssquery-jquery.html) 20:22:25 INFO - PROCESS | 5438 | RSS: Main: 166133760 20:22:25 INFO - PROCESS | 5438 | 20:25:27 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47377/tests/dromaeo/cssquery-mootools.html) 20:25:28 INFO - PROCESS | 5438 | RSS: Main: 170631168 20:25:28 INFO - PROCESS | 5438 | 20:28:30 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47377/tests/dromaeo/cssquery-prototype.html) 20:28:30 INFO - PROCESS | 5438 | RSS: Main: 165203968 20:28:30 INFO - PROCESS | 5438 | 20:31:33 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47377/tests/dromaeo/cssquery-yui.html) 20:31:33 INFO - PROCESS | 5438 | RSS: Main: 167149568 20:31:33 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | Cycle 1(1): loaded http://localhost:47377/tests/dromaeo/cssquery-yui.html (next: http://localhost:47377/tests/dromaeo/cssquery-dojo.html) 20:34:36 INFO - PROCESS | 5438 | RSS: Main: 170536960 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | __start_tp_report 20:34:36 INFO - PROCESS | 5438 | _x_x_mozilla_page_load 20:34:36 INFO - PROCESS | 5438 | _x_x_mozilla_page_load_details 20:34:36 INFO - PROCESS | 5438 | |i|pagename|runs| 20:34:36 INFO - PROCESS | 5438 | |0;dojo.html;3093.5514350419185;3102.053873568561;3126.3434678717467;3132.9060128196147;3156.1320636824885;5242.6330156889035;5363.141897296428;5387.299651045363;5400.810971615994;5452.291202143726;5395.21769343446;5415.350157981048;5465.07093794055;5504.889902201953;5511.173324001392;4858.78135483904;4945.901081978358;4946.109700253953;4984;5059.266406371093;4968.453470118284;4999.475055119215;5028.245763135523;5050.368703912011;5061.645684802065;4709.411323584552;4779.307000484945;4881.8779530511665;4927.531884470987;4929.433115191763;4786.641001924835;4816.710997340171;4818.518148185189;4820.060088282787;4824.372831531913;4758.976205118987;4759.643026772971;4776;4780.4741478437345;4894.094592500363;5382.8923421531745;5416.539594134503;5422.864428389283;5447.918281225785;5455.563554915597;5754.798582049608;5756.107803290497;5773.971130144322;5802.071668533056;5818.854528636775;5852.56105792063;5885.646861188342;5913.29040515141;5920.437558431942;5921.703914804286;5458.5087342139395;5479.315085614258;5493.340799104093;5496.4778346057465;5503.449655034545;5721.8569535761935;5881.588288819741;5906;5907.940920590825;5987.520998320124;5724.914126288109;5772.105323674753;5775.884482310415;5777.277840269966;5779.711014449261;5812.564057695689;5814.796482123105;5828.76684932598;5832.650040997553;5854.619449735838;5571.9442805572235;5771.307443106854;5808.5933984621515;5817.7382017809305;5915.497182739429;5835.737391817378;5857.47282744555;5859.794907178229;5860.589758716934;5869.295684517885;4434.445694288214;4484.641228701696;4495.9325610115875;4497.280435130363;4529.026259354255;3874.9612503875164;3918;3934.1934903344745;3956.1296514766705;4016.979915100406;5481.260029895992;5489.094299440548;5533.750981205855;5545.195946587723;5554.805581804618;5835.081233776958;5835.854103647358;5839.299284085937;5858.179854820329;5860.531157507389;5429.049916264638;5556.111022236423;5560.972195138998;5591.692456914909;5678.0915053591225;5042.294078828967;5045.243213517928;5052.722100284446;5057.620678449131;5061.6962982221185;6069.908951365733;6110.663913484712;6111.54163437735;6128.295246046761;6150.876982460326;5604.6917419542315;5740.13897915316;5812.564057695774;5826.271716035496;5899.262592175978;6018.037114061729;6047.0627052806885;6058.394160583906;6058.454739073504;6088.695565221809;5743.483086522233;5756.510696590669;5768.336641286306;5774.3648198697265;5792.507636850914;5642.097264437671;5726.083826587893;5735.483806457439;5776.335721392094;5873.970630146822;5662.57530685192;5694.345150307768;5694.800681976111;5697.943020569741;5711.657300561979;5623.268975033219;5639.605227634191;5672.2058911751565;5677.659340439587;5686.630369026;5390.784368625211;5567.331920169606;5627.155926611041;5631.8592035199445;5642.774289028557;5705.34388545306;5767.423257674199;5782.363939966516;5785.508231800344;5792.681402522901;5429.972850135882;5601;5611.80358687444;5614.522765564972;5628.099504079328 20:34:36 INFO - PROCESS | 5438 | |1;ext.html;544.5224416348796;575.197599348908;585.5023230254285;600.8197540737779;619.7490016543302;38158.23683526328;42667.14665706684;42716.57283427169;42719.78640106799;42889.14221715564;43284;43302;43436.56563434365;43448.78275608626;43638.56361436385;8770.780730481758;9037;9052.592633331516;9059.728208153765;9060.773480663003;8944.329175311845;9014;9031.774205644879;9060.365774395763;9078.636854525812;9076.137766912167;9108.134727200906;9117.49853758043;9138.360314777969;9164.954175229148;9054.77363065922;9098.45409275439;9107.817843643157;9110.180083792491;9136.954315228448;8927.687530936386;9015.954920225422;9023.593938272794;9034.322425818023;9044.592993315317;41775;42188;42256.3661545074;42275.154496910196;42321.78839105816;3518;3635.745497815154;3749.606291339425;4147.937780933288;4232.8518501852595;32451.51322730161;32524;32682.182945426317;32766.180845478815;34233.82883085569;4278.44380230568;4365.12697460506;4378.846740364103;4401.735895846259;4512.165249428834;356237;356763;357926.2103689491;360496;360931;59225;59720.40279597235;59733;59772;59811;33906.32187356239;34172.31655366879;34189.829050855085;34482.82758586191;34485.310293793984;16080.919595402182;16088.276027578788;16152.919235403748;16168;16218.10800405989;12181;12264.325462099492;12301.261924284392;12307.93846030782;12326.938365308117;19592.70610940837;19683.31108411199;19701.40895773129;19770.60458790845;19817.306394276133;7538.585377804164;7551.320381165611;7571.091469023752;7583;7601.909474894338;949.8907625623003;1033.3128469567653;1061.5806756331206;1084.8481212630238;1120.3781901045;33785;34463.827680861934;34735.47896781551;34787.478187827204;35149.824250878584;1144.9084073274119;1161.0479406886272;1176.5470293936726;1204.6807595986895;1225.4975460061332;17691.823081769016;17724.556886077695;17913.462596122135;18032.909835451002;18072.819271807377;619622;619943;622605;622786;628311;60668;60762.696186518784;61184.69407653022;61279.6936015326;61497.69251153805;1313.6912825486195;1366.7608168570262;1367.418846990045;1376.9724605507834;1403.4596680278166;32063.519047213846;33047.50428743619;33614;33873.830630846685;34024.82987585046;53377;53595;53694;53772.193417097995;53858.46141538535;458882;461160;462300;462447;464893;28948.27629309284;30095.548566771955;30138.09585712432;30142;30219.69780302257;49215.26177107275;50763.238551422495;51052;51247.74376128095;51671.48328516817;41730.58269417267;42546;43177.3523397143;43345.34981975336;44700;41758.37362439626;42020;42513.574864250964;43361.78319108384;43941.340879886186;42661.14677706367;42708;44061.33907991319;44139;44205.55794442014;33472.33055338831;37536.812315938245;37583.81208093942;37600.43599345957;38401;28935.276618084717;28979.565306520843;29058;29159.562606561343;29349.55975660324 20:34:36 INFO - PROCESS | 5438 | |2;jquery.html;373.83924912287716;376.8172436368361;380.77724531149283;392.6132759232156;397.4277041060874;18355;19622.117004734784;20029.399118026464;20231.898840505793;20240;19050.33323833666;19302.420927372164;19600.90199549004;19806.90096549515;19823.702644460343;5387.568994480452;5584.581156413265;5623.80316688916;5870.148828419877;5876.70616469177;5750.683712395817;5777.393373695764;5793.652380857162;5797.507211886995;5803.564732645047;5682.232898558683;5764.106563482646;5767.625104368223;5788.392218817026;5793.826185214451;5664.20701101846;5775.740091695884;5776.768929242825;5784.161296611967;5791.681457519835;4657.743824089674;4924.039812236615;4935.703857768545;5007.974960125176;5009.373828271466;12138.422005139364;12319.076069294839;19751;22605;22865.77134228653;2170.4790850195996;2486.2168416948784;2562.57717476618;2774.3618967637353;2967.0903708863134;10267.537960791708;10326;10367;10430;10693.572257109707;1837.2926423326983;1875.7655293088364;1950.8439324853978;1951.0829909942304;1964.2437661500283;79981.99999999942;81696.59151704263;82497.58751206266;83570;88586;9716.222702183808;9970.601175953027;10025.699229023141;10177.236707246986;10250.38497690141;13683.452661893412;13692.31538423075;13713.862861371457;13732.176069435665;13821.585352439442;7288;7580.54516728998;7595.5442673439775;7760.805979850436;7790.961045194851;7263.237360077222;7359.889601655979;7586.051743532059;7600.961995189989;7613.162552119263;4080.3063479208604;4203.117345357509;4258.276093064186;4274.700770946004;4359.258925982591;1716.9484915452556;1749.2390809997692;1764.479478553804;1765.2409463930633;1904.5333893196255;437.64332069363365;460.82488654311146;463.64762780287225;471.24835886760565;1038.3977293170094;10593.311434756715;11292;11433.942830285796;11538.538458461735;11715.824262636068;471.3165909431338;474.122872685529;478.82762205605957;480.19567224898157;487.5928599619287;6027.095935609606;6083.8174854754425;6125.264968203844;6185.134081228632;6223.661912688794;529962;530942;542911;551336;552655;83612.58193708993;84737;91589;101625;104881;445.1120015568961;461.7621924708778;467.6889868237584;986.8963758805365;1023.7696518283327;9942.403455792386;10453.738656533647;10608.310459820086;11063;11261.380624065427;32281.35437291288;40765.59234407737;42004;42286.365704515076;42858.35703965198;54882.45117548773;60138.39861601328;60653.39346606477;60867.69566152141;61102.0834687489;8275.717994886656;8336.791580210544;8682.652693892174;8716.956415217883;8751.91248087511;9487.620495180116;12400.19398739079;13442.932785336401;13508.662283442993;13537.187768733907;11781.469833857669;11806;11908.76182476363;12105.69735756613;12389.62831115068;11268.38023908693;11387.715307117389;11436.142289328167;11868.40657967081;12102.878971210175;11725.237859539102;11860.76278474443;11897.583584574499;11902.345371004678;11960.222585532261;8433.325333973391;8540.70107546233;8606.483610983361;8759.737207883774;8928.910710893068;10904.61833835812;11770.941145294219;11868.169228153947;11982.10134239918;11998.860108289698 20:34:36 INFO - PROCESS | 5438 | |3;mootools.html;1506.8493150684928;1518.8177418709754;1652.5538104711727;1742.5382273697464;1786.508710104721;7739.187385324544;8709.695160669378;8787.472751634907;9346.252299816015;9367.484788336638;8815.118488151182;9142;9160.038195989426;9169.358144929842;9221.58502867371;2291.9312420627407;2357.634566642173;2360.3509035015336;2362.232274510782;2362.4566349739484;2262.9773702263014;2267.8299127565415;2321.0367697405554;2322.245270287155;2324.7442781294044;2327.499587588668;2332.3003099070297;2338.8128949683983;2357.3988632898586;2366.8934897929635;2231.631780756173;2243.1251811793413;2243.2372993182316;2251.3921241264766;2261.8416710830247;2262.106467945169;2269.693591365161;2291.7593652666565;2292.1862738727846;2316.791488766019;9110.908890911072;9181.173694367539;9235.122663347038;9271.860922086174;9294.302927280414;5182.196759502283;5330.546903513206;5335.413104558495;5337.572994160458;5338.27933229013;3205.8397080146133;3219.3239419721885;3289.506574013893;3327.234736010707;3372.0558243691808;1128.328644456547;1132.592266783957;1137;1147.5639257082255;1155.3587758793867;12729.554465593752;12749.74500509994;12814.42335094923;12859.935700321532;12877.67805804853;4382.890427739332;4396.054848207651;4651.837185698484;4715.858524244278;4738.1708201064675;10680;10706.089982351432;10714.303570267908;10718.678439646823;10724.41015744126;5277.709725965109;5333.626646134733;5345.278387417727;5347.598930080259;5349.625526213128;4256.2551553478015;4692.202325604587;4799.488161229271;4810.326554282403;4914.926276105862;3807.3146833569667;4027.597240275949;4042.9393559096047;4047.655949244347;4073.6333729964445;1236.6290112966253;1246.7880460321767;1248.2759999200441;1257.874212578753;1273.089740835307;793.4089103617727;909.3997961345481;914.8444764390069;938.6996161228342;949.9335046546813;5785.161151633074;5959.433853783884;5975.19334889793;6006.579539432198;6168.383161683885;447.84101643915943;450.4616982705701;459.07496394764576;463.0807846424844;463.59667089632234;3872.554656214515;3940.625640564142;3997.2205419942834;4031.213913286881;4070.816813243411;11062.115030797517;11505.367204803648;11514.136439767051;11523.48144333507;11539.423028848523;11336.093112550976;11352.091832653368;11393.658190254306;11395.430228488542;11428;8100.392470564731;8449.155084491502;8506.106858779738;8507.361947853935;8592.3555733319;5874.735636896265;5987.820365389045;6052.606580572248;6165.260168779775;6182.567220294716;10631.20265980039;10714.357138571711;10721.839172412265;10754.139668826632;10763.408012559072;10137.746556336151;10302.536385862804;10442.791144176921;10520.842187367349;10560.419176945034;6580.76967306142;7702.807429814299;7724.382049435919;7856.175101614477;7935.285824275843;8787.384883058125;8837.646494140163;8871.556422178735;8899.510526921082;8906.73279801607;7760.611969401621;7982.680692772224;7992.360611150978;8019.879701804594;8354.16458354184;7618.961905190438;7886.329661978796;7894.486858354188;7956.9602151988865;7987.840243194987;7003.5797852129035;7015.263397343206;7091;7114.644267786486;7133.964330178316;5142.614303927146;5207.661502002357;5254;5276.129438642581;5289.867753306198;5075.390953085654;5076.11168045598;5092.261622064854;5182.818601348935;5335.279737235579 20:34:36 INFO - PROCESS | 5438 | |4;prototype.html;322.49690482846756;322.61125343960543;324.2137815796692;327.45315323409903;329.13930072859466;5253.8949221015555;5414.593905457087;5450.509454149126;5491.286132802735;5511.6968566728865;5440.483154100364;5497.92790405871;5508.614396992212;5518.392976772562;5522.6134170608075;4283.229018776619;4307.418498502709;4318.762468064255;4324.654027677794;4328.805203765838;4105.404716316148;4223.683223758215;4277.8288868445225;4314.266574682296;4315;4236.745795252279;4242.639375653073;4250.404943307939;4264.978675106636;4290.227759003378;4289.4209281747035;4294.184105020067;4300.290452075404;4307.935380969288;4314.417553630283;3644.125409901631;3797.468354430382;3809.333366660851;3831.406132049509;3840.2127563849344;5250.687328167958;5279.759256574702;5283.577313814885;5337.226102215196;5345.305110335631;4856.781444834991;4883.804647814083;4900.26496025599;4923.950760492385;4954.504549545053;5550.696460968693;5744.511716504102;5746.626469279525;5750.913736293959;5771.595988280822;4129.050318426779;4134.793260336971;4147.543770185277;4168.228877657643;4181.97909010453;6002.909956350658;6017.398260173992;6017.669028203447;6032.849178770522;6062.938985677489;3944.861929832442;4137.731047481964;4260.573942605714;4264.249559034405;4300.7634580097765;4175.578164664487;4178.185253875465;4186.769727664947;4189.895252618648;4191.811368488426;4779.139754844162;4834.613230941516;4845.75771211438;4846.854594362175;4849.975750121227;5641.984442800253;5811.593188476766;5836.941630583725;5852;5868.4424979626865;1405.36758458694;1421.1473116130446;1425.7576212043978;1425.828900531922;1426.7075249573813;874.2830878679422;898.9437411042;912.7489940266347;918.8208299381556;927.596495524449;4893.388326459192;4897.657163998486;4900.26496025599;4944.354770197999;5011.649184557119;5177.301064356264;5216.921746173811;5228.581713462914;5229.372475302988;5247.763850626731;4787.832425865078;4908.779104940286;4979.460475157695;5011.699298042129;5049.495050494921;2745.546984747534;2779.4857951279077;2781.2490627530856;2794.7484726374723;2808.0031588786096;5330.893382132335;5363.2759577456545;5427.565794736412;5431.293931788921;5441.183822426668;5273.525382715574;5291.841244762663;5624.634398764068;6083.992282546749;6103.176071230416;6198.81403557894;6250.9373406521;6258.687065646699;6263.968680156661;6297.055441683784;5813.460704296271;5945.732442040032;5982.611130276518;5988.790392336247;6007.669578173242;5928.762849485972;5939.732712027882;5941.168236446814;5947.739858853608;5968.46283834457;6186.566940314135;6233.657148856856;6260.906086408617;6282.748690052346;6292.622442653455;3874.767513949172;4137.531176432443;4236.796865629917;4261.232978063854;4284.635805956528;5842.38654941225;5857.4435428634215;5858.384869588632;5872.677002764889;5936.317323507852;5678.914816277676;5735.8852822944145;5809.680467574324;5812.360640329645;5823.563232757476;5648.435156484319;5678.346990096192;5708.771649134154;5730.71346432685;5735.4551317624755;5701.344345400332;5719.654941473976;5722.341930678025;5731.627444216113;5751.252337196138;5498.835034948958;5660.349059858005;5704.828855134187;5766.826995190151;5773.971130144322;5653.943460565341;5683;5700.25896633435;5729.28383952006;5742.310922689304 20:34:36 INFO - PROCESS | 5438 | |5;yui.html;680.0920770771021;703.9436845052395;745.7278093495876;772.7565816767718;776.483638380477;15752.606184845385;17291.654166916687;17296.308147674077;17304.307827686876;17435.738463923037;14593.562193134223;14796.778048329285;14797.926010369933;14815.851841481608;14819.55541333759;666.8466252761843;791.9960400197991;796.9920300796975;817.4931542443663;822.5928165558057;823.5347028928666;829.6059371798377;831.9126491718373;831.9251267385933;833.6332013913858;877.079066979672;877.8946526416839;878.2315473960285;880.9075047120057;884.5709830732089;876.758891304893;876.9429987050821;877.0308808766285;877.3419935048713;878.6178012564554;632.6963057732314;637.8692368064582;638.8019713888709;638.8307098618869;639.9616023038633;15474.381024758995;15487.303071361815;15496.92251538735;15500.689986200212;15502.844971550252;15783.289751961189;15835.920820395939;15849.683006339925;15870.12714300713;15881;12335.074869384742;12354.75290494194;12470.563530276397;12594.43325050375;12636.178648387826;3857.662798050255;3929.115948911472;4054.979725101385;4092.5907409259135;4188.727732697365;83120.58439707823;83827.58086209591;84138.99999999939;84321.15678843194;84408.15591844065;11588.246763960316;11703.590374336858;11832;11838.171328007129;12210.450529726184;23071.423214419774;23401.648975265383;23447;23449.648255275843;23564.293071207892;8810.251128654008;8987.370884038186;9096.81806363869;9180.724578262663;9207.861882071775;4785.306130611042;4890.095332363524;4927.43334516528;4944.283078953604;4974.204127339681;3437.5015622734563;3499.580050393969;3545.539079919594;3556.6976806971697;3560.394732895414;570.1846359705578;579.0503574138417;587.5475883569627;594.1325664529835;595.1905408644241;618.3476432363899;703.8888114533773;719.8956151358024;729.2707292707292;743.7880204141902;9081.45511269326;9093.272538196929;9298.445430204229;9449.574769135406;9653.855192171983;628.4815027602247;643.4305639509068;665.2781731821028;668.582136164897;675.2673349415841;4617.376654151713;4626.606738427204;4629.560191781776;4629.6990695605355;4679.555442233051;112126;128611.35694321469;128702.35648821696;130081.34959325143;132368.6907827312;109127;110997;113060;114683.42658286823;115466.42266788612;97602;97797;98460.50769746248;99316.50341748245;102011;8642.919635045619;8745.091377811457;8791.296696264155;8905.955470222607;9121.498317592595;55713.88572228614;56763.43236567581;56950;57997.42002580089;58720.11919821121;74942.6252868754;82930.58534707288;83064.16935830565;84299.15700843159;86841.56579217063;12296;12544.749105017667;12629.2422454653;12761.489540418279;13392.531261405804;12762.361881906054;12909.096363254483;13249.470021199044;13470.124441911245;13500.662483437993;11855;11977.221480603734;12300.87699123033;12416.068794840243;13017.153884997444;13132.803007955079;13212.537561185312;13370.598882033555;13469.663258418226;13870.791938120734;12696.809547856974;12755.362231888183;12909.160904541175;13052.412641431349;13284.933575332061;10565.735856603338;10582.4708764563;10794.622188223375;10946.357181216292;11058.723531911766;9390.741006730977;10440.895591044296;10907.672769816918;10923.344599324066;11090.334579925231 20:34:36 INFO - PROCESS | 5438 | __end_tp_report 20:34:36 INFO - PROCESS | 5438 | __start_cc_report 20:34:36 INFO - PROCESS | 5438 | _x_x_mozilla_cycle_collect,332 20:34:36 INFO - PROCESS | 5438 | __end_cc_report 20:34:36 INFO - PROCESS | 5438 | __startTimestamp1470454476705__endTimestamp 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | ------- Summary: start ------- 20:34:36 INFO - PROCESS | 5438 | Number of tests: 6 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#0] dojo.html Cycles:165 Average:5400.73 Median:5623.27 stddev:628.39 (11.2%) stddev-sans-first:603.69 20:34:36 INFO - PROCESS | 5438 | Values: 3093.6 3102.1 3126.3 3132.9 3156.1 5242.6 5363.1 5387.3 5400.8 5452.3 5395.2 5415.4 5465.1 5504.9 5511.2 4858.8 4945.9 4946.1 4984.0 5059.3 4968.5 4999.5 5028.2 5050.4 5061.6 4709.4 4779.3 4881.9 4927.5 4929.4 4786.6 4816.7 4818.5 4820.1 4824.4 4759.0 4759.6 4776.0 4780.5 4894.1 5382.9 5416.5 5422.9 5447.9 5455.6 5754.8 5756.1 5774.0 5802.1 5818.9 5852.6 5885.6 5913.3 5920.4 5921.7 5458.5 5479.3 5493.3 5496.5 5503.4 5721.9 5881.6 5906.0 5907.9 5987.5 5724.9 5772.1 5775.9 5777.3 5779.7 5812.6 5814.8 5828.8 5832.7 5854.6 5571.9 5771.3 5808.6 5817.7 5915.5 5835.7 5857.5 5859.8 5860.6 5869.3 4434.4 4484.6 4495.9 4497.3 4529.0 3875.0 3918.0 3934.2 3956.1 4017.0 5481.3 5489.1 5533.8 5545.2 5554.8 5835.1 5835.9 5839.3 5858.2 5860.5 5429.0 5556.1 5561.0 5591.7 5678.1 5042.3 5045.2 5052.7 5057.6 5061.7 6069.9 6110.7 6111.5 6128.3 6150.9 5604.7 5740.1 5812.6 5826.3 5899.3 6018.0 6047.1 6058.4 6058.5 6088.7 5743.5 5756.5 5768.3 5774.4 5792.5 5642.1 5726.1 5735.5 5776.3 5874.0 5662.6 5694.3 5694.8 5697.9 5711.7 5623.3 5639.6 5672.2 5677.7 5686.6 5390.8 5567.3 5627.2 5631.9 5642.8 5705.3 5767.4 5782.4 5785.5 5792.7 5430.0 5601.0 5611.8 5614.5 5628.1 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#1] ext.html Cycles:180 Average:63536.40 Median:42664.15 stddev:131314.65 (307.8%) stddev-sans-first:131597.85 20:34:36 INFO - PROCESS | 5438 | Values: 544.5 575.2 585.5 600.8 619.7 38158.2 42667.1 42716.6 42719.8 42889.1 43284.0 43302.0 43436.6 43448.8 43638.6 8770.8 9037.0 9052.6 9059.7 9060.8 8944.3 9014.0 9031.8 9060.4 9078.6 9076.1 9108.1 9117.5 9138.4 9165.0 9054.8 9098.5 9107.8 9110.2 9137.0 8927.7 9016.0 9023.6 9034.3 9044.6 41775.0 42188.0 42256.4 42275.2 42321.8 3518.0 3635.7 3749.6 4147.9 4232.9 32451.5 32524.0 32682.2 32766.2 34233.8 4278.4 4365.1 4378.8 4401.7 4512.2 356237.0 356763.0 357926.2 360496.0 360931.0 59225.0 59720.4 59733.0 59772.0 59811.0 33906.3 34172.3 34189.8 34482.8 34485.3 16080.9 16088.3 16152.9 16168.0 16218.1 12181.0 12264.3 12301.3 12307.9 12326.9 19592.7 19683.3 19701.4 19770.6 19817.3 7538.6 7551.3 7571.1 7583.0 7601.9 949.9 1033.3 1061.6 1084.8 1120.4 33785.0 34463.8 34735.5 34787.5 35149.8 1144.9 1161.0 1176.5 1204.7 1225.5 17691.8 17724.6 17913.5 18032.9 18072.8 619622.0 619943.0 622605.0 622786.0 628311.0 60668.0 60762.7 61184.7 61279.7 61497.7 1313.7 1366.8 1367.4 1377.0 1403.5 32063.5 33047.5 33614.0 33873.8 34024.8 53377.0 53595.0 53694.0 53772.2 53858.5 458882.0 461160.0 462300.0 462447.0 464893.0 28948.3 30095.5 30138.1 30142.0 30219.7 49215.3 50763.2 51052.0 51247.7 51671.5 41730.6 42546.0 43177.4 43345.3 44700.0 41758.4 42020.0 42513.6 43361.8 43941.3 42661.1 42708.0 44061.3 44139.0 44205.6 33472.3 37536.8 37583.8 37600.4 38401.0 28935.3 28979.6 29058.0 29159.6 29349.6 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#2] jquery.html Cycles:180 Average:29710.72 Median:23272.32 stddev:89293.99 (383.7%) stddev-sans-first:89517.32 20:34:36 INFO - PROCESS | 5438 | Values: 373.8 376.8 380.8 392.6 397.4 18355.0 19622.1 20029.4 20231.9 20240.0 19050.3 19302.4 19600.9 19806.9 19823.7 5387.6 5584.6 5623.8 5870.1 5876.7 5750.7 5777.4 5793.7 5797.5 5803.6 5682.2 5764.1 5767.6 5788.4 5793.8 5664.2 5775.7 5776.8 5784.2 5791.7 4657.7 4924.0 4935.7 5008.0 5009.4 12138.4 12319.1 19751.0 22605.0 22865.8 2170.5 2486.2 2562.6 2774.4 2967.1 10267.5 10326.0 10367.0 10430.0 10693.6 1837.3 1875.8 1950.8 1951.1 1964.2 79982.0 81696.6 82497.6 83570.0 88586.0 9716.2 9970.6 10025.7 10177.2 10250.4 13683.5 13692.3 13713.9 13732.2 13821.6 7288.0 7580.5 7595.5 7760.8 7791.0 7263.2 7359.9 7586.1 7601.0 7613.2 4080.3 4203.1 4258.3 4274.7 4359.3 1716.9 1749.2 1764.5 1765.2 1904.5 437.6 460.8 463.6 471.2 1038.4 10593.3 11292.0 11433.9 11538.5 11715.8 471.3 474.1 478.8 480.2 487.6 6027.1 6083.8 6125.3 6185.1 6223.7 529962.0 530942.0 542911.0 551336.0 552655.0 83612.6 84737.0 91589.0 101625.0 104881.0 445.1 461.8 467.7 986.9 1023.8 9942.4 10453.7 10608.3 11063.0 11261.4 32281.4 40765.6 42004.0 42286.4 42858.4 54882.5 60138.4 60653.4 60867.7 61102.1 8275.7 8336.8 8682.7 8717.0 8751.9 9487.6 12400.2 13442.9 13508.7 13537.2 11781.5 11806.0 11908.8 12105.7 12389.6 11268.4 11387.7 11436.1 11868.4 12102.9 11725.2 11860.8 11897.6 11902.3 11960.2 8433.3 8540.7 8606.5 8759.7 8928.9 10904.6 11770.9 11868.2 11982.1 11998.9 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#3] mootools.html Cycles:180 Average:5912.93 Median:461.08 stddev:3480.73 (754.9%) stddev-sans-first:3474.75 20:34:36 INFO - PROCESS | 5438 | Values: 1506.8 1518.8 1652.6 1742.5 1786.5 7739.2 8709.7 8787.5 9346.3 9367.5 8815.1 9142.0 9160.0 9169.4 9221.6 2291.9 2357.6 2360.4 2362.2 2362.5 2263.0 2267.8 2321.0 2322.2 2324.7 2327.5 2332.3 2338.8 2357.4 2366.9 2231.6 2243.1 2243.2 2251.4 2261.8 2262.1 2269.7 2291.8 2292.2 2316.8 9110.9 9181.2 9235.1 9271.9 9294.3 5182.2 5330.5 5335.4 5337.6 5338.3 3205.8 3219.3 3289.5 3327.2 3372.1 1128.3 1132.6 1137.0 1147.6 1155.4 12729.6 12749.7 12814.4 12859.9 12877.7 4382.9 4396.1 4651.8 4715.9 4738.2 10680.0 10706.1 10714.3 10718.7 10724.4 5277.7 5333.6 5345.3 5347.6 5349.6 4256.3 4692.2 4799.5 4810.3 4914.9 3807.3 4027.6 4042.9 4047.7 4073.6 1236.6 1246.8 1248.3 1257.9 1273.1 793.4 909.4 914.8 938.7 949.9 5785.2 5959.4 5975.2 6006.6 6168.4 447.8 450.5 459.1 463.1 463.6 3872.6 3940.6 3997.2 4031.2 4070.8 11062.1 11505.4 11514.1 11523.5 11539.4 11336.1 11352.1 11393.7 11395.4 11428.0 8100.4 8449.2 8506.1 8507.4 8592.4 5874.7 5987.8 6052.6 6165.3 6182.6 10631.2 10714.4 10721.8 10754.1 10763.4 10137.7 10302.5 10442.8 10520.8 10560.4 6580.8 7702.8 7724.4 7856.2 7935.3 8787.4 8837.6 8871.6 8899.5 8906.7 7760.6 7982.7 7992.4 8019.9 8354.2 7619.0 7886.3 7894.5 7957.0 7987.8 7003.6 7015.3 7091.0 7114.6 7134.0 5142.6 5207.7 5254.0 5276.1 5289.9 5075.4 5076.1 5092.3 5182.8 5335.3 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#4] prototype.html Cycles:180 Average:4764.88 Median:5311.37 stddev:1424.16 (26.8%) stddev-sans-first:1388.57 20:34:36 INFO - PROCESS | 5438 | Values: 322.5 322.6 324.2 327.5 329.1 5253.9 5414.6 5450.5 5491.3 5511.7 5440.5 5497.9 5508.6 5518.4 5522.6 4283.2 4307.4 4318.8 4324.7 4328.8 4105.4 4223.7 4277.8 4314.3 4315.0 4236.7 4242.6 4250.4 4265.0 4290.2 4289.4 4294.2 4300.3 4307.9 4314.4 3644.1 3797.5 3809.3 3831.4 3840.2 5250.7 5279.8 5283.6 5337.2 5345.3 4856.8 4883.8 4900.3 4924.0 4954.5 5550.7 5744.5 5746.6 5750.9 5771.6 4129.1 4134.8 4147.5 4168.2 4182.0 6002.9 6017.4 6017.7 6032.8 6062.9 3944.9 4137.7 4260.6 4264.2 4300.8 4175.6 4178.2 4186.8 4189.9 4191.8 4779.1 4834.6 4845.8 4846.9 4850.0 5642.0 5811.6 5836.9 5852.0 5868.4 1405.4 1421.1 1425.8 1425.8 1426.7 874.3 898.9 912.7 918.8 927.6 4893.4 4897.7 4900.3 4944.4 5011.6 5177.3 5216.9 5228.6 5229.4 5247.8 4787.8 4908.8 4979.5 5011.7 5049.5 2745.5 2779.5 2781.2 2794.7 2808.0 5330.9 5363.3 5427.6 5431.3 5441.2 5273.5 5291.8 5624.6 6084.0 6103.2 6198.8 6250.9 6258.7 6264.0 6297.1 5813.5 5945.7 5982.6 5988.8 6007.7 5928.8 5939.7 5941.2 5947.7 5968.5 6186.6 6233.7 6260.9 6282.7 6292.6 3874.8 4137.5 4236.8 4261.2 4284.6 5842.4 5857.4 5858.4 5872.7 5936.3 5678.9 5735.9 5809.7 5812.4 5823.6 5648.4 5678.3 5708.8 5730.7 5735.5 5701.3 5719.7 5722.3 5731.6 5751.3 5498.8 5660.3 5704.8 5766.8 5774.0 5653.9 5683.0 5700.3 5729.3 5742.3 20:34:36 INFO - PROCESS | 5438 | 20:34:36 INFO - PROCESS | 5438 | [#5] yui.html Cycles:180 Average:22483.26 Median:4621.99 stddev:33718.42 (729.5%) stddev-sans-first:33773.27 20:34:36 INFO - PROCESS | 5438 | Values: 680.1 703.9 745.7 772.8 776.5 15752.6 17291.7 17296.3 17304.3 17435.7 14593.6 14796.8 14797.9 14815.9 14819.6 666.8 792.0 797.0 817.5 822.6 823.5 829.6 831.9 831.9 833.6 877.1 877.9 878.2 880.9 884.6 876.8 876.9 877.0 877.3 878.6 632.7 637.9 638.8 638.8 640.0 15474.4 15487.3 15496.9 15500.7 15502.8 15783.3 15835.9 15849.7 15870.1 15881.0 12335.1 12354.8 12470.6 12594.4 12636.2 3857.7 3929.1 4055.0 4092.6 4188.7 83120.6 83827.6 84139.0 84321.2 84408.2 11588.2 11703.6 11832.0 11838.2 12210.5 23071.4 23401.6 23447.0 23449.6 23564.3 8810.3 8987.4 9096.8 9180.7 9207.9 4785.3 4890.1 4927.4 4944.3 4974.2 3437.5 3499.6 3545.5 3556.7 3560.4 570.2 579.1 587.5 594.1 595.2 618.3 703.9 719.9 729.3 743.8 9081.5 9093.3 9298.4 9449.6 9653.9 628.5 643.4 665.3 668.6 675.3 4617.4 4626.6 4629.6 4629.7 4679.6 112126.0 128611.4 128702.4 130081.3 132368.7 109127.0 110997.0 113060.0 114683.4 115466.4 97602.0 97797.0 98460.5 99316.5 102011.0 8642.9 8745.1 8791.3 8906.0 9121.5 55713.9 56763.4 56950.0 57997.4 58720.1 74942.6 82930.6 83064.2 84299.2 86841.6 12296.0 12544.7 12629.2 12761.5 13392.5 12762.4 12909.1 13249.5 13470.1 13500.7 11855.0 11977.2 12300.9 12416.1 13017.2 13132.8 13212.5 13370.6 13469.7 13870.8 12696.8 12755.4 12909.2 13052.4 13284.9 10565.7 10582.5 10794.6 10946.4 11058.7 9390.7 10440.9 10907.7 10923.3 11090.3 20:34:36 INFO - PROCESS | 5438 | -------- Summary: end -------- 20:34:36 INFO - PROCESS | 5438 | 20:34:37 INFO - TEST-INFO | 5438: exit 0 20:34:37 INFO - TEST-OK | dromaeo_css | took 1112920ms 20:34:37 INFO - TEST-START | kraken 20:34:37 INFO - operating with platform_type : linux_ 20:34:37 INFO - Initialising browser for kraken test... 20:34:37 INFO - TEST-INFO | started process 5686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMopJOr/profile http://localhost:47377/getInfo.html) 20:34:42 INFO - PROCESS | 5686 | __metrics Screen width/height:1600/1200 20:34:42 INFO - PROCESS | 5686 | colorDepth:24 20:34:42 INFO - PROCESS | 5686 | Browser inner width/height: 1024/697 20:34:42 INFO - PROCESS | 5686 | __metrics 20:34:43 ERROR - PROCESS | 5686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:34:43 INFO - TEST-INFO | 5686: exit 0 20:34:43 INFO - Browser initialized. 20:34:43 INFO - Running cycle 1/1 for kraken test... 20:34:43 INFO - TEST-INFO | started process 5805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMopJOr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:55 INFO - PROCESS | 5805 | RSS: Main: 163938304 20:34:55 INFO - PROCESS | 5805 | 20:34:58 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47377/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:59 INFO - PROCESS | 5805 | RSS: Main: 169619456 20:34:59 INFO - PROCESS | 5805 | 20:35:01 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47377/tests/kraken/driver.html?testName=audio-dft) 20:35:02 INFO - PROCESS | 5805 | RSS: Main: 168415232 20:35:02 INFO - PROCESS | 5805 | 20:35:05 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47377/tests/kraken/driver.html?testName=audio-fft) 20:35:05 INFO - PROCESS | 5805 | RSS: Main: 164179968 20:35:05 INFO - PROCESS | 5805 | 20:35:08 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47377/tests/kraken/driver.html?testName=audio-oscillator) 20:35:08 INFO - PROCESS | 5805 | RSS: Main: 165662720 20:35:08 INFO - PROCESS | 5805 | 20:35:10 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:35:11 INFO - PROCESS | 5805 | RSS: Main: 166195200 20:35:11 INFO - PROCESS | 5805 | 20:35:14 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47377/tests/kraken/driver.html?testName=imaging-darkroom) 20:35:15 INFO - PROCESS | 5805 | RSS: Main: 166125568 20:35:15 INFO - PROCESS | 5805 | 20:35:18 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47377/tests/kraken/driver.html?testName=imaging-desaturate) 20:35:19 INFO - PROCESS | 5805 | RSS: Main: 163991552 20:35:19 INFO - PROCESS | 5805 | 20:35:22 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47377/tests/kraken/driver.html?testName=json-parse-financial) 20:35:22 INFO - PROCESS | 5805 | RSS: Main: 164843520 20:35:22 INFO - PROCESS | 5805 | 20:35:24 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:35:25 INFO - PROCESS | 5805 | RSS: Main: 164872192 20:35:25 INFO - PROCESS | 5805 | 20:35:26 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:27 INFO - PROCESS | 5805 | RSS: Main: 164765696 20:35:27 INFO - PROCESS | 5805 | 20:35:29 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:30 INFO - PROCESS | 5805 | RSS: Main: 166662144 20:35:30 INFO - PROCESS | 5805 | 20:35:32 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:33 INFO - PROCESS | 5805 | RSS: Main: 165597184 20:35:33 INFO - PROCESS | 5805 | 20:35:36 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:36 INFO - PROCESS | 5805 | RSS: Main: 166014976 20:35:36 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | Cycle 1(1): loaded http://localhost:47377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47377/tests/kraken/driver.html?testName=ai-astar) 20:35:38 INFO - PROCESS | 5805 | RSS: Main: 167034880 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | __start_tp_report 20:35:38 INFO - PROCESS | 5805 | _x_x_mozilla_page_load 20:35:38 INFO - PROCESS | 5805 | _x_x_mozilla_page_load_details 20:35:38 INFO - PROCESS | 5805 | |i|pagename|runs| 20:35:38 INFO - PROCESS | 5805 | |0;ai-astar;103;114;107;113;114;113;114;114;113;114 20:35:38 INFO - PROCESS | 5805 | |1;audio-beat-detection;146;117;146;197;125;151;143;120;187;118 20:35:38 INFO - PROCESS | 5805 | |2;audio-dft;161;162;161;162;162;167;169;163;161;164 20:35:38 INFO - PROCESS | 5805 | |3;audio-fft;87;76;77;175;76;76;77;76;183;87 20:35:38 INFO - PROCESS | 5805 | |4;audio-oscillator;84;88;140;86;85;85;138;84;84;154 20:35:38 INFO - PROCESS | 5805 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;118;117;126 20:35:38 INFO - PROCESS | 5805 | |6;imaging-darkroom;148;147;148;154;146;146;147;147;146;149 20:35:38 INFO - PROCESS | 5805 | |7;imaging-desaturate;97;97;95;96;96;96;96;95;96;95 20:35:38 INFO - PROCESS | 5805 | |8;json-parse-financial;52;52;52;51;52;53;52;50;51;51 20:35:38 INFO - PROCESS | 5805 | |9;json-stringify-tinderbox;60;61;62;60;61;60;61;61;61;61 20:35:38 INFO - PROCESS | 5805 | |10;stanford-crypto-aes;81;78;76;77;77;75;76;78;80;78 20:35:38 INFO - PROCESS | 5805 | |11;stanford-crypto-ccm;134;127;124;132;130;128;122;125;129;127 20:35:38 INFO - PROCESS | 5805 | |12;stanford-crypto-pbkdf2;161;163;161;159;162;162;162;160;161;158 20:35:38 INFO - PROCESS | 5805 | |13;stanford-crypto-sha256-iterative;65;64;64;65;63;65;63;63;62;62 20:35:38 INFO - PROCESS | 5805 | __end_tp_report 20:35:38 INFO - PROCESS | 5805 | __start_cc_report 20:35:38 INFO - PROCESS | 5805 | _x_x_mozilla_cycle_collect,890 20:35:38 INFO - PROCESS | 5805 | __end_cc_report 20:35:38 INFO - PROCESS | 5805 | __startTimestamp1470454538755__endTimestamp 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | ------- Summary: start ------- 20:35:38 INFO - PROCESS | 5805 | Number of tests: 14 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#0] ai-astar Cycles:10 Average:111.90 Median:114.00 stddev:3.78 (3.3%) stddev-sans-first:2.26 20:35:38 INFO - PROCESS | 5805 | Values: 103.0 114.0 107.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:146.00 stddev:27.98 (19.2%) stddev-sans-first:29.68 20:35:38 INFO - PROCESS | 5805 | Values: 146.0 117.0 146.0 197.0 125.0 151.0 143.0 120.0 187.0 118.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.74 (1.7%) stddev-sans-first:2.79 20:35:38 INFO - PROCESS | 5805 | Values: 161.0 162.0 161.0 162.0 162.0 167.0 169.0 163.0 161.0 164.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#3] audio-fft Cycles:10 Average:99.00 Median:76.50 stddev:42.43 (55.5%) stddev-sans-first:44.78 20:35:38 INFO - PROCESS | 5805 | Values: 87.0 76.0 77.0 175.0 76.0 76.0 77.0 76.0 183.0 87.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.50 stddev:28.75 (34.0%) stddev-sans-first:29.68 20:35:38 INFO - PROCESS | 5805 | Values: 84.0 88.0 140.0 86.0 85.0 85.0 138.0 84.0 84.0 154.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:2.72 (2.3%) stddev-sans-first:2.83 20:35:38 INFO - PROCESS | 5805 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 126.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:2.39 (1.6%) stddev-sans-first:2.54 20:35:38 INFO - PROCESS | 5805 | Values: 148.0 147.0 148.0 154.0 146.0 146.0 147.0 147.0 146.0 149.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 20:35:38 INFO - PROCESS | 5805 | Values: 97.0 97.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.84 (1.6%) stddev-sans-first:0.88 20:35:38 INFO - PROCESS | 5805 | Values: 52.0 52.0 52.0 51.0 52.0 53.0 52.0 50.0 51.0 51.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 20:35:38 INFO - PROCESS | 5805 | Values: 60.0 61.0 62.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.84 (2.4%) stddev-sans-first:1.48 20:35:38 INFO - PROCESS | 5805 | Values: 81.0 78.0 76.0 77.0 77.0 75.0 76.0 78.0 80.0 78.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:128.50 stddev:3.65 (2.8%) stddev-sans-first:3.10 20:35:38 INFO - PROCESS | 5805 | Values: 134.0 127.0 124.0 132.0 130.0 128.0 122.0 125.0 129.0 127.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:1.52 (0.9%) stddev-sans-first:1.62 20:35:38 INFO - PROCESS | 5805 | Values: 161.0 163.0 161.0 159.0 162.0 162.0 162.0 160.0 161.0 158.0 20:35:38 INFO - PROCESS | 5805 | 20:35:38 INFO - PROCESS | 5805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.13 20:35:38 INFO - PROCESS | 5805 | Values: 65.0 64.0 64.0 65.0 63.0 65.0 63.0 63.0 62.0 62.0 20:35:38 INFO - PROCESS | 5805 | -------- Summary: end -------- 20:35:38 INFO - PROCESS | 5805 | 20:35:39 INFO - TEST-INFO | 5805: exit 0 20:35:39 INFO - TEST-OK | kraken | took 62194ms 20:35:39 INFO - SUITE-END | took 1175s 20:35:39 INFO - Completed test suite (00:19:35) 20:35:39 INFO - javascript benchmark 20:35:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7183.542437892231, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.5514350419185, 3102.053873568561, 3126.3434678717467, 3132.9060128196147, 3156.1320636824885, 5242.6330156889035, 5363.141897296428, 5387.299651045363, 5400.810971615994, 5452.291202143726, 5395.21769343446, 5415.350157981048, 5465.07093794055, 5504.889902201953, 5511.173324001392, 4858.78135483904, 4945.901081978358, 4946.109700253953, 4984.0, 5059.266406371093, 4968.453470118284, 4999.475055119215, 5028.245763135523, 5050.368703912011, 5061.645684802065, 4709.411323584552, 4779.307000484945, 4881.8779530511665, 4927.531884470987, 4929.433115191763, 4786.641001924835, 4816.710997340171, 4818.518148185189, 4820.060088282787, 4824.372831531913, 4758.976205118987, 4759.643026772971, 4776.0, 4780.4741478437345, 4894.094592500363, 5382.8923421531745, 5416.539594134503, 5422.864428389283, 5447.918281225785, 5455.563554915597, 5754.798582049608, 5756.107803290497, 5773.971130144322, 5802.071668533056, 5818.854528636775, 5852.56105792063, 5885.646861188342, 5913.29040515141, 5920.437558431942, 5921.703914804286, 5458.5087342139395, 5479.315085614258, 5493.340799104093, 5496.4778346057465, 5503.449655034545, 5721.8569535761935, 5881.588288819741, 5906.0, 5907.940920590825, 5987.520998320124, 5724.914126288109, 5772.105323674753, 5775.884482310415, 5777.277840269966, 5779.711014449261, 5812.564057695689, 5814.796482123105, 5828.76684932598, 5832.650040997553, 5854.619449735838, 5571.9442805572235, 5771.307443106854, 5808.5933984621515, 5817.7382017809305, 5915.497182739429, 5835.737391817378, 5857.47282744555, 5859.794907178229, 5860.589758716934, 5869.295684517885, 4434.445694288214, 4484.641228701696, 4495.9325610115875, 4497.280435130363, 4529.026259354255, 3874.9612503875164, 3918.0, 3934.1934903344745, 3956.1296514766705, 4016.979915100406, 5481.260029895992, 5489.094299440548, 5533.750981205855, 5545.195946587723, 5554.805581804618, 5835.081233776958, 5835.854103647358, 5839.299284085937, 5858.179854820329, 5860.531157507389, 5429.049916264638, 5556.111022236423, 5560.972195138998, 5591.692456914909, 5678.0915053591225, 5042.294078828967, 5045.243213517928, 5052.722100284446, 5057.620678449131, 5061.6962982221185, 6069.908951365733, 6110.663913484712, 6111.54163437735, 6128.295246046761, 6150.876982460326, 5604.6917419542315, 5740.13897915316, 5812.564057695774, 5826.271716035496, 5899.262592175978, 6018.037114061729, 6047.0627052806885, 6058.394160583906, 6058.454739073504, 6088.695565221809, 5743.483086522233, 5756.510696590669, 5768.336641286306, 5774.3648198697265, 5792.507636850914, 5642.097264437671, 5726.083826587893, 5735.483806457439, 5776.335721392094, 5873.970630146822, 5662.57530685192, 5694.345150307768, 5694.800681976111, 5697.943020569741, 5711.657300561979, 5623.268975033219, 5639.605227634191, 5672.2058911751565, 5677.659340439587, 5686.630369026, 5390.784368625211, 5567.331920169606, 5627.155926611041, 5631.8592035199445, 5642.774289028557, 5705.34388545306, 5767.423257674199, 5782.363939966516, 5785.508231800344, 5792.681402522901, 5429.972850135882, 5601.0, 5611.80358687444, 5614.522765564972, 5628.099504079328], "value": 5357.30565104267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5224416348796, 575.197599348908, 585.5023230254285, 600.8197540737779, 619.7490016543302, 38158.23683526328, 42667.14665706684, 42716.57283427169, 42719.78640106799, 42889.14221715564, 43284.0, 43302.0, 43436.56563434365, 43448.78275608626, 43638.56361436385, 8770.780730481758, 9037.0, 9052.592633331516, 9059.728208153765, 9060.773480663003, 8944.329175311845, 9014.0, 9031.774205644879, 9060.365774395763, 9078.636854525812, 9076.137766912167, 9108.134727200906, 9117.49853758043, 9138.360314777969, 9164.954175229148, 9054.77363065922, 9098.45409275439, 9107.817843643157, 9110.180083792491, 9136.954315228448, 8927.687530936386, 9015.954920225422, 9023.593938272794, 9034.322425818023, 9044.592993315317, 41775.0, 42188.0, 42256.3661545074, 42275.154496910196, 42321.78839105816, 3518.0, 3635.745497815154, 3749.606291339425, 4147.937780933288, 4232.8518501852595, 32451.51322730161, 32524.0, 32682.182945426317, 32766.180845478815, 34233.82883085569, 4278.44380230568, 4365.12697460506, 4378.846740364103, 4401.735895846259, 4512.165249428834, 356237.0, 356763.0, 357926.2103689491, 360496.0, 360931.0, 59225.0, 59720.40279597235, 59733.0, 59772.0, 59811.0, 33906.32187356239, 34172.31655366879, 34189.829050855085, 34482.82758586191, 34485.310293793984, 16080.919595402182, 16088.276027578788, 16152.919235403748, 16168.0, 16218.10800405989, 12181.0, 12264.325462099492, 12301.261924284392, 12307.93846030782, 12326.938365308117, 19592.70610940837, 19683.31108411199, 19701.40895773129, 19770.60458790845, 19817.306394276133, 7538.585377804164, 7551.320381165611, 7571.091469023752, 7583.0, 7601.909474894338, 949.8907625623003, 1033.3128469567653, 1061.5806756331206, 1084.8481212630238, 1120.3781901045, 33785.0, 34463.827680861934, 34735.47896781551, 34787.478187827204, 35149.824250878584, 1144.9084073274119, 1161.0479406886272, 1176.5470293936726, 1204.6807595986895, 1225.4975460061332, 17691.823081769016, 17724.556886077695, 17913.462596122135, 18032.909835451002, 18072.819271807377, 619622.0, 619943.0, 622605.0, 622786.0, 628311.0, 60668.0, 60762.696186518784, 61184.69407653022, 61279.6936015326, 61497.69251153805, 1313.6912825486195, 1366.7608168570262, 1367.418846990045, 1376.9724605507834, 1403.4596680278166, 32063.519047213846, 33047.50428743619, 33614.0, 33873.830630846685, 34024.82987585046, 53377.0, 53595.0, 53694.0, 53772.193417097995, 53858.46141538535, 458882.0, 461160.0, 462300.0, 462447.0, 464893.0, 28948.27629309284, 30095.548566771955, 30138.09585712432, 30142.0, 30219.69780302257, 49215.26177107275, 50763.238551422495, 51052.0, 51247.74376128095, 51671.48328516817, 41730.58269417267, 42546.0, 43177.3523397143, 43345.34981975336, 44700.0, 41758.37362439626, 42020.0, 42513.574864250964, 43361.78319108384, 43941.340879886186, 42661.14677706367, 42708.0, 44061.33907991319, 44139.0, 44205.55794442014, 33472.33055338831, 37536.812315938245, 37583.81208093942, 37600.43599345957, 38401.0, 28935.276618084717, 28979.565306520843, 29058.0, 29159.562606561343, 29349.55975660324], "value": 20408.157759313217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.83924912287716, 376.8172436368361, 380.77724531149283, 392.6132759232156, 397.4277041060874, 18355.0, 19622.117004734784, 20029.399118026464, 20231.898840505793, 20240.0, 19050.33323833666, 19302.420927372164, 19600.90199549004, 19806.90096549515, 19823.702644460343, 5387.568994480452, 5584.581156413265, 5623.80316688916, 5870.148828419877, 5876.70616469177, 5750.683712395817, 5777.393373695764, 5793.652380857162, 5797.507211886995, 5803.564732645047, 5682.232898558683, 5764.106563482646, 5767.625104368223, 5788.392218817026, 5793.826185214451, 5664.20701101846, 5775.740091695884, 5776.768929242825, 5784.161296611967, 5791.681457519835, 4657.743824089674, 4924.039812236615, 4935.703857768545, 5007.974960125176, 5009.373828271466, 12138.422005139364, 12319.076069294839, 19751.0, 22605.0, 22865.77134228653, 2170.4790850195996, 2486.2168416948784, 2562.57717476618, 2774.3618967637353, 2967.0903708863134, 10267.537960791708, 10326.0, 10367.0, 10430.0, 10693.572257109707, 1837.2926423326983, 1875.7655293088364, 1950.8439324853978, 1951.0829909942304, 1964.2437661500283, 79981.99999999942, 81696.59151704263, 82497.58751206266, 83570.0, 88586.0, 9716.222702183808, 9970.601175953027, 10025.699229023141, 10177.236707246986, 10250.38497690141, 13683.452661893412, 13692.31538423075, 13713.862861371457, 13732.176069435665, 13821.585352439442, 7288.0, 7580.54516728998, 7595.5442673439775, 7760.805979850436, 7790.961045194851, 7263.237360077222, 7359.889601655979, 7586.051743532059, 7600.961995189989, 7613.162552119263, 4080.3063479208604, 4203.117345357509, 4258.276093064186, 4274.700770946004, 4359.258925982591, 1716.9484915452556, 1749.2390809997692, 1764.479478553804, 1765.2409463930633, 1904.5333893196255, 437.64332069363365, 460.82488654311146, 463.64762780287225, 471.24835886760565, 1038.3977293170094, 10593.311434756715, 11292.0, 11433.942830285796, 11538.538458461735, 11715.824262636068, 471.3165909431338, 474.122872685529, 478.82762205605957, 480.19567224898157, 487.5928599619287, 6027.095935609606, 6083.8174854754425, 6125.264968203844, 6185.134081228632, 6223.661912688794, 529962.0, 530942.0, 542911.0, 551336.0, 552655.0, 83612.58193708993, 84737.0, 91589.0, 101625.0, 104881.0, 445.1120015568961, 461.7621924708778, 467.6889868237584, 986.8963758805365, 1023.7696518283327, 9942.403455792386, 10453.738656533647, 10608.310459820086, 11063.0, 11261.380624065427, 32281.35437291288, 40765.59234407737, 42004.0, 42286.365704515076, 42858.35703965198, 54882.45117548773, 60138.39861601328, 60653.39346606477, 60867.69566152141, 61102.0834687489, 8275.717994886656, 8336.791580210544, 8682.652693892174, 8716.956415217883, 8751.91248087511, 9487.620495180116, 12400.19398739079, 13442.932785336401, 13508.662283442993, 13537.187768733907, 11781.469833857669, 11806.0, 11908.76182476363, 12105.69735756613, 12389.62831115068, 11268.38023908693, 11387.715307117389, 11436.142289328167, 11868.40657967081, 12102.878971210175, 11725.237859539102, 11860.76278474443, 11897.583584574499, 11902.345371004678, 11960.222585532261, 8433.325333973391, 8540.70107546233, 8606.483610983361, 8759.737207883774, 8928.910710893068, 10904.61833835812, 11770.941145294219, 11868.169228153947, 11982.10134239918, 11998.860108289698], "value": 8270.374095251342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.8493150684928, 1518.8177418709754, 1652.5538104711727, 1742.5382273697464, 1786.508710104721, 7739.187385324544, 8709.695160669378, 8787.472751634907, 9346.252299816015, 9367.484788336638, 8815.118488151182, 9142.0, 9160.038195989426, 9169.358144929842, 9221.58502867371, 2291.9312420627407, 2357.634566642173, 2360.3509035015336, 2362.232274510782, 2362.4566349739484, 2262.9773702263014, 2267.8299127565415, 2321.0367697405554, 2322.245270287155, 2324.7442781294044, 2327.499587588668, 2332.3003099070297, 2338.8128949683983, 2357.3988632898586, 2366.8934897929635, 2231.631780756173, 2243.1251811793413, 2243.2372993182316, 2251.3921241264766, 2261.8416710830247, 2262.106467945169, 2269.693591365161, 2291.7593652666565, 2292.1862738727846, 2316.791488766019, 9110.908890911072, 9181.173694367539, 9235.122663347038, 9271.860922086174, 9294.302927280414, 5182.196759502283, 5330.546903513206, 5335.413104558495, 5337.572994160458, 5338.27933229013, 3205.8397080146133, 3219.3239419721885, 3289.506574013893, 3327.234736010707, 3372.0558243691808, 1128.328644456547, 1132.592266783957, 1137.0, 1147.5639257082255, 1155.3587758793867, 12729.554465593752, 12749.74500509994, 12814.42335094923, 12859.935700321532, 12877.67805804853, 4382.890427739332, 4396.054848207651, 4651.837185698484, 4715.858524244278, 4738.1708201064675, 10680.0, 10706.089982351432, 10714.303570267908, 10718.678439646823, 10724.41015744126, 5277.709725965109, 5333.626646134733, 5345.278387417727, 5347.598930080259, 5349.625526213128, 4256.2551553478015, 4692.202325604587, 4799.488161229271, 4810.326554282403, 4914.926276105862, 3807.3146833569667, 4027.597240275949, 4042.9393559096047, 4047.655949244347, 4073.6333729964445, 1236.6290112966253, 1246.7880460321767, 1248.2759999200441, 1257.874212578753, 1273.089740835307, 793.4089103617727, 909.3997961345481, 914.8444764390069, 938.6996161228342, 949.9335046546813, 5785.161151633074, 5959.433853783884, 5975.19334889793, 6006.579539432198, 6168.383161683885, 447.84101643915943, 450.4616982705701, 459.07496394764576, 463.0807846424844, 463.59667089632234, 3872.554656214515, 3940.625640564142, 3997.2205419942834, 4031.213913286881, 4070.816813243411, 11062.115030797517, 11505.367204803648, 11514.136439767051, 11523.48144333507, 11539.423028848523, 11336.093112550976, 11352.091832653368, 11393.658190254306, 11395.430228488542, 11428.0, 8100.392470564731, 8449.155084491502, 8506.106858779738, 8507.361947853935, 8592.3555733319, 5874.735636896265, 5987.820365389045, 6052.606580572248, 6165.260168779775, 6182.567220294716, 10631.20265980039, 10714.357138571711, 10721.839172412265, 10754.139668826632, 10763.408012559072, 10137.746556336151, 10302.536385862804, 10442.791144176921, 10520.842187367349, 10560.419176945034, 6580.76967306142, 7702.807429814299, 7724.382049435919, 7856.175101614477, 7935.285824275843, 8787.384883058125, 8837.646494140163, 8871.556422178735, 8899.510526921082, 8906.73279801607, 7760.611969401621, 7982.680692772224, 7992.360611150978, 8019.879701804594, 8354.16458354184, 7618.961905190438, 7886.329661978796, 7894.486858354188, 7956.9602151988865, 7987.840243194987, 7003.5797852129035, 7015.263397343206, 7091.0, 7114.644267786486, 7133.964330178316, 5142.614303927146, 5207.661502002357, 5254.0, 5276.129438642581, 5289.867753306198, 5075.390953085654, 5076.11168045598, 5092.261622064854, 5182.818601348935, 5335.279737235579], "value": 4599.661678182369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.49690482846756, 322.61125343960543, 324.2137815796692, 327.45315323409903, 329.13930072859466, 5253.8949221015555, 5414.593905457087, 5450.509454149126, 5491.286132802735, 5511.6968566728865, 5440.483154100364, 5497.92790405871, 5508.614396992212, 5518.392976772562, 5522.6134170608075, 4283.229018776619, 4307.418498502709, 4318.762468064255, 4324.654027677794, 4328.805203765838, 4105.404716316148, 4223.683223758215, 4277.8288868445225, 4314.266574682296, 4315.0, 4236.745795252279, 4242.639375653073, 4250.404943307939, 4264.978675106636, 4290.227759003378, 4289.4209281747035, 4294.184105020067, 4300.290452075404, 4307.935380969288, 4314.417553630283, 3644.125409901631, 3797.468354430382, 3809.333366660851, 3831.406132049509, 3840.2127563849344, 5250.687328167958, 5279.759256574702, 5283.577313814885, 5337.226102215196, 5345.305110335631, 4856.781444834991, 4883.804647814083, 4900.26496025599, 4923.950760492385, 4954.504549545053, 5550.696460968693, 5744.511716504102, 5746.626469279525, 5750.913736293959, 5771.595988280822, 4129.050318426779, 4134.793260336971, 4147.543770185277, 4168.228877657643, 4181.97909010453, 6002.909956350658, 6017.398260173992, 6017.669028203447, 6032.849178770522, 6062.938985677489, 3944.861929832442, 4137.731047481964, 4260.573942605714, 4264.249559034405, 4300.7634580097765, 4175.578164664487, 4178.185253875465, 4186.769727664947, 4189.895252618648, 4191.811368488426, 4779.139754844162, 4834.613230941516, 4845.75771211438, 4846.854594362175, 4849.975750121227, 5641.984442800253, 5811.593188476766, 5836.941630583725, 5852.0, 5868.4424979626865, 1405.36758458694, 1421.1473116130446, 1425.7576212043978, 1425.828900531922, 1426.7075249573813, 874.2830878679422, 898.9437411042, 912.7489940266347, 918.8208299381556, 927.596495524449, 4893.388326459192, 4897.657163998486, 4900.26496025599, 4944.354770197999, 5011.649184557119, 5177.301064356264, 5216.921746173811, 5228.581713462914, 5229.372475302988, 5247.763850626731, 4787.832425865078, 4908.779104940286, 4979.460475157695, 5011.699298042129, 5049.495050494921, 2745.546984747534, 2779.4857951279077, 2781.2490627530856, 2794.7484726374723, 2808.0031588786096, 5330.893382132335, 5363.2759577456545, 5427.565794736412, 5431.293931788921, 5441.183822426668, 5273.525382715574, 5291.841244762663, 5624.634398764068, 6083.992282546749, 6103.176071230416, 6198.81403557894, 6250.9373406521, 6258.687065646699, 6263.968680156661, 6297.055441683784, 5813.460704296271, 5945.732442040032, 5982.611130276518, 5988.790392336247, 6007.669578173242, 5928.762849485972, 5939.732712027882, 5941.168236446814, 5947.739858853608, 5968.46283834457, 6186.566940314135, 6233.657148856856, 6260.906086408617, 6282.748690052346, 6292.622442653455, 3874.767513949172, 4137.531176432443, 4236.796865629917, 4261.232978063854, 4284.635805956528, 5842.38654941225, 5857.4435428634215, 5858.384869588632, 5872.677002764889, 5936.317323507852, 5678.914816277676, 5735.8852822944145, 5809.680467574324, 5812.360640329645, 5823.563232757476, 5648.435156484319, 5678.346990096192, 5708.771649134154, 5730.71346432685, 5735.4551317624755, 5701.344345400332, 5719.654941473976, 5722.341930678025, 5731.627444216113, 5751.252337196138, 5498.835034948958, 5660.349059858005, 5704.828855134187, 5766.826995190151, 5773.971130144322, 5653.943460565341, 5683.0, 5700.25896633435, 5729.28383952006, 5742.310922689304], "value": 4301.849877145232, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.0920770771021, 703.9436845052395, 745.7278093495876, 772.7565816767718, 776.483638380477, 15752.606184845385, 17291.654166916687, 17296.308147674077, 17304.307827686876, 17435.738463923037, 14593.562193134223, 14796.778048329285, 14797.926010369933, 14815.851841481608, 14819.55541333759, 666.8466252761843, 791.9960400197991, 796.9920300796975, 817.4931542443663, 822.5928165558057, 823.5347028928666, 829.6059371798377, 831.9126491718373, 831.9251267385933, 833.6332013913858, 877.079066979672, 877.8946526416839, 878.2315473960285, 880.9075047120057, 884.5709830732089, 876.758891304893, 876.9429987050821, 877.0308808766285, 877.3419935048713, 878.6178012564554, 632.6963057732314, 637.8692368064582, 638.8019713888709, 638.8307098618869, 639.9616023038633, 15474.381024758995, 15487.303071361815, 15496.92251538735, 15500.689986200212, 15502.844971550252, 15783.289751961189, 15835.920820395939, 15849.683006339925, 15870.12714300713, 15881.0, 12335.074869384742, 12354.75290494194, 12470.563530276397, 12594.43325050375, 12636.178648387826, 3857.662798050255, 3929.115948911472, 4054.979725101385, 4092.5907409259135, 4188.727732697365, 83120.58439707823, 83827.58086209591, 84138.99999999939, 84321.15678843194, 84408.15591844065, 11588.246763960316, 11703.590374336858, 11832.0, 11838.171328007129, 12210.450529726184, 23071.423214419774, 23401.648975265383, 23447.0, 23449.648255275843, 23564.293071207892, 8810.251128654008, 8987.370884038186, 9096.81806363869, 9180.724578262663, 9207.861882071775, 4785.306130611042, 4890.095332363524, 4927.43334516528, 4944.283078953604, 4974.204127339681, 3437.5015622734563, 3499.580050393969, 3545.539079919594, 3556.6976806971697, 3560.394732895414, 570.1846359705578, 579.0503574138417, 587.5475883569627, 594.1325664529835, 595.1905408644241, 618.3476432363899, 703.8888114533773, 719.8956151358024, 729.2707292707292, 743.7880204141902, 9081.45511269326, 9093.272538196929, 9298.445430204229, 9449.574769135406, 9653.855192171983, 628.4815027602247, 643.4305639509068, 665.2781731821028, 668.582136164897, 675.2673349415841, 4617.376654151713, 4626.606738427204, 4629.560191781776, 4629.6990695605355, 4679.555442233051, 112126.0, 128611.35694321469, 128702.35648821696, 130081.34959325143, 132368.6907827312, 109127.0, 110997.0, 113060.0, 114683.42658286823, 115466.42266788612, 97602.0, 97797.0, 98460.50769746248, 99316.50341748245, 102011.0, 8642.919635045619, 8745.091377811457, 8791.296696264155, 8905.955470222607, 9121.498317592595, 55713.88572228614, 56763.43236567581, 56950.0, 57997.42002580089, 58720.11919821121, 74942.6252868754, 82930.58534707288, 83064.16935830565, 84299.15700843159, 86841.56579217063, 12296.0, 12544.749105017667, 12629.2422454653, 12761.489540418279, 13392.531261405804, 12762.361881906054, 12909.096363254483, 13249.470021199044, 13470.124441911245, 13500.662483437993, 11855.0, 11977.221480603734, 12300.87699123033, 12416.068794840243, 13017.153884997444, 13132.803007955079, 13212.537561185312, 13370.598882033555, 13469.663258418226, 13870.791938120734, 12696.809547856974, 12755.362231888183, 12909.160904541175, 13052.412641431349, 13284.933575332061, 10565.735856603338, 10582.4708764563, 10794.622188223375, 10946.357181216292, 11058.723531911766, 9390.741006730977, 10440.895591044296, 10907.672769816918, 10923.344599324066, 11090.334579925231], "value": 7679.4729795297835, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 107.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 146.0, 197.0, 125.0, 151.0, 143.0, 120.0, 187.0, 118.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 167.0, 169.0, 163.0, 161.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 77.0, 175.0, 76.0, 76.0, 77.0, 76.0, 183.0, 87.0], "value": 99.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 140.0, 86.0, 85.0, 85.0, 138.0, 84.0, 84.0, 154.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 126.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 154.0, 146.0, 146.0, 147.0, 147.0, 146.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 52.0, 53.0, 52.0, 50.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 76.0, 77.0, 77.0, 75.0, 76.0, 78.0, 80.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 124.0, 132.0, 130.0, 128.0, 122.0, 125.0, 129.0, 127.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 159.0, 162.0, 162.0, 162.0, 160.0, 161.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 63.0, 65.0, 63.0, 63.0, 62.0, 62.0], "value": 63.6, "unit": "score"}]}]} 20:35:39 INFO - Return code: 0 20:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:40 ERROR - # TBPL SUCCESS # 20:35:40 INFO - Running post-action listener: _resource_record_post_action 20:35:40 INFO - [mozharness: 2016-08-06 03:35:40.057614Z] Finished run-tests step (success) 20:35:40 INFO - Running post-run listener: _resource_record_post_run 20:35:40 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559423488; Read time: 8; Write time: 807564 20:35:40 INFO - TinderboxPrint: CPU usage
13.4% 20:35:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:35:40 INFO - TinderboxPrint: I/O write bytes / time
559,423,488 / 807,564 20:35:40 INFO - TinderboxPrint: CPU idle
8,242.4 (86.6%) 20:35:40 INFO - TinderboxPrint: CPU user
1,214.7 (12.8%) 20:35:40 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:40 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 266649600; Read time: 0; Write time: 439108 20:35:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292634624; Read time: 8; Write time: 368420 20:35:40 INFO - Running post-run listener: _upload_blobber_files 20:35:40 INFO - Blob upload gear active. 20:35:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:40 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 20:35:40 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'] 20:35:40 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 20:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:41 INFO - (blobuploader) - INFO - Done attempting. 20:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:42 INFO - (blobuploader) - INFO - Done attempting. 20:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:45 INFO - (blobuploader) - INFO - Done attempting. 20:35:45 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:45 INFO - Return code: 0 20:35:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa84d0a98f9e39b4966c157b6bcdca674b3c042b024e856724d977fa3400adbe791ebd3c619c65a167e068e1458879e4a98304d28e946eebb8280a1640ccd7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61c656a0adffb453e88e8974c13f2020d28b763812fa18845209e735017899e46721c806e697f43c1a3dffabbb81a337c11bb62cf07ee8e2a6b533e5e6e124c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70eef48b6ecf1c03d109de56a04905d41e0f9ddc7e2b36e55efc83f98e04f6b524d7765ce27d92434e3f3fa860418bf63c203b3f59e1b1628f709cb3f37fbc65"} 20:35:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:45 INFO - Contents: 20:35:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa84d0a98f9e39b4966c157b6bcdca674b3c042b024e856724d977fa3400adbe791ebd3c619c65a167e068e1458879e4a98304d28e946eebb8280a1640ccd7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61c656a0adffb453e88e8974c13f2020d28b763812fa18845209e735017899e46721c806e697f43c1a3dffabbb81a337c11bb62cf07ee8e2a6b533e5e6e124c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70eef48b6ecf1c03d109de56a04905d41e0f9ddc7e2b36e55efc83f98e04f6b524d7765ce27d92434e3f3fa860418bf63c203b3f59e1b1628f709cb3f37fbc65"} 20:35:45 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:45 INFO - Copying logs to upload dir... 20:35:45 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.395970 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 20:35:45.689494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 20:35:45.693434) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 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/cfa84d0a98f9e39b4966c157b6bcdca674b3c042b024e856724d977fa3400adbe791ebd3c619c65a167e068e1458879e4a98304d28e946eebb8280a1640ccd7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61c656a0adffb453e88e8974c13f2020d28b763812fa18845209e735017899e46721c806e697f43c1a3dffabbb81a337c11bb62cf07ee8e2a6b533e5e6e124c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70eef48b6ecf1c03d109de56a04905d41e0f9ddc7e2b36e55efc83f98e04f6b524d7765ce27d92434e3f3fa860418bf63c203b3f59e1b1628f709cb3f37fbc65"} build_url:https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/TNMfJLCISr6tlwBUJNFOwA/artifacts/public/build/firefox-51.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/cfa84d0a98f9e39b4966c157b6bcdca674b3c042b024e856724d977fa3400adbe791ebd3c619c65a167e068e1458879e4a98304d28e946eebb8280a1640ccd7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61c656a0adffb453e88e8974c13f2020d28b763812fa18845209e735017899e46721c806e697f43c1a3dffabbb81a337c11bb62cf07ee8e2a6b533e5e6e124c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70eef48b6ecf1c03d109de56a04905d41e0f9ddc7e2b36e55efc83f98e04f6b524d7765ce27d92434e3f3fa860418bf63c203b3f59e1b1628f709cb3f37fbc65"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 20:35:45.719254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:35:45.719591) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470444155.456286-1675973547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 20:35:45.804017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 20:35:45.804332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 20:35:45.804668) ========= ========= Total master_lag: 0.16 =========