builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1471628119.16 results: success (0) buildid: 20160819053002 builduid: ba5cf8c20a394a26a887d61f25c4b676 revision: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.157184) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.157615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.157914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.176030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.176412) ========= 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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 10:35:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-19 10:35:20 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.393728 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.583816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.584102) ========= 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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023268 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.674108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:19.674471) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a3b356bd3fbac6745f671c756dc799ad5aa94bc --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 5a3b356bd3fbac6745f671c756dc799ad5aa94bc --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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 10:35:20,443 truncating revision to first 12 chars 2016-08-19 10:35:20,443 Setting DEBUG logging. 2016-08-19 10:35:20,443 attempt 1/10 2016-08-19 10:35:20,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a3b356bd3fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 10:35:20,812 unpacking tar archive at: fx-team-5a3b356bd3fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.807398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:20.495162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:20.495470) ========= script_repo_revision: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:20.495885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:20.496158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 10:35:20.505745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-19 10:35:20.506028) ========= /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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:35:21 INFO - MultiFileLogger online at 20160819 10:35:21 in /builds/slave/test 10:35:21 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 10:35:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:35:21 INFO - {'append_to_log': False, 10:35:21 INFO - 'base_work_dir': '/builds/slave/test', 10:35:21 INFO - 'blob_upload_branch': 'Fx-Team', 10:35:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:35:21 INFO - 'branch': 'Fx-Team', 10:35:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:35:21 INFO - 'config_files': ('talos/linux_config.py',), 10:35:21 INFO - 'default_actions': ('clobber', 10:35:21 INFO - 'read-buildbot-config', 10:35:21 INFO - 'download-and-extract', 10:35:21 INFO - 'populate-webroot', 10:35:21 INFO - 'create-virtualenv', 10:35:21 INFO - 'install', 10:35:21 INFO - 'run-tests'), 10:35:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:35:21 INFO - 'download_minidump_stackwalk': True, 10:35:21 INFO - 'download_symbols': 'ondemand', 10:35:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:35:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:35:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:35:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:35:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:35:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:35:21 INFO - 'installer_path': 'installer.exe', 10:35:21 INFO - 'log_level': 'info', 10:35:21 INFO - 'log_name': 'talos', 10:35:21 INFO - 'log_to_console': True, 10:35:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:35:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:35:21 INFO - 'opt_config_files': (), 10:35:21 INFO - 'pip_index': False, 10:35:21 INFO - 'sps_profile': False, 10:35:21 INFO - 'sps_profile_interval': 0, 10:35:21 INFO - 'suite': 'dromaeojs', 10:35:21 INFO - 'system_bits': '32', 10:35:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:35:21 INFO - 'title': 'talos-linux64-ix-043', 10:35:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:35:21 INFO - 'use_talos_json': True, 10:35:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:35:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:35:21 INFO - 'work_dir': 'build'} 10:35:21 INFO - [mozharness: 2016-08-19 17:35:21.370891Z] Running clobber step. 10:35:21 INFO - Running pre-action listener: _resource_record_pre_action 10:35:21 INFO - Running main action method: clobber 10:35:21 INFO - rmtree: /builds/slave/test/build 10:35:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:35:21 INFO - Running post-action listener: _resource_record_post_action 10:35:21 INFO - [mozharness: 2016-08-19 17:35:21.829993Z] Finished clobber step (success) 10:35:21 INFO - [mozharness: 2016-08-19 17:35:21.830091Z] Running read-buildbot-config step. 10:35:21 INFO - Running pre-action listener: _resource_record_pre_action 10:35:21 INFO - Running main action method: read_buildbot_config 10:35:21 INFO - Using buildbot properties: 10:35:21 INFO - { 10:35:21 INFO - "project": "", 10:35:21 INFO - "product": "firefox", 10:35:21 INFO - "script_repo_revision": "production", 10:35:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:35:21 INFO - "repository": "", 10:35:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:35:21 INFO - "buildid": "20160819053002", 10:35:21 INFO - "pgo_build": "True", 10:35:21 INFO - "basedir": "/builds/slave/test", 10:35:21 INFO - "buildnumber": 1480, 10:35:21 INFO - "slavename": "talos-linux64-ix-043", 10:35:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:35:21 INFO - "platform": "ubuntu64_hw", 10:35:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:35:21 INFO - "branch": "fx-team", 10:35:21 INFO - "repo_path": "integration/fx-team", 10:35:21 INFO - "revision": "5a3b356bd3fbac6745f671c756dc799ad5aa94bc", 10:35:21 INFO - "stage_platform": "linux64-pgo", 10:35:21 INFO - "builduid": "ba5cf8c20a394a26a887d61f25c4b676", 10:35:21 INFO - "slavebuilddir": "test" 10:35:21 INFO - } 10:35:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:35:21 INFO - Running post-action listener: _resource_record_post_action 10:35:21 INFO - [mozharness: 2016-08-19 17:35:21.832478Z] Finished read-buildbot-config step (success) 10:35:21 INFO - [mozharness: 2016-08-19 17:35:21.832566Z] Running download-and-extract step. 10:35:21 INFO - Running pre-action listener: _resource_record_pre_action 10:35:21 INFO - Running main action method: download_and_extract 10:35:21 INFO - mkdir: /builds/slave/test/build/tests 10:35: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')]} 10:35:21 INFO - trying https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:35:21 INFO - Downloading https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:22 INFO - Downloaded 1361 bytes. 10:35:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:35:22 INFO - Using the following test package requirements: 10:35:22 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:35:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:35:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:35:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'jsshell-linux-x86_64.zip'], 10:35:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:35:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:35:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:35:22 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:35:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:35:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:35:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:22 INFO - trying https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:22 INFO - Downloading https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:23 INFO - Downloaded 21906216 bytes. 10:35:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:35:27 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 10:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:27 INFO - trying https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:28 INFO - Downloaded 21906216 bytes. 10:35:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:35:33 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')]} 10:35:33 INFO - trying https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:33 INFO - Downloaded 14413981 bytes. 10:35:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:34 INFO - trying https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:34 INFO - Downloading https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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 10:35:35 INFO - Downloaded 59605909 bytes. 10:35:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:35 INFO - mkdir: /builds/slave/test/properties 10:35:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:35 INFO - Contents: 10:35:35 INFO - build_url:https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:36 INFO - Running post-action listener: _resource_record_post_action 10:35:36 INFO - Running post-action listener: set_extra_try_arguments 10:35:36 INFO - [mozharness: 2016-08-19 17:35:36.325129Z] Finished download-and-extract step (success) 10:35:36 INFO - [mozharness: 2016-08-19 17:35:36.325351Z] Running populate-webroot step. 10:35:36 INFO - Running pre-action listener: _resource_record_pre_action 10:35:36 INFO - Running main action method: populate_webroot 10:35:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:36 INFO - '--tppagecycles', 10:35:36 INFO - '7'], 10:35:36 INFO - 'tests': ['tsvgm']}}, 10:35:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['damp', 'tps']}, 10:35:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'tests': ['damp', 'tps']}, 10:35:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['dromaeo_dom']}, 10:35:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['basic_compositor_video']}, 10:35:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:35:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['a11yr', 10:35:36 INFO - 'ts_paint', 10:35:36 INFO - 'tpaint', 10:35:36 INFO - 'sessionrestore', 10:35:36 INFO - 'sessionrestore_no_auto_restore', 10:35:36 INFO - 'tabpaint']}, 10:35:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['tsvgx', 10:35:36 INFO - 'tsvgr_opacity', 10:35:36 INFO - 'tart', 10:35:36 INFO - 'tscrollx', 10:35:36 INFO - 'cart']}, 10:35:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:36 INFO - 'tsvgr_opacity', 10:35:36 INFO - 'tart', 10:35:36 INFO - 'tscrollx', 10:35:36 INFO - 'cart']}, 10:35:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'talos_options': ['--disable-e10s'], 10:35:36 INFO - 'tests': ['tp5o']}, 10:35:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'tests': ['tp5o']}, 10:35:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'talos_options': ['--disable-e10s', 10:35:36 INFO - '--xperf_path', 10:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:36 INFO - 'tests': ['tp5n']}, 10:35:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:36 INFO - 'talos_options': ['--xperf_path', 10:35:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:36 INFO - 'tests': ['tp5n']}}, 10:35:36 INFO - 'talos.zip': {'path': '', 10:35:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:36 INFO - Running post-action listener: _resource_record_post_action 10:35:36 INFO - [mozharness: 2016-08-19 17:35:36.343830Z] Finished populate-webroot step (success) 10:35:36 INFO - [mozharness: 2016-08-19 17:35:36.343917Z] Running create-virtualenv step. 10:35:36 INFO - Running pre-action listener: _resource_record_pre_action 10:35:36 INFO - Running main action method: create_virtualenv 10:35:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:36 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 10:35:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:36 INFO - Using real prefix '/usr' 10:35:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:38 INFO - Installing pip.................done. 10:35:38 INFO - Return code: 0 10:35:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:35:38 INFO - Using env: {'DISPLAY': ':0', 10:35:38 INFO - 'HOME': '/home/cltbld', 10:35:38 INFO - 'LANG': 'en_US.UTF-8', 10:35:38 INFO - 'LANGUAGE': 'en_US:en', 10:35:38 INFO - 'LOGNAME': 'cltbld', 10:35:38 INFO - 'MAIL': '/var/mail/cltbld', 10:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:38 INFO - 'MOZ_NO_REMOTE': '1', 10:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:38 INFO - 'NO_EM_RESTART': '1', 10:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:38 INFO - 'PWD': '/builds/slave/test', 10:35:38 INFO - 'SHELL': '/bin/bash', 10:35:38 INFO - 'SHLVL': '1', 10:35:38 INFO - 'TERM': 'linux', 10:35:38 INFO - 'TMOUT': '86400', 10:35:38 INFO - 'USER': 'cltbld', 10:35:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:38 INFO - '_': '/tools/buildbot/bin/python'} 10:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:39 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 10:35:39 INFO - Cleaning up... 10:35:39 INFO - Return code: 0 10:35:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:39 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:39 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 10:35:39 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 10:35:39 INFO - Using env: {'DISPLAY': ':0', 10:35:39 INFO - 'HOME': '/home/cltbld', 10:35:39 INFO - 'LANG': 'en_US.UTF-8', 10:35:39 INFO - 'LANGUAGE': 'en_US:en', 10:35:39 INFO - 'LOGNAME': 'cltbld', 10:35:39 INFO - 'MAIL': '/var/mail/cltbld', 10:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:39 INFO - 'MOZ_NO_REMOTE': '1', 10:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:39 INFO - 'NO_EM_RESTART': '1', 10:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:39 INFO - 'PWD': '/builds/slave/test', 10:35:39 INFO - 'SHELL': '/bin/bash', 10:35:39 INFO - 'SHLVL': '1', 10:35:39 INFO - 'TERM': 'linux', 10:35:39 INFO - 'TMOUT': '86400', 10:35:39 INFO - 'USER': 'cltbld', 10:35:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:39 INFO - '_': '/tools/buildbot/bin/python'} 10:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:39 INFO - Downloading/unpacking psutil>=3.1.1 10:35:39 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 10:35:39 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 10:35:39 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 10:35:39 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 10:35:39 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 10:35:39 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 10:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:41 INFO - Installing collected packages: psutil 10:35:41 INFO - Running setup.py install for psutil 10:35:41 INFO - building 'psutil._psutil_linux' extension 10:35:41 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 10:35:41 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 10:35:41 INFO - building 'psutil._psutil_posix' extension 10:35:41 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 10:35:41 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 10:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:41 INFO - Successfully installed psutil 10:35:41 INFO - Cleaning up... 10:35:41 INFO - Return code: 0 10:35:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35:41 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')]} 10:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:41 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')]} 10:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:41 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:41 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 10:35:41 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 10:35:41 INFO - Using env: {'DISPLAY': ':0', 10:35:41 INFO - 'HOME': '/home/cltbld', 10:35:41 INFO - 'LANG': 'en_US.UTF-8', 10:35:41 INFO - 'LANGUAGE': 'en_US:en', 10:35:41 INFO - 'LOGNAME': 'cltbld', 10:35:41 INFO - 'MAIL': '/var/mail/cltbld', 10:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:41 INFO - 'MOZ_NO_REMOTE': '1', 10:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:41 INFO - 'NO_EM_RESTART': '1', 10:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:41 INFO - 'PWD': '/builds/slave/test', 10:35:41 INFO - 'SHELL': '/bin/bash', 10:35:41 INFO - 'SHLVL': '1', 10:35:41 INFO - 'TERM': 'linux', 10:35:41 INFO - 'TMOUT': '86400', 10:35:41 INFO - 'USER': 'cltbld', 10:35:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:41 INFO - '_': '/tools/buildbot/bin/python'} 10:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35:42 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 10:35:42 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 10:35:42 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 10:35:42 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 10:35:42 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 10:35:42 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 10:35:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:44 INFO - Installing collected packages: mozsystemmonitor 10:35:44 INFO - Running setup.py install for mozsystemmonitor 10:35:44 INFO - Successfully installed mozsystemmonitor 10:35:44 INFO - Cleaning up... 10:35:44 INFO - Return code: 0 10:35:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:44 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')]} 10:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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')]} 10:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:44 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 10:35:44 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 10:35:44 INFO - Using env: {'DISPLAY': ':0', 10:35:44 INFO - 'HOME': '/home/cltbld', 10:35:44 INFO - 'LANG': 'en_US.UTF-8', 10:35:44 INFO - 'LANGUAGE': 'en_US:en', 10:35:44 INFO - 'LOGNAME': 'cltbld', 10:35:44 INFO - 'MAIL': '/var/mail/cltbld', 10:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:44 INFO - 'MOZ_NO_REMOTE': '1', 10:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:44 INFO - 'NO_EM_RESTART': '1', 10:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:44 INFO - 'PWD': '/builds/slave/test', 10:35:44 INFO - 'SHELL': '/bin/bash', 10:35:44 INFO - 'SHLVL': '1', 10:35:44 INFO - 'TERM': 'linux', 10:35:44 INFO - 'TMOUT': '86400', 10:35:44 INFO - 'USER': 'cltbld', 10:35:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:44 INFO - '_': '/tools/buildbot/bin/python'} 10:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:44 INFO - Downloading/unpacking jsonschema==2.5.1 10:35:44 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 10:35:44 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 10:35:44 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 10:35:44 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 10:35:44 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 10:35:44 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 10:35:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:47 INFO - warning: no files found matching '*.txt' 10:35:47 INFO - no previously-included directories found matching 'build' 10:35:47 INFO - no previously-included directories found matching 'dist' 10:35:47 INFO - no previously-included directories found matching '.git*' 10:35:47 INFO - Installing collected packages: jsonschema, functools32 10:35:47 INFO - Running setup.py install for functools32 10:35:47 INFO - warning: no files found matching '*.txt' 10:35:47 INFO - no previously-included directories found matching 'build' 10:35:47 INFO - no previously-included directories found matching 'dist' 10:35:47 INFO - no previously-included directories found matching '.git*' 10:35:47 INFO - Successfully installed jsonschema functools32 10:35:47 INFO - Cleaning up... 10:35:47 INFO - Return code: 0 10:35:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:47 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:47 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 10:35:47 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 10:35:47 INFO - Using env: {'DISPLAY': ':0', 10:35:47 INFO - 'HOME': '/home/cltbld', 10:35:47 INFO - 'LANG': 'en_US.UTF-8', 10:35:47 INFO - 'LANGUAGE': 'en_US:en', 10:35:47 INFO - 'LOGNAME': 'cltbld', 10:35:47 INFO - 'MAIL': '/var/mail/cltbld', 10:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:47 INFO - 'MOZ_NO_REMOTE': '1', 10:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:47 INFO - 'NO_EM_RESTART': '1', 10:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:47 INFO - 'PWD': '/builds/slave/test', 10:35:47 INFO - 'SHELL': '/bin/bash', 10:35:47 INFO - 'SHLVL': '1', 10:35:47 INFO - 'TERM': 'linux', 10:35:47 INFO - 'TMOUT': '86400', 10:35:47 INFO - 'USER': 'cltbld', 10:35:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:47 INFO - '_': '/tools/buildbot/bin/python'} 10:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:35:48 INFO - Cleaning up... 10:35:48 INFO - Return code: 0 10:35:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:48 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:48 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 10:35:48 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 10:35:48 INFO - Using env: {'DISPLAY': ':0', 10:35:48 INFO - 'HOME': '/home/cltbld', 10:35:48 INFO - 'LANG': 'en_US.UTF-8', 10:35:48 INFO - 'LANGUAGE': 'en_US:en', 10:35:48 INFO - 'LOGNAME': 'cltbld', 10:35:48 INFO - 'MAIL': '/var/mail/cltbld', 10:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:48 INFO - 'MOZ_NO_REMOTE': '1', 10:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:48 INFO - 'NO_EM_RESTART': '1', 10:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:48 INFO - 'PWD': '/builds/slave/test', 10:35:48 INFO - 'SHELL': '/bin/bash', 10:35:48 INFO - 'SHLVL': '1', 10:35:48 INFO - 'TERM': 'linux', 10:35:48 INFO - 'TMOUT': '86400', 10:35:48 INFO - 'USER': 'cltbld', 10:35:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:48 INFO - '_': '/tools/buildbot/bin/python'} 10:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 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 10:35:50 INFO - Downloading docopt-0.6.1.tar.gz 10:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:50 INFO - Running setup.py install for blobuploader 10:35:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:50 INFO - Running setup.py install for requests 10:35:51 INFO - Running setup.py install for docopt 10:35:51 INFO - Successfully installed blobuploader requests docopt 10:35:51 INFO - Cleaning up... 10:35:51 INFO - Return code: 0 10:35:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:51 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:51 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 10:35:51 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 10:35:51 INFO - Using env: {'DISPLAY': ':0', 10:35:51 INFO - 'HOME': '/home/cltbld', 10:35:51 INFO - 'LANG': 'en_US.UTF-8', 10:35:51 INFO - 'LANGUAGE': 'en_US:en', 10:35:51 INFO - 'LOGNAME': 'cltbld', 10:35:51 INFO - 'MAIL': '/var/mail/cltbld', 10:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:51 INFO - 'MOZ_NO_REMOTE': '1', 10:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:51 INFO - 'NO_EM_RESTART': '1', 10:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:51 INFO - 'PWD': '/builds/slave/test', 10:35:51 INFO - 'SHELL': '/bin/bash', 10:35:51 INFO - 'SHLVL': '1', 10:35:51 INFO - 'TERM': 'linux', 10:35:51 INFO - 'TMOUT': '86400', 10:35:51 INFO - 'USER': 'cltbld', 10:35:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:51 INFO - '_': '/tools/buildbot/bin/python'} 10:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:51 INFO - Running setup.py (path:/tmp/pip-GheR3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:51 INFO - Running setup.py (path:/tmp/pip-GgSi9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:51 INFO - Running setup.py (path:/tmp/pip-YMohuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:51 INFO - Running setup.py (path:/tmp/pip-A0vBbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:52 INFO - Running setup.py (path:/tmp/pip-XV3Ioy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:52 INFO - Running setup.py (path:/tmp/pip-eaM_vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:52 INFO - Running setup.py (path:/tmp/pip-sSPWb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:52 INFO - Running setup.py (path:/tmp/pip-EtwNsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:52 INFO - Running setup.py (path:/tmp/pip-eYF3yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:52 INFO - Running setup.py (path:/tmp/pip-sb2kSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:52 INFO - Running setup.py (path:/tmp/pip-5Agj8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:52 INFO - Running setup.py (path:/tmp/pip-92gWRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:52 INFO - Running setup.py (path:/tmp/pip-fboBdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:52 INFO - Running setup.py (path:/tmp/pip-DIiNZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:52 INFO - Running setup.py (path:/tmp/pip-yfhGIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:52 INFO - Running setup.py (path:/tmp/pip-54Kt2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:52 INFO - Running setup.py (path:/tmp/pip-dPvBAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:52 INFO - Running setup.py install for manifestparser 10:35:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozcrash 10:35:53 INFO - Running setup.py install for mozdebug 10:35:53 INFO - Running setup.py install for mozdevice 10:35:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozfile 10:35:53 INFO - Running setup.py install for mozhttpd 10:35:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozinfo 10:35:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozInstall 10:35:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozleak 10:35:53 INFO - Running setup.py install for mozlog 10:35:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for moznetwork 10:35:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Running setup.py install for mozprocess 10:35:54 INFO - Running setup.py install for mozprofile 10:35:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Running setup.py install for mozrunner 10:35:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Running setup.py install for mozscreenshot 10:35:54 INFO - Running setup.py install for moztest 10:35:54 INFO - Running setup.py install for mozversion 10:35:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:54 INFO - Cleaning up... 10:35:54 INFO - Return code: 0 10:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:54 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')]} 10:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 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')]} 10:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:54 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 10:35:54 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 10:35:54 INFO - Using env: {'DISPLAY': ':0', 10:35:54 INFO - 'HOME': '/home/cltbld', 10:35:54 INFO - 'LANG': 'en_US.UTF-8', 10:35:54 INFO - 'LANGUAGE': 'en_US:en', 10:35:54 INFO - 'LOGNAME': 'cltbld', 10:35:54 INFO - 'MAIL': '/var/mail/cltbld', 10:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:54 INFO - 'MOZ_NO_REMOTE': '1', 10:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:54 INFO - 'NO_EM_RESTART': '1', 10:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:54 INFO - 'PWD': '/builds/slave/test', 10:35:54 INFO - 'SHELL': '/bin/bash', 10:35:54 INFO - 'SHLVL': '1', 10:35:54 INFO - 'TERM': 'linux', 10:35:54 INFO - 'TMOUT': '86400', 10:35:54 INFO - 'USER': 'cltbld', 10:35:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:54 INFO - '_': '/tools/buildbot/bin/python'} 10:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:54 INFO - Running setup.py (path:/tmp/pip-7lv7yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:55 INFO - Running setup.py (path:/tmp/pip-WzMxpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:55 INFO - Running setup.py (path:/tmp/pip-HryJ7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:55 INFO - Running setup.py (path:/tmp/pip-zsCs_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:55 INFO - Running setup.py (path:/tmp/pip-ee3Zi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:55 INFO - Running setup.py (path:/tmp/pip-DlBeGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:55 INFO - Running setup.py (path:/tmp/pip-2ndsyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:55 INFO - Running setup.py (path:/tmp/pip-sOfFYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:55 INFO - Running setup.py (path:/tmp/pip-6KL4l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:55 INFO - Running setup.py (path:/tmp/pip-YwIpps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:55 INFO - Running setup.py (path:/tmp/pip-RfaWaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:55 INFO - Running setup.py (path:/tmp/pip-yz0hWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:55 INFO - Running setup.py (path:/tmp/pip-3ZJJE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:55 INFO - Running setup.py (path:/tmp/pip-EEQa44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:55 INFO - Running setup.py (path:/tmp/pip-VRSJXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:56 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)) 10:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:56 INFO - Running setup.py (path:/tmp/pip-350e9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:56 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)) 10:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:56 INFO - Running setup.py (path:/tmp/pip-s9d16M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:58 INFO - Downloading blessings-1.6.tar.gz 10:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:58 INFO - Installing collected packages: blessings 10:35:58 INFO - Running setup.py install for blessings 10:35:58 INFO - Successfully installed blessings 10:35:58 INFO - Cleaning up... 10:35:58 INFO - Return code: 0 10:35:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:58 INFO - Reading from file tmpfile_stdout 10:35:58 INFO - Current package versions: 10:35:58 INFO - argparse == 1.2.1 10:35:58 INFO - blessings == 1.6 10:35:58 INFO - blobuploader == 1.2.4 10:35:58 INFO - docopt == 0.6.1 10:35:58 INFO - functools32 == 3.2.3-2 10:35:58 INFO - jsonschema == 2.5.1 10:35:58 INFO - manifestparser == 1.1 10:35:58 INFO - mozInstall == 1.12 10:35:58 INFO - mozcrash == 0.17 10:35:58 INFO - mozdebug == 0.1 10:35:58 INFO - mozdevice == 0.48 10:35:58 INFO - mozfile == 1.2 10:35:58 INFO - mozhttpd == 0.7 10:35:58 INFO - mozinfo == 0.9 10:35:58 INFO - mozleak == 0.1 10:35:58 INFO - mozlog == 3.3 10:35:58 INFO - moznetwork == 0.27 10:35:58 INFO - mozprocess == 0.23 10:35:58 INFO - mozprofile == 0.28 10:35:58 INFO - mozrunner == 6.12 10:35:58 INFO - mozscreenshot == 0.1 10:35:58 INFO - mozsystemmonitor == 0.3 10:35:58 INFO - moztest == 0.7 10:35:58 INFO - mozversion == 1.4 10:35:58 INFO - psutil == 3.1.1 10:35:58 INFO - requests == 1.2.3 10:35:58 INFO - wsgiref == 0.1.2 10:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:58 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 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:58 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 10:35:58 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 10:35:58 INFO - Using env: {'DISPLAY': ':0', 10:35:58 INFO - 'HOME': '/home/cltbld', 10:35:58 INFO - 'LANG': 'en_US.UTF-8', 10:35:58 INFO - 'LANGUAGE': 'en_US:en', 10:35:58 INFO - 'LOGNAME': 'cltbld', 10:35:58 INFO - 'MAIL': '/var/mail/cltbld', 10:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:58 INFO - 'MOZ_NO_REMOTE': '1', 10:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:58 INFO - 'NO_EM_RESTART': '1', 10:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:58 INFO - 'PWD': '/builds/slave/test', 10:35:58 INFO - 'SHELL': '/bin/bash', 10:35:58 INFO - 'SHLVL': '1', 10:35:58 INFO - 'TERM': 'linux', 10:35:58 INFO - 'TMOUT': '86400', 10:35:58 INFO - 'USER': 'cltbld', 10:35:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:58 INFO - '_': '/tools/buildbot/bin/python'} 10:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 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)) 10:35:58 INFO - Cleaning up... 10:35:58 INFO - Return code: 0 10:35:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a4ca0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, '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': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', '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 10:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:35:58 INFO - Using env: {'DISPLAY': ':0', 10:35:58 INFO - 'HOME': '/home/cltbld', 10:35:58 INFO - 'LANG': 'en_US.UTF-8', 10:35:58 INFO - 'LANGUAGE': 'en_US:en', 10:35:58 INFO - 'LOGNAME': 'cltbld', 10:35:58 INFO - 'MAIL': '/var/mail/cltbld', 10:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:58 INFO - 'MOZ_NO_REMOTE': '1', 10:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:58 INFO - 'NO_EM_RESTART': '1', 10:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:58 INFO - 'PWD': '/builds/slave/test', 10:35:58 INFO - 'SHELL': '/bin/bash', 10:35:58 INFO - 'SHLVL': '1', 10:35:58 INFO - 'TERM': 'linux', 10:35:58 INFO - 'TMOUT': '86400', 10:35:58 INFO - 'USER': 'cltbld', 10:35:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:58 INFO - '_': '/tools/buildbot/bin/python'} 10:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:58 INFO - Cleaning up... 10:35:58 INFO - Return code: 0 10:35:58 INFO - Running post-action listener: _resource_record_post_action 10:35:58 INFO - Running post-action listener: _start_resource_monitoring 10:35:59 INFO - Starting resource monitoring. 10:35:59 INFO - [mozharness: 2016-08-19 17:35:59.009252Z] Finished create-virtualenv step (success) 10:35:59 INFO - [mozharness: 2016-08-19 17:35:59.009823Z] Running install step. 10:35:59 INFO - Running pre-action listener: _resource_record_pre_action 10:35:59 INFO - Running main action method: install 10:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:59 INFO - Reading from file tmpfile_stdout 10:35:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:59 INFO - Reading from file tmpfile_stdout 10:35:59 INFO - Output received: 10:35:59 INFO - Usage: mozinstall [options] installer 10:35:59 INFO - Options: 10:35:59 INFO - -h, --help show this help message and exit 10:35:59 INFO - -d DEST, --destination=DEST 10:35:59 INFO - Directory to install application into. [default: 10:35:59 INFO - "/builds/slave/test"] 10:35:59 INFO - --app=APP Application being installed. [default: firefox] 10:35:59 INFO - mkdir: /builds/slave/test/build/application 10:35:59 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'] 10:35:59 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 10:36:16 INFO - Reading from file tmpfile_stdout 10:36:16 INFO - Output received: 10:36:16 INFO - /builds/slave/test/build/application/firefox/firefox 10:36:16 INFO - Running post-action listener: _resource_record_post_action 10:36:16 INFO - [mozharness: 2016-08-19 17:36:16.294656Z] Finished install step (success) 10:36:16 INFO - [mozharness: 2016-08-19 17:36:16.294899Z] Running run-tests step. 10:36:16 INFO - Running pre-action listener: _resource_record_pre_action 10:36:16 INFO - Running main action method: run_tests 10:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:16 INFO - Python 2.7.3 10:36:16 INFO - Return code: 0 10:36:16 INFO - grabbing minidump binary from tooltool 10:36: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')]} 10:36:16 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 0x2be1370>, '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 0x2be48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:16 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 10:36:16 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 10:36:16 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 10:36:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:16 INFO - Return code: 0 10:36:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:36:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:36:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:16 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/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:36:16 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/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 10:36:16 INFO - Using env: {'DISPLAY': ':0', 10:36:16 INFO - 'HOME': '/home/cltbld', 10:36:16 INFO - 'LANG': 'en_US.UTF-8', 10:36:16 INFO - 'LANGUAGE': 'en_US:en', 10:36:16 INFO - 'LOGNAME': 'cltbld', 10:36:16 INFO - 'MAIL': '/var/mail/cltbld', 10:36:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:36:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:16 INFO - 'MOZ_NO_REMOTE': '1', 10:36:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:16 INFO - 'NO_EM_RESTART': '1', 10:36:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:16 INFO - 'PWD': '/builds/slave/test', 10:36:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:36:16 INFO - 'SHELL': '/bin/bash', 10:36:16 INFO - 'SHLVL': '1', 10:36:16 INFO - 'TERM': 'linux', 10:36:16 INFO - 'TMOUT': '86400', 10:36:16 INFO - 'USER': 'cltbld', 10:36:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750', 10:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:16 INFO - '_': '/tools/buildbot/bin/python'} 10:36:16 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/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:36:16 INFO - mozversion application_buildid: 20160819053002 10:36:16 INFO - mozversion application_changeset: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc 10:36:16 INFO - mozversion application_display_name: Nightly 10:36:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:36:16 INFO - mozversion application_name: Firefox 10:36:16 INFO - mozversion application_remotingname: firefox 10:36:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:36:16 INFO - mozversion application_vendor: Mozilla 10:36:16 INFO - mozversion application_version: 51.0a1 10:36:16 INFO - mozversion platform_buildid: 20160819053002 10:36:16 INFO - mozversion platform_changeset: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc 10:36:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:36:16 INFO - mozversion platform_version: 51.0a1 10:36:16 INFO - using testdate: 1471628176 10:36:16 INFO - actual date: 1471628176 10:36:16 INFO - starting webserver on 'localhost:59084' 10:36:16 INFO - SUITE-START | Running 2 tests 10:36:16 INFO - TEST-START | dromaeo_css 10:36:16 INFO - operating with platform_type : linux_ 10:36:16 INFO - Initialising browser for dromaeo_css test... 10:36:16 INFO - TEST-INFO | started process 28434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxcuZ0a/profile http://localhost:59084/getInfo.html) 10:36:20 INFO - PROCESS | 28434 | __metrics Screen width/height:1600/1200 10:36:20 INFO - PROCESS | 28434 | colorDepth:24 10:36:20 INFO - PROCESS | 28434 | Browser inner width/height: 1024/697 10:36:20 INFO - PROCESS | 28434 | __metrics 10:36:21 INFO - PROCESS | 28434 | 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" 10:36:21 INFO - PROCESS | 28434 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:21 INFO - PROCESS | 28434 | console.error: PushService: 10:36:21 INFO - PROCESS | 28434 | stateChangeProcessEnqueue: Error transitioning state 10:36:22 INFO - PROCESS | 28434 | UnknownError 10:36:22 INFO - TEST-INFO | 28434: exit 0 10:36:22 INFO - Browser initialized. 10:36:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:22 INFO - TEST-INFO | started process 28514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxcuZ0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:34 INFO - PROCESS | 28514 | RSS: Main: 155295744 10:36:34 INFO - PROCESS | 28514 | 10:37:26 INFO - PROCESS | 28514 | 1471628246032 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] 10:39:35 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59084/tests/dromaeo/cssquery-ext.html) 10:39:36 INFO - PROCESS | 28514 | RSS: Main: 233971712 10:39:36 INFO - PROCESS | 28514 | 10:42:38 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-ext.html (next: http://localhost:59084/tests/dromaeo/cssquery-jquery.html) 10:42:39 INFO - PROCESS | 28514 | RSS: Main: 241299456 10:42:39 INFO - PROCESS | 28514 | 10:45:41 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59084/tests/dromaeo/cssquery-mootools.html) 10:45:41 INFO - PROCESS | 28514 | RSS: Main: 182710272 10:45:41 INFO - PROCESS | 28514 | 10:48:43 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59084/tests/dromaeo/cssquery-prototype.html) 10:48:44 INFO - PROCESS | 28514 | RSS: Main: 233095168 10:48:44 INFO - PROCESS | 28514 | 10:51:47 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59084/tests/dromaeo/cssquery-yui.html) 10:51:47 INFO - PROCESS | 28514 | RSS: Main: 185683968 10:51:47 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | Cycle 1(1): loaded http://localhost:59084/tests/dromaeo/cssquery-yui.html (next: http://localhost:59084/tests/dromaeo/cssquery-dojo.html) 10:54:50 INFO - PROCESS | 28514 | RSS: Main: 279310336 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | __start_tp_report 10:54:50 INFO - PROCESS | 28514 | _x_x_mozilla_page_load 10:54:50 INFO - PROCESS | 28514 | _x_x_mozilla_page_load_details 10:54:50 INFO - PROCESS | 28514 | |i|pagename|runs| 10:54:50 INFO - PROCESS | 28514 | |0;dojo.html;3038.5594088857115;3059.7093276138785;3082.445159871223;3091.2580980564658;3095.938081238375;5168.612354073441;5224.5297923187;5307.601929855262;5374.9193762093555;5398.514133727964;5268.683878967255;5306.151015837467;5309.893802123965;5341;5371.81198658047;4789.712617242959;4834.782434790425;4872;4879.39007624047;5038.924416133761;4948.257761335811;4964.329815474901;4991;5003.274525193845;5013.398392192924;4714.057188562301;4784.593309568656;4817.205161148407;4818.734969576672;4920.335754673127;4826.662133650646;4827.396575428072;4846.224604063368;4910.533499317559;4921.163402221595;4833.516648335173;4853.126437241295;4861.538153875376;4888.388951381077;4915.5084491550915;5117.616178786606;5284.048871203182;5365.490278423583;5380.461953804627;5388.110961691316;5685.744141513601;5739.368669446358;5778.768849246025;5782.3350314713925;5788.88422231553;5803.7098145093;5810.128480727883;5820.185174075633;5824.24284842972;5825.825225243249;5110.872228194325;5306.893862122774;5355.116405793001;5373.731313434313;5435.565154787608;5951.821445356646;5957.523398128139;5962.284525856839;5964.254468191476;5971.0744834550715;5668.433156684381;5672.14917762339;5705.857353566111;5717.542596592262;5719.399463056402;5461.344638643309;5614.550835933115;5696.0031994400815;5703.401142879938;5774.653520788766;5723.942760572424;5724.742386592613;5731.656100633975;5736.5123964462655;5764.452377024176;5708.372079071299;5745.712714364265;5754.251947246915;5757.913631295534;5762.9135562966585;4127.29835927893;4190.685698572619;4191.371294305817;4250.893727656833;4351;3797.4303854421505;3837.194189220239;3839.212961342974;3857.3442514772555;3858.054776579756;5415.702136382458;5419;5431.2667789847865;5454.699991500505;5456.045192091368;5716.08542633185;5717.628354156966;5718.199452076713;5720.08478643415;5725.570582206351;5236.869078272997;5336.306280183551;5378.542823859937;5391.7034563099405;5417.83746487606;4941.678790878582;4993.275974983607;5013.072581572348;5022.547970682656;5025.748712564357;5890.204822348928;5934.703264836828;5954.940450595439;5956.315023772235;5968.462838344483;5474.616776825744;5723.313202415737;5744.569157313134;5753.108268218432;5762.596618236683;5963.970180149072;6045.758169673164;6085.543584231112;6086.634801911722;6088.756449742138;5707.9429205709075;5712.228849105318;5718.971405142947;5725.656460612377;5731.713414329183;5492.5331346835965;5831.562632802642;5843.474087332161;5843.94156058434;5844.649321040752;5526.86182845416;5559.972200139136;5570.749316280858;5616.747246373841;5662.150677398258;5541.833744987657;5578.804741834017;5590.636608620427;5591.30108736408;5592.440755924375;5349.786008559614;5528.861778455571;5582.944170558242;5585.078462053878;5587.217789509391;5574.386817449996;5628.718564071862;5630.831075067591;5665.716714164358;5726.513246373938;5552.52803511706;5558;5559.33288005442;5563.58273129525;5568.025595520687 10:54:50 INFO - PROCESS | 28514 | |1;ext.html;591.8076625096844;612.9049997250428;617.2222999021234;626.799424184261;637.3626373626373;42736.57263427369;43703.78148109259;43709.34435983463;43852.12295754087;47820;46703.065938681204;47110.528894711046;47151.76424117883;47158.76420617892;47228.52771472284;8730.738077857643;8923;8934.195922366986;8943.418677785956;8949.731508054769;8872.37893347466;8934.195922366986;8953.77615559613;8963.462192268486;8966.596503157374;8915.153060459246;9035.638574457047;9036.50299233542;9043.59303831329;9046.185843274105;8977.95511022444;9012.729618111467;9017.188453039193;9023.323250756219;9035.45787252767;8819.779505512413;8873.11268873114;8887;8888.244499217575;8889.688860889837;42579.14841703149;42778.35832462516;42964.785176074234;43005;43020.78489607532;3479.3389256041273;3653.5433070866143;3673.8530458781615;3783.5981022268497;4111.444954931106;32247.51628725571;32745.83627081873;32908.341833163446;33047.834760826045;34242;4350.8912277193;4407.184670835905;4419.801108950105;4422.204003279408;4544.272916333404;342531;343602;344552;344575;346071;58211.70894145502;58475.70762146162;58536.4146358531;58690.30477561785;58726;53486.465135348924;59441.702791486634;63428.68285658635;64321.67839160868;64712;17203.741943870853;17411.216495257744;17424.303027878745;17429.738553921703;17431.65136697259;13378.331083445788;13481.325933703276;13528.458861645424;13536.187828730112;13537.39081741324;14608.342624581706;16014.599635009217;16372.836271637369;16382.39587290794;17092;6506.934930650633;6529.804105876831;6530.542861999709;6592.71442068792;6666.166729158856;955.4076472587041;970.9757256068655;1015.5988384588046;1050.7496079665175;1104.5305745058317;31000.0699979001;32675.34649307048;33160.336793264;33394.49908251378;33727.494087588704;1132.943352832355;1157.7568710570874;1158.212415557429;1221.0292817210338;1225.0100430985328;17199.91400042992;17539;17569.465618330185;17664.646707065785;17673.591512360315;510669;535952;538041;538774;540159;59582.70208648929;59597;59807.401925980186;60320;60333.39666603366;1342.214804339453;1370.1915869636962;1381.6683995840926;1407.4862675123507;1429.9642508937359;30701.232469187555;32637.18407039843;32994.17514562059;33278;33794.66205337915;53696;54232;54235.45764542304;54283.45716542942;54286.18570721521;443123;443837;443865;447177;447466;36473;38332.233355333294;38347.84956451311;43871.34192987044;44448.555514444444;49422.752886236776;49441.75279123581;49444.50555494543;49982.50017499778;50060.99878002492;40939.59060409358;41365.37951930783;42032.369514456695;42185.156296873276;43589.34615980699;42228.36657450202;42643;42937;43231.78384108059;43730.562694372646;41811.163776724905;42425;43089.138217236105;43181.7840910806;43211.783941081354;33970.49044264387;36260.81869590741;36355.272894541435;37041.62958370382;37605.435918460695;27606.309842254104;28028.43943121167;28030.579541306488;28071;28112.859435702692 10:54:50 INFO - PROCESS | 28514 | |2;jquery.html;393.62605524751496;398.96808255339573;405.4830091633168;408.8752930356241;423.3755211063681;13246.536371227008;18369.448916532492;19967.60064798705;20019.499512512193;20344.491387715316;15165.620859478518;15593.688126237497;17814.46556603304;18571.535711607215;18618.53453663659;5550.222968784374;5740.741666624991;5745.798897038583;5749.396313387097;5765.106408506688;5506.669599824003;5624.606277560552;5678.630888992202;5698.145278208261;5705;5630.268065151525;5655.886882262353;5670.829875103754;5681.545476361881;5688.089905615102;5457.617966742329;5620.1288800236025;5672.943270567303;5679.148127780824;5679.801206957736;5073.822416215415;5075;5083;5083.262926875583;5084.44071152173;21135.365939021853;21901.342959711234;22061.558768824692;22803.657945130835;23210.65184022241;2203.5923354179367;2219.345293138512;2375.91684291049;2460.360306320352;2792.539231026878;10307.536160872703;10556.736081597945;10562.471876406149;10672.679819605424;12721.10952233344;1829.7072468404992;1866.766654168229;1895.7110900586724;1912.7704675439036;1931.4978105692621;78898;81232.59383703103;82173.9999999994;83156.58421707853;83882.58058709728;9404.623815047458;9931.404115752934;9936.900630993741;9991.450470224207;10171.64399246023;13260.541340452542;13314;13390.330483475787;13412.664683382798;13415.597532074053;7744.457887947902;7769.378449724121;7886.960565197137;8064.112947575762;8084.151164127799;7718.305352518188;7954.323882470055;7961;8210.384221183316;8216.671333146727;4113.71204015716;4328.805203765838;4639.721616703008;4874.731889746098;4876.244182151772;1909.4558050955688;2008.2268326694327;2038.1643526154205;2061.3403710812395;2069.193014724259;915.208344781759;954.6229239450518;973.4084771398814;1012.6354512375539;1043.5043354406748;19276.22895084209;19469.610607787767;19599.412017639494;19689.212431502867;20012.199512019648;942.9292803039663;959.3859929645033;997.3467378866853;1004.4023805835516;1008.7377281906757;10259.998600545792;10789.46052697362;10910.5090270938;10948.835767463494;11004.889951100547;483835;502812;510843;512353;514301;93954;93954;94961;99634;99869;1001.8060447619689;1046.042870773234;1055.9894401055892;1060.5969731502134;1067.4289255248405;17138.742918855976;17472.650546989244;17544.73682894732;18164.45506634803;18365.26538938481;42044.36933445939;42859.357109642755;43871.56128438802;43935.34096988484;44025;54078;59361.40638593559;60030.69984650049;60553.39446605478;60938.69530652319;7531.585762783099;7595.5442673439775;7906.327962123284;8491.108433614381;8627.266682332072;9873.23621082838;11053.944730276296;12622.116451848282;12635.305058221886;13755.518556850462;11721.413929303671;11831.704207394883;11997.100217483548;12066.3363515004;12521.686957826127;7109.60897150641;11664.88335116672;11967.880321196677;12092.516299347928;12203.20679155852;11938.403079845799;12307.384630768605;12359.073069519642;12377.257364558156;12535.749285014432;8623;8720.91279087201;8739;8861.379703420698;9149.496777677292;10996.505157267782;11008.504617292081;11722;11867.228630139014;12312.630621081382 10:54:50 INFO - PROCESS | 28514 | |3;mootools.html;1314;1502.601810520212;1512.8865335099867;1645.6132808789932;1760.5334586334623;8430.36772242082;8994.235489983343;9003.369764116505;9327.90672093279;9353.812923741538;9146.679866204684;9258.166764991167;9279.304052196096;9297;9300.581473833678;2264.7055882735262;2291.140822191678;2294.300238427279;2295.1278514164596;2296.873671948042;2342.4612339161918;2382.0709923129907;2384.940376490584;2388.0805889732405;2393.760623937601;2370.431096536827;2380.666706661069;2384.3919800450863;2425.841001508659;2429.757024297574;2288.965665515002;2304.101400453824;2325.03511042917;2328.9534209315802;2329.0567320235245;2277.0664027748544;2277.225743247304;2282.8744419056943;2285.074544809355;2289.3933107726466;9063.773405664846;9238.953805230998;9296.581653825595;9326.72019839406;9359.438433694;5205.973970130125;5447;5467.425920278393;5474.288342515487;5482.424345443751;3559.8220088995704;3590.1922067534856;3622.5290712207507;3644.6173151818944;3655.4334078217653;1222.8104643780227;1239.4980033086615;1248.756492483966;1282.5190553542423;1298.9220646761225;12964.22214667123;13052.673683157902;13057.477700892048;13063.085584009123;13068.150570212905;4373.431453910971;4588.770561471913;4667.603253723403;4678.60231880294;4697.084068606658;10217.386956782617;10220.744481388025;10226.13077888373;10228;10234.744131396774;5200.141976573898;5262.289590905179;5267.762950667229;5268;5271.6309858310315;4155.563665815106;4776.761161941889;4795.328653988445;4936.975315123402;4976.850694479172;3859.96140038596;3917.725759196886;3973.2848087343978;4006.6994975376965;4027.8993025174605;1173.7945859474557;1174.8296497008057;1189.084405008139;1195.8056965468463;1196.7127889306678;821.6549049399266;919.3380765848578;1008.1632245236436;1009.9293049486465;1043.4678314059731;5884.382139875337;6050.42520960508;6246.812595622138;6292.370762923671;6298.559100862895;905.1310741688053;920.093707697917;956.2636769687302;960.6877764726491;973.6105557776946;4205.217805662582;4274.358846173099;4351.97824010878;4361.672874534423;4552.385427967249;10954.452277386099;11070.501827417786;11159.665210043711;11160.553577856957;11199.832002519968;10856.294340867818;10969;11125.554977800797;11130.276532025393;11156.832647510293;8528.701495447629;8564.528950907636;8666.78333041679;8681.479111253218;8684.6526138955;6077.179580756541;6085.878282434238;6160.3223645398075;6227.50179985591;6254.405831446005;10331.276810623183;10529.57881684724;10664.520096595517;10708.518116684612;10746.408947507962;10754.623588174376;10770.676879693621;10877.945610271898;10918;11026.228164028442;6757.662116894234;7791.415643826623;7794;8159.34725221969;8510.446820956618;8768.34237432208;9094.045125262017;9095.363324567217;9095.408798428081;9097.727068187965;7669.501482403626;7681.078270607562;7744.5740484271655;7965.681372745257;7969;7865.960670196612;7931.643076061707;7935.365170786208;7953.363730901629;8013.19868013194;6960.443164546926;7084.964575177091;7105.857882842418;7109.3601575856355;7112.679929403086;5076.593872490266;5141.177411614124;5301;5333.3066701330135;5559.527440167631;5371.543418809289;5437.564994800327;5478.424765399575;5528.456909821366;5534.501894829485 10:54:50 INFO - PROCESS | 28514 | |4;prototype.html;332.1059851274277;334.7924286942096;343.37334364784266;345.90487615905636;348.1800360151842;5182.196759502279;5207.760662914945;5234.607404444668;5253.737313134342;5267.683938963665;4870.537298956593;5017.49825017499;5045.268436076767;5049.2678561608545;5197.168453047513;3980.681545476355;4049.898752531188;4077.245709543744;4085.3259212229946;4180.28935081037;4133.106825222341;4136.482939632546;4143.316352801784;4149.958500415002;4178.101708132751;3955.3671412573995;4141.109661422794;4142.5857414258635;4144.274751918402;4167.708260421772;4139.7166878267535;4150.418941348214;4155.646770024551;4156.43888075112;4168.791560421982;3724.417122722832;3724.4413337999245;3726.329260733094;3743.3636281832155;3755.9812200939095;4979.30289759434;5039.395272567279;5073.873153171164;5116.437191908924;5156.381234251914;4675.438947326308;4712.1858084637315;4722.6221902247735;4723.102610504027;4741.596964258042;5369.275147855029;5425.13197888336;5461.808836690697;5464.961657285103;5506.587005974568;3864.8840534784003;4044.130511939947;4064.329385651364;4074.5110586729484;4085.673146148301;5628.859278518029;5651.5415794129685;5656.123300888369;5656.179853921159;5682.261306030231;4164.500259968762;4171.666266698657;4175.436316097288;4178.1643671265265;4193.014641559231;4111.149982507884;4230.513490948519;4248.553901840262;4259.23333799919;4259.7231179973205;4672.789724462339;4699.224627936353;4720.905581888343;4730.455997560256;4753.049390121921;5531.834044978657;5534.335879694462;5535.418781028015;5536.972315138399;5554.500094991389;1343.1250841322853;1459.963425967575;1468.941242350294;1469.8236211654455;1475.2328789029646;969.3650658818485;970.1947383671536;991.4101109839634;1000.9299349045497;1013.8479228115694;5107.974460127675;5154.690718556899;5193.558547523503;5194.6104042196985;5196.168613021899;5417.36152025642;5505.532029777513;5512.366077901012;5524.640898341595;5525.889482210414;5119.846404607868;5128.384593848762;5131.973605278959;5143.97428012865;5169.586433085344;2900.752676349148;2900.941981160407;2914.941701166007;2920.167752190658;2921.4303210873677;5456.809011684572;5661.46216109469;5662.462066103713;5671.858203544862;5758.222639943638;5635.971820140873;5649.971750141223;5667.716614169275;5701.429857014348;5702.714864256771;5740.42595740431;5750.88498230033;5767.923547522804;5782.855428614234;5789.797357092481;5454.263674403905;5531.225628411945;5560.2493663356545;5572.832815015556;5573.442655734556;5496.862578435571;5509.669419834662;5511.669299842022;5512.9877594678455;5528.253685752533;5617.7191140442;5749.511291540266;5754.597178197486;5778.36437991829;5812.680302583399;3937.680876906154;3975.74763949355;3992.2813893498287;3993.940090898581;3997.3004724173734;5531.487505433998;5620.522255608155;5632.971835140798;5639.943600563942;5652.971735141298;5407.161889907071;5408.859869014294;5440.727963601883;5527.668339899619;5551.722413879209;5387.218853266176;5392.514673679388;5399.487048730364;5414.756335964812;5428.728563571726;5227.58179345659;5247.16045432729;5369.677819330853;5409.242706021081;5436.700981445901;5410;5434.945650543444;5450.8909821802545;5458.153986132156;5461.563074954073;5322.8935421292135;5327.9733601331745;5344.225087362233;5370.624056316176;5391.379991301051 10:54:50 INFO - PROCESS | 28514 | |5;yui.html;702.5257950883152;743.1787874398789;767.6737386610689;772.3396495995923;825.5088222507608;14317.498887538939;16078.035317880935;16143.43497977571;16165.838341616565;16183.757243641356;15276.236188190602;15679.372825087012;15749.60625984351;15759.369625214978;15763.84236157638;655.632845606462;788.5071830106184;797.9202079792033;816.828466022136;819.0253598218102;811.5698679699739;813.7599408174602;819.315871247506;819.9959000204991;820.6143112737004;864.7059999600135;867.4318321499428;867.5402036920442;867.9088695686956;868.3921255121409;689.9827504312382;705.1573369823063;861.2378045429778;863.1023735315296;863.5336918064206;524.897644959233;610.66108309888;629.1914889367141;631.3654776949182;632.6552029144082;13049.608511744664;13087;13103.737925241441;13114;13145.014123940742;13361.331933403388;13859.792103118461;14221.146731196059;14246.786298205536;14252.786208206886;12977.480900763958;13037.478500859954;13287.20276783396;13599.796003059962;13695.589132326046;4396.604305612478;4602.6809225235465;4618.584327410549;4626.421697287839;4718.056388722235;76125.61937190278;77609.61195194045;78052.21947780506;85959.57020214859;86661.56669216613;11135.944320278346;11233.438328083563;11410.372429516456;11422.600208992646;11668.416579171007;21025.894870525855;21164.682529762067;21236.681449778265;21292;21380.251691191046;8145.226203510657;8237.546934918517;8399.11809260031;8463.06906240313;8506.276966457921;4645.74448405341;4720.12677654635;4737.6683632146105;4912.312276281324;4913.410390753133;3363.4786608075788;3487.877924272638;3492.1269682579355;3502.1069627244888;3504.176518518146;627.0374974414252;630.7382436288889;637.4549759955264;640.2573015302227;649.6686689788243;556.9164625306155;587.2483221476517;620.7299824576323;651.0754728285846;673.1955313400538;8995;9028.322875784343;9216.986131525528;9319.207867331217;9488;542.3112646938366;593.3473179502599;617.4227097663698;642.081822993115;679.9592024478449;4064.7357921734992;4268.0823622921225;4444.866654000385;4482.618977386894;4482.8655140345845;75070.62464687641;75279.24720752831;75551;87596.12403876007;108239;90235;108336;111175.44412277886;112036.43981780039;112374;59002.40997590055;75037.62481187668;76032.9999999989;76588.23411765811;93737;9652.372595781251;9667.17828984516;10154.898451015395;10176.236782241509;10185.08334249921;54534.727326363114;54797.726011371284;56211.437885622254;57804.42195578159;58425.65189569818;81318;82319.17680823115;82378;82879;85876;13827.355222569518;14283.785743213652;14404.351804168627;14480.855191448372;14810.925945370203;15486.05426557804;15574.766378504104;15939.282732277306;15976.760348594547;16390.098544579687;14196.645083872985;14752.409903603735;14872.925635371754;14948.103113813206;15500.92249538745;14783.113013219241;14827.110373377633;15518.534443966699;15631.140287284308;16300.266488008305;13544.119632223874;14074.929625351808;14240.365532376543;15301.846981530041;15326.540203793904;10646.8402973957;11532.365719885487;12073.818892716441;12116.697082572653;12144.817827732415;10401.84397234027;12008.519659213884;12032;12177.817332740193;12314 10:54:50 INFO - PROCESS | 28514 | __end_tp_report 10:54:50 INFO - PROCESS | 28514 | __start_cc_report 10:54:50 INFO - PROCESS | 28514 | _x_x_mozilla_cycle_collect,1087 10:54:50 INFO - PROCESS | 28514 | __end_cc_report 10:54:50 INFO - PROCESS | 28514 | __startTimestamp1471629290864__endTimestamp 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | ------- Summary: start ------- 10:54:50 INFO - PROCESS | 28514 | Number of tests: 6 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#0] dojo.html Cycles:165 Average:5325.17 Median:5552.53 stddev:630.51 (11.4%) stddev-sans-first:606.39 10:54:50 INFO - PROCESS | 28514 | Values: 3038.6 3059.7 3082.4 3091.3 3095.9 5168.6 5224.5 5307.6 5374.9 5398.5 5268.7 5306.2 5309.9 5341.0 5371.8 4789.7 4834.8 4872.0 4879.4 5038.9 4948.3 4964.3 4991.0 5003.3 5013.4 4714.1 4784.6 4817.2 4818.7 4920.3 4826.7 4827.4 4846.2 4910.5 4921.2 4833.5 4853.1 4861.5 4888.4 4915.5 5117.6 5284.0 5365.5 5380.5 5388.1 5685.7 5739.4 5778.8 5782.3 5788.9 5803.7 5810.1 5820.2 5824.2 5825.8 5110.9 5306.9 5355.1 5373.7 5435.6 5951.8 5957.5 5962.3 5964.3 5971.1 5668.4 5672.1 5705.9 5717.5 5719.4 5461.3 5614.6 5696.0 5703.4 5774.7 5723.9 5724.7 5731.7 5736.5 5764.5 5708.4 5745.7 5754.3 5757.9 5762.9 4127.3 4190.7 4191.4 4250.9 4351.0 3797.4 3837.2 3839.2 3857.3 3858.1 5415.7 5419.0 5431.3 5454.7 5456.0 5716.1 5717.6 5718.2 5720.1 5725.6 5236.9 5336.3 5378.5 5391.7 5417.8 4941.7 4993.3 5013.1 5022.5 5025.7 5890.2 5934.7 5954.9 5956.3 5968.5 5474.6 5723.3 5744.6 5753.1 5762.6 5964.0 6045.8 6085.5 6086.6 6088.8 5707.9 5712.2 5719.0 5725.7 5731.7 5492.5 5831.6 5843.5 5843.9 5844.6 5526.9 5560.0 5570.7 5616.7 5662.2 5541.8 5578.8 5590.6 5591.3 5592.4 5349.8 5528.9 5582.9 5585.1 5587.2 5574.4 5628.7 5630.8 5665.7 5726.5 5552.5 5558.0 5559.3 5563.6 5568.0 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#1] ext.html Cycles:180 Average:61073.44 Median:23970.12 stddev:118462.85 (494.2%) stddev-sans-first:118708.13 10:54:50 INFO - PROCESS | 28514 | Values: 591.8 612.9 617.2 626.8 637.4 42736.6 43703.8 43709.3 43852.1 47820.0 46703.1 47110.5 47151.8 47158.8 47228.5 8730.7 8923.0 8934.2 8943.4 8949.7 8872.4 8934.2 8953.8 8963.5 8966.6 8915.2 9035.6 9036.5 9043.6 9046.2 8978.0 9012.7 9017.2 9023.3 9035.5 8819.8 8873.1 8887.0 8888.2 8889.7 42579.1 42778.4 42964.8 43005.0 43020.8 3479.3 3653.5 3673.9 3783.6 4111.4 32247.5 32745.8 32908.3 33047.8 34242.0 4350.9 4407.2 4419.8 4422.2 4544.3 342531.0 343602.0 344552.0 344575.0 346071.0 58211.7 58475.7 58536.4 58690.3 58726.0 53486.5 59441.7 63428.7 64321.7 64712.0 17203.7 17411.2 17424.3 17429.7 17431.7 13378.3 13481.3 13528.5 13536.2 13537.4 14608.3 16014.6 16372.8 16382.4 17092.0 6506.9 6529.8 6530.5 6592.7 6666.2 955.4 971.0 1015.6 1050.7 1104.5 31000.1 32675.3 33160.3 33394.5 33727.5 1132.9 1157.8 1158.2 1221.0 1225.0 17199.9 17539.0 17569.5 17664.6 17673.6 510669.0 535952.0 538041.0 538774.0 540159.0 59582.7 59597.0 59807.4 60320.0 60333.4 1342.2 1370.2 1381.7 1407.5 1430.0 30701.2 32637.2 32994.2 33278.0 33794.7 53696.0 54232.0 54235.5 54283.5 54286.2 443123.0 443837.0 443865.0 447177.0 447466.0 36473.0 38332.2 38347.8 43871.3 44448.6 49422.8 49441.8 49444.5 49982.5 50061.0 40939.6 41365.4 42032.4 42185.2 43589.3 42228.4 42643.0 42937.0 43231.8 43730.6 41811.2 42425.0 43089.1 43181.8 43211.8 33970.5 36260.8 36355.3 37041.6 37605.4 27606.3 28028.4 28030.6 28071.0 28112.9 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#2] jquery.html Cycles:180 Average:29425.31 Median:407.18 stddev:83348.93 (20469.8%) stddev-sans-first:83554.24 10:54:50 INFO - PROCESS | 28514 | Values: 393.6 399.0 405.5 408.9 423.4 13246.5 18369.4 19967.6 20019.5 20344.5 15165.6 15593.7 17814.5 18571.5 18618.5 5550.2 5740.7 5745.8 5749.4 5765.1 5506.7 5624.6 5678.6 5698.1 5705.0 5630.3 5655.9 5670.8 5681.5 5688.1 5457.6 5620.1 5672.9 5679.1 5679.8 5073.8 5075.0 5083.0 5083.3 5084.4 21135.4 21901.3 22061.6 22803.7 23210.7 2203.6 2219.3 2375.9 2460.4 2792.5 10307.5 10556.7 10562.5 10672.7 12721.1 1829.7 1866.8 1895.7 1912.8 1931.5 78898.0 81232.6 82174.0 83156.6 83882.6 9404.6 9931.4 9936.9 9991.5 10171.6 13260.5 13314.0 13390.3 13412.7 13415.6 7744.5 7769.4 7887.0 8064.1 8084.2 7718.3 7954.3 7961.0 8210.4 8216.7 4113.7 4328.8 4639.7 4874.7 4876.2 1909.5 2008.2 2038.2 2061.3 2069.2 915.2 954.6 973.4 1012.6 1043.5 19276.2 19469.6 19599.4 19689.2 20012.2 942.9 959.4 997.3 1004.4 1008.7 10260.0 10789.5 10910.5 10948.8 11004.9 483835.0 502812.0 510843.0 512353.0 514301.0 93954.0 93954.0 94961.0 99634.0 99869.0 1001.8 1046.0 1056.0 1060.6 1067.4 17138.7 17472.7 17544.7 18164.5 18365.3 42044.4 42859.4 43871.6 43935.3 44025.0 54078.0 59361.4 60030.7 60553.4 60938.7 7531.6 7595.5 7906.3 8491.1 8627.3 9873.2 11053.9 12622.1 12635.3 13755.5 11721.4 11831.7 11997.1 12066.3 12521.7 7109.6 11664.9 11967.9 12092.5 12203.2 11938.4 12307.4 12359.1 12377.3 12535.7 8623.0 8720.9 8739.0 8861.4 9149.5 10996.5 11008.5 11722.0 11867.2 12312.6 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#3] mootools.html Cycles:180 Average:5979.11 Median:4628.19 stddev:3441.86 (74.4%) stddev-sans-first:3433.66 10:54:50 INFO - PROCESS | 28514 | Values: 1314.0 1502.6 1512.9 1645.6 1760.5 8430.4 8994.2 9003.4 9327.9 9353.8 9146.7 9258.2 9279.3 9297.0 9300.6 2264.7 2291.1 2294.3 2295.1 2296.9 2342.5 2382.1 2384.9 2388.1 2393.8 2370.4 2380.7 2384.4 2425.8 2429.8 2289.0 2304.1 2325.0 2329.0 2329.1 2277.1 2277.2 2282.9 2285.1 2289.4 9063.8 9239.0 9296.6 9326.7 9359.4 5206.0 5447.0 5467.4 5474.3 5482.4 3559.8 3590.2 3622.5 3644.6 3655.4 1222.8 1239.5 1248.8 1282.5 1298.9 12964.2 13052.7 13057.5 13063.1 13068.2 4373.4 4588.8 4667.6 4678.6 4697.1 10217.4 10220.7 10226.1 10228.0 10234.7 5200.1 5262.3 5267.8 5268.0 5271.6 4155.6 4776.8 4795.3 4937.0 4976.9 3860.0 3917.7 3973.3 4006.7 4027.9 1173.8 1174.8 1189.1 1195.8 1196.7 821.7 919.3 1008.2 1009.9 1043.5 5884.4 6050.4 6246.8 6292.4 6298.6 905.1 920.1 956.3 960.7 973.6 4205.2 4274.4 4352.0 4361.7 4552.4 10954.5 11070.5 11159.7 11160.6 11199.8 10856.3 10969.0 11125.6 11130.3 11156.8 8528.7 8564.5 8666.8 8681.5 8684.7 6077.2 6085.9 6160.3 6227.5 6254.4 10331.3 10529.6 10664.5 10708.5 10746.4 10754.6 10770.7 10877.9 10918.0 11026.2 6757.7 7791.4 7794.0 8159.3 8510.4 8768.3 9094.0 9095.4 9095.4 9097.7 7669.5 7681.1 7744.6 7965.7 7969.0 7866.0 7931.6 7935.4 7953.4 8013.2 6960.4 7085.0 7105.9 7109.4 7112.7 5076.6 5141.2 5301.0 5333.3 5559.5 5371.5 5437.6 5478.4 5528.5 5534.5 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#4] prototype.html Cycles:180 Average:4611.60 Median:5195.39 stddev:1322.32 (25.5%) stddev-sans-first:1286.43 10:54:50 INFO - PROCESS | 28514 | Values: 332.1 334.8 343.4 345.9 348.2 5182.2 5207.8 5234.6 5253.7 5267.7 4870.5 5017.5 5045.3 5049.3 5197.2 3980.7 4049.9 4077.2 4085.3 4180.3 4133.1 4136.5 4143.3 4150.0 4178.1 3955.4 4141.1 4142.6 4144.3 4167.7 4139.7 4150.4 4155.6 4156.4 4168.8 3724.4 3724.4 3726.3 3743.4 3756.0 4979.3 5039.4 5073.9 5116.4 5156.4 4675.4 4712.2 4722.6 4723.1 4741.6 5369.3 5425.1 5461.8 5465.0 5506.6 3864.9 4044.1 4064.3 4074.5 4085.7 5628.9 5651.5 5656.1 5656.2 5682.3 4164.5 4171.7 4175.4 4178.2 4193.0 4111.1 4230.5 4248.6 4259.2 4259.7 4672.8 4699.2 4720.9 4730.5 4753.0 5531.8 5534.3 5535.4 5537.0 5554.5 1343.1 1460.0 1468.9 1469.8 1475.2 969.4 970.2 991.4 1000.9 1013.8 5108.0 5154.7 5193.6 5194.6 5196.2 5417.4 5505.5 5512.4 5524.6 5525.9 5119.8 5128.4 5132.0 5144.0 5169.6 2900.8 2900.9 2914.9 2920.2 2921.4 5456.8 5661.5 5662.5 5671.9 5758.2 5636.0 5650.0 5667.7 5701.4 5702.7 5740.4 5750.9 5767.9 5782.9 5789.8 5454.3 5531.2 5560.2 5572.8 5573.4 5496.9 5509.7 5511.7 5513.0 5528.3 5617.7 5749.5 5754.6 5778.4 5812.7 3937.7 3975.7 3992.3 3993.9 3997.3 5531.5 5620.5 5633.0 5639.9 5653.0 5407.2 5408.9 5440.7 5527.7 5551.7 5387.2 5392.5 5399.5 5414.8 5428.7 5227.6 5247.2 5369.7 5409.2 5436.7 5410.0 5434.9 5450.9 5458.2 5461.6 5322.9 5328.0 5344.2 5370.6 5391.4 10:54:50 INFO - PROCESS | 28514 | 10:54:50 INFO - PROCESS | 28514 | [#5] yui.html Cycles:180 Average:20599.46 Median:4622.50 stddev:28646.25 (619.7%) stddev-sans-first:28687.65 10:54:50 INFO - PROCESS | 28514 | Values: 702.5 743.2 767.7 772.3 825.5 14317.5 16078.0 16143.4 16165.8 16183.8 15276.2 15679.4 15749.6 15759.4 15763.8 655.6 788.5 797.9 816.8 819.0 811.6 813.8 819.3 820.0 820.6 864.7 867.4 867.5 867.9 868.4 690.0 705.2 861.2 863.1 863.5 524.9 610.7 629.2 631.4 632.7 13049.6 13087.0 13103.7 13114.0 13145.0 13361.3 13859.8 14221.1 14246.8 14252.8 12977.5 13037.5 13287.2 13599.8 13695.6 4396.6 4602.7 4618.6 4626.4 4718.1 76125.6 77609.6 78052.2 85959.6 86661.6 11135.9 11233.4 11410.4 11422.6 11668.4 21025.9 21164.7 21236.7 21292.0 21380.3 8145.2 8237.5 8399.1 8463.1 8506.3 4645.7 4720.1 4737.7 4912.3 4913.4 3363.5 3487.9 3492.1 3502.1 3504.2 627.0 630.7 637.5 640.3 649.7 556.9 587.2 620.7 651.1 673.2 8995.0 9028.3 9217.0 9319.2 9488.0 542.3 593.3 617.4 642.1 680.0 4064.7 4268.1 4444.9 4482.6 4482.9 75070.6 75279.2 75551.0 87596.1 108239.0 90235.0 108336.0 111175.4 112036.4 112374.0 59002.4 75037.6 76033.0 76588.2 93737.0 9652.4 9667.2 10154.9 10176.2 10185.1 54534.7 54797.7 56211.4 57804.4 58425.7 81318.0 82319.2 82378.0 82879.0 85876.0 13827.4 14283.8 14404.4 14480.9 14810.9 15486.1 15574.8 15939.3 15976.8 16390.1 14196.6 14752.4 14872.9 14948.1 15500.9 14783.1 14827.1 15518.5 15631.1 16300.3 13544.1 14074.9 14240.4 15301.8 15326.5 10646.8 11532.4 12073.8 12116.7 12144.8 10401.8 12008.5 12032.0 12177.8 12314.0 10:54:50 INFO - PROCESS | 28514 | -------- Summary: end -------- 10:54:50 INFO - PROCESS | 28514 | 10:54:51 INFO - TEST-INFO | 28514: exit 0 10:54:51 INFO - TEST-OK | dromaeo_css | took 1115079ms 10:54:51 INFO - TEST-START | kraken 10:54:51 INFO - operating with platform_type : linux_ 10:54:51 INFO - Initialising browser for kraken test... 10:54:51 INFO - TEST-INFO | started process 28819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL3gAKb/profile http://localhost:59084/getInfo.html) 10:54:55 INFO - PROCESS | 28819 | __metrics Screen width/height:1600/1200 10:54:55 INFO - PROCESS | 28819 | colorDepth:24 10:54:55 INFO - PROCESS | 28819 | Browser inner width/height: 1024/697 10:54:55 INFO - PROCESS | 28819 | __metrics 10:54:56 INFO - PROCESS | 28819 | 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" 10:54:56 INFO - PROCESS | 28819 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:56 INFO - PROCESS | 28819 | console.error: PushService: 10:54:56 INFO - PROCESS | 28819 | stateChangeProcessEnqueue: Error transitioning state 10:54:56 INFO - PROCESS | 28819 | UnknownError 10:54:57 INFO - TEST-INFO | 28819: exit 0 10:54:57 INFO - Browser initialized. 10:54:57 INFO - Running cycle 1/1 for kraken test... 10:54:57 INFO - TEST-INFO | started process 28901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL3gAKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:09 INFO - PROCESS | 28901 | RSS: Main: 155668480 10:55:09 INFO - PROCESS | 28901 | 10:55:11 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59084/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:12 INFO - PROCESS | 28901 | RSS: Main: 204259328 10:55:12 INFO - PROCESS | 28901 | 10:55:15 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59084/tests/kraken/driver.html?testName=audio-dft) 10:55:15 INFO - PROCESS | 28901 | RSS: Main: 195063808 10:55:15 INFO - PROCESS | 28901 | 10:55:18 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59084/tests/kraken/driver.html?testName=audio-fft) 10:55:19 INFO - PROCESS | 28901 | RSS: Main: 275316736 10:55:19 INFO - PROCESS | 28901 | 10:55:21 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59084/tests/kraken/driver.html?testName=audio-oscillator) 10:55:22 INFO - PROCESS | 28901 | RSS: Main: 186163200 10:55:22 INFO - PROCESS | 28901 | 10:55:24 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:25 INFO - PROCESS | 28901 | RSS: Main: 191569920 10:55:25 INFO - PROCESS | 28901 | 10:55:28 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59084/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:28 INFO - PROCESS | 28901 | RSS: Main: 226091008 10:55:28 INFO - PROCESS | 28901 | 10:55:32 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59084/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:32 INFO - PROCESS | 28901 | RSS: Main: 226500608 10:55:32 INFO - PROCESS | 28901 | 10:55:35 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59084/tests/kraken/driver.html?testName=json-parse-financial) 10:55:36 INFO - PROCESS | 28901 | RSS: Main: 225640448 10:55:36 INFO - PROCESS | 28901 | 10:55:37 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:38 INFO - PROCESS | 28901 | RSS: Main: 188583936 10:55:38 INFO - PROCESS | 28901 | 10:55:40 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:40 INFO - PROCESS | 28901 | RSS: Main: 194768896 10:55:40 INFO - PROCESS | 28901 | 10:55:42 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:43 INFO - PROCESS | 28901 | RSS: Main: 193048576 10:55:43 INFO - PROCESS | 28901 | 10:55:45 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:46 INFO - PROCESS | 28901 | RSS: Main: 187965440 10:55:46 INFO - PROCESS | 28901 | 10:55:49 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:49 INFO - PROCESS | 28901 | RSS: Main: 191787008 10:55:49 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | Cycle 1(1): loaded http://localhost:59084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59084/tests/kraken/driver.html?testName=ai-astar) 10:55:51 INFO - PROCESS | 28901 | RSS: Main: 242446336 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | __start_tp_report 10:55:51 INFO - PROCESS | 28901 | _x_x_mozilla_page_load 10:55:51 INFO - PROCESS | 28901 | _x_x_mozilla_page_load_details 10:55:51 INFO - PROCESS | 28901 | |i|pagename|runs| 10:55:51 INFO - PROCESS | 28901 | |0;ai-astar;104;112;113;112;108;114;113;114;114;112 10:55:51 INFO - PROCESS | 28901 | |1;audio-beat-detection;147;117;126;182;117;121;144;122;154;117 10:55:51 INFO - PROCESS | 28901 | |2;audio-dft;160;161;160;160;160;162;160;160;160;161 10:55:51 INFO - PROCESS | 28901 | |3;audio-fft;75;77;77;117;75;75;75;74;105;75 10:55:51 INFO - PROCESS | 28901 | |4;audio-oscillator;85;84;136;84;85;86;122;85;86;135 10:55:51 INFO - PROCESS | 28901 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;119 10:55:51 INFO - PROCESS | 28901 | |6;imaging-darkroom;146;147;146;146;146;147;147;146;147;148 10:55:51 INFO - PROCESS | 28901 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 10:55:51 INFO - PROCESS | 28901 | |8;json-parse-financial;51;49;52;61;52;54;49;49;52;50 10:55:51 INFO - PROCESS | 28901 | |9;json-stringify-tinderbox;62;63;62;62;62;61;63;62;62;63 10:55:51 INFO - PROCESS | 28901 | |10;stanford-crypto-aes;83;78;78;77;88;81;77;78;78;78 10:55:51 INFO - PROCESS | 28901 | |11;stanford-crypto-ccm;131;123;120;122;123;121;121;121;141;132 10:55:51 INFO - PROCESS | 28901 | |12;stanford-crypto-pbkdf2;160;161;160;162;160;160;159;166;159;162 10:55:51 INFO - PROCESS | 28901 | |13;stanford-crypto-sha256-iterative;65;67;63;64;63;66;63;64;63;62 10:55:51 INFO - PROCESS | 28901 | __end_tp_report 10:55:51 INFO - PROCESS | 28901 | __start_cc_report 10:55:51 INFO - PROCESS | 28901 | _x_x_mozilla_cycle_collect,1675 10:55:51 INFO - PROCESS | 28901 | __end_cc_report 10:55:51 INFO - PROCESS | 28901 | __startTimestamp1471629351773__endTimestamp 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | ------- Summary: start ------- 10:55:51 INFO - PROCESS | 28901 | Number of tests: 14 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:1.88 10:55:51 INFO - PROCESS | 28901 | Values: 104.0 112.0 113.0 112.0 108.0 114.0 113.0 114.0 114.0 112.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:135.00 stddev:21.63 (16.0%) stddev-sans-first:22.48 10:55:51 INFO - PROCESS | 28901 | Values: 147.0 117.0 126.0 182.0 117.0 121.0 144.0 122.0 154.0 117.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 10:55:51 INFO - PROCESS | 28901 | Values: 160.0 161.0 160.0 160.0 160.0 162.0 160.0 160.0 160.0 161.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:15.31 (20.4%) stddev-sans-first:16.00 10:55:51 INFO - PROCESS | 28901 | Values: 75.0 77.0 77.0 117.0 75.0 75.0 75.0 74.0 105.0 75.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:85.00 stddev:22.53 (26.5%) stddev-sans-first:23.34 10:55:51 INFO - PROCESS | 28901 | Values: 85.0 84.0 136.0 84.0 85.0 86.0 122.0 85.0 86.0 135.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:55:51 INFO - PROCESS | 28901 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 119.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:55:51 INFO - PROCESS | 28901 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 148.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:55:51 INFO - PROCESS | 28901 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:3.60 (6.9%) stddev-sans-first:3.81 10:55:51 INFO - PROCESS | 28901 | Values: 51.0 49.0 52.0 61.0 52.0 54.0 49.0 49.0 52.0 50.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 10:55:51 INFO - PROCESS | 28901 | Values: 62.0 63.0 62.0 62.0 62.0 61.0 63.0 62.0 62.0 63.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.00 stddev:3.50 (4.5%) stddev-sans-first:3.49 10:55:51 INFO - PROCESS | 28901 | Values: 83.0 78.0 78.0 77.0 88.0 81.0 77.0 78.0 78.0 78.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:123.00 stddev:6.90 (5.6%) stddev-sans-first:7.03 10:55:51 INFO - PROCESS | 28901 | Values: 131.0 123.0 120.0 122.0 123.0 121.0 121.0 121.0 141.0 132.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:160.50 stddev:2.08 (1.3%) stddev-sans-first:2.18 10:55:51 INFO - PROCESS | 28901 | Values: 160.0 161.0 160.0 162.0 160.0 160.0 159.0 166.0 159.0 162.0 10:55:51 INFO - PROCESS | 28901 | 10:55:51 INFO - PROCESS | 28901 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 10:55:51 INFO - PROCESS | 28901 | Values: 65.0 67.0 63.0 64.0 63.0 66.0 63.0 64.0 63.0 62.0 10:55:51 INFO - PROCESS | 28901 | -------- Summary: end -------- 10:55:51 INFO - PROCESS | 28901 | 10:55:52 INFO - TEST-INFO | 28901: exit 0 10:55:52 INFO - TEST-OK | kraken | took 61137ms 10:55:52 INFO - SUITE-END | took 1176s 10:55:52 INFO - Completed test suite (00:19:36) 10:55:52 INFO - javascript benchmark 10:55:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.5594088857115, 3059.7093276138785, 3082.445159871223, 3091.2580980564658, 3095.938081238375, 5168.612354073441, 5224.5297923187, 5307.601929855262, 5374.9193762093555, 5398.514133727964, 5268.683878967255, 5306.151015837467, 5309.893802123965, 5341.0, 5371.81198658047, 4789.712617242959, 4834.782434790425, 4872.0, 4879.39007624047, 5038.924416133761, 4948.257761335811, 4964.329815474901, 4991.0, 5003.274525193845, 5013.398392192924, 4714.057188562301, 4784.593309568656, 4817.205161148407, 4818.734969576672, 4920.335754673127, 4826.662133650646, 4827.396575428072, 4846.224604063368, 4910.533499317559, 4921.163402221595, 4833.516648335173, 4853.126437241295, 4861.538153875376, 4888.388951381077, 4915.5084491550915, 5117.616178786606, 5284.048871203182, 5365.490278423583, 5380.461953804627, 5388.110961691316, 5685.744141513601, 5739.368669446358, 5778.768849246025, 5782.3350314713925, 5788.88422231553, 5803.7098145093, 5810.128480727883, 5820.185174075633, 5824.24284842972, 5825.825225243249, 5110.872228194325, 5306.893862122774, 5355.116405793001, 5373.731313434313, 5435.565154787608, 5951.821445356646, 5957.523398128139, 5962.284525856839, 5964.254468191476, 5971.0744834550715, 5668.433156684381, 5672.14917762339, 5705.857353566111, 5717.542596592262, 5719.399463056402, 5461.344638643309, 5614.550835933115, 5696.0031994400815, 5703.401142879938, 5774.653520788766, 5723.942760572424, 5724.742386592613, 5731.656100633975, 5736.5123964462655, 5764.452377024176, 5708.372079071299, 5745.712714364265, 5754.251947246915, 5757.913631295534, 5762.9135562966585, 4127.29835927893, 4190.685698572619, 4191.371294305817, 4250.893727656833, 4351.0, 3797.4303854421505, 3837.194189220239, 3839.212961342974, 3857.3442514772555, 3858.054776579756, 5415.702136382458, 5419.0, 5431.2667789847865, 5454.699991500505, 5456.045192091368, 5716.08542633185, 5717.628354156966, 5718.199452076713, 5720.08478643415, 5725.570582206351, 5236.869078272997, 5336.306280183551, 5378.542823859937, 5391.7034563099405, 5417.83746487606, 4941.678790878582, 4993.275974983607, 5013.072581572348, 5022.547970682656, 5025.748712564357, 5890.204822348928, 5934.703264836828, 5954.940450595439, 5956.315023772235, 5968.462838344483, 5474.616776825744, 5723.313202415737, 5744.569157313134, 5753.108268218432, 5762.596618236683, 5963.970180149072, 6045.758169673164, 6085.543584231112, 6086.634801911722, 6088.756449742138, 5707.9429205709075, 5712.228849105318, 5718.971405142947, 5725.656460612377, 5731.713414329183, 5492.5331346835965, 5831.562632802642, 5843.474087332161, 5843.94156058434, 5844.649321040752, 5526.86182845416, 5559.972200139136, 5570.749316280858, 5616.747246373841, 5662.150677398258, 5541.833744987657, 5578.804741834017, 5590.636608620427, 5591.30108736408, 5592.440755924375, 5349.786008559614, 5528.861778455571, 5582.944170558242, 5585.078462053878, 5587.217789509391, 5574.386817449996, 5628.718564071862, 5630.831075067591, 5665.716714164358, 5726.513246373938, 5552.52803511706, 5558.0, 5559.33288005442, 5563.58273129525, 5568.025595520687], "value": 5280.88022484522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8076625096844, 612.9049997250428, 617.2222999021234, 626.799424184261, 637.3626373626373, 42736.57263427369, 43703.78148109259, 43709.34435983463, 43852.12295754087, 47820.0, 46703.065938681204, 47110.528894711046, 47151.76424117883, 47158.76420617892, 47228.52771472284, 8730.738077857643, 8923.0, 8934.195922366986, 8943.418677785956, 8949.731508054769, 8872.37893347466, 8934.195922366986, 8953.77615559613, 8963.462192268486, 8966.596503157374, 8915.153060459246, 9035.638574457047, 9036.50299233542, 9043.59303831329, 9046.185843274105, 8977.95511022444, 9012.729618111467, 9017.188453039193, 9023.323250756219, 9035.45787252767, 8819.779505512413, 8873.11268873114, 8887.0, 8888.244499217575, 8889.688860889837, 42579.14841703149, 42778.35832462516, 42964.785176074234, 43005.0, 43020.78489607532, 3479.3389256041273, 3653.5433070866143, 3673.8530458781615, 3783.5981022268497, 4111.444954931106, 32247.51628725571, 32745.83627081873, 32908.341833163446, 33047.834760826045, 34242.0, 4350.8912277193, 4407.184670835905, 4419.801108950105, 4422.204003279408, 4544.272916333404, 342531.0, 343602.0, 344552.0, 344575.0, 346071.0, 58211.70894145502, 58475.70762146162, 58536.4146358531, 58690.30477561785, 58726.0, 53486.465135348924, 59441.702791486634, 63428.68285658635, 64321.67839160868, 64712.0, 17203.741943870853, 17411.216495257744, 17424.303027878745, 17429.738553921703, 17431.65136697259, 13378.331083445788, 13481.325933703276, 13528.458861645424, 13536.187828730112, 13537.39081741324, 14608.342624581706, 16014.599635009217, 16372.836271637369, 16382.39587290794, 17092.0, 6506.934930650633, 6529.804105876831, 6530.542861999709, 6592.71442068792, 6666.166729158856, 955.4076472587041, 970.9757256068655, 1015.5988384588046, 1050.7496079665175, 1104.5305745058317, 31000.0699979001, 32675.34649307048, 33160.336793264, 33394.49908251378, 33727.494087588704, 1132.943352832355, 1157.7568710570874, 1158.212415557429, 1221.0292817210338, 1225.0100430985328, 17199.91400042992, 17539.0, 17569.465618330185, 17664.646707065785, 17673.591512360315, 510669.0, 535952.0, 538041.0, 538774.0, 540159.0, 59582.70208648929, 59597.0, 59807.401925980186, 60320.0, 60333.39666603366, 1342.214804339453, 1370.1915869636962, 1381.6683995840926, 1407.4862675123507, 1429.9642508937359, 30701.232469187555, 32637.18407039843, 32994.17514562059, 33278.0, 33794.66205337915, 53696.0, 54232.0, 54235.45764542304, 54283.45716542942, 54286.18570721521, 443123.0, 443837.0, 443865.0, 447177.0, 447466.0, 36473.0, 38332.233355333294, 38347.84956451311, 43871.34192987044, 44448.555514444444, 49422.752886236776, 49441.75279123581, 49444.50555494543, 49982.50017499778, 50060.99878002492, 40939.59060409358, 41365.37951930783, 42032.369514456695, 42185.156296873276, 43589.34615980699, 42228.36657450202, 42643.0, 42937.0, 43231.78384108059, 43730.562694372646, 41811.163776724905, 42425.0, 43089.138217236105, 43181.7840910806, 43211.783941081354, 33970.49044264387, 36260.81869590741, 36355.272894541435, 37041.62958370382, 37605.435918460695, 27606.309842254104, 28028.43943121167, 28030.579541306488, 28071.0, 28112.859435702692], "value": 20602.80947132721, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.62605524751496, 398.96808255339573, 405.4830091633168, 408.8752930356241, 423.3755211063681, 13246.536371227008, 18369.448916532492, 19967.60064798705, 20019.499512512193, 20344.491387715316, 15165.620859478518, 15593.688126237497, 17814.46556603304, 18571.535711607215, 18618.53453663659, 5550.222968784374, 5740.741666624991, 5745.798897038583, 5749.396313387097, 5765.106408506688, 5506.669599824003, 5624.606277560552, 5678.630888992202, 5698.145278208261, 5705.0, 5630.268065151525, 5655.886882262353, 5670.829875103754, 5681.545476361881, 5688.089905615102, 5457.617966742329, 5620.1288800236025, 5672.943270567303, 5679.148127780824, 5679.801206957736, 5073.822416215415, 5075.0, 5083.0, 5083.262926875583, 5084.44071152173, 21135.365939021853, 21901.342959711234, 22061.558768824692, 22803.657945130835, 23210.65184022241, 2203.5923354179367, 2219.345293138512, 2375.91684291049, 2460.360306320352, 2792.539231026878, 10307.536160872703, 10556.736081597945, 10562.471876406149, 10672.679819605424, 12721.10952233344, 1829.7072468404992, 1866.766654168229, 1895.7110900586724, 1912.7704675439036, 1931.4978105692621, 78898.0, 81232.59383703103, 82173.9999999994, 83156.58421707853, 83882.58058709728, 9404.623815047458, 9931.404115752934, 9936.900630993741, 9991.450470224207, 10171.64399246023, 13260.541340452542, 13314.0, 13390.330483475787, 13412.664683382798, 13415.597532074053, 7744.457887947902, 7769.378449724121, 7886.960565197137, 8064.112947575762, 8084.151164127799, 7718.305352518188, 7954.323882470055, 7961.0, 8210.384221183316, 8216.671333146727, 4113.71204015716, 4328.805203765838, 4639.721616703008, 4874.731889746098, 4876.244182151772, 1909.4558050955688, 2008.2268326694327, 2038.1643526154205, 2061.3403710812395, 2069.193014724259, 915.208344781759, 954.6229239450518, 973.4084771398814, 1012.6354512375539, 1043.5043354406748, 19276.22895084209, 19469.610607787767, 19599.412017639494, 19689.212431502867, 20012.199512019648, 942.9292803039663, 959.3859929645033, 997.3467378866853, 1004.4023805835516, 1008.7377281906757, 10259.998600545792, 10789.46052697362, 10910.5090270938, 10948.835767463494, 11004.889951100547, 483835.0, 502812.0, 510843.0, 512353.0, 514301.0, 93954.0, 93954.0, 94961.0, 99634.0, 99869.0, 1001.8060447619689, 1046.042870773234, 1055.9894401055892, 1060.5969731502134, 1067.4289255248405, 17138.742918855976, 17472.650546989244, 17544.73682894732, 18164.45506634803, 18365.26538938481, 42044.36933445939, 42859.357109642755, 43871.56128438802, 43935.34096988484, 44025.0, 54078.0, 59361.40638593559, 60030.69984650049, 60553.39446605478, 60938.69530652319, 7531.585762783099, 7595.5442673439775, 7906.327962123284, 8491.108433614381, 8627.266682332072, 9873.23621082838, 11053.944730276296, 12622.116451848282, 12635.305058221886, 13755.518556850462, 11721.413929303671, 11831.704207394883, 11997.100217483548, 12066.3363515004, 12521.686957826127, 7109.60897150641, 11664.88335116672, 11967.880321196677, 12092.516299347928, 12203.20679155852, 11938.403079845799, 12307.384630768605, 12359.073069519642, 12377.257364558156, 12535.749285014432, 8623.0, 8720.91279087201, 8739.0, 8861.379703420698, 9149.496777677292, 10996.505157267782, 11008.504617292081, 11722.0, 11867.228630139014, 12312.630621081382], "value": 9113.776415989181, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.0, 1502.601810520212, 1512.8865335099867, 1645.6132808789932, 1760.5334586334623, 8430.36772242082, 8994.235489983343, 9003.369764116505, 9327.90672093279, 9353.812923741538, 9146.679866204684, 9258.166764991167, 9279.304052196096, 9297.0, 9300.581473833678, 2264.7055882735262, 2291.140822191678, 2294.300238427279, 2295.1278514164596, 2296.873671948042, 2342.4612339161918, 2382.0709923129907, 2384.940376490584, 2388.0805889732405, 2393.760623937601, 2370.431096536827, 2380.666706661069, 2384.3919800450863, 2425.841001508659, 2429.757024297574, 2288.965665515002, 2304.101400453824, 2325.03511042917, 2328.9534209315802, 2329.0567320235245, 2277.0664027748544, 2277.225743247304, 2282.8744419056943, 2285.074544809355, 2289.3933107726466, 9063.773405664846, 9238.953805230998, 9296.581653825595, 9326.72019839406, 9359.438433694, 5205.973970130125, 5447.0, 5467.425920278393, 5474.288342515487, 5482.424345443751, 3559.8220088995704, 3590.1922067534856, 3622.5290712207507, 3644.6173151818944, 3655.4334078217653, 1222.8104643780227, 1239.4980033086615, 1248.756492483966, 1282.5190553542423, 1298.9220646761225, 12964.22214667123, 13052.673683157902, 13057.477700892048, 13063.085584009123, 13068.150570212905, 4373.431453910971, 4588.770561471913, 4667.603253723403, 4678.60231880294, 4697.084068606658, 10217.386956782617, 10220.744481388025, 10226.13077888373, 10228.0, 10234.744131396774, 5200.141976573898, 5262.289590905179, 5267.762950667229, 5268.0, 5271.6309858310315, 4155.563665815106, 4776.761161941889, 4795.328653988445, 4936.975315123402, 4976.850694479172, 3859.96140038596, 3917.725759196886, 3973.2848087343978, 4006.6994975376965, 4027.8993025174605, 1173.7945859474557, 1174.8296497008057, 1189.084405008139, 1195.8056965468463, 1196.7127889306678, 821.6549049399266, 919.3380765848578, 1008.1632245236436, 1009.9293049486465, 1043.4678314059731, 5884.382139875337, 6050.42520960508, 6246.812595622138, 6292.370762923671, 6298.559100862895, 905.1310741688053, 920.093707697917, 956.2636769687302, 960.6877764726491, 973.6105557776946, 4205.217805662582, 4274.358846173099, 4351.97824010878, 4361.672874534423, 4552.385427967249, 10954.452277386099, 11070.501827417786, 11159.665210043711, 11160.553577856957, 11199.832002519968, 10856.294340867818, 10969.0, 11125.554977800797, 11130.276532025393, 11156.832647510293, 8528.701495447629, 8564.528950907636, 8666.78333041679, 8681.479111253218, 8684.6526138955, 6077.179580756541, 6085.878282434238, 6160.3223645398075, 6227.50179985591, 6254.405831446005, 10331.276810623183, 10529.57881684724, 10664.520096595517, 10708.518116684612, 10746.408947507962, 10754.623588174376, 10770.676879693621, 10877.945610271898, 10918.0, 11026.228164028442, 6757.662116894234, 7791.415643826623, 7794.0, 8159.34725221969, 8510.446820956618, 8768.34237432208, 9094.045125262017, 9095.363324567217, 9095.408798428081, 9097.727068187965, 7669.501482403626, 7681.078270607562, 7744.5740484271655, 7965.681372745257, 7969.0, 7865.960670196612, 7931.643076061707, 7935.365170786208, 7953.363730901629, 8013.19868013194, 6960.443164546926, 7084.964575177091, 7105.857882842418, 7109.3601575856355, 7112.679929403086, 5076.593872490266, 5141.177411614124, 5301.0, 5333.3066701330135, 5559.527440167631, 5371.543418809289, 5437.564994800327, 5478.424765399575, 5528.456909821366, 5534.501894829485], "value": 4754.203087690359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1059851274277, 334.7924286942096, 343.37334364784266, 345.90487615905636, 348.1800360151842, 5182.196759502279, 5207.760662914945, 5234.607404444668, 5253.737313134342, 5267.683938963665, 4870.537298956593, 5017.49825017499, 5045.268436076767, 5049.2678561608545, 5197.168453047513, 3980.681545476355, 4049.898752531188, 4077.245709543744, 4085.3259212229946, 4180.28935081037, 4133.106825222341, 4136.482939632546, 4143.316352801784, 4149.958500415002, 4178.101708132751, 3955.3671412573995, 4141.109661422794, 4142.5857414258635, 4144.274751918402, 4167.708260421772, 4139.7166878267535, 4150.418941348214, 4155.646770024551, 4156.43888075112, 4168.791560421982, 3724.417122722832, 3724.4413337999245, 3726.329260733094, 3743.3636281832155, 3755.9812200939095, 4979.30289759434, 5039.395272567279, 5073.873153171164, 5116.437191908924, 5156.381234251914, 4675.438947326308, 4712.1858084637315, 4722.6221902247735, 4723.102610504027, 4741.596964258042, 5369.275147855029, 5425.13197888336, 5461.808836690697, 5464.961657285103, 5506.587005974568, 3864.8840534784003, 4044.130511939947, 4064.329385651364, 4074.5110586729484, 4085.673146148301, 5628.859278518029, 5651.5415794129685, 5656.123300888369, 5656.179853921159, 5682.261306030231, 4164.500259968762, 4171.666266698657, 4175.436316097288, 4178.1643671265265, 4193.014641559231, 4111.149982507884, 4230.513490948519, 4248.553901840262, 4259.23333799919, 4259.7231179973205, 4672.789724462339, 4699.224627936353, 4720.905581888343, 4730.455997560256, 4753.049390121921, 5531.834044978657, 5534.335879694462, 5535.418781028015, 5536.972315138399, 5554.500094991389, 1343.1250841322853, 1459.963425967575, 1468.941242350294, 1469.8236211654455, 1475.2328789029646, 969.3650658818485, 970.1947383671536, 991.4101109839634, 1000.9299349045497, 1013.8479228115694, 5107.974460127675, 5154.690718556899, 5193.558547523503, 5194.6104042196985, 5196.168613021899, 5417.36152025642, 5505.532029777513, 5512.366077901012, 5524.640898341595, 5525.889482210414, 5119.846404607868, 5128.384593848762, 5131.973605278959, 5143.97428012865, 5169.586433085344, 2900.752676349148, 2900.941981160407, 2914.941701166007, 2920.167752190658, 2921.4303210873677, 5456.809011684572, 5661.46216109469, 5662.462066103713, 5671.858203544862, 5758.222639943638, 5635.971820140873, 5649.971750141223, 5667.716614169275, 5701.429857014348, 5702.714864256771, 5740.42595740431, 5750.88498230033, 5767.923547522804, 5782.855428614234, 5789.797357092481, 5454.263674403905, 5531.225628411945, 5560.2493663356545, 5572.832815015556, 5573.442655734556, 5496.862578435571, 5509.669419834662, 5511.669299842022, 5512.9877594678455, 5528.253685752533, 5617.7191140442, 5749.511291540266, 5754.597178197486, 5778.36437991829, 5812.680302583399, 3937.680876906154, 3975.74763949355, 3992.2813893498287, 3993.940090898581, 3997.3004724173734, 5531.487505433998, 5620.522255608155, 5632.971835140798, 5639.943600563942, 5652.971735141298, 5407.161889907071, 5408.859869014294, 5440.727963601883, 5527.668339899619, 5551.722413879209, 5387.218853266176, 5392.514673679388, 5399.487048730364, 5414.756335964812, 5428.728563571726, 5227.58179345659, 5247.16045432729, 5369.677819330853, 5409.242706021081, 5436.700981445901, 5410.0, 5434.945650543444, 5450.8909821802545, 5458.153986132156, 5461.563074954073, 5322.8935421292135, 5327.9733601331745, 5344.225087362233, 5370.624056316176, 5391.379991301051], "value": 4197.285382377828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.5257950883152, 743.1787874398789, 767.6737386610689, 772.3396495995923, 825.5088222507608, 14317.498887538939, 16078.035317880935, 16143.43497977571, 16165.838341616565, 16183.757243641356, 15276.236188190602, 15679.372825087012, 15749.60625984351, 15759.369625214978, 15763.84236157638, 655.632845606462, 788.5071830106184, 797.9202079792033, 816.828466022136, 819.0253598218102, 811.5698679699739, 813.7599408174602, 819.315871247506, 819.9959000204991, 820.6143112737004, 864.7059999600135, 867.4318321499428, 867.5402036920442, 867.9088695686956, 868.3921255121409, 689.9827504312382, 705.1573369823063, 861.2378045429778, 863.1023735315296, 863.5336918064206, 524.897644959233, 610.66108309888, 629.1914889367141, 631.3654776949182, 632.6552029144082, 13049.608511744664, 13087.0, 13103.737925241441, 13114.0, 13145.014123940742, 13361.331933403388, 13859.792103118461, 14221.146731196059, 14246.786298205536, 14252.786208206886, 12977.480900763958, 13037.478500859954, 13287.20276783396, 13599.796003059962, 13695.589132326046, 4396.604305612478, 4602.6809225235465, 4618.584327410549, 4626.421697287839, 4718.056388722235, 76125.61937190278, 77609.61195194045, 78052.21947780506, 85959.57020214859, 86661.56669216613, 11135.944320278346, 11233.438328083563, 11410.372429516456, 11422.600208992646, 11668.416579171007, 21025.894870525855, 21164.682529762067, 21236.681449778265, 21292.0, 21380.251691191046, 8145.226203510657, 8237.546934918517, 8399.11809260031, 8463.06906240313, 8506.276966457921, 4645.74448405341, 4720.12677654635, 4737.6683632146105, 4912.312276281324, 4913.410390753133, 3363.4786608075788, 3487.877924272638, 3492.1269682579355, 3502.1069627244888, 3504.176518518146, 627.0374974414252, 630.7382436288889, 637.4549759955264, 640.2573015302227, 649.6686689788243, 556.9164625306155, 587.2483221476517, 620.7299824576323, 651.0754728285846, 673.1955313400538, 8995.0, 9028.322875784343, 9216.986131525528, 9319.207867331217, 9488.0, 542.3112646938366, 593.3473179502599, 617.4227097663698, 642.081822993115, 679.9592024478449, 4064.7357921734992, 4268.0823622921225, 4444.866654000385, 4482.618977386894, 4482.8655140345845, 75070.62464687641, 75279.24720752831, 75551.0, 87596.12403876007, 108239.0, 90235.0, 108336.0, 111175.44412277886, 112036.43981780039, 112374.0, 59002.40997590055, 75037.62481187668, 76032.9999999989, 76588.23411765811, 93737.0, 9652.372595781251, 9667.17828984516, 10154.898451015395, 10176.236782241509, 10185.08334249921, 54534.727326363114, 54797.726011371284, 56211.437885622254, 57804.42195578159, 58425.65189569818, 81318.0, 82319.17680823115, 82378.0, 82879.0, 85876.0, 13827.355222569518, 14283.785743213652, 14404.351804168627, 14480.855191448372, 14810.925945370203, 15486.05426557804, 15574.766378504104, 15939.282732277306, 15976.760348594547, 16390.098544579687, 14196.645083872985, 14752.409903603735, 14872.925635371754, 14948.103113813206, 15500.92249538745, 14783.113013219241, 14827.110373377633, 15518.534443966699, 15631.140287284308, 16300.266488008305, 13544.119632223874, 14074.929625351808, 14240.365532376543, 15301.846981530041, 15326.540203793904, 10646.8402973957, 11532.365719885487, 12073.818892716441, 12116.697082572653, 12144.817827732415, 10401.84397234027, 12008.519659213884, 12032.0, 12177.817332740193, 12314.0], "value": 7592.596909796899, "unit": "score"}], "name": "dromaeo_css", "value": 7291.253820815302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 108.0, 114.0, 113.0, 114.0, 114.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 126.0, 182.0, 117.0, 121.0, 144.0, 122.0, 154.0, 117.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 117.0, 75.0, 75.0, 75.0, 74.0, 105.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 136.0, 84.0, 85.0, 86.0, 122.0, 85.0, 86.0, 135.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 52.0, 61.0, 52.0, 54.0, 49.0, 49.0, 52.0, 50.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 78.0, 77.0, 88.0, 81.0, 77.0, 78.0, 78.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 123.0, 120.0, 122.0, 123.0, 121.0, 121.0, 121.0, 141.0, 132.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 159.0, 166.0, 159.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 63.0, 64.0, 63.0, 66.0, 63.0, 64.0, 63.0, 62.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1490.7, "alertThreshold": 2.0}]} 10:55:53 INFO - Return code: 0 10:55:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:53 INFO - # TBPL SUCCESS # 10:55:53 INFO - Running post-action listener: _resource_record_post_action 10:55:53 INFO - [mozharness: 2016-08-19 17:55:53.081567Z] Finished run-tests step (success) 10:55:53 INFO - Running post-run listener: _resource_record_post_run 10:55:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419115008; Read time: 12; Write time: 236904 10:55:53 INFO - TinderboxPrint: CPU usage
12.9% 10:55:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:55:53 INFO - TinderboxPrint: I/O write bytes / time
419,115,008 / 236,904 10:55:53 INFO - TinderboxPrint: CPU idle
8,296.4 (87.1%) 10:55:53 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 10:55:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:55:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118247424; Read time: 0; Write time: 73364 10:55:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289562624; Read time: 0; Write time: 162344 10:55:53 INFO - Running post-run listener: _upload_blobber_files 10:55:53 INFO - Blob upload gear active. 10:55:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:53 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 10:55:53 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'] 10:55:53 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 10:55:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:58 INFO - (blobuploader) - INFO - Done attempting. 10:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:59 INFO - (blobuploader) - INFO - Done attempting. 10:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:56:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:00 INFO - (blobuploader) - INFO - Done attempting. 10:56:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:56:00 INFO - Return code: 0 10:56:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:56:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:56:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bff04242391abf473dbd4b79b11c3b9675710a49cc0ebd2e8c1316e868862923e8f4cd7e27df9931a0ca2d5c0c83cb8261902dc8a0b1fee27be0fcbb7ddf2a0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/216ac8c51d7a92185d530506068e3ebf66f0efa7c52bd4210dfc35b1a982ca6543e7a1c80a219edb9068c65fcccba0cee1ef71aa57e060314e185d500af0bc6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030216394cc59bfdb9ed28ac4e569ac3f355d065a9f215a8654cb0a831707fe83b347afe9a26213301a2a9b13d5814eadd53da3099aa97ca3eb32581156fad88"} 10:56:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:56:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:56:00 INFO - Contents: 10:56:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bff04242391abf473dbd4b79b11c3b9675710a49cc0ebd2e8c1316e868862923e8f4cd7e27df9931a0ca2d5c0c83cb8261902dc8a0b1fee27be0fcbb7ddf2a0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/216ac8c51d7a92185d530506068e3ebf66f0efa7c52bd4210dfc35b1a982ca6543e7a1c80a219edb9068c65fcccba0cee1ef71aa57e060314e185d500af0bc6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030216394cc59bfdb9ed28ac4e569ac3f355d065a9f215a8654cb0a831707fe83b347afe9a26213301a2a9b13d5814eadd53da3099aa97ca3eb32581156fad88"} 10:56:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:56:00 INFO - Copying logs to upload dir... 10:56:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:56:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.233154 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-19 10:55:59.749582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:55:59.753160) ========= 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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 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/bff04242391abf473dbd4b79b11c3b9675710a49cc0ebd2e8c1316e868862923e8f4cd7e27df9931a0ca2d5c0c83cb8261902dc8a0b1fee27be0fcbb7ddf2a0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/216ac8c51d7a92185d530506068e3ebf66f0efa7c52bd4210dfc35b1a982ca6543e7a1c80a219edb9068c65fcccba0cee1ef71aa57e060314e185d500af0bc6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030216394cc59bfdb9ed28ac4e569ac3f355d065a9f215a8654cb0a831707fe83b347afe9a26213301a2a9b13d5814eadd53da3099aa97ca3eb32581156fad88"} build_url:https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/QVrWDpp5SLO3Qw-UwVhPqw/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/bff04242391abf473dbd4b79b11c3b9675710a49cc0ebd2e8c1316e868862923e8f4cd7e27df9931a0ca2d5c0c83cb8261902dc8a0b1fee27be0fcbb7ddf2a0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/216ac8c51d7a92185d530506068e3ebf66f0efa7c52bd4210dfc35b1a982ca6543e7a1c80a219edb9068c65fcccba0cee1ef71aa57e060314e185d500af0bc6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030216394cc59bfdb9ed28ac4e569ac3f355d065a9f215a8654cb0a831707fe83b347afe9a26213301a2a9b13d5814eadd53da3099aa97ca3eb32581156fad88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 10:55:59.778433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:55:59.778786) ========= 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=d2a8c569965ab8367867b893000001a1-1471627252.494399-2031106750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 10:55:59.864583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:55:59.864917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 10:55:59.865214) ========= ========= Total master_lag: 0.20 =========