builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1470334616.91 results: success (0) buildid: 20160804083001 builduid: a96fba148aec48588be53f7222bb8850 revision: 0636c302f407c4fd16e551a5ce0267a6df939002 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:56.907396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:56.907887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:56.908365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:56.961953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:56.962315) ========= 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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 11:16:57-- 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% 226M=0s 2016-08-04 11:16:57 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.457546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:57.434818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:57.435132) ========= 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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023154 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:57.485666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 11:16:57.486017) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0636c302f407c4fd16e551a5ce0267a6df939002 --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 0636c302f407c4fd16e551a5ce0267a6df939002 --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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 11:16:57,578 truncating revision to first 12 chars 2016-08-04 11:16:57,578 Setting DEBUG logging. 2016-08-04 11:16:57,578 attempt 1/10 2016-08-04 11:16:57,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0636c302f407?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 11:16:58,556 unpacking tar archive at: fx-team-0636c302f407/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 11:16:58.847519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:58.847830) ========= script_repo_revision: 0636c302f407c4fd16e551a5ce0267a6df939002 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:58.848203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:58.848522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 11:16:58.867164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-04 11:16:58.867497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:59 INFO - MultiFileLogger online at 20160804 11:16:59 in /builds/slave/test 11:16:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:16:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:59 INFO - {'append_to_log': False, 11:16:59 INFO - 'base_work_dir': '/builds/slave/test', 11:16:59 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:59 INFO - 'branch': 'Fx-Team', 11:16:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:59 INFO - 'config_files': ('talos/linux_config.py',), 11:16:59 INFO - 'default_actions': ('clobber', 11:16:59 INFO - 'read-buildbot-config', 11:16:59 INFO - 'download-and-extract', 11:16:59 INFO - 'populate-webroot', 11:16:59 INFO - 'create-virtualenv', 11:16:59 INFO - 'install', 11:16:59 INFO - 'run-tests'), 11:16:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:59 INFO - 'download_minidump_stackwalk': True, 11:16:59 INFO - 'download_symbols': 'ondemand', 11:16:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:59 INFO - 'installer_path': 'installer.exe', 11:16:59 INFO - 'log_level': 'info', 11:16:59 INFO - 'log_name': 'talos', 11:16:59 INFO - 'log_to_console': True, 11:16:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:59 INFO - 'opt_config_files': (), 11:16:59 INFO - 'pip_index': False, 11:16:59 INFO - 'sps_profile': False, 11:16:59 INFO - 'sps_profile_interval': 0, 11:16:59 INFO - 'suite': 'dromaeojs', 11:16:59 INFO - 'system_bits': '32', 11:16:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:59 INFO - 'title': 'talos-linux64-ix-018', 11:16:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:59 INFO - 'use_talos_json': True, 11:16:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:59 INFO - 'work_dir': 'build'} 11:16:59 INFO - [mozharness: 2016-08-04 18:16:59.047114Z] Running clobber step. 11:16:59 INFO - Running pre-action listener: _resource_record_pre_action 11:16:59 INFO - Running main action method: clobber 11:16:59 INFO - rmtree: /builds/slave/test/build 11:16:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:59 INFO - Running post-action listener: _resource_record_post_action 11:16:59 INFO - [mozharness: 2016-08-04 18:16:59.504254Z] Finished clobber step (success) 11:16:59 INFO - [mozharness: 2016-08-04 18:16:59.504354Z] Running read-buildbot-config step. 11:16:59 INFO - Running pre-action listener: _resource_record_pre_action 11:16:59 INFO - Running main action method: read_buildbot_config 11:16:59 INFO - Using buildbot properties: 11:16:59 INFO - { 11:16:59 INFO - "project": "", 11:16:59 INFO - "product": "firefox", 11:16:59 INFO - "script_repo_revision": "production", 11:16:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:16:59 INFO - "repository": "", 11:16:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:16:59 INFO - "buildid": "20160804083001", 11:16:59 INFO - "pgo_build": "True", 11:16:59 INFO - "basedir": "/builds/slave/test", 11:16:59 INFO - "buildnumber": 1417, 11:16:59 INFO - "slavename": "talos-linux64-ix-018", 11:16:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:16:59 INFO - "platform": "ubuntu64_hw", 11:16:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:16:59 INFO - "branch": "fx-team", 11:16:59 INFO - "repo_path": "integration/fx-team", 11:16:59 INFO - "revision": "0636c302f407c4fd16e551a5ce0267a6df939002", 11:16:59 INFO - "stage_platform": "linux64-pgo", 11:16:59 INFO - "builduid": "a96fba148aec48588be53f7222bb8850", 11:16:59 INFO - "slavebuilddir": "test" 11:16:59 INFO - } 11:16:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:16:59 INFO - Running post-action listener: _resource_record_post_action 11:16:59 INFO - [mozharness: 2016-08-04 18:16:59.506780Z] Finished read-buildbot-config step (success) 11:16:59 INFO - [mozharness: 2016-08-04 18:16:59.506869Z] Running download-and-extract step. 11:16:59 INFO - Running pre-action listener: _resource_record_pre_action 11:16:59 INFO - Running main action method: download_and_extract 11:16:59 INFO - mkdir: /builds/slave/test/build/tests 11:16:59 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')]} 11:16:59 INFO - trying https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:16:59 INFO - Downloading https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:00 INFO - Downloaded 1361 bytes. 11:17:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:00 INFO - Using the following test package requirements: 11:17:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:17:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'jsshell-linux-x86_64.zip'], 11:17:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:00 INFO - trying https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:00 INFO - Downloading https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:03 INFO - Downloaded 21819823 bytes. 11:17:03 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'] 11:17:03 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 11:17:04 INFO - Return code: 0 11:17:04 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 11:17: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')]} 11:17:04 INFO - trying https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:05 INFO - Downloaded 21819823 bytes. 11:17:05 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'] 11:17:05 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 11:17:06 INFO - Return code: 0 11:17:06 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')]} 11:17:06 INFO - trying https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:06 INFO - Downloading https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:08 INFO - Downloaded 14413723 bytes. 11:17:08 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'] 11:17:08 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 11:17:08 INFO - Return code: 0 11:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:08 INFO - trying https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:08 INFO - Downloading https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/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 11:17:10 INFO - Downloaded 59362540 bytes. 11:17:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:10 INFO - mkdir: /builds/slave/test/properties 11:17:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:10 INFO - Contents: 11:17:10 INFO - build_url:https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:11 INFO - Running post-action listener: _resource_record_post_action 11:17:11 INFO - Running post-action listener: set_extra_try_arguments 11:17:11 INFO - [mozharness: 2016-08-04 18:17:11.227888Z] Finished download-and-extract step (success) 11:17:11 INFO - [mozharness: 2016-08-04 18:17:11.228120Z] Running populate-webroot step. 11:17:11 INFO - Running pre-action listener: _resource_record_pre_action 11:17:11 INFO - Running main action method: populate_webroot 11:17:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:11 INFO - '--tppagecycles', 11:17:11 INFO - '7'], 11:17:11 INFO - 'tests': ['tsvgm']}}, 11:17:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['damp', 'tps']}, 11:17:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'tests': ['damp', 'tps']}, 11:17:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['dromaeo_dom']}, 11:17:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['basic_compositor_video']}, 11:17:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:17:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['a11yr', 11:17:11 INFO - 'ts_paint', 11:17:11 INFO - 'tpaint', 11:17:11 INFO - 'sessionrestore', 11:17:11 INFO - 'sessionrestore_no_auto_restore', 11:17:11 INFO - 'tabpaint']}, 11:17:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['tsvgx', 11:17:11 INFO - 'tsvgr_opacity', 11:17:11 INFO - 'tart', 11:17:11 INFO - 'tscrollx', 11:17:11 INFO - 'cart']}, 11:17:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:11 INFO - 'tsvgr_opacity', 11:17:11 INFO - 'tart', 11:17:11 INFO - 'tscrollx', 11:17:11 INFO - 'cart']}, 11:17:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'talos_options': ['--disable-e10s'], 11:17:11 INFO - 'tests': ['tp5o']}, 11:17:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'tests': ['tp5o']}, 11:17:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'talos_options': ['--disable-e10s', 11:17:11 INFO - '--xperf_path', 11:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:11 INFO - 'tests': ['tp5n']}, 11:17:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:11 INFO - 'talos_options': ['--xperf_path', 11:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:11 INFO - 'tests': ['tp5n']}}, 11:17:11 INFO - 'talos.zip': {'path': '', 11:17:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:11 INFO - Running post-action listener: _resource_record_post_action 11:17:11 INFO - [mozharness: 2016-08-04 18:17:11.247305Z] Finished populate-webroot step (success) 11:17:11 INFO - [mozharness: 2016-08-04 18:17:11.247393Z] Running create-virtualenv step. 11:17:11 INFO - Running pre-action listener: _resource_record_pre_action 11:17:11 INFO - Running main action method: create_virtualenv 11:17:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:11 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 11:17:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:11 INFO - Using real prefix '/usr' 11:17:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:11 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:13 INFO - Installing pip.................done. 11:17:13 INFO - Return code: 0 11:17:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:13 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')]} 11:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:13 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')]} 11:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:13 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:13 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 11:17:13 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 11:17:13 INFO - Using env: {'DISPLAY': ':0', 11:17:13 INFO - 'HOME': '/home/cltbld', 11:17:13 INFO - 'LANG': 'en_US.UTF-8', 11:17:13 INFO - 'LANGUAGE': 'en_US:en', 11:17:13 INFO - 'LOGNAME': 'cltbld', 11:17:13 INFO - 'MAIL': '/var/mail/cltbld', 11:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:13 INFO - 'MOZ_NO_REMOTE': '1', 11:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:13 INFO - 'NO_EM_RESTART': '1', 11:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:13 INFO - 'PWD': '/builds/slave/test', 11:17:13 INFO - 'SHELL': '/bin/bash', 11:17:13 INFO - 'SHLVL': '1', 11:17:13 INFO - 'TERM': 'linux', 11:17:13 INFO - 'TMOUT': '86400', 11:17:13 INFO - 'USER': 'cltbld', 11:17:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:13 INFO - '_': '/tools/buildbot/bin/python'} 11:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:14 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 11:17:14 INFO - Cleaning up... 11:17:14 INFO - Return code: 0 11:17:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:14 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')]} 11:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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')]} 11:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:14 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 11:17:14 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 11:17:14 INFO - Using env: {'DISPLAY': ':0', 11:17:14 INFO - 'HOME': '/home/cltbld', 11:17:14 INFO - 'LANG': 'en_US.UTF-8', 11:17:14 INFO - 'LANGUAGE': 'en_US:en', 11:17:14 INFO - 'LOGNAME': 'cltbld', 11:17:14 INFO - 'MAIL': '/var/mail/cltbld', 11:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:14 INFO - 'MOZ_NO_REMOTE': '1', 11:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:14 INFO - 'NO_EM_RESTART': '1', 11:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:14 INFO - 'PWD': '/builds/slave/test', 11:17:14 INFO - 'SHELL': '/bin/bash', 11:17:14 INFO - 'SHLVL': '1', 11:17:14 INFO - 'TERM': 'linux', 11:17:14 INFO - 'TMOUT': '86400', 11:17:14 INFO - 'USER': 'cltbld', 11:17:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:14 INFO - '_': '/tools/buildbot/bin/python'} 11:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:14 INFO - Downloading/unpacking psutil>=3.1.1 11:17:14 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 11:17:14 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 11:17:14 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 11:17:14 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 11:17:14 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 11:17:14 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 11:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:16 INFO - Installing collected packages: psutil 11:17:16 INFO - Running setup.py install for psutil 11:17:16 INFO - building 'psutil._psutil_linux' extension 11:17:16 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 11:17:16 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 11:17:16 INFO - building 'psutil._psutil_posix' extension 11:17:16 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 11:17:16 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 11:17:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:16 INFO - Successfully installed psutil 11:17:16 INFO - Cleaning up... 11:17:16 INFO - Return code: 0 11:17:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:17:16 INFO - Using env: {'DISPLAY': ':0', 11:17:16 INFO - 'HOME': '/home/cltbld', 11:17:16 INFO - 'LANG': 'en_US.UTF-8', 11:17:16 INFO - 'LANGUAGE': 'en_US:en', 11:17:16 INFO - 'LOGNAME': 'cltbld', 11:17:16 INFO - 'MAIL': '/var/mail/cltbld', 11:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:16 INFO - 'MOZ_NO_REMOTE': '1', 11:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:16 INFO - 'NO_EM_RESTART': '1', 11:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:16 INFO - 'PWD': '/builds/slave/test', 11:17:16 INFO - 'SHELL': '/bin/bash', 11:17:16 INFO - 'SHLVL': '1', 11:17:16 INFO - 'TERM': 'linux', 11:17:16 INFO - 'TMOUT': '86400', 11:17:16 INFO - 'USER': 'cltbld', 11:17:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:16 INFO - '_': '/tools/buildbot/bin/python'} 11:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:18 INFO - Installing collected packages: mozsystemmonitor 11:17:18 INFO - Running setup.py install for mozsystemmonitor 11:17:19 INFO - Successfully installed mozsystemmonitor 11:17:19 INFO - Cleaning up... 11:17:19 INFO - Return code: 0 11:17:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:19 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:19 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 11:17:19 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 11:17:19 INFO - Using env: {'DISPLAY': ':0', 11:17:19 INFO - 'HOME': '/home/cltbld', 11:17:19 INFO - 'LANG': 'en_US.UTF-8', 11:17:19 INFO - 'LANGUAGE': 'en_US:en', 11:17:19 INFO - 'LOGNAME': 'cltbld', 11:17:19 INFO - 'MAIL': '/var/mail/cltbld', 11:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:19 INFO - 'MOZ_NO_REMOTE': '1', 11:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:19 INFO - 'NO_EM_RESTART': '1', 11:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:19 INFO - 'PWD': '/builds/slave/test', 11:17:19 INFO - 'SHELL': '/bin/bash', 11:17:19 INFO - 'SHLVL': '1', 11:17:19 INFO - 'TERM': 'linux', 11:17:19 INFO - 'TMOUT': '86400', 11:17:19 INFO - 'USER': 'cltbld', 11:17:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:19 INFO - '_': '/tools/buildbot/bin/python'} 11:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:19 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:21 INFO - warning: no files found matching '*.txt' 11:17:21 INFO - no previously-included directories found matching 'build' 11:17:21 INFO - no previously-included directories found matching 'dist' 11:17:21 INFO - no previously-included directories found matching '.git*' 11:17:21 INFO - Installing collected packages: jsonschema, functools32 11:17:21 INFO - Running setup.py install for functools32 11:17:21 INFO - warning: no files found matching '*.txt' 11:17:21 INFO - no previously-included directories found matching 'build' 11:17:21 INFO - no previously-included directories found matching 'dist' 11:17:21 INFO - no previously-included directories found matching '.git*' 11:17:21 INFO - Successfully installed jsonschema functools32 11:17:21 INFO - Cleaning up... 11:17:21 INFO - Return code: 0 11:17:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:21 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:21 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 11:17:21 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 11:17:21 INFO - Using env: {'DISPLAY': ':0', 11:17:21 INFO - 'HOME': '/home/cltbld', 11:17:21 INFO - 'LANG': 'en_US.UTF-8', 11:17:21 INFO - 'LANGUAGE': 'en_US:en', 11:17:21 INFO - 'LOGNAME': 'cltbld', 11:17:21 INFO - 'MAIL': '/var/mail/cltbld', 11:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:21 INFO - 'MOZ_NO_REMOTE': '1', 11:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:21 INFO - 'NO_EM_RESTART': '1', 11:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:21 INFO - 'PWD': '/builds/slave/test', 11:17:21 INFO - 'SHELL': '/bin/bash', 11:17:21 INFO - 'SHLVL': '1', 11:17:21 INFO - 'TERM': 'linux', 11:17:21 INFO - 'TMOUT': '86400', 11:17:21 INFO - 'USER': 'cltbld', 11:17:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:21 INFO - '_': '/tools/buildbot/bin/python'} 11:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:21 INFO - Cleaning up... 11:17:21 INFO - Return code: 0 11:17:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:21 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:21 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 11:17:21 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 11:17:21 INFO - Using env: {'DISPLAY': ':0', 11:17:21 INFO - 'HOME': '/home/cltbld', 11:17:21 INFO - 'LANG': 'en_US.UTF-8', 11:17:21 INFO - 'LANGUAGE': 'en_US:en', 11:17:21 INFO - 'LOGNAME': 'cltbld', 11:17:21 INFO - 'MAIL': '/var/mail/cltbld', 11:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:21 INFO - 'MOZ_NO_REMOTE': '1', 11:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:21 INFO - 'NO_EM_RESTART': '1', 11:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:21 INFO - 'PWD': '/builds/slave/test', 11:17:21 INFO - 'SHELL': '/bin/bash', 11:17:21 INFO - 'SHLVL': '1', 11:17:21 INFO - 'TERM': 'linux', 11:17:21 INFO - 'TMOUT': '86400', 11:17:21 INFO - 'USER': 'cltbld', 11:17:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:21 INFO - '_': '/tools/buildbot/bin/python'} 11:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:23 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 INFO - Downloading docopt-0.6.1.tar.gz 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:24 INFO - Running setup.py install for blobuploader 11:17:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:24 INFO - Running setup.py install for requests 11:17:25 INFO - Running setup.py install for docopt 11:17:25 INFO - Successfully installed blobuploader requests docopt 11:17:25 INFO - Cleaning up... 11:17:25 INFO - Return code: 0 11:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:25 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')]} 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 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')]} 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:25 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 11:17:25 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 11:17:25 INFO - Using env: {'DISPLAY': ':0', 11:17:25 INFO - 'HOME': '/home/cltbld', 11:17:25 INFO - 'LANG': 'en_US.UTF-8', 11:17:25 INFO - 'LANGUAGE': 'en_US:en', 11:17:25 INFO - 'LOGNAME': 'cltbld', 11:17:25 INFO - 'MAIL': '/var/mail/cltbld', 11:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:25 INFO - 'MOZ_NO_REMOTE': '1', 11:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:25 INFO - 'NO_EM_RESTART': '1', 11:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:25 INFO - 'PWD': '/builds/slave/test', 11:17:25 INFO - 'SHELL': '/bin/bash', 11:17:25 INFO - 'SHLVL': '1', 11:17:25 INFO - 'TERM': 'linux', 11:17:25 INFO - 'TMOUT': '86400', 11:17:25 INFO - 'USER': 'cltbld', 11:17:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:25 INFO - '_': '/tools/buildbot/bin/python'} 11:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:25 INFO - Running setup.py (path:/tmp/pip-RGBiYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:25 INFO - Running setup.py (path:/tmp/pip-3TjSBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:25 INFO - Running setup.py (path:/tmp/pip-qYhFAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:25 INFO - Running setup.py (path:/tmp/pip-NB8SRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:25 INFO - Running setup.py (path:/tmp/pip-bOb2oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:25 INFO - Running setup.py (path:/tmp/pip-ms4uSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:25 INFO - Running setup.py (path:/tmp/pip-9b5OPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:26 INFO - Running setup.py (path:/tmp/pip-pd5J6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:26 INFO - Running setup.py (path:/tmp/pip-fs_v5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:26 INFO - Running setup.py (path:/tmp/pip-vaGtwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:26 INFO - Running setup.py (path:/tmp/pip-5veAfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:26 INFO - Running setup.py (path:/tmp/pip-lGJmbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:26 INFO - Running setup.py (path:/tmp/pip-MRvZUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:26 INFO - Running setup.py (path:/tmp/pip-sWHC3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:26 INFO - Running setup.py (path:/tmp/pip-7MHfuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:26 INFO - Running setup.py (path:/tmp/pip-w2QyI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:26 INFO - Running setup.py (path:/tmp/pip-r4s9gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:26 INFO - Running setup.py install for manifestparser 11:17:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:26 INFO - Running setup.py install for mozcrash 11:17:26 INFO - Running setup.py install for mozdebug 11:17:27 INFO - Running setup.py install for mozdevice 11:17:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozfile 11:17:27 INFO - Running setup.py install for mozhttpd 11:17:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozinfo 11:17:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozInstall 11:17:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozleak 11:17:27 INFO - Running setup.py install for mozlog 11:17:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for moznetwork 11:17:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozprocess 11:17:27 INFO - Running setup.py install for mozprofile 11:17:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Running setup.py install for mozrunner 11:17:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Running setup.py install for mozscreenshot 11:17:28 INFO - Running setup.py install for moztest 11:17:28 INFO - Running setup.py install for mozversion 11:17:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:28 INFO - Running setup.py (path:/tmp/pip-gTbq97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:28 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)) 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:28 INFO - Running setup.py (path:/tmp/pip-ZT3yJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:28 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)) 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:28 INFO - Running setup.py (path:/tmp/pip-QS9shG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:28 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)) 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:28 INFO - Running setup.py (path:/tmp/pip-8TvtWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:29 INFO - Running setup.py (path:/tmp/pip-clvrZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:29 INFO - Running setup.py (path:/tmp/pip-Yr8IOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:29 INFO - Running setup.py (path:/tmp/pip-WvEm2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:29 INFO - Running setup.py (path:/tmp/pip-GPlqez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:29 INFO - Running setup.py (path:/tmp/pip-Eoc9SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:29 INFO - Running setup.py (path:/tmp/pip-5N0SjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:29 INFO - Running setup.py (path:/tmp/pip-rPY611-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:29 INFO - Running setup.py (path:/tmp/pip-wF3hqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:29 INFO - Running setup.py (path:/tmp/pip-9ukJEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:29 INFO - Running setup.py (path:/tmp/pip-Ec_hFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:29 INFO - Running setup.py (path:/tmp/pip-XKNacu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:29 INFO - Running setup.py (path:/tmp/pip-JhRerw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:29 INFO - Running setup.py (path:/tmp/pip-PXDopC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:29 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)) 11:17:29 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)) 11:17:29 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)) 11:17:29 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)) 11:17:29 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)) 11:17:29 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)) 11:17:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:31 INFO - Downloading blessings-1.6.tar.gz 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:31 INFO - Installing collected packages: blessings 11:17:31 INFO - Running setup.py install for blessings 11:17:32 INFO - Successfully installed blessings 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:32 INFO - Reading from file tmpfile_stdout 11:17:32 INFO - Current package versions: 11:17:32 INFO - argparse == 1.2.1 11:17:32 INFO - blessings == 1.6 11:17:32 INFO - blobuploader == 1.2.4 11:17:32 INFO - docopt == 0.6.1 11:17:32 INFO - functools32 == 3.2.3-2 11:17:32 INFO - jsonschema == 2.5.1 11:17:32 INFO - manifestparser == 1.1 11:17:32 INFO - mozInstall == 1.12 11:17:32 INFO - mozcrash == 0.17 11:17:32 INFO - mozdebug == 0.1 11:17:32 INFO - mozdevice == 0.48 11:17:32 INFO - mozfile == 1.2 11:17:32 INFO - mozhttpd == 0.7 11:17:32 INFO - mozinfo == 0.9 11:17:32 INFO - mozleak == 0.1 11:17:32 INFO - mozlog == 3.3 11:17:32 INFO - moznetwork == 0.27 11:17:32 INFO - mozprocess == 0.23 11:17:32 INFO - mozprofile == 0.28 11:17:32 INFO - mozrunner == 6.12 11:17:32 INFO - mozscreenshot == 0.1 11:17:32 INFO - mozsystemmonitor == 0.3 11:17:32 INFO - moztest == 0.7 11:17:32 INFO - mozversion == 1.4 11:17:32 INFO - psutil == 3.1.1 11:17:32 INFO - requests == 1.2.3 11:17:32 INFO - wsgiref == 0.1.2 11:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 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 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17:32 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 11:17:32 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 11:17:32 INFO - Using env: {'DISPLAY': ':0', 11:17:32 INFO - 'HOME': '/home/cltbld', 11:17:32 INFO - 'LANG': 'en_US.UTF-8', 11:17:32 INFO - 'LANGUAGE': 'en_US:en', 11:17:32 INFO - 'LOGNAME': 'cltbld', 11:17:32 INFO - 'MAIL': '/var/mail/cltbld', 11:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:32 INFO - 'MOZ_NO_REMOTE': '1', 11:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:32 INFO - 'NO_EM_RESTART': '1', 11:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:32 INFO - 'PWD': '/builds/slave/test', 11:17:32 INFO - 'SHELL': '/bin/bash', 11:17:32 INFO - 'SHLVL': '1', 11:17:32 INFO - 'TERM': 'linux', 11:17:32 INFO - 'TMOUT': '86400', 11:17:32 INFO - 'USER': 'cltbld', 11:17:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:32 INFO - '_': '/tools/buildbot/bin/python'} 11:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, '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': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', '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 11:17: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'] in /builds/slave/test/build 11:17: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 11:17:32 INFO - Using env: {'DISPLAY': ':0', 11:17:32 INFO - 'HOME': '/home/cltbld', 11:17:32 INFO - 'LANG': 'en_US.UTF-8', 11:17:32 INFO - 'LANGUAGE': 'en_US:en', 11:17:32 INFO - 'LOGNAME': 'cltbld', 11:17:32 INFO - 'MAIL': '/var/mail/cltbld', 11:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:32 INFO - 'MOZ_NO_REMOTE': '1', 11:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:32 INFO - 'NO_EM_RESTART': '1', 11:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:32 INFO - 'PWD': '/builds/slave/test', 11:17:32 INFO - 'SHELL': '/bin/bash', 11:17:32 INFO - 'SHLVL': '1', 11:17:32 INFO - 'TERM': 'linux', 11:17:32 INFO - 'TMOUT': '86400', 11:17:32 INFO - 'USER': 'cltbld', 11:17:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:32 INFO - '_': '/tools/buildbot/bin/python'} 11:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Running post-action listener: _resource_record_post_action 11:17:32 INFO - Running post-action listener: _start_resource_monitoring 11:17:32 INFO - Starting resource monitoring. 11:17:32 INFO - [mozharness: 2016-08-04 18:17:32.794474Z] Finished create-virtualenv step (success) 11:17:32 INFO - [mozharness: 2016-08-04 18:17:32.794906Z] Running install step. 11:17:32 INFO - Running pre-action listener: _resource_record_pre_action 11:17:32 INFO - Running main action method: install 11:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:33 INFO - Reading from file tmpfile_stdout 11:17:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:33 INFO - Reading from file tmpfile_stdout 11:17:33 INFO - Output received: 11:17:33 INFO - Usage: mozinstall [options] installer 11:17:33 INFO - Options: 11:17:33 INFO - -h, --help show this help message and exit 11:17:33 INFO - -d DEST, --destination=DEST 11:17:33 INFO - Directory to install application into. [default: 11:17:33 INFO - "/builds/slave/test"] 11:17:33 INFO - --app=APP Application being installed. [default: firefox] 11:17:33 INFO - mkdir: /builds/slave/test/build/application 11:17:33 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'] 11:17:33 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 11:17:49 INFO - Reading from file tmpfile_stdout 11:17:49 INFO - Output received: 11:17:49 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:49 INFO - Running post-action listener: _resource_record_post_action 11:17:49 INFO - [mozharness: 2016-08-04 18:17:49.943540Z] Finished install step (success) 11:17:49 INFO - [mozharness: 2016-08-04 18:17:49.943787Z] Running run-tests step. 11:17:49 INFO - Running pre-action listener: _resource_record_pre_action 11:17:49 INFO - Running main action method: run_tests 11:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:49 INFO - Python 2.7.3 11:17:49 INFO - Return code: 0 11:17:49 INFO - grabbing minidump binary from tooltool 11:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:49 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 0x251c3b0>, '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 0x251d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:49 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 11:17:49 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 11:17:49 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 11:17:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:50 INFO - Return code: 0 11:17:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:17:50 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:17:50 INFO - Using env: {'DISPLAY': ':0', 11:17:50 INFO - 'HOME': '/home/cltbld', 11:17:50 INFO - 'LANG': 'en_US.UTF-8', 11:17:50 INFO - 'LANGUAGE': 'en_US:en', 11:17:50 INFO - 'LOGNAME': 'cltbld', 11:17:50 INFO - 'MAIL': '/var/mail/cltbld', 11:17:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:50 INFO - 'MOZ_NO_REMOTE': '1', 11:17:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:50 INFO - 'NO_EM_RESTART': '1', 11:17:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:50 INFO - 'PWD': '/builds/slave/test', 11:17:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:50 INFO - 'SHELL': '/bin/bash', 11:17:50 INFO - 'SHLVL': '1', 11:17:50 INFO - 'TERM': 'linux', 11:17:50 INFO - 'TMOUT': '86400', 11:17:50 INFO - 'USER': 'cltbld', 11:17:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505', 11:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:50 INFO - '_': '/tools/buildbot/bin/python'} 11:17:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:17:50 INFO - mozversion application_buildid: 20160804083001 11:17:50 INFO - mozversion application_changeset: 0636c302f407c4fd16e551a5ce0267a6df939002 11:17:50 INFO - mozversion application_display_name: Nightly 11:17:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:50 INFO - mozversion application_name: Firefox 11:17:50 INFO - mozversion application_remotingname: firefox 11:17:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:50 INFO - mozversion application_vendor: Mozilla 11:17:50 INFO - mozversion application_version: 51.0a1 11:17:50 INFO - mozversion platform_buildid: 20160804083001 11:17:50 INFO - mozversion platform_changeset: 0636c302f407c4fd16e551a5ce0267a6df939002 11:17:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:50 INFO - mozversion platform_version: 51.0a1 11:17:50 INFO - using testdate: 1470334670 11:17:50 INFO - actual date: 1470334670 11:17:50 INFO - starting webserver on 'localhost:38281' 11:17:50 INFO - SUITE-START | Running 2 tests 11:17:50 INFO - TEST-START | dromaeo_css 11:17:50 INFO - operating with platform_type : linux_ 11:17:50 INFO - Initialising browser for dromaeo_css test... 11:17:50 INFO - TEST-INFO | started process 21129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNcfDln/profile http://localhost:38281/getInfo.html) 11:17:54 INFO - PROCESS | 21129 | __metrics Screen width/height:1600/1200 11:17:54 INFO - PROCESS | 21129 | colorDepth:24 11:17:54 INFO - PROCESS | 21129 | Browser inner width/height: 1024/697 11:17:54 INFO - PROCESS | 21129 | __metrics 11:17:54 INFO - PROCESS | 21129 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:17:54 INFO - PROCESS | 21129 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:55 INFO - TEST-INFO | 21129: exit 0 11:17:55 INFO - Browser initialized. 11:17:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:55 INFO - TEST-INFO | started process 21210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNcfDln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:07 INFO - PROCESS | 21210 | RSS: Main: 156581888 11:18:07 INFO - PROCESS | 21210 | 11:18:59 INFO - PROCESS | 21210 | 1470334739034 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] 11:21:08 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38281/tests/dromaeo/cssquery-ext.html) 11:21:09 INFO - PROCESS | 21210 | RSS: Main: 263290880 11:21:09 INFO - PROCESS | 21210 | 11:24:11 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-ext.html (next: http://localhost:38281/tests/dromaeo/cssquery-jquery.html) 11:24:12 INFO - PROCESS | 21210 | RSS: Main: 248135680 11:24:12 INFO - PROCESS | 21210 | 11:27:13 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38281/tests/dromaeo/cssquery-mootools.html) 11:27:14 INFO - PROCESS | 21210 | RSS: Main: 185708544 11:27:14 INFO - PROCESS | 21210 | 11:30:16 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38281/tests/dromaeo/cssquery-prototype.html) 11:30:17 INFO - PROCESS | 21210 | RSS: Main: 219807744 11:30:17 INFO - PROCESS | 21210 | 11:33:19 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38281/tests/dromaeo/cssquery-yui.html) 11:33:20 INFO - PROCESS | 21210 | RSS: Main: 186134528 11:33:20 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:38281/tests/dromaeo/cssquery-yui.html (next: http://localhost:38281/tests/dromaeo/cssquery-dojo.html) 11:36:23 INFO - PROCESS | 21210 | RSS: Main: 273055744 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | __start_tp_report 11:36:23 INFO - PROCESS | 21210 | _x_x_mozilla_page_load 11:36:23 INFO - PROCESS | 21210 | _x_x_mozilla_page_load_details 11:36:23 INFO - PROCESS | 21210 | |i|pagename|runs| 11:36:23 INFO - PROCESS | 21210 | |0;dojo.html;3000.3399252164522;3002.2194229500324;3018.6075810144685;3038.7417069549088;3060.449119158552;5141.074606570825;5172.534471897528;5181.093308670982;5274.129768588183;5290.656107353019;5190.792368305263;5245.291885595443;5274.340707411574;5361.356637203531;5391;4747.501512341206;4758.143534163849;4760.880977975544;4777.163996300651;4967.379077615298;4882.368451163887;4886.657933944625;4918.409790825106;4930.309756634074;4936.481669424713;4751.168545504523;4752.904941901143;4777.546133117348;4803.111424386465;4886.096072226632;4705.905881882378;4712.222483290253;4736.715797052153;4786.904261914777;4880.682755620874;4724.291356296549;4761.904761904777;4762.666613337068;4792.9760351198365;4838.467768545457;5108.463611320833;5126.512981266774;5203.9219411708855;5206.297149884755;5237.659552129099;5584.5253153482;5617.410171931929;5637.9718101409235;5640.32316122068;5643.153526970947;5636.774529018834;5647;5675.886482270373;5685.886282274373;5690.459406356389;5105.566026887719;5124.4875512448825;5133.589312854962;5142.357205349332;5274.024305503494;5667.149927510906;5675.57433192504;5696.458836410535;5706.771729130788;5717.199592057115;5375.838724838261;5377.300950876361;5420.810271640474;5428.267183930119;5433.26650902131;5394.217838413408;5443.537299329601;5495.505404513613;5531.3362396512675;5548.306461692288;5596.356419011866;5603.943960560342;5608.186812912187;5637.548996080386;5645.491905728422;5569.498745112959;5612.5229355504425;5615.887682246333;5621.0444224481935;5625.240592520039;4223.704340696122;4319.589638984291;4348.673849461303;4350.912981740347;4363.19280933022;3877.5928527504207;3882.941755873664;3909.8240579174008;3917.9020524487114;3922.843086276574;5318.468153184651;5338.386085600128;5342.332208473941;5344.652597581145;5387.218853266333;5442.755076021588;5595.496405323541;5598.048331783607;5656.660600363992;5670.347909990322;5370.731463426813;5371.57027437804;5401.378841433207;5402.837914862561;5412.242286079952;4960.801567937314;4971.65198436106;4971.875703107379;4975.676581022222;5012.172991456368;5658.830235092872;5805.419458054161;5883.411658834082;5886.499647529922;5898.970505147447;5650.406707295675;5705.286839145107;5707.086866101404;5746.626469279484;5752.884942301214;5890;5892.145638882253;5897.3807750187325;5899.882002360015;5905.202797622438;5337.54630856366;5453.64551304164;5512.3385193777;5609.6073274872;5610.7755689773585;5537.584681148849;5595.524380427709;5628.465295796893;5665.3201615806365;5666.603337766317;5473.589480788877;5481.835544933659;5485.890282194254;5487.314085739283;5488.890222195613;5366.302380690485;5385.057614917452;5477.534409575231;5495.199407321903;5534.308211473566;5371.328583927009;5465.453454654503;5479.232907393048;5510.779568817203;5512.3660779010925;5492.340919089735;5495.587830912617;5543.057680194296;5546.833594992157;5546.972265138648;5268.710220937885;5323.0152421802095;5374.892502150014;5380.219868119023;5385 11:36:23 INFO - PROCESS | 21210 | |1;ext.html;586.2173997713053;590.5659340384818;609.8475381154711;616.198941376211;621.9160413344197;43460.13079738403;44773.776131119295;44809.77595112028;44888.38895138108;47223.513766192154;45993.54006459934;46522.534774652246;46600;46628.533714662844;46635.53364466354;9171.633134674605;9316.8602470963;9326.906730932706;9334.06659334068;9334.393264437824;9096.226820720247;9183.908160918405;9190.908090919072;9200.263978881707;9201.95399023004;9197.586108625095;9208.49353285569;9229.6308147674;9236.307276954221;9245.491497967609;9166.450012999208;9181.540922953893;9204.631814727403;9208.3093767967;9218.539073046355;9085;9159.313051521096;9161.496117713523;9162.770930726718;9168.404053736553;43047.35428968568;43362.566374336166;43442.56557434449;43479.34780978288;43490.34764478535;3539.7699149555197;3641.8725344613076;3649.905028491442;3765.6234376562397;4061.4720086388875;32727.6727232727;32859.67140328614;33336;34389.14027149316;35161.94514164579;4409.536998615131;4457.8439754608435;4491.461024677027;4514.683972121953;4682.789274482657;248560;250380;250427;250466;251289;58544.7072764642;58857.70571147117;58861;58909.41090589039;58936.11595826066;61190.38809611847;61545.07682384768;61634.38365616376;61952.38047619466;61972;15575;15603.453879114404;15723.135227562365;15760.92119539418;15768.68462630741;12133.635990920286;12217.511299548096;12227.633171004883;12228.327441990776;12231.633051008484;16591.751123733153;16737.497875063767;16814;16819.159042048093;16929.32282708678;6472.190976127984;6636.568623039487;6666.166729158856;6709.865802683919;6783.864322713518;1007.4308015970953;1087.9129669626411;1151.1999160583314;1154.342025045716;1169.1348402182323;32740;32841.985826897006;33017.834910825295;33178.3364332712;33420;886.3396769406704;1071.9088877445504;1096.2271598523023;1096.5394534295615;1155.1913660437726;16832;16993.490195294162;17131.828681713025;17175.227114779864;17343.2195551198;584008;589345;589883;591943;591952;59005;59284.11073833896;59308;59310.40689593135;59348.40651593515;1197.5329621447643;1242.912996090265;1274.566647339909;1324.5496531179253;1347.4273433790795;32598.185045374055;33650.83174584111;34026.319473610885;34312.7554742703;34349.31301374009;49911.50088499069;50740;50807.2378914324;50856.491435085176;50866;396767;398595;398840;401440;404043;28419.147425577266;29405.558916616697;29449.705502945555;30617.08148755541;30770.230744231572;49109.263361050325;49419.258711118644;49428.50571494383;49644.25533616926;51415.74292128516;41483.37774933318;41492.37761433521;41842.58157418387;42489.78755106328;43659.126817462835;41589.79205103955;42045.58521355336;43317;43618;43749;42964.570354296055;43905.34141987937;44116.33825492684;44144.779276103414;44366;34253.31493370069;37312.253754925296;37731.62268377281;37746.81126594349;38503.807480962416;29031.564526531696;29319.41361172722;29552.408951821275;29594.852025739732;29597.26006849846 11:36:23 INFO - PROCESS | 21210 | |2;jquery.html;379.571084674318;388.63080073929774;400.88173988673327;412.1694785008208;415.41011763296115;13856.792148117775;17855.464336069923;19556.804431955676;19669.31157409491;19775.703364449546;19673.901630491862;19684.704729429035;19686.409407717754;19855.702164467544;19936.40190794275;5466.890662186754;5610.915836262459;5631.211630371731;5645.887082258352;5660.3490598581075;5618.241537392461;5707.62900411474;5714.771409143629;5721.914171287434;5723.828285151431;5589.0219211638005;5596.608237423382;5622.606417550773;5685.602007859451;5695.629784064023;5616.606837521375;5686.431356864322;5698.487136157745;5699.145128230757;5699.658020518761;4930.531599498042;5085;5119.206522988943;5120.052790233782;5121.129408000649;22939.311820645406;23142.305730828102;23253.069877204893;23396.88301558481;23498.412539686473;2369;2522.230719630512;2728.386113124551;3062.5099984002454;3170.0172946386692;13951.441942322295;14878;14879.330430130562;14933.402663893432;15025.323860426197;1958.0405601255425;1958.1188465190721;1966.0955960258298;2016.798320167986;2018.8485863560145;64717;75817.24182758157;75896.62051689706;78339.60830195813;78572.21427785706;10420.218483613759;10420.68737937863;10551.366917984946;10566.788664226673;10690.358578485315;13687.384067716977;13687.863121368659;13710.588682339545;13712.314384280746;15350.846491535165;8064.395170362246;8155.673773049011;8284.130166332448;8374.330053595697;8438.789030274293;7756.573388463576;7890.684372625031;8090.150534193943;8099.392545559107;8100.311473524816;6604.306547812506;6821.4542836572955;6846.931530684629;6875.862482750317;6946.687399067054;1903.8572107092023;1928.594995051027;1955;1971.7929617390255;2006.0872303102053;942.0391200974967;1040.3549799124592;1045.5608644369383;1116.1193389139326;1164.1152723929874;20221.595568088556;20758.065887035118;20836.166553337698;20918.58162836765;21169.25907593227;1016.1413605503337;1034.4207243943415;1046.9633562825265;1092.2372426988948;1118.6196693124377;10992.615258465916;11925.344106074075;11938.701532461759;11949.462274197682;11995.340256285814;425739;429751;440459;441151;441281;72737;75910;77398;79121.20878791138;80147.19852801514;990.2028866762325;1041.5729550884253;1052.8210204265292;1064.563528953141;1067.0023528001343;17692.292308307522;17904.91047544754;18444.907775461037;18567.350142744937;18828.341008064654;39242.411363830135;39551.80224098861;39705.2058958825;40622.39066413947;40659.3901091478;51602.48397515977;52602.47397525976;53306.4669353317;54435.45564544304;54894;8315.126911674188;8356.916430835614;8537.487750734976;8757.956210218908;9035.864462032943;12971.935140324238;13217.801732973821;13288;13290.401931912893;13507.72984540284;6640.402363787282;11441.599544015919;11657.125715571536;11987.22083064598;12139.39303034827;10422.218333624856;11048.502817373399;11164.88835111671;11274.154438416988;11589.82615260755;11569.6529104127;11854;11978.820317695066;12117.575884843987;12168.087393445705;8659.307255419677;8815;8832.64669413242;8838.116188381111;8953.865692014755;11198.720031999264;11742.88257117418;11793.41032948332;11873.346965916957;11890.227135236182 11:36:23 INFO - PROCESS | 21210 | |3;mootools.html;1269.75874583829;1426.6290764401256;1488.6873756511134;1579.3603590545833;1739.1217435195217;7874.763757087289;8304.66781328747;8307.91692083079;8503.362247831406;8507.872381914276;8390.202930721587;8492.660293588264;8494.150584941503;8496.872546911802;8500.489970601753;2342.9414264643433;2366.053578568578;2367.1241640593003;2369.5379401016808;2370.265217782493;2285.257291380308;2318.96521552176;2351.1300818697105;2351.7413084560685;2352.2120089769946;2297.781710737477;2311.39903625057;2318.1886339781026;2334.439734463725;2337.1936681844736;2276.4536511237347;2293.7591552886956;2304.896279667419;2305.6541518772233;2309.203324852923;2141.1328411993168;2149.7420309562954;2152.074607918594;2153.23560136151;2156.105216335219;8375.623096960591;8525.062243153248;8525.701600443954;8530.530820804854;8538.146185381474;5007.123753343187;5061.696298222082;5130.53825155734;5135.871603209912;5143.974280128576;3311.768176227665;3403.7447191460737;3419.5725534308212;3458.0836078439233;3478;1048.6591857646295;1072.5656109275756;1091.4815462655254;1092.6558134187785;1100.658795773313;11262.155338349574;11354.375509346983;11418.657440276806;11434.085273178209;11447.942760286229;4246.978765106154;4279.33670281107;4449.621782148489;4451.643868490513;4462.44219472566;9285.767855803659;9288.535573221447;9289.535523223813;9291.396059256127;9304.53477326131;5043.268726034705;5081.898362032739;5084.77118529667;5088.338515992898;5091.261767043758;4169.10364271683;4372.693911426233;4508.797104130322;4549.112922979987;4770.856874293777;3602.819859007039;3713.2759111973446;3716.7212459065677;3726.292004519187;3813.103920578662;1118.2395970739974;1119.5130118398522;1125.386664267976;1127.7406196574834;1131.6831287239586;870.5560164316245;968.7917097824002;975.5024937282037;992.5979978108877;1003.9297249192487;5731.168980497804;5739.913901291484;5913.674747888907;5938.524918006549;6054;459.20786643041157;461.98614041578804;470.4237309296085;472.15248628711544;486.23418116466706;4129.566395528486;4135.1316223592785;4152.979235103866;4163.812628431728;4171.20747058058;10209.54057067419;10470.424126673106;10522.526486308134;10535.157187424988;10548.947255263674;10404.167666586654;10425.635102771366;10440.321379110334;10451.007154320327;10478.109360704273;7491.475596708178;7823.921760782433;8005.599020171563;8052.436329456999;8090.959545202354;5731.5701322400155;5919.496842768241;5944.494717949023;5958.910616340845;6131.356207598316;9296.488693121673;9415.905840941503;9484.383515071499;9491.430514169171;9577.425354478753;9654.469004204837;9812.509374531102;9815;9821.754456138653;9870.259730520384;6702.832429189114;7140.393066589398;7268.818279543054;7269.890951635624;7358.632068396451;7987.800304992422;8029;8047.557384343917;8053.154418785943;8056.637451314587;7171.964140179266;7225.277472252733;7266.491345605757;7302.233265507045;7423.146338171179;7220.927790722026;7356.77929662111;7363.7422690205585;7390.371818395497;7533.811654708456;6861.759838405632;6886.345797149263;6948.374646281859;6948.826279343057;6953.721851125898;4976.154053810788;5164.870878228075;5194.3766747990485;5233.476652334736;5250.901967838993;5199.74001299941;5213.374395072464;5229.633925625322;5238.266642670105;5331.5201631853315 11:36:23 INFO - PROCESS | 21210 | |4;prototype.html;318.9649138594756;330.94043072246984;331.8291080093751;333.0508052051653;337.43816545451824;5106.923396149061;5217.37391513019;5234.398044224915;5236.895262094756;5253.57971362291;4908.337374454448;4985.675931064478;4995.400551933764;5007.22388029855;5152.716600586976;4008.759474431529;4013.4983127109113;4030.717849750519;4059.675225981929;4061.1471590965934;4063.553009168989;4068.084680946793;4072.3077076896852;4079.77561234132;4104.630583247507;3902.8829135125993;4042.130941847502;4056.9391459127987;4063.3701776224584;4100.179964007196;4080.9387859182134;4084;4087.7956102195067;4093.9795301023455;4099.754014759124;3660.871869484555;3667.111437609633;3671.94492082619;3675.228202077567;3681.5398075240596;4792.873674686446;5059.924101138486;5078.568321692661;5084.661055914284;5090.261912022736;4644.2801365788355;4663.417072865892;4670.229412146991;4683.344331793552;4688.929666055012;5400.324959380077;5405.405405405402;5407.675539467645;5414.864628384283;5429.267048948381;3903.3949737790404;4012.1574469361176;4015.377616469452;4017.3773065174946;4027.2549578328103;5565.220869078333;5568.415316391761;5594.188842617838;5627.352854421712;5633.521150702195;4137.668986481074;4138.255114079495;4140.834366625301;4143.37849322598;4148.647364973951;4182.121754431542;4188.246115699203;4195.328747400401;4200.348945913388;4202.348635961431;4518.887027824265;4656.813727450932;4671.369365135663;4676.836310729108;4689.577937985529;5417.756200970965;5417.918731219035;5427.620066595379;5442.782288708487;5445.319335083114;1340.2092765268537;1427.2863568215892;1432.6561625209874;1448.9639907466;1450.8766754825747;996.9451680157516;1012.2205901455837;1018.9286749927583;1021.8211812932856;1029.953652085658;5154.896902061938;5159.819406320761;5176.127249376556;5184.9740751296;5187.455317191716;5264.42091369949;5381;5421.241026256327;5435.701036443033;5447.863803404946;5113.846584602394;5154.072266991902;5184.811341025243;5197.506236907488;5199.896002080013;2901.347196880685;2906.790838962404;2910.2433367324647;2913.562965555141;2917.1977706130983;5436.184572314105;5664.773409063591;5671.17767923657;5671.234383358194;5751.367349591542;5564.721763911788;5634.211210430543;5646.153077038395;5649.180868774005;5687.772489100473;5711.600187986801;5722.713864306851;5741.85645358861;5752.884942301214;5765.452282033284;5296.232046353334;5457.154141108134;5505.6696598204235;5549.389567147691;5562.9443705564045;5497.670139791625;5512.448755124456;5513.779448822002;5517.117261238182;5520.834374968757;5634.690092044813;5699.430056994267;5775.537956963517;5779.190913272229;5790.986577348863;3934.586868378779;3975.92048159041;3982.26328129297;3986.7840308706122;3993.840246390228;5477.3427188737605;5546.473085056913;5548.611597188319;5557.527610153021;5560.165975103767;5172.818951336685;5408.593765620888;5411.323584551931;5414.35027796667;5420.8373748786025;5326.174442961347;5386.8383948481605;5390.460953904578;5401.783928642967;5405.594580406564;5156.922646160236;5254.422013578427;5383.5423988961375;5401.756920938488;5404.59465540094;5387.838364849061;5401.838604700009;5417.620766546304;5426.42633636241;5431.646942948696;5275.920861187008;5277.472252774845;5281.630285879952;5288.968651112996;5293 11:36:23 INFO - PROCESS | 21210 | |5;yui.html;783.9490433121847;802.4102284820656;806.8951036365273;827.9875801862969;843.3759018326436;17712.468625941226;18181.181846816875;18291.72562411565;18299.08504574771;18318.633627327446;16113.113778742165;16116.274767635456;16163.515094547183;16173.676526469464;16184.83815161848;665.6904539389183;805.1907832628215;817.9468334558235;823.2878560045577;824.3322908444179;798.932090772285;818.3412353055787;824.5094168969454;825.8926339575846;825.9710910118147;842.0695131879277;845.6279237135672;851.3955091884769;851.5103815306193;853.4751128056263;687.5427840486071;846.255295340103;846.8856704344927;847.1105339393642;848.1391387741417;611.9173911521932;618.8452886778306;621.5338496127904;623.3548277532732;624.7688355308519;15046.247687615685;15046.398144074225;15103.39586416542;15116.848831511654;15133.621659458491;14098.154110753389;14379;14813.18527480988;14961.925190374088;15100.169490678009;13435.92896310328;13766.380512876844;13778.104423212559;13915.30423478822;14595.635109122251;4543.636509079266;4603.332516785081;4628.979662957721;4662.930056049162;4681.531846815291;59814;60627.696861515855;60698.39301607016;63406.36593634051;85239.57380213059;10627.681169564925;11023.779524409467;11114.222004459773;11352.886471135349;11751.529938802352;21597.35207943764;21667.891660541598;21695.783042169693;21714.24000159987;21718.565628687338;8261.628226729812;8268.793280167924;8612.354073444516;8628.22345988864;8804.47173169612;4733.148033354029;4860.198067318924;4876.756162191876;4932.605391568666;5009.7244651544515;3525.876594319238;3695.7782533048103;3701.370766969622;3703.185299234164;3706.592274849764;628.6919409489317;641.5468962799264;644.5810223354857;648.4131860666105;648.7599588152414;678.3420082519948;705.9188193357829;757.75373003774;807.915168907268;808.1716240853056;9711.902880971242;9906;10218.897811021943;10844.186685998582;10934.671959841218;608.5192697768713;655.0499203451377;686.5057158845623;715.5742333311671;762.9885551716728;5230.267762513251;5245.527902488718;5267.5143355771625;5300.92048619271;5310.283111779938;126815;127421;127718;130055.34972325267;136643.31678341544;69616.6519167401;89365.55317223372;109738;111028.44485777519;117411;100862;101147.49426252821;101506.49246753719;101974;103124.48437757914;9688.951555242178;10025.899741002788;10278.691639250834;10349.74125646865;10363.274570779973;56248.71875640596;56281;56869.293921182434;56915.14627280511;56960.43039569717;76560;78563;83083.5845820767;84272.57863710888;86700;12137.21108127969;12317.568885089337;12354.629361119181;12374.876251237733;12779.424925878544;13742.519011834538;13752.243626600633;14045.438182472586;14055.22696251716;14706.044107133002;12867.099303048697;13058;13239.86760132425;13645.727085458037;13666.590002299947;11350.375729334966;12345.753084938431;12554.560590379293;12984.091113621957;13636.79544806809;14147.221902795445;14544.41822327095;14748.410063597335;15444.84555154479;16109.355625774837;11357.4889129991;11662.739902071828;11735.295882247092;11967.820482692592;12184;11450.826489499179;12641.683957900757;12768.2339059653;12863.6784080395;12982.805257921327 11:36:23 INFO - PROCESS | 21210 | __end_tp_report 11:36:23 INFO - PROCESS | 21210 | __start_cc_report 11:36:23 INFO - PROCESS | 21210 | _x_x_mozilla_cycle_collect,995 11:36:23 INFO - PROCESS | 21210 | __end_cc_report 11:36:23 INFO - PROCESS | 21210 | __startTimestamp1470335783568__endTimestamp 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | ------- Summary: start ------- 11:36:23 INFO - PROCESS | 21210 | Number of tests: 6 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#0] dojo.html Cycles:165 Average:5223.53 Median:5391.00 stddev:583.28 (10.8%) stddev-sans-first:558.38 11:36:23 INFO - PROCESS | 21210 | Values: 3000.3 3002.2 3018.6 3038.7 3060.4 5141.1 5172.5 5181.1 5274.1 5290.7 5190.8 5245.3 5274.3 5361.4 5391.0 4747.5 4758.1 4760.9 4777.2 4967.4 4882.4 4886.7 4918.4 4930.3 4936.5 4751.2 4752.9 4777.5 4803.1 4886.1 4705.9 4712.2 4736.7 4786.9 4880.7 4724.3 4761.9 4762.7 4793.0 4838.5 5108.5 5126.5 5203.9 5206.3 5237.7 5584.5 5617.4 5638.0 5640.3 5643.2 5636.8 5647.0 5675.9 5685.9 5690.5 5105.6 5124.5 5133.6 5142.4 5274.0 5667.1 5675.6 5696.5 5706.8 5717.2 5375.8 5377.3 5420.8 5428.3 5433.3 5394.2 5443.5 5495.5 5531.3 5548.3 5596.4 5603.9 5608.2 5637.5 5645.5 5569.5 5612.5 5615.9 5621.0 5625.2 4223.7 4319.6 4348.7 4350.9 4363.2 3877.6 3882.9 3909.8 3917.9 3922.8 5318.5 5338.4 5342.3 5344.7 5387.2 5442.8 5595.5 5598.0 5656.7 5670.3 5370.7 5371.6 5401.4 5402.8 5412.2 4960.8 4971.7 4971.9 4975.7 5012.2 5658.8 5805.4 5883.4 5886.5 5899.0 5650.4 5705.3 5707.1 5746.6 5752.9 5890.0 5892.1 5897.4 5899.9 5905.2 5337.5 5453.6 5512.3 5609.6 5610.8 5537.6 5595.5 5628.5 5665.3 5666.6 5473.6 5481.8 5485.9 5487.3 5488.9 5366.3 5385.1 5477.5 5495.2 5534.3 5371.3 5465.5 5479.2 5510.8 5512.4 5492.3 5495.6 5543.1 5546.8 5547.0 5268.7 5323.0 5374.9 5380.2 5385.0 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#1] ext.html Cycles:180 Average:58531.40 Median:43469.74 stddev:116042.40 (266.9%) stddev-sans-first:116286.37 11:36:23 INFO - PROCESS | 21210 | Values: 586.2 590.6 609.8 616.2 621.9 43460.1 44773.8 44809.8 44888.4 47223.5 45993.5 46522.5 46600.0 46628.5 46635.5 9171.6 9316.9 9326.9 9334.1 9334.4 9096.2 9183.9 9190.9 9200.3 9202.0 9197.6 9208.5 9229.6 9236.3 9245.5 9166.5 9181.5 9204.6 9208.3 9218.5 9085.0 9159.3 9161.5 9162.8 9168.4 43047.4 43362.6 43442.6 43479.3 43490.3 3539.8 3641.9 3649.9 3765.6 4061.5 32727.7 32859.7 33336.0 34389.1 35161.9 4409.5 4457.8 4491.5 4514.7 4682.8 248560.0 250380.0 250427.0 250466.0 251289.0 58544.7 58857.7 58861.0 58909.4 58936.1 61190.4 61545.1 61634.4 61952.4 61972.0 15575.0 15603.5 15723.1 15760.9 15768.7 12133.6 12217.5 12227.6 12228.3 12231.6 16591.8 16737.5 16814.0 16819.2 16929.3 6472.2 6636.6 6666.2 6709.9 6783.9 1007.4 1087.9 1151.2 1154.3 1169.1 32740.0 32842.0 33017.8 33178.3 33420.0 886.3 1071.9 1096.2 1096.5 1155.2 16832.0 16993.5 17131.8 17175.2 17343.2 584008.0 589345.0 589883.0 591943.0 591952.0 59005.0 59284.1 59308.0 59310.4 59348.4 1197.5 1242.9 1274.6 1324.5 1347.4 32598.2 33650.8 34026.3 34312.8 34349.3 49911.5 50740.0 50807.2 50856.5 50866.0 396767.0 398595.0 398840.0 401440.0 404043.0 28419.1 29405.6 29449.7 30617.1 30770.2 49109.3 49419.3 49428.5 49644.3 51415.7 41483.4 41492.4 41842.6 42489.8 43659.1 41589.8 42045.6 43317.0 43618.0 43749.0 42964.6 43905.3 44116.3 44144.8 44366.0 34253.3 37312.3 37731.6 37746.8 38503.8 29031.6 29319.4 29552.4 29594.9 29597.3 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#2] jquery.html Cycles:180 Average:26923.12 Median:23447.65 stddev:71624.01 (305.5%) stddev-sans-first:71797.21 11:36:23 INFO - PROCESS | 21210 | Values: 379.6 388.6 400.9 412.2 415.4 13856.8 17855.5 19556.8 19669.3 19775.7 19673.9 19684.7 19686.4 19855.7 19936.4 5466.9 5610.9 5631.2 5645.9 5660.3 5618.2 5707.6 5714.8 5721.9 5723.8 5589.0 5596.6 5622.6 5685.6 5695.6 5616.6 5686.4 5698.5 5699.1 5699.7 4930.5 5085.0 5119.2 5120.1 5121.1 22939.3 23142.3 23253.1 23396.9 23498.4 2369.0 2522.2 2728.4 3062.5 3170.0 13951.4 14878.0 14879.3 14933.4 15025.3 1958.0 1958.1 1966.1 2016.8 2018.8 64717.0 75817.2 75896.6 78339.6 78572.2 10420.2 10420.7 10551.4 10566.8 10690.4 13687.4 13687.9 13710.6 13712.3 15350.8 8064.4 8155.7 8284.1 8374.3 8438.8 7756.6 7890.7 8090.2 8099.4 8100.3 6604.3 6821.5 6846.9 6875.9 6946.7 1903.9 1928.6 1955.0 1971.8 2006.1 942.0 1040.4 1045.6 1116.1 1164.1 20221.6 20758.1 20836.2 20918.6 21169.3 1016.1 1034.4 1047.0 1092.2 1118.6 10992.6 11925.3 11938.7 11949.5 11995.3 425739.0 429751.0 440459.0 441151.0 441281.0 72737.0 75910.0 77398.0 79121.2 80147.2 990.2 1041.6 1052.8 1064.6 1067.0 17692.3 17904.9 18444.9 18567.4 18828.3 39242.4 39551.8 39705.2 40622.4 40659.4 51602.5 52602.5 53306.5 54435.5 54894.0 8315.1 8356.9 8537.5 8758.0 9035.9 12971.9 13217.8 13288.0 13290.4 13507.7 6640.4 11441.6 11657.1 11987.2 12139.4 10422.2 11048.5 11164.9 11274.2 11589.8 11569.7 11854.0 11978.8 12117.6 12168.1 8659.3 8815.0 8832.6 8838.1 8953.9 11198.7 11742.9 11793.4 11873.3 11890.2 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#3] mootools.html Cycles:180 Average:5551.86 Median:5083.33 stddev:3109.15 (61.2%) stddev-sans-first:3101.22 11:36:23 INFO - PROCESS | 21210 | Values: 1269.8 1426.6 1488.7 1579.4 1739.1 7874.8 8304.7 8307.9 8503.4 8507.9 8390.2 8492.7 8494.2 8496.9 8500.5 2342.9 2366.1 2367.1 2369.5 2370.3 2285.3 2319.0 2351.1 2351.7 2352.2 2297.8 2311.4 2318.2 2334.4 2337.2 2276.5 2293.8 2304.9 2305.7 2309.2 2141.1 2149.7 2152.1 2153.2 2156.1 8375.6 8525.1 8525.7 8530.5 8538.1 5007.1 5061.7 5130.5 5135.9 5144.0 3311.8 3403.7 3419.6 3458.1 3478.0 1048.7 1072.6 1091.5 1092.7 1100.7 11262.2 11354.4 11418.7 11434.1 11447.9 4247.0 4279.3 4449.6 4451.6 4462.4 9285.8 9288.5 9289.5 9291.4 9304.5 5043.3 5081.9 5084.8 5088.3 5091.3 4169.1 4372.7 4508.8 4549.1 4770.9 3602.8 3713.3 3716.7 3726.3 3813.1 1118.2 1119.5 1125.4 1127.7 1131.7 870.6 968.8 975.5 992.6 1003.9 5731.2 5739.9 5913.7 5938.5 6054.0 459.2 462.0 470.4 472.2 486.2 4129.6 4135.1 4153.0 4163.8 4171.2 10209.5 10470.4 10522.5 10535.2 10548.9 10404.2 10425.6 10440.3 10451.0 10478.1 7491.5 7823.9 8005.6 8052.4 8091.0 5731.6 5919.5 5944.5 5958.9 6131.4 9296.5 9415.9 9484.4 9491.4 9577.4 9654.5 9812.5 9815.0 9821.8 9870.3 6702.8 7140.4 7268.8 7269.9 7358.6 7987.8 8029.0 8047.6 8053.2 8056.6 7172.0 7225.3 7266.5 7302.2 7423.1 7220.9 7356.8 7363.7 7390.4 7533.8 6861.8 6886.3 6948.4 6948.8 6953.7 4976.2 5164.9 5194.4 5233.5 5250.9 5199.7 5213.4 5229.6 5238.3 5331.5 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#4] prototype.html Cycles:180 Average:4573.69 Median:5174.47 stddev:1312.65 (25.4%) stddev-sans-first:1276.89 11:36:23 INFO - PROCESS | 21210 | Values: 319.0 330.9 331.8 333.1 337.4 5106.9 5217.4 5234.4 5236.9 5253.6 4908.3 4985.7 4995.4 5007.2 5152.7 4008.8 4013.5 4030.7 4059.7 4061.1 4063.6 4068.1 4072.3 4079.8 4104.6 3902.9 4042.1 4056.9 4063.4 4100.2 4080.9 4084.0 4087.8 4094.0 4099.8 3660.9 3667.1 3671.9 3675.2 3681.5 4792.9 5059.9 5078.6 5084.7 5090.3 4644.3 4663.4 4670.2 4683.3 4688.9 5400.3 5405.4 5407.7 5414.9 5429.3 3903.4 4012.2 4015.4 4017.4 4027.3 5565.2 5568.4 5594.2 5627.4 5633.5 4137.7 4138.3 4140.8 4143.4 4148.6 4182.1 4188.2 4195.3 4200.3 4202.3 4518.9 4656.8 4671.4 4676.8 4689.6 5417.8 5417.9 5427.6 5442.8 5445.3 1340.2 1427.3 1432.7 1449.0 1450.9 996.9 1012.2 1018.9 1021.8 1030.0 5154.9 5159.8 5176.1 5185.0 5187.5 5264.4 5381.0 5421.2 5435.7 5447.9 5113.8 5154.1 5184.8 5197.5 5199.9 2901.3 2906.8 2910.2 2913.6 2917.2 5436.2 5664.8 5671.2 5671.2 5751.4 5564.7 5634.2 5646.2 5649.2 5687.8 5711.6 5722.7 5741.9 5752.9 5765.5 5296.2 5457.2 5505.7 5549.4 5562.9 5497.7 5512.4 5513.8 5517.1 5520.8 5634.7 5699.4 5775.5 5779.2 5791.0 3934.6 3975.9 3982.3 3986.8 3993.8 5477.3 5546.5 5548.6 5557.5 5560.2 5172.8 5408.6 5411.3 5414.4 5420.8 5326.2 5386.8 5390.5 5401.8 5405.6 5156.9 5254.4 5383.5 5401.8 5404.6 5387.8 5401.8 5417.6 5426.4 5431.6 5275.9 5277.5 5281.6 5289.0 5293.0 11:36:23 INFO - PROCESS | 21210 | 11:36:23 INFO - PROCESS | 21210 | [#5] yui.html Cycles:180 Average:22000.17 Median:3610.83 stddev:32466.23 (899.1%) stddev-sans-first:32518.22 11:36:23 INFO - PROCESS | 21210 | Values: 783.9 802.4 806.9 828.0 843.4 17712.5 18181.2 18291.7 18299.1 18318.6 16113.1 16116.3 16163.5 16173.7 16184.8 665.7 805.2 817.9 823.3 824.3 798.9 818.3 824.5 825.9 826.0 842.1 845.6 851.4 851.5 853.5 687.5 846.3 846.9 847.1 848.1 611.9 618.8 621.5 623.4 624.8 15046.2 15046.4 15103.4 15116.8 15133.6 14098.2 14379.0 14813.2 14961.9 15100.2 13435.9 13766.4 13778.1 13915.3 14595.6 4543.6 4603.3 4629.0 4662.9 4681.5 59814.0 60627.7 60698.4 63406.4 85239.6 10627.7 11023.8 11114.2 11352.9 11751.5 21597.4 21667.9 21695.8 21714.2 21718.6 8261.6 8268.8 8612.4 8628.2 8804.5 4733.1 4860.2 4876.8 4932.6 5009.7 3525.9 3695.8 3701.4 3703.2 3706.6 628.7 641.5 644.6 648.4 648.8 678.3 705.9 757.8 807.9 808.2 9711.9 9906.0 10218.9 10844.2 10934.7 608.5 655.0 686.5 715.6 763.0 5230.3 5245.5 5267.5 5300.9 5310.3 126815.0 127421.0 127718.0 130055.3 136643.3 69616.7 89365.6 109738.0 111028.4 117411.0 100862.0 101147.5 101506.5 101974.0 103124.5 9689.0 10025.9 10278.7 10349.7 10363.3 56248.7 56281.0 56869.3 56915.1 56960.4 76560.0 78563.0 83083.6 84272.6 86700.0 12137.2 12317.6 12354.6 12374.9 12779.4 13742.5 13752.2 14045.4 14055.2 14706.0 12867.1 13058.0 13239.9 13645.7 13666.6 11350.4 12345.8 12554.6 12984.1 13636.8 14147.2 14544.4 14748.4 15444.8 16109.4 11357.5 11662.7 11735.3 11967.8 12184.0 11450.8 12641.7 12768.2 12863.7 12982.8 11:36:23 INFO - PROCESS | 21210 | -------- Summary: end -------- 11:36:23 INFO - PROCESS | 21210 | 11:36:24 INFO - TEST-INFO | 21210: exit 0 11:36:24 INFO - TEST-OK | dromaeo_css | took 1114103ms 11:36:24 INFO - TEST-START | kraken 11:36:24 INFO - operating with platform_type : linux_ 11:36:24 INFO - Initialising browser for kraken test... 11:36:24 INFO - TEST-INFO | started process 21395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEeCcLK/profile http://localhost:38281/getInfo.html) 11:36:28 INFO - PROCESS | 21395 | __metrics Screen width/height:1600/1200 11:36:28 INFO - PROCESS | 21395 | colorDepth:24 11:36:28 INFO - PROCESS | 21395 | Browser inner width/height: 1024/697 11:36:28 INFO - PROCESS | 21395 | __metrics 11:36:28 INFO - PROCESS | 21395 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:36:28 INFO - PROCESS | 21395 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:29 INFO - TEST-INFO | 21395: exit 0 11:36:29 INFO - Browser initialized. 11:36:29 INFO - Running cycle 1/1 for kraken test... 11:36:29 INFO - TEST-INFO | started process 21475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEeCcLK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:41 INFO - PROCESS | 21475 | RSS: Main: 157028352 11:36:41 INFO - PROCESS | 21475 | 11:36:44 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38281/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:44 INFO - PROCESS | 21475 | RSS: Main: 213200896 11:36:44 INFO - PROCESS | 21475 | 11:36:47 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38281/tests/kraken/driver.html?testName=audio-dft) 11:36:48 INFO - PROCESS | 21475 | RSS: Main: 192024576 11:36:48 INFO - PROCESS | 21475 | 11:36:51 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38281/tests/kraken/driver.html?testName=audio-fft) 11:36:51 INFO - PROCESS | 21475 | RSS: Main: 270708736 11:36:51 INFO - PROCESS | 21475 | 11:36:53 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38281/tests/kraken/driver.html?testName=audio-oscillator) 11:36:54 INFO - PROCESS | 21475 | RSS: Main: 179118080 11:36:54 INFO - PROCESS | 21475 | 11:36:56 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:57 INFO - PROCESS | 21475 | RSS: Main: 184770560 11:36:57 INFO - PROCESS | 21475 | 11:37:00 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38281/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:00 INFO - PROCESS | 21475 | RSS: Main: 219521024 11:37:00 INFO - PROCESS | 21475 | 11:37:04 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38281/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:04 INFO - PROCESS | 21475 | RSS: Main: 220233728 11:37:04 INFO - PROCESS | 21475 | 11:37:07 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38281/tests/kraken/driver.html?testName=json-parse-financial) 11:37:08 INFO - PROCESS | 21475 | RSS: Main: 219975680 11:37:08 INFO - PROCESS | 21475 | 11:37:09 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:10 INFO - PROCESS | 21475 | RSS: Main: 184250368 11:37:10 INFO - PROCESS | 21475 | 11:37:12 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:12 INFO - PROCESS | 21475 | RSS: Main: 190025728 11:37:12 INFO - PROCESS | 21475 | 11:37:14 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:15 INFO - PROCESS | 21475 | RSS: Main: 195215360 11:37:15 INFO - PROCESS | 21475 | 11:37:17 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:18 INFO - PROCESS | 21475 | RSS: Main: 195436544 11:37:18 INFO - PROCESS | 21475 | 11:37:21 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:21 INFO - PROCESS | 21475 | RSS: Main: 197439488 11:37:21 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | Cycle 1(1): loaded http://localhost:38281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38281/tests/kraken/driver.html?testName=ai-astar) 11:37:23 INFO - PROCESS | 21475 | RSS: Main: 244408320 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | __start_tp_report 11:37:23 INFO - PROCESS | 21475 | _x_x_mozilla_page_load 11:37:23 INFO - PROCESS | 21475 | _x_x_mozilla_page_load_details 11:37:23 INFO - PROCESS | 21475 | |i|pagename|runs| 11:37:23 INFO - PROCESS | 21475 | |0;ai-astar;101;113;113;112;111;112;110;111;110;112 11:37:23 INFO - PROCESS | 21475 | |1;audio-beat-detection;151;116;119;185;122;119;137;117;156;120 11:37:23 INFO - PROCESS | 21475 | |2;audio-dft;160;160;161;162;160;160;161;161;161;162 11:37:23 INFO - PROCESS | 21475 | |3;audio-fft;75;76;75;119;75;75;73;75;105;75 11:37:23 INFO - PROCESS | 21475 | |4;audio-oscillator;84;83;131;84;84;83;127;85;85;122 11:37:23 INFO - PROCESS | 21475 | |5;imaging-gaussian-blur;118;116;116;117;116;117;117;117;116;116 11:37:23 INFO - PROCESS | 21475 | |6;imaging-darkroom;145;145;148;145;146;146;145;146;145;145 11:37:23 INFO - PROCESS | 21475 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;96;95 11:37:23 INFO - PROCESS | 21475 | |8;json-parse-financial;51;49;47;50;49;59;49;49;49;48 11:37:23 INFO - PROCESS | 21475 | |9;json-stringify-tinderbox;62;63;62;62;61;63;62;61;62;62 11:37:23 INFO - PROCESS | 21475 | |10;stanford-crypto-aes;75;85;75;89;75;76;76;76;75;80 11:37:23 INFO - PROCESS | 21475 | |11;stanford-crypto-ccm;130;126;122;120;120;119;122;121;122;122 11:37:23 INFO - PROCESS | 21475 | |12;stanford-crypto-pbkdf2;157;158;157;157;162;160;163;160;167;162 11:37:23 INFO - PROCESS | 21475 | |13;stanford-crypto-sha256-iterative;66;62;63;65;62;64;62;63;63;65 11:37:23 INFO - PROCESS | 21475 | __end_tp_report 11:37:23 INFO - PROCESS | 21475 | __start_cc_report 11:37:23 INFO - PROCESS | 21475 | _x_x_mozilla_cycle_collect,1717 11:37:23 INFO - PROCESS | 21475 | __end_cc_report 11:37:23 INFO - PROCESS | 21475 | __startTimestamp1470335843706__endTimestamp 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | ------- Summary: start ------- 11:37:23 INFO - PROCESS | 21475 | Number of tests: 14 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:1.13 11:37:23 INFO - PROCESS | 21475 | Values: 101.0 113.0 113.0 112.0 111.0 112.0 110.0 111.0 110.0 112.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:129.50 stddev:23.06 (17.8%) stddev-sans-first:23.64 11:37:23 INFO - PROCESS | 21475 | Values: 151.0 116.0 119.0 185.0 122.0 119.0 137.0 117.0 156.0 120.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:37:23 INFO - PROCESS | 21475 | Values: 160.0 160.0 161.0 162.0 160.0 160.0 161.0 161.0 161.0 162.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:16.01 (21.4%) stddev-sans-first:16.77 11:37:23 INFO - PROCESS | 21475 | Values: 75.0 76.0 75.0 119.0 75.0 75.0 73.0 75.0 105.0 75.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.73 (24.7%) stddev-sans-first:21.46 11:37:23 INFO - PROCESS | 21475 | Values: 84.0 83.0 131.0 84.0 84.0 83.0 127.0 85.0 85.0 122.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 11:37:23 INFO - PROCESS | 21475 | Values: 118.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 11:37:23 INFO - PROCESS | 21475 | Values: 145.0 145.0 148.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:37:23 INFO - PROCESS | 21475 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:49.00 stddev:3.33 (6.8%) stddev-sans-first:3.52 11:37:23 INFO - PROCESS | 21475 | Values: 51.0 49.0 47.0 50.0 49.0 59.0 49.0 49.0 49.0 48.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 11:37:23 INFO - PROCESS | 21475 | Values: 62.0 63.0 62.0 62.0 61.0 63.0 62.0 61.0 62.0 62.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:76.00 stddev:4.96 (6.5%) stddev-sans-first:5.13 11:37:23 INFO - PROCESS | 21475 | Values: 75.0 85.0 75.0 89.0 75.0 76.0 76.0 76.0 75.0 80.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.00 stddev:3.27 (2.7%) stddev-sans-first:2.01 11:37:23 INFO - PROCESS | 21475 | Values: 130.0 126.0 122.0 120.0 120.0 119.0 122.0 121.0 122.0 122.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:3.27 (2.0%) stddev-sans-first:3.24 11:37:23 INFO - PROCESS | 21475 | Values: 157.0 158.0 157.0 157.0 162.0 160.0 163.0 160.0 167.0 162.0 11:37:23 INFO - PROCESS | 21475 | 11:37:23 INFO - PROCESS | 21475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.43 (2.3%) stddev-sans-first:1.20 11:37:23 INFO - PROCESS | 21475 | Values: 66.0 62.0 63.0 65.0 62.0 64.0 62.0 63.0 63.0 65.0 11:37:23 INFO - PROCESS | 21475 | -------- Summary: end -------- 11:37:23 INFO - PROCESS | 21475 | 11:37:24 INFO - TEST-INFO | 21475: exit 0 11:37:24 INFO - TEST-OK | kraken | took 60393ms 11:37:24 INFO - SUITE-END | took 1174s 11:37:24 INFO - Completed test suite (00:19:34) 11:37:24 INFO - javascript benchmark 11:37:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.3399252164522, 3002.2194229500324, 3018.6075810144685, 3038.7417069549088, 3060.449119158552, 5141.074606570825, 5172.534471897528, 5181.093308670982, 5274.129768588183, 5290.656107353019, 5190.792368305263, 5245.291885595443, 5274.340707411574, 5361.356637203531, 5391.0, 4747.501512341206, 4758.143534163849, 4760.880977975544, 4777.163996300651, 4967.379077615298, 4882.368451163887, 4886.657933944625, 4918.409790825106, 4930.309756634074, 4936.481669424713, 4751.168545504523, 4752.904941901143, 4777.546133117348, 4803.111424386465, 4886.096072226632, 4705.905881882378, 4712.222483290253, 4736.715797052153, 4786.904261914777, 4880.682755620874, 4724.291356296549, 4761.904761904777, 4762.666613337068, 4792.9760351198365, 4838.467768545457, 5108.463611320833, 5126.512981266774, 5203.9219411708855, 5206.297149884755, 5237.659552129099, 5584.5253153482, 5617.410171931929, 5637.9718101409235, 5640.32316122068, 5643.153526970947, 5636.774529018834, 5647.0, 5675.886482270373, 5685.886282274373, 5690.459406356389, 5105.566026887719, 5124.4875512448825, 5133.589312854962, 5142.357205349332, 5274.024305503494, 5667.149927510906, 5675.57433192504, 5696.458836410535, 5706.771729130788, 5717.199592057115, 5375.838724838261, 5377.300950876361, 5420.810271640474, 5428.267183930119, 5433.26650902131, 5394.217838413408, 5443.537299329601, 5495.505404513613, 5531.3362396512675, 5548.306461692288, 5596.356419011866, 5603.943960560342, 5608.186812912187, 5637.548996080386, 5645.491905728422, 5569.498745112959, 5612.5229355504425, 5615.887682246333, 5621.0444224481935, 5625.240592520039, 4223.704340696122, 4319.589638984291, 4348.673849461303, 4350.912981740347, 4363.19280933022, 3877.5928527504207, 3882.941755873664, 3909.8240579174008, 3917.9020524487114, 3922.843086276574, 5318.468153184651, 5338.386085600128, 5342.332208473941, 5344.652597581145, 5387.218853266333, 5442.755076021588, 5595.496405323541, 5598.048331783607, 5656.660600363992, 5670.347909990322, 5370.731463426813, 5371.57027437804, 5401.378841433207, 5402.837914862561, 5412.242286079952, 4960.801567937314, 4971.65198436106, 4971.875703107379, 4975.676581022222, 5012.172991456368, 5658.830235092872, 5805.419458054161, 5883.411658834082, 5886.499647529922, 5898.970505147447, 5650.406707295675, 5705.286839145107, 5707.086866101404, 5746.626469279484, 5752.884942301214, 5890.0, 5892.145638882253, 5897.3807750187325, 5899.882002360015, 5905.202797622438, 5337.54630856366, 5453.64551304164, 5512.3385193777, 5609.6073274872, 5610.7755689773585, 5537.584681148849, 5595.524380427709, 5628.465295796893, 5665.3201615806365, 5666.603337766317, 5473.589480788877, 5481.835544933659, 5485.890282194254, 5487.314085739283, 5488.890222195613, 5366.302380690485, 5385.057614917452, 5477.534409575231, 5495.199407321903, 5534.308211473566, 5371.328583927009, 5465.453454654503, 5479.232907393048, 5510.779568817203, 5512.3660779010925, 5492.340919089735, 5495.587830912617, 5543.057680194296, 5546.833594992157, 5546.972265138648, 5268.710220937885, 5323.0152421802095, 5374.892502150014, 5380.219868119023, 5385.0], "value": 5184.626446830629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2173997713053, 590.5659340384818, 609.8475381154711, 616.198941376211, 621.9160413344197, 43460.13079738403, 44773.776131119295, 44809.77595112028, 44888.38895138108, 47223.513766192154, 45993.54006459934, 46522.534774652246, 46600.0, 46628.533714662844, 46635.53364466354, 9171.633134674605, 9316.8602470963, 9326.906730932706, 9334.06659334068, 9334.393264437824, 9096.226820720247, 9183.908160918405, 9190.908090919072, 9200.263978881707, 9201.95399023004, 9197.586108625095, 9208.49353285569, 9229.6308147674, 9236.307276954221, 9245.491497967609, 9166.450012999208, 9181.540922953893, 9204.631814727403, 9208.3093767967, 9218.539073046355, 9085.0, 9159.313051521096, 9161.496117713523, 9162.770930726718, 9168.404053736553, 43047.35428968568, 43362.566374336166, 43442.56557434449, 43479.34780978288, 43490.34764478535, 3539.7699149555197, 3641.8725344613076, 3649.905028491442, 3765.6234376562397, 4061.4720086388875, 32727.6727232727, 32859.67140328614, 33336.0, 34389.14027149316, 35161.94514164579, 4409.536998615131, 4457.8439754608435, 4491.461024677027, 4514.683972121953, 4682.789274482657, 248560.0, 250380.0, 250427.0, 250466.0, 251289.0, 58544.7072764642, 58857.70571147117, 58861.0, 58909.41090589039, 58936.11595826066, 61190.38809611847, 61545.07682384768, 61634.38365616376, 61952.38047619466, 61972.0, 15575.0, 15603.453879114404, 15723.135227562365, 15760.92119539418, 15768.68462630741, 12133.635990920286, 12217.511299548096, 12227.633171004883, 12228.327441990776, 12231.633051008484, 16591.751123733153, 16737.497875063767, 16814.0, 16819.159042048093, 16929.32282708678, 6472.190976127984, 6636.568623039487, 6666.166729158856, 6709.865802683919, 6783.864322713518, 1007.4308015970953, 1087.9129669626411, 1151.1999160583314, 1154.342025045716, 1169.1348402182323, 32740.0, 32841.985826897006, 33017.834910825295, 33178.3364332712, 33420.0, 886.3396769406704, 1071.9088877445504, 1096.2271598523023, 1096.5394534295615, 1155.1913660437726, 16832.0, 16993.490195294162, 17131.828681713025, 17175.227114779864, 17343.2195551198, 584008.0, 589345.0, 589883.0, 591943.0, 591952.0, 59005.0, 59284.11073833896, 59308.0, 59310.40689593135, 59348.40651593515, 1197.5329621447643, 1242.912996090265, 1274.566647339909, 1324.5496531179253, 1347.4273433790795, 32598.185045374055, 33650.83174584111, 34026.319473610885, 34312.7554742703, 34349.31301374009, 49911.50088499069, 50740.0, 50807.2378914324, 50856.491435085176, 50866.0, 396767.0, 398595.0, 398840.0, 401440.0, 404043.0, 28419.147425577266, 29405.558916616697, 29449.705502945555, 30617.08148755541, 30770.230744231572, 49109.263361050325, 49419.258711118644, 49428.50571494383, 49644.25533616926, 51415.74292128516, 41483.37774933318, 41492.37761433521, 41842.58157418387, 42489.78755106328, 43659.126817462835, 41589.79205103955, 42045.58521355336, 43317.0, 43618.0, 43749.0, 42964.570354296055, 43905.34141987937, 44116.33825492684, 44144.779276103414, 44366.0, 34253.31493370069, 37312.253754925296, 37731.62268377281, 37746.81126594349, 38503.807480962416, 29031.564526531696, 29319.41361172722, 29552.408951821275, 29594.852025739732, 29597.26006849846], "value": 20237.27139454522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.571084674318, 388.63080073929774, 400.88173988673327, 412.1694785008208, 415.41011763296115, 13856.792148117775, 17855.464336069923, 19556.804431955676, 19669.31157409491, 19775.703364449546, 19673.901630491862, 19684.704729429035, 19686.409407717754, 19855.702164467544, 19936.40190794275, 5466.890662186754, 5610.915836262459, 5631.211630371731, 5645.887082258352, 5660.3490598581075, 5618.241537392461, 5707.62900411474, 5714.771409143629, 5721.914171287434, 5723.828285151431, 5589.0219211638005, 5596.608237423382, 5622.606417550773, 5685.602007859451, 5695.629784064023, 5616.606837521375, 5686.431356864322, 5698.487136157745, 5699.145128230757, 5699.658020518761, 4930.531599498042, 5085.0, 5119.206522988943, 5120.052790233782, 5121.129408000649, 22939.311820645406, 23142.305730828102, 23253.069877204893, 23396.88301558481, 23498.412539686473, 2369.0, 2522.230719630512, 2728.386113124551, 3062.5099984002454, 3170.0172946386692, 13951.441942322295, 14878.0, 14879.330430130562, 14933.402663893432, 15025.323860426197, 1958.0405601255425, 1958.1188465190721, 1966.0955960258298, 2016.798320167986, 2018.8485863560145, 64717.0, 75817.24182758157, 75896.62051689706, 78339.60830195813, 78572.21427785706, 10420.218483613759, 10420.68737937863, 10551.366917984946, 10566.788664226673, 10690.358578485315, 13687.384067716977, 13687.863121368659, 13710.588682339545, 13712.314384280746, 15350.846491535165, 8064.395170362246, 8155.673773049011, 8284.130166332448, 8374.330053595697, 8438.789030274293, 7756.573388463576, 7890.684372625031, 8090.150534193943, 8099.392545559107, 8100.311473524816, 6604.306547812506, 6821.4542836572955, 6846.931530684629, 6875.862482750317, 6946.687399067054, 1903.8572107092023, 1928.594995051027, 1955.0, 1971.7929617390255, 2006.0872303102053, 942.0391200974967, 1040.3549799124592, 1045.5608644369383, 1116.1193389139326, 1164.1152723929874, 20221.595568088556, 20758.065887035118, 20836.166553337698, 20918.58162836765, 21169.25907593227, 1016.1413605503337, 1034.4207243943415, 1046.9633562825265, 1092.2372426988948, 1118.6196693124377, 10992.615258465916, 11925.344106074075, 11938.701532461759, 11949.462274197682, 11995.340256285814, 425739.0, 429751.0, 440459.0, 441151.0, 441281.0, 72737.0, 75910.0, 77398.0, 79121.20878791138, 80147.19852801514, 990.2028866762325, 1041.5729550884253, 1052.8210204265292, 1064.563528953141, 1067.0023528001343, 17692.292308307522, 17904.91047544754, 18444.907775461037, 18567.350142744937, 18828.341008064654, 39242.411363830135, 39551.80224098861, 39705.2058958825, 40622.39066413947, 40659.3901091478, 51602.48397515977, 52602.47397525976, 53306.4669353317, 54435.45564544304, 54894.0, 8315.126911674188, 8356.916430835614, 8537.487750734976, 8757.956210218908, 9035.864462032943, 12971.935140324238, 13217.801732973821, 13288.0, 13290.401931912893, 13507.72984540284, 6640.402363787282, 11441.599544015919, 11657.125715571536, 11987.22083064598, 12139.39303034827, 10422.218333624856, 11048.502817373399, 11164.88835111671, 11274.154438416988, 11589.82615260755, 11569.6529104127, 11854.0, 11978.820317695066, 12117.575884843987, 12168.087393445705, 8659.307255419677, 8815.0, 8832.64669413242, 8838.116188381111, 8953.865692014755, 11198.720031999264, 11742.88257117418, 11793.41032948332, 11873.346965916957, 11890.227135236182], "value": 9341.644586745533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.75874583829, 1426.6290764401256, 1488.6873756511134, 1579.3603590545833, 1739.1217435195217, 7874.763757087289, 8304.66781328747, 8307.91692083079, 8503.362247831406, 8507.872381914276, 8390.202930721587, 8492.660293588264, 8494.150584941503, 8496.872546911802, 8500.489970601753, 2342.9414264643433, 2366.053578568578, 2367.1241640593003, 2369.5379401016808, 2370.265217782493, 2285.257291380308, 2318.96521552176, 2351.1300818697105, 2351.7413084560685, 2352.2120089769946, 2297.781710737477, 2311.39903625057, 2318.1886339781026, 2334.439734463725, 2337.1936681844736, 2276.4536511237347, 2293.7591552886956, 2304.896279667419, 2305.6541518772233, 2309.203324852923, 2141.1328411993168, 2149.7420309562954, 2152.074607918594, 2153.23560136151, 2156.105216335219, 8375.623096960591, 8525.062243153248, 8525.701600443954, 8530.530820804854, 8538.146185381474, 5007.123753343187, 5061.696298222082, 5130.53825155734, 5135.871603209912, 5143.974280128576, 3311.768176227665, 3403.7447191460737, 3419.5725534308212, 3458.0836078439233, 3478.0, 1048.6591857646295, 1072.5656109275756, 1091.4815462655254, 1092.6558134187785, 1100.658795773313, 11262.155338349574, 11354.375509346983, 11418.657440276806, 11434.085273178209, 11447.942760286229, 4246.978765106154, 4279.33670281107, 4449.621782148489, 4451.643868490513, 4462.44219472566, 9285.767855803659, 9288.535573221447, 9289.535523223813, 9291.396059256127, 9304.53477326131, 5043.268726034705, 5081.898362032739, 5084.77118529667, 5088.338515992898, 5091.261767043758, 4169.10364271683, 4372.693911426233, 4508.797104130322, 4549.112922979987, 4770.856874293777, 3602.819859007039, 3713.2759111973446, 3716.7212459065677, 3726.292004519187, 3813.103920578662, 1118.2395970739974, 1119.5130118398522, 1125.386664267976, 1127.7406196574834, 1131.6831287239586, 870.5560164316245, 968.7917097824002, 975.5024937282037, 992.5979978108877, 1003.9297249192487, 5731.168980497804, 5739.913901291484, 5913.674747888907, 5938.524918006549, 6054.0, 459.20786643041157, 461.98614041578804, 470.4237309296085, 472.15248628711544, 486.23418116466706, 4129.566395528486, 4135.1316223592785, 4152.979235103866, 4163.812628431728, 4171.20747058058, 10209.54057067419, 10470.424126673106, 10522.526486308134, 10535.157187424988, 10548.947255263674, 10404.167666586654, 10425.635102771366, 10440.321379110334, 10451.007154320327, 10478.109360704273, 7491.475596708178, 7823.921760782433, 8005.599020171563, 8052.436329456999, 8090.959545202354, 5731.5701322400155, 5919.496842768241, 5944.494717949023, 5958.910616340845, 6131.356207598316, 9296.488693121673, 9415.905840941503, 9484.383515071499, 9491.430514169171, 9577.425354478753, 9654.469004204837, 9812.509374531102, 9815.0, 9821.754456138653, 9870.259730520384, 6702.832429189114, 7140.393066589398, 7268.818279543054, 7269.890951635624, 7358.632068396451, 7987.800304992422, 8029.0, 8047.557384343917, 8053.154418785943, 8056.637451314587, 7171.964140179266, 7225.277472252733, 7266.491345605757, 7302.233265507045, 7423.146338171179, 7220.927790722026, 7356.77929662111, 7363.7422690205585, 7390.371818395497, 7533.811654708456, 6861.759838405632, 6886.345797149263, 6948.374646281859, 6948.826279343057, 6953.721851125898, 4976.154053810788, 5164.870878228075, 5194.3766747990485, 5233.476652334736, 5250.901967838993, 5199.74001299941, 5213.374395072464, 5229.633925625322, 5238.266642670105, 5331.5201631853315], "value": 4396.494299533229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.9649138594756, 330.94043072246984, 331.8291080093751, 333.0508052051653, 337.43816545451824, 5106.923396149061, 5217.37391513019, 5234.398044224915, 5236.895262094756, 5253.57971362291, 4908.337374454448, 4985.675931064478, 4995.400551933764, 5007.22388029855, 5152.716600586976, 4008.759474431529, 4013.4983127109113, 4030.717849750519, 4059.675225981929, 4061.1471590965934, 4063.553009168989, 4068.084680946793, 4072.3077076896852, 4079.77561234132, 4104.630583247507, 3902.8829135125993, 4042.130941847502, 4056.9391459127987, 4063.3701776224584, 4100.179964007196, 4080.9387859182134, 4084.0, 4087.7956102195067, 4093.9795301023455, 4099.754014759124, 3660.871869484555, 3667.111437609633, 3671.94492082619, 3675.228202077567, 3681.5398075240596, 4792.873674686446, 5059.924101138486, 5078.568321692661, 5084.661055914284, 5090.261912022736, 4644.2801365788355, 4663.417072865892, 4670.229412146991, 4683.344331793552, 4688.929666055012, 5400.324959380077, 5405.405405405402, 5407.675539467645, 5414.864628384283, 5429.267048948381, 3903.3949737790404, 4012.1574469361176, 4015.377616469452, 4017.3773065174946, 4027.2549578328103, 5565.220869078333, 5568.415316391761, 5594.188842617838, 5627.352854421712, 5633.521150702195, 4137.668986481074, 4138.255114079495, 4140.834366625301, 4143.37849322598, 4148.647364973951, 4182.121754431542, 4188.246115699203, 4195.328747400401, 4200.348945913388, 4202.348635961431, 4518.887027824265, 4656.813727450932, 4671.369365135663, 4676.836310729108, 4689.577937985529, 5417.756200970965, 5417.918731219035, 5427.620066595379, 5442.782288708487, 5445.319335083114, 1340.2092765268537, 1427.2863568215892, 1432.6561625209874, 1448.9639907466, 1450.8766754825747, 996.9451680157516, 1012.2205901455837, 1018.9286749927583, 1021.8211812932856, 1029.953652085658, 5154.896902061938, 5159.819406320761, 5176.127249376556, 5184.9740751296, 5187.455317191716, 5264.42091369949, 5381.0, 5421.241026256327, 5435.701036443033, 5447.863803404946, 5113.846584602394, 5154.072266991902, 5184.811341025243, 5197.506236907488, 5199.896002080013, 2901.347196880685, 2906.790838962404, 2910.2433367324647, 2913.562965555141, 2917.1977706130983, 5436.184572314105, 5664.773409063591, 5671.17767923657, 5671.234383358194, 5751.367349591542, 5564.721763911788, 5634.211210430543, 5646.153077038395, 5649.180868774005, 5687.772489100473, 5711.600187986801, 5722.713864306851, 5741.85645358861, 5752.884942301214, 5765.452282033284, 5296.232046353334, 5457.154141108134, 5505.6696598204235, 5549.389567147691, 5562.9443705564045, 5497.670139791625, 5512.448755124456, 5513.779448822002, 5517.117261238182, 5520.834374968757, 5634.690092044813, 5699.430056994267, 5775.537956963517, 5779.190913272229, 5790.986577348863, 3934.586868378779, 3975.92048159041, 3982.26328129297, 3986.7840308706122, 3993.840246390228, 5477.3427188737605, 5546.473085056913, 5548.611597188319, 5557.527610153021, 5560.165975103767, 5172.818951336685, 5408.593765620888, 5411.323584551931, 5414.35027796667, 5420.8373748786025, 5326.174442961347, 5386.8383948481605, 5390.460953904578, 5401.783928642967, 5405.594580406564, 5156.922646160236, 5254.422013578427, 5383.5423988961375, 5401.756920938488, 5404.59465540094, 5387.838364849061, 5401.838604700009, 5417.620766546304, 5426.42633636241, 5431.646942948696, 5275.920861187008, 5277.472252774845, 5281.630285879952, 5288.968651112996, 5293.0], "value": 4162.406780403312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.9490433121847, 802.4102284820656, 806.8951036365273, 827.9875801862969, 843.3759018326436, 17712.468625941226, 18181.181846816875, 18291.72562411565, 18299.08504574771, 18318.633627327446, 16113.113778742165, 16116.274767635456, 16163.515094547183, 16173.676526469464, 16184.83815161848, 665.6904539389183, 805.1907832628215, 817.9468334558235, 823.2878560045577, 824.3322908444179, 798.932090772285, 818.3412353055787, 824.5094168969454, 825.8926339575846, 825.9710910118147, 842.0695131879277, 845.6279237135672, 851.3955091884769, 851.5103815306193, 853.4751128056263, 687.5427840486071, 846.255295340103, 846.8856704344927, 847.1105339393642, 848.1391387741417, 611.9173911521932, 618.8452886778306, 621.5338496127904, 623.3548277532732, 624.7688355308519, 15046.247687615685, 15046.398144074225, 15103.39586416542, 15116.848831511654, 15133.621659458491, 14098.154110753389, 14379.0, 14813.18527480988, 14961.925190374088, 15100.169490678009, 13435.92896310328, 13766.380512876844, 13778.104423212559, 13915.30423478822, 14595.635109122251, 4543.636509079266, 4603.332516785081, 4628.979662957721, 4662.930056049162, 4681.531846815291, 59814.0, 60627.696861515855, 60698.39301607016, 63406.36593634051, 85239.57380213059, 10627.681169564925, 11023.779524409467, 11114.222004459773, 11352.886471135349, 11751.529938802352, 21597.35207943764, 21667.891660541598, 21695.783042169693, 21714.24000159987, 21718.565628687338, 8261.628226729812, 8268.793280167924, 8612.354073444516, 8628.22345988864, 8804.47173169612, 4733.148033354029, 4860.198067318924, 4876.756162191876, 4932.605391568666, 5009.7244651544515, 3525.876594319238, 3695.7782533048103, 3701.370766969622, 3703.185299234164, 3706.592274849764, 628.6919409489317, 641.5468962799264, 644.5810223354857, 648.4131860666105, 648.7599588152414, 678.3420082519948, 705.9188193357829, 757.75373003774, 807.915168907268, 808.1716240853056, 9711.902880971242, 9906.0, 10218.897811021943, 10844.186685998582, 10934.671959841218, 608.5192697768713, 655.0499203451377, 686.5057158845623, 715.5742333311671, 762.9885551716728, 5230.267762513251, 5245.527902488718, 5267.5143355771625, 5300.92048619271, 5310.283111779938, 126815.0, 127421.0, 127718.0, 130055.34972325267, 136643.31678341544, 69616.6519167401, 89365.55317223372, 109738.0, 111028.44485777519, 117411.0, 100862.0, 101147.49426252821, 101506.49246753719, 101974.0, 103124.48437757914, 9688.951555242178, 10025.899741002788, 10278.691639250834, 10349.74125646865, 10363.274570779973, 56248.71875640596, 56281.0, 56869.293921182434, 56915.14627280511, 56960.43039569717, 76560.0, 78563.0, 83083.5845820767, 84272.57863710888, 86700.0, 12137.21108127969, 12317.568885089337, 12354.629361119181, 12374.876251237733, 12779.424925878544, 13742.519011834538, 13752.243626600633, 14045.438182472586, 14055.22696251716, 14706.044107133002, 12867.099303048697, 13058.0, 13239.86760132425, 13645.727085458037, 13666.590002299947, 11350.375729334966, 12345.753084938431, 12554.560590379293, 12984.091113621957, 13636.79544806809, 14147.221902795445, 14544.41822327095, 14748.410063597335, 15444.84555154479, 16109.355625774837, 11357.4889129991, 11662.739902071828, 11735.295882247092, 11967.820482692592, 12184.0, 11450.826489499179, 12641.683957900757, 12768.2339059653, 12863.6784080395, 12982.805257921327], "value": 7851.8326786863245, "unit": "score"}], "name": "dromaeo_css", "value": 7213.188585997877, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 112.0, 111.0, 112.0, 110.0, 111.0, 110.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 119.0, 185.0, 122.0, 119.0, 137.0, 117.0, 156.0, 120.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 119.0, 75.0, 75.0, 73.0, 75.0, 105.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 131.0, 84.0, 84.0, 83.0, 127.0, 85.0, 85.0, 122.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 148.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 47.0, 50.0, 49.0, 59.0, 49.0, 49.0, 49.0, 48.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 61.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 75.0, 89.0, 75.0, 76.0, 76.0, 76.0, 75.0, 80.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 122.0, 120.0, 120.0, 119.0, 122.0, 121.0, 122.0, 122.0], "value": 122.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 157.0, 157.0, 162.0, 160.0, 163.0, 160.0, 167.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 65.0, 62.0, 64.0, 62.0, 63.0, 63.0, 65.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1478.5, "alertThreshold": 2.0}]} 11:37:24 INFO - Return code: 0 11:37:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:25 INFO - # TBPL SUCCESS # 11:37:25 INFO - Running post-action listener: _resource_record_post_action 11:37:25 INFO - [mozharness: 2016-08-04 18:37:25.017738Z] Finished run-tests step (success) 11:37:25 INFO - Running post-run listener: _resource_record_post_run 11:37:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 550395904; Read time: 400; Write time: 526636 11:37:25 INFO - TinderboxPrint: CPU usage
13.0% 11:37:25 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 400 11:37:25 INFO - TinderboxPrint: I/O write bytes / time
550,395,904 / 526,636 11:37:25 INFO - TinderboxPrint: CPU idle
8,280.5 (87.0%) 11:37:25 INFO - TinderboxPrint: CPU user
1,189.0 (12.5%) 11:37:25 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257089536; Read time: 0; Write time: 303468 11:37:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292872192; Read time: 392; Write time: 223052 11:37:25 INFO - Running post-run listener: _upload_blobber_files 11:37:25 INFO - Blob upload gear active. 11:37:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:25 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 11:37:25 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'] 11:37:25 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 11:37:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:26 INFO - (blobuploader) - INFO - Done attempting. 11:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:27 INFO - (blobuploader) - INFO - Done attempting. 11:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:30 INFO - (blobuploader) - INFO - Done attempting. 11:37:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:30 INFO - Return code: 0 11:37:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98868779c4c92a5f2a171f97cfe10852e0f10c5af6f3eb7acf7d281bd765f874a942d9d3012a471890e478c9ecb3af9034591e725d83b7de7d601da998ae3638", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d910fb710ffa93c126fe0de2618982b0835fda9605ea2fd569f143995637bd2b573267fc0b12049fdd2bfcb1095b12cdf0073a740fa9abeb1a6e49a60285e824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fec0d8040b7ed94649a8e8bba53df26b9ff77cd12bb5cacbc67b137a1c24de6048ad8ecfce83dff6bab0028e42a47cc1bff26fb7b5e4e6d77190ea08fb8e318b"} 11:37:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:30 INFO - Contents: 11:37:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98868779c4c92a5f2a171f97cfe10852e0f10c5af6f3eb7acf7d281bd765f874a942d9d3012a471890e478c9ecb3af9034591e725d83b7de7d601da998ae3638", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d910fb710ffa93c126fe0de2618982b0835fda9605ea2fd569f143995637bd2b573267fc0b12049fdd2bfcb1095b12cdf0073a740fa9abeb1a6e49a60285e824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fec0d8040b7ed94649a8e8bba53df26b9ff77cd12bb5cacbc67b137a1c24de6048ad8ecfce83dff6bab0028e42a47cc1bff26fb7b5e4e6d77190ea08fb8e318b"} 11:37:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:30 INFO - Copying logs to upload dir... 11:37:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.868095 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-04 11:37:30.753607) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:37:30.756790) ========= 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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98868779c4c92a5f2a171f97cfe10852e0f10c5af6f3eb7acf7d281bd765f874a942d9d3012a471890e478c9ecb3af9034591e725d83b7de7d601da998ae3638", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d910fb710ffa93c126fe0de2618982b0835fda9605ea2fd569f143995637bd2b573267fc0b12049fdd2bfcb1095b12cdf0073a740fa9abeb1a6e49a60285e824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fec0d8040b7ed94649a8e8bba53df26b9ff77cd12bb5cacbc67b137a1c24de6048ad8ecfce83dff6bab0028e42a47cc1bff26fb7b5e4e6d77190ea08fb8e318b"} build_url:https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/D0pYORXHS4K5d37vebMkCw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98868779c4c92a5f2a171f97cfe10852e0f10c5af6f3eb7acf7d281bd765f874a942d9d3012a471890e478c9ecb3af9034591e725d83b7de7d601da998ae3638", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d910fb710ffa93c126fe0de2618982b0835fda9605ea2fd569f143995637bd2b573267fc0b12049fdd2bfcb1095b12cdf0073a740fa9abeb1a6e49a60285e824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fec0d8040b7ed94649a8e8bba53df26b9ff77cd12bb5cacbc67b137a1c24de6048ad8ecfce83dff6bab0028e42a47cc1bff26fb7b5e4e6d77190ea08fb8e318b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:37:30.785575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:37:30.785900) ========= 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=62c568580acbfdaac3eec7be000001dc-1470334193.528836-1101401505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004728 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:37:30.870402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:37:30.870732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:37:30.871039) ========= ========= Total master_lag: 0.18 =========