builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1470755929.67 results: success (0) buildid: 20160809053001 builduid: fc41c04d306a491b862d8003a5ffc71a revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.671663) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.672196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.672538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.687496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.687881) ========= 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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 08:18:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-08-09 08:18:51 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.818628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.818987) ========= 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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.869764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:49.870157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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 a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 08:18:51,651 truncating revision to first 12 chars 2016-08-09 08:18:51,651 Setting DEBUG logging. 2016-08-09 08:18:51,651 attempt 1/10 2016-08-09 08:18:51,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3fb4eb11fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 08:18:52,022 unpacking tar archive at: fx-team-a3fb4eb11fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:50.602088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:50.602809) ========= script_repo_revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:50.603564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:50.604218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:18:50.616291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-09 08:18:50.617009) ========= /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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:52 INFO - MultiFileLogger online at 20160809 08:18:52 in /builds/slave/test 08:18:52 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 08:18:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:52 INFO - {'append_to_log': False, 08:18:52 INFO - 'base_work_dir': '/builds/slave/test', 08:18:52 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:52 INFO - 'branch': 'Fx-Team', 08:18:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:52 INFO - 'config_files': ('talos/linux_config.py',), 08:18:52 INFO - 'default_actions': ('clobber', 08:18:52 INFO - 'read-buildbot-config', 08:18:52 INFO - 'download-and-extract', 08:18:52 INFO - 'populate-webroot', 08:18:52 INFO - 'create-virtualenv', 08:18:52 INFO - 'install', 08:18:52 INFO - 'run-tests'), 08:18:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:52 INFO - 'download_minidump_stackwalk': True, 08:18:52 INFO - 'download_symbols': 'ondemand', 08:18:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:52 INFO - 'installer_path': 'installer.exe', 08:18:52 INFO - 'log_level': 'info', 08:18:52 INFO - 'log_name': 'talos', 08:18:52 INFO - 'log_to_console': True, 08:18:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:52 INFO - 'opt_config_files': (), 08:18:52 INFO - 'pip_index': False, 08:18:52 INFO - 'sps_profile': False, 08:18:52 INFO - 'sps_profile_interval': 0, 08:18:52 INFO - 'suite': 'dromaeojs', 08:18:52 INFO - 'system_bits': '32', 08:18:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:52 INFO - 'title': 'talos-linux64-ix-050', 08:18:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:52 INFO - 'use_talos_json': True, 08:18:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:52 INFO - 'work_dir': 'build'} 08:18:52 INFO - [mozharness: 2016-08-09 15:18:52.487080Z] Running clobber step. 08:18:52 INFO - Running pre-action listener: _resource_record_pre_action 08:18:52 INFO - Running main action method: clobber 08:18:52 INFO - rmtree: /builds/slave/test/build 08:18:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:52 INFO - Running post-action listener: _resource_record_post_action 08:18:52 INFO - [mozharness: 2016-08-09 15:18:52.973518Z] Finished clobber step (success) 08:18:52 INFO - [mozharness: 2016-08-09 15:18:52.973619Z] Running read-buildbot-config step. 08:18:52 INFO - Running pre-action listener: _resource_record_pre_action 08:18:52 INFO - Running main action method: read_buildbot_config 08:18:52 INFO - Using buildbot properties: 08:18:52 INFO - { 08:18:52 INFO - "project": "", 08:18:52 INFO - "product": "firefox", 08:18:52 INFO - "script_repo_revision": "production", 08:18:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:18:52 INFO - "repository": "", 08:18:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:18:52 INFO - "buildid": "20160809053001", 08:18:52 INFO - "pgo_build": "True", 08:18:52 INFO - "basedir": "/builds/slave/test", 08:18:52 INFO - "buildnumber": 1445, 08:18:52 INFO - "slavename": "talos-linux64-ix-050", 08:18:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:18:52 INFO - "platform": "ubuntu64_hw", 08:18:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:18:52 INFO - "branch": "fx-team", 08:18:52 INFO - "repo_path": "integration/fx-team", 08:18:52 INFO - "revision": "a3fb4eb11fcf840b9e0d65a06be6cf64584add08", 08:18:52 INFO - "stage_platform": "linux64-pgo", 08:18:52 INFO - "builduid": "fc41c04d306a491b862d8003a5ffc71a", 08:18:52 INFO - "slavebuilddir": "test" 08:18:52 INFO - } 08:18:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:18:52 INFO - Running post-action listener: _resource_record_post_action 08:18:52 INFO - [mozharness: 2016-08-09 15:18:52.976100Z] Finished read-buildbot-config step (success) 08:18:52 INFO - [mozharness: 2016-08-09 15:18:52.976191Z] Running download-and-extract step. 08:18:52 INFO - Running pre-action listener: _resource_record_pre_action 08:18:52 INFO - Running main action method: download_and_extract 08:18:52 INFO - mkdir: /builds/slave/test/build/tests 08:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:52 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:53 INFO - Downloaded 1361 bytes. 08:18:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:18:53 INFO - Using the following test package requirements: 08:18:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:18:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'jsshell-linux-x86_64.zip'], 08:18:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:53 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')]} 08:18:53 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:18:53 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:54 INFO - Downloaded 21829645 bytes. 08:18:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:18:55 INFO - Return code: 0 08:18:55 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 08:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:55 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:18:55 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:56 INFO - Downloaded 21829645 bytes. 08:18:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:18:57 INFO - Return code: 0 08:18:57 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')]} 08:18:57 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:58 INFO - Downloaded 14413723 bytes. 08:18:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:18:58 INFO - Return code: 0 08:18: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')]} 08:18:58 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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 08:18:59 INFO - Downloaded 59951927 bytes. 08:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:18:59 INFO - mkdir: /builds/slave/test/properties 08:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:59 INFO - Contents: 08:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:19:00 INFO - Running post-action listener: _resource_record_post_action 08:19:00 INFO - Running post-action listener: set_extra_try_arguments 08:19:00 INFO - [mozharness: 2016-08-09 15:19:00.683659Z] Finished download-and-extract step (success) 08:19:00 INFO - [mozharness: 2016-08-09 15:19:00.683892Z] Running populate-webroot step. 08:19:00 INFO - Running pre-action listener: _resource_record_pre_action 08:19:00 INFO - Running main action method: populate_webroot 08:19:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:00 INFO - '--tppagecycles', 08:19:00 INFO - '7'], 08:19:00 INFO - 'tests': ['tsvgm']}}, 08:19:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['damp', 'tps']}, 08:19:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'tests': ['damp', 'tps']}, 08:19:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['dromaeo_dom']}, 08:19:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['basic_compositor_video']}, 08:19:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:19:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['a11yr', 08:19:00 INFO - 'ts_paint', 08:19:00 INFO - 'tpaint', 08:19:00 INFO - 'sessionrestore', 08:19:00 INFO - 'sessionrestore_no_auto_restore', 08:19:00 INFO - 'tabpaint']}, 08:19:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['tsvgx', 08:19:00 INFO - 'tsvgr_opacity', 08:19:00 INFO - 'tart', 08:19:00 INFO - 'tscrollx', 08:19:00 INFO - 'cart']}, 08:19:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:00 INFO - 'tsvgr_opacity', 08:19:00 INFO - 'tart', 08:19:00 INFO - 'tscrollx', 08:19:00 INFO - 'cart']}, 08:19:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'talos_options': ['--disable-e10s'], 08:19:00 INFO - 'tests': ['tp5o']}, 08:19:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'tests': ['tp5o']}, 08:19:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'talos_options': ['--disable-e10s', 08:19:00 INFO - '--xperf_path', 08:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:00 INFO - 'tests': ['tp5n']}, 08:19:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:00 INFO - 'talos_options': ['--xperf_path', 08:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:00 INFO - 'tests': ['tp5n']}}, 08:19:00 INFO - 'talos.zip': {'path': '', 08:19:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:00 INFO - Running post-action listener: _resource_record_post_action 08:19:00 INFO - [mozharness: 2016-08-09 15:19:00.701527Z] Finished populate-webroot step (success) 08:19:00 INFO - [mozharness: 2016-08-09 15:19:00.701617Z] Running create-virtualenv step. 08:19:00 INFO - Running pre-action listener: _resource_record_pre_action 08:19:00 INFO - Running main action method: create_virtualenv 08:19:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:19:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:00 INFO - Using real prefix '/usr' 08:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:03 INFO - Installing pip.................done. 08:19:03 INFO - Return code: 0 08:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:03 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')]} 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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')]} 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:03 INFO - Using env: {'DISPLAY': ':0', 08:19:03 INFO - 'HOME': '/home/cltbld', 08:19:03 INFO - 'LANG': 'en_US.UTF-8', 08:19:03 INFO - 'LANGUAGE': 'en_US:en', 08:19:03 INFO - 'LOGNAME': 'cltbld', 08:19:03 INFO - 'MAIL': '/var/mail/cltbld', 08:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:03 INFO - 'MOZ_NO_REMOTE': '1', 08:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:03 INFO - 'NO_EM_RESTART': '1', 08:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:03 INFO - 'PWD': '/builds/slave/test', 08:19:03 INFO - 'SHELL': '/bin/bash', 08:19:03 INFO - 'SHLVL': '1', 08:19:03 INFO - 'TERM': 'linux', 08:19:03 INFO - 'TMOUT': '86400', 08:19:03 INFO - 'USER': 'cltbld', 08:19:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:03 INFO - '_': '/tools/buildbot/bin/python'} 08:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:19:03 INFO - Cleaning up... 08:19:03 INFO - Return code: 0 08:19:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:03 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')]} 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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')]} 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:03 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 08:19:03 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 08:19:03 INFO - Using env: {'DISPLAY': ':0', 08:19:03 INFO - 'HOME': '/home/cltbld', 08:19:03 INFO - 'LANG': 'en_US.UTF-8', 08:19:03 INFO - 'LANGUAGE': 'en_US:en', 08:19:03 INFO - 'LOGNAME': 'cltbld', 08:19:03 INFO - 'MAIL': '/var/mail/cltbld', 08:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:03 INFO - 'MOZ_NO_REMOTE': '1', 08:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:03 INFO - 'NO_EM_RESTART': '1', 08:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:03 INFO - 'PWD': '/builds/slave/test', 08:19:03 INFO - 'SHELL': '/bin/bash', 08:19:03 INFO - 'SHLVL': '1', 08:19:03 INFO - 'TERM': 'linux', 08:19:03 INFO - 'TMOUT': '86400', 08:19:03 INFO - 'USER': 'cltbld', 08:19:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:03 INFO - '_': '/tools/buildbot/bin/python'} 08:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:03 INFO - Downloading/unpacking psutil>=3.1.1 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:05 INFO - Installing collected packages: psutil 08:19:05 INFO - Running setup.py install for psutil 08:19:05 INFO - building 'psutil._psutil_linux' extension 08:19:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:19:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:19:05 INFO - building 'psutil._psutil_posix' extension 08:19:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:19:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:06 INFO - Successfully installed psutil 08:19:06 INFO - Cleaning up... 08:19:06 INFO - Return code: 0 08:19:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:06 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 08:19:06 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 08:19:06 INFO - Using env: {'DISPLAY': ':0', 08:19:06 INFO - 'HOME': '/home/cltbld', 08:19:06 INFO - 'LANG': 'en_US.UTF-8', 08:19:06 INFO - 'LANGUAGE': 'en_US:en', 08:19:06 INFO - 'LOGNAME': 'cltbld', 08:19:06 INFO - 'MAIL': '/var/mail/cltbld', 08:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:06 INFO - 'MOZ_NO_REMOTE': '1', 08:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:06 INFO - 'NO_EM_RESTART': '1', 08:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:06 INFO - 'PWD': '/builds/slave/test', 08:19:06 INFO - 'SHELL': '/bin/bash', 08:19:06 INFO - 'SHLVL': '1', 08:19:06 INFO - 'TERM': 'linux', 08:19:06 INFO - 'TMOUT': '86400', 08:19:06 INFO - 'USER': 'cltbld', 08:19:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:06 INFO - '_': '/tools/buildbot/bin/python'} 08:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:08 INFO - Installing collected packages: mozsystemmonitor 08:19:08 INFO - Running setup.py install for mozsystemmonitor 08:19:08 INFO - Successfully installed mozsystemmonitor 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:08 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 08:19:08 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 08:19:08 INFO - Using env: {'DISPLAY': ':0', 08:19:08 INFO - 'HOME': '/home/cltbld', 08:19:08 INFO - 'LANG': 'en_US.UTF-8', 08:19:08 INFO - 'LANGUAGE': 'en_US:en', 08:19:08 INFO - 'LOGNAME': 'cltbld', 08:19:08 INFO - 'MAIL': '/var/mail/cltbld', 08:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:08 INFO - 'MOZ_NO_REMOTE': '1', 08:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:08 INFO - 'NO_EM_RESTART': '1', 08:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:08 INFO - 'PWD': '/builds/slave/test', 08:19:08 INFO - 'SHELL': '/bin/bash', 08:19:08 INFO - 'SHLVL': '1', 08:19:08 INFO - 'TERM': 'linux', 08:19:08 INFO - 'TMOUT': '86400', 08:19:08 INFO - 'USER': 'cltbld', 08:19:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:08 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:10 INFO - warning: no files found matching '*.txt' 08:19:10 INFO - no previously-included directories found matching 'build' 08:19:10 INFO - no previously-included directories found matching 'dist' 08:19:10 INFO - no previously-included directories found matching '.git*' 08:19:10 INFO - Installing collected packages: jsonschema, functools32 08:19:10 INFO - Running setup.py install for functools32 08:19:11 INFO - warning: no files found matching '*.txt' 08:19:11 INFO - no previously-included directories found matching 'build' 08:19:11 INFO - no previously-included directories found matching 'dist' 08:19:11 INFO - no previously-included directories found matching '.git*' 08:19:11 INFO - Successfully installed jsonschema functools32 08:19:11 INFO - Cleaning up... 08:19:11 INFO - Return code: 0 08:19:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:11 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:11 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 08:19:11 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 08:19:11 INFO - Using env: {'DISPLAY': ':0', 08:19:11 INFO - 'HOME': '/home/cltbld', 08:19:11 INFO - 'LANG': 'en_US.UTF-8', 08:19:11 INFO - 'LANGUAGE': 'en_US:en', 08:19:11 INFO - 'LOGNAME': 'cltbld', 08:19:11 INFO - 'MAIL': '/var/mail/cltbld', 08:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:11 INFO - 'MOZ_NO_REMOTE': '1', 08:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:11 INFO - 'NO_EM_RESTART': '1', 08:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:11 INFO - 'PWD': '/builds/slave/test', 08:19:11 INFO - 'SHELL': '/bin/bash', 08:19:11 INFO - 'SHLVL': '1', 08:19:11 INFO - 'TERM': 'linux', 08:19:11 INFO - 'TMOUT': '86400', 08:19:11 INFO - 'USER': 'cltbld', 08:19:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:11 INFO - '_': '/tools/buildbot/bin/python'} 08:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:19:11 INFO - Cleaning up... 08:19:11 INFO - Return code: 0 08:19:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:11 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:19:11 INFO - Using env: {'DISPLAY': ':0', 08:19:11 INFO - 'HOME': '/home/cltbld', 08:19:11 INFO - 'LANG': 'en_US.UTF-8', 08:19:11 INFO - 'LANGUAGE': 'en_US:en', 08:19:11 INFO - 'LOGNAME': 'cltbld', 08:19:11 INFO - 'MAIL': '/var/mail/cltbld', 08:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:11 INFO - 'MOZ_NO_REMOTE': '1', 08:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:11 INFO - 'NO_EM_RESTART': '1', 08:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:11 INFO - 'PWD': '/builds/slave/test', 08:19:11 INFO - 'SHELL': '/bin/bash', 08:19:11 INFO - 'SHLVL': '1', 08:19:11 INFO - 'TERM': 'linux', 08:19:11 INFO - 'TMOUT': '86400', 08:19:11 INFO - 'USER': 'cltbld', 08:19:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:11 INFO - '_': '/tools/buildbot/bin/python'} 08:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - Downloading docopt-0.6.1.tar.gz 08:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:14 INFO - Running setup.py install for blobuploader 08:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:14 INFO - Running setup.py install for requests 08:19:14 INFO - Running setup.py install for docopt 08:19:14 INFO - Successfully installed blobuploader requests docopt 08:19:14 INFO - Cleaning up... 08:19:14 INFO - Return code: 0 08:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:14 INFO - Using env: {'DISPLAY': ':0', 08:19:14 INFO - 'HOME': '/home/cltbld', 08:19:14 INFO - 'LANG': 'en_US.UTF-8', 08:19:14 INFO - 'LANGUAGE': 'en_US:en', 08:19:14 INFO - 'LOGNAME': 'cltbld', 08:19:14 INFO - 'MAIL': '/var/mail/cltbld', 08:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:14 INFO - 'MOZ_NO_REMOTE': '1', 08:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:14 INFO - 'NO_EM_RESTART': '1', 08:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:14 INFO - 'PWD': '/builds/slave/test', 08:19:14 INFO - 'SHELL': '/bin/bash', 08:19:14 INFO - 'SHLVL': '1', 08:19:14 INFO - 'TERM': 'linux', 08:19:14 INFO - 'TMOUT': '86400', 08:19:14 INFO - 'USER': 'cltbld', 08:19:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:14 INFO - '_': '/tools/buildbot/bin/python'} 08:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:14 INFO - Running setup.py (path:/tmp/pip-AeSCaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:15 INFO - Running setup.py (path:/tmp/pip-vwWfPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:15 INFO - Running setup.py (path:/tmp/pip-EckJUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:15 INFO - Running setup.py (path:/tmp/pip-q6hub6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:15 INFO - Running setup.py (path:/tmp/pip-QZxgRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:15 INFO - Running setup.py (path:/tmp/pip-RcMFws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:15 INFO - Running setup.py (path:/tmp/pip-Kkn4j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:15 INFO - Running setup.py (path:/tmp/pip-B6DyxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:15 INFO - Running setup.py (path:/tmp/pip-EgI8IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:15 INFO - Running setup.py (path:/tmp/pip-bSSSsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:15 INFO - Running setup.py (path:/tmp/pip-KRLjdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:15 INFO - Running setup.py (path:/tmp/pip-M3VDdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:15 INFO - Running setup.py (path:/tmp/pip-6B4XFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:15 INFO - Running setup.py (path:/tmp/pip-Bvvx7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:16 INFO - Running setup.py (path:/tmp/pip-KG57Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:16 INFO - Running setup.py (path:/tmp/pip-SteM1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:16 INFO - Running setup.py (path:/tmp/pip-85E0uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:16 INFO - Running setup.py install for manifestparser 08:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozcrash 08:19:16 INFO - Running setup.py install for mozdebug 08:19:16 INFO - Running setup.py install for mozdevice 08:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozfile 08:19:16 INFO - Running setup.py install for mozhttpd 08:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozinfo 08:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:16 INFO - Running setup.py install for mozInstall 08:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for mozleak 08:19:17 INFO - Running setup.py install for mozlog 08:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for moznetwork 08:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for mozprocess 08:19:17 INFO - Running setup.py install for mozprofile 08:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for mozrunner 08:19:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for mozscreenshot 08:19:17 INFO - Running setup.py install for moztest 08:19:17 INFO - Running setup.py install for mozversion 08:19:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:18 INFO - Cleaning up... 08:19:18 INFO - Return code: 0 08:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:18 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:18 INFO - Using env: {'DISPLAY': ':0', 08:19:18 INFO - 'HOME': '/home/cltbld', 08:19:18 INFO - 'LANG': 'en_US.UTF-8', 08:19:18 INFO - 'LANGUAGE': 'en_US:en', 08:19:18 INFO - 'LOGNAME': 'cltbld', 08:19:18 INFO - 'MAIL': '/var/mail/cltbld', 08:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:18 INFO - 'MOZ_NO_REMOTE': '1', 08:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:18 INFO - 'NO_EM_RESTART': '1', 08:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:18 INFO - 'PWD': '/builds/slave/test', 08:19:18 INFO - 'SHELL': '/bin/bash', 08:19:18 INFO - 'SHLVL': '1', 08:19:18 INFO - 'TERM': 'linux', 08:19:18 INFO - 'TMOUT': '86400', 08:19:18 INFO - 'USER': 'cltbld', 08:19:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:18 INFO - '_': '/tools/buildbot/bin/python'} 08:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:18 INFO - Running setup.py (path:/tmp/pip-MW46nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:18 INFO - Running setup.py (path:/tmp/pip-YyUs2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:18 INFO - Running setup.py (path:/tmp/pip-ax9hf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:18 INFO - Running setup.py (path:/tmp/pip-oSOnD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:18 INFO - Running setup.py (path:/tmp/pip-Klajls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:18 INFO - Running setup.py (path:/tmp/pip-dSolsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:18 INFO - Running setup.py (path:/tmp/pip-BrvNwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:18 INFO - Running setup.py (path:/tmp/pip-wkSDXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:18 INFO - Running setup.py (path:/tmp/pip-N9r1yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:18 INFO - Running setup.py (path:/tmp/pip-B6mA2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:18 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)) 08:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:18 INFO - Running setup.py (path:/tmp/pip-jFCN0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:19 INFO - Running setup.py (path:/tmp/pip-Y8rFwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:19 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)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:19 INFO - Running setup.py (path:/tmp/pip-Opcg4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:19 INFO - Running setup.py (path:/tmp/pip-5CPQ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:19 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)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:19 INFO - Running setup.py (path:/tmp/pip-3QpC7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:19 INFO - Running setup.py (path:/tmp/pip-SDxBWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:19 INFO - Running setup.py (path:/tmp/pip-OP1FLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:21 INFO - Downloading blessings-1.6.tar.gz 08:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:21 INFO - Installing collected packages: blessings 08:19:21 INFO - Running setup.py install for blessings 08:19:21 INFO - Successfully installed blessings 08:19:21 INFO - Cleaning up... 08:19:21 INFO - Return code: 0 08:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:21 INFO - Reading from file tmpfile_stdout 08:19:21 INFO - Current package versions: 08:19:21 INFO - argparse == 1.2.1 08:19:21 INFO - blessings == 1.6 08:19:21 INFO - blobuploader == 1.2.4 08:19:21 INFO - docopt == 0.6.1 08:19:21 INFO - functools32 == 3.2.3-2 08:19:21 INFO - jsonschema == 2.5.1 08:19:21 INFO - manifestparser == 1.1 08:19:21 INFO - mozInstall == 1.12 08:19:21 INFO - mozcrash == 0.17 08:19:21 INFO - mozdebug == 0.1 08:19:21 INFO - mozdevice == 0.48 08:19:21 INFO - mozfile == 1.2 08:19:21 INFO - mozhttpd == 0.7 08:19:21 INFO - mozinfo == 0.9 08:19:21 INFO - mozleak == 0.1 08:19:21 INFO - mozlog == 3.3 08:19:21 INFO - moznetwork == 0.27 08:19:21 INFO - mozprocess == 0.23 08:19:21 INFO - mozprofile == 0.28 08:19:21 INFO - mozrunner == 6.12 08:19:21 INFO - mozscreenshot == 0.1 08:19:21 INFO - mozsystemmonitor == 0.3 08:19:21 INFO - moztest == 0.7 08:19:21 INFO - mozversion == 1.4 08:19:21 INFO - psutil == 3.1.1 08:19:21 INFO - requests == 1.2.3 08:19:21 INFO - wsgiref == 0.1.2 08:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:21 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:21 INFO - Using env: {'DISPLAY': ':0', 08:19:21 INFO - 'HOME': '/home/cltbld', 08:19:21 INFO - 'LANG': 'en_US.UTF-8', 08:19:21 INFO - 'LANGUAGE': 'en_US:en', 08:19:21 INFO - 'LOGNAME': 'cltbld', 08:19:21 INFO - 'MAIL': '/var/mail/cltbld', 08:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:21 INFO - 'MOZ_NO_REMOTE': '1', 08:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:21 INFO - 'NO_EM_RESTART': '1', 08:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:21 INFO - 'PWD': '/builds/slave/test', 08:19:21 INFO - 'SHELL': '/bin/bash', 08:19:21 INFO - 'SHLVL': '1', 08:19:21 INFO - 'TERM': 'linux', 08:19:21 INFO - 'TMOUT': '86400', 08:19:21 INFO - 'USER': 'cltbld', 08:19:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:21 INFO - '_': '/tools/buildbot/bin/python'} 08:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:22 INFO - Cleaning up... 08:19:22 INFO - Return code: 0 08:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:22 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 0x20bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, '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': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:22 INFO - Using env: {'DISPLAY': ':0', 08:19:22 INFO - 'HOME': '/home/cltbld', 08:19:22 INFO - 'LANG': 'en_US.UTF-8', 08:19:22 INFO - 'LANGUAGE': 'en_US:en', 08:19:22 INFO - 'LOGNAME': 'cltbld', 08:19:22 INFO - 'MAIL': '/var/mail/cltbld', 08:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:22 INFO - 'MOZ_NO_REMOTE': '1', 08:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:22 INFO - 'NO_EM_RESTART': '1', 08:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:22 INFO - 'PWD': '/builds/slave/test', 08:19:22 INFO - 'SHELL': '/bin/bash', 08:19:22 INFO - 'SHLVL': '1', 08:19:22 INFO - 'TERM': 'linux', 08:19:22 INFO - 'TMOUT': '86400', 08:19:22 INFO - 'USER': 'cltbld', 08:19:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:22 INFO - '_': '/tools/buildbot/bin/python'} 08:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:22 INFO - Cleaning up... 08:19:22 INFO - Return code: 0 08:19:22 INFO - Running post-action listener: _resource_record_post_action 08:19:22 INFO - Running post-action listener: _start_resource_monitoring 08:19:22 INFO - Starting resource monitoring. 08:19:22 INFO - [mozharness: 2016-08-09 15:19:22.317906Z] Finished create-virtualenv step (success) 08:19:22 INFO - [mozharness: 2016-08-09 15:19:22.318384Z] Running install step. 08:19:22 INFO - Running pre-action listener: _resource_record_pre_action 08:19:22 INFO - Running main action method: install 08:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:22 INFO - Reading from file tmpfile_stdout 08:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:22 INFO - Reading from file tmpfile_stdout 08:19:22 INFO - Output received: 08:19:22 INFO - Usage: mozinstall [options] installer 08:19:22 INFO - Options: 08:19:22 INFO - -h, --help show this help message and exit 08:19:22 INFO - -d DEST, --destination=DEST 08:19:22 INFO - Directory to install application into. [default: 08:19:22 INFO - "/builds/slave/test"] 08:19:22 INFO - --app=APP Application being installed. [default: firefox] 08:19:22 INFO - mkdir: /builds/slave/test/build/application 08:19:22 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'] 08:19:22 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 08:19:39 INFO - Reading from file tmpfile_stdout 08:19:39 INFO - Output received: 08:19:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:39 INFO - Running post-action listener: _resource_record_post_action 08:19:39 INFO - [mozharness: 2016-08-09 15:19:39.661488Z] Finished install step (success) 08:19:39 INFO - [mozharness: 2016-08-09 15:19:39.661737Z] Running run-tests step. 08:19:39 INFO - Running pre-action listener: _resource_record_pre_action 08:19:39 INFO - Running main action method: run_tests 08:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:39 INFO - Python 2.7.3 08:19:39 INFO - Return code: 0 08:19:39 INFO - grabbing minidump binary from tooltool 08:19: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')]} 08:19:39 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 0x237c3b0>, '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 0x237d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:19:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:19:39 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 08:19:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:39 INFO - Return code: 0 08:19:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 08:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 08:19:39 INFO - Using env: {'DISPLAY': ':0', 08:19:39 INFO - 'HOME': '/home/cltbld', 08:19:39 INFO - 'LANG': 'en_US.UTF-8', 08:19:39 INFO - 'LANGUAGE': 'en_US:en', 08:19:39 INFO - 'LOGNAME': 'cltbld', 08:19:39 INFO - 'MAIL': '/var/mail/cltbld', 08:19:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:39 INFO - 'MOZ_NO_REMOTE': '1', 08:19:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:39 INFO - 'NO_EM_RESTART': '1', 08:19:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:39 INFO - 'PWD': '/builds/slave/test', 08:19:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:39 INFO - 'SHELL': '/bin/bash', 08:19:39 INFO - 'SHLVL': '1', 08:19:39 INFO - 'TERM': 'linux', 08:19:39 INFO - 'TMOUT': '86400', 08:19:39 INFO - 'USER': 'cltbld', 08:19:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805', 08:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:39 INFO - '_': '/tools/buildbot/bin/python'} 08:19:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 08:19:39 INFO - mozversion application_buildid: 20160809053001 08:19:39 INFO - mozversion application_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 08:19:39 INFO - mozversion application_display_name: Nightly 08:19:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:39 INFO - mozversion application_name: Firefox 08:19:39 INFO - mozversion application_remotingname: firefox 08:19:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:39 INFO - mozversion application_vendor: Mozilla 08:19:39 INFO - mozversion application_version: 51.0a1 08:19:39 INFO - mozversion platform_buildid: 20160809053001 08:19:39 INFO - mozversion platform_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 08:19:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:39 INFO - mozversion platform_version: 51.0a1 08:19:39 INFO - using testdate: 1470755979 08:19:39 INFO - actual date: 1470755979 08:19:39 INFO - starting webserver on 'localhost:51917' 08:19:39 INFO - SUITE-START | Running 2 tests 08:19:39 INFO - TEST-START | dromaeo_css 08:19:39 INFO - operating with platform_type : linux_ 08:19:39 INFO - Initialising browser for dromaeo_css test... 08:19:39 INFO - TEST-INFO | started process 24008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzCLNQ/profile http://localhost:51917/getInfo.html) 08:19:43 INFO - PROCESS | 24008 | __metrics Screen width/height:1600/1200 08:19:43 INFO - PROCESS | 24008 | colorDepth:24 08:19:43 INFO - PROCESS | 24008 | Browser inner width/height: 1024/697 08:19:43 INFO - PROCESS | 24008 | __metrics 08:19:44 INFO - PROCESS | 24008 | 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" 08:19:44 INFO - PROCESS | 24008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:45 INFO - TEST-INFO | 24008: exit 0 08:19:45 INFO - Browser initialized. 08:19:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:45 INFO - TEST-INFO | started process 24093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzCLNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:57 INFO - PROCESS | 24093 | RSS: Main: 156577792 08:19:57 INFO - PROCESS | 24093 | 08:20:47 INFO - PROCESS | 24093 | 1470756047873 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:22:58 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51917/tests/dromaeo/cssquery-ext.html) 08:22:59 INFO - PROCESS | 24093 | RSS: Main: 266375168 08:22:59 INFO - PROCESS | 24093 | 08:26:01 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-ext.html (next: http://localhost:51917/tests/dromaeo/cssquery-jquery.html) 08:26:02 INFO - PROCESS | 24093 | RSS: Main: 245940224 08:26:02 INFO - PROCESS | 24093 | 08:29:04 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51917/tests/dromaeo/cssquery-mootools.html) 08:29:05 INFO - PROCESS | 24093 | RSS: Main: 185077760 08:29:05 INFO - PROCESS | 24093 | 08:32:07 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51917/tests/dromaeo/cssquery-prototype.html) 08:32:07 INFO - PROCESS | 24093 | RSS: Main: 217280512 08:32:07 INFO - PROCESS | 24093 | 08:35:10 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51917/tests/dromaeo/cssquery-yui.html) 08:35:10 INFO - PROCESS | 24093 | RSS: Main: 184446976 08:35:10 INFO - PROCESS | 24093 | 08:38:13 INFO - PROCESS | 24093 | Cycle 1(1): loaded http://localhost:51917/tests/dromaeo/cssquery-yui.html (next: http://localhost:51917/tests/dromaeo/cssquery-dojo.html) 08:38:14 INFO - PROCESS | 24093 | RSS: Main: 251682816 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | __start_tp_report 08:38:14 INFO - PROCESS | 24093 | _x_x_mozilla_page_load 08:38:14 INFO - PROCESS | 24093 | _x_x_mozilla_page_load_details 08:38:14 INFO - PROCESS | 24093 | |i|pagename|runs| 08:38:14 INFO - PROCESS | 24093 | |0;dojo.html;3040.5591189277557;3056.037348235307;3079.2455848317168;3084.6915308469142;3100.4729196036687;5212.478752124785;5223.268742376065;5264.842054738355;5303.655262407946;5339.8398048058525;5270.0250453666;5305.151175811871;5319.760610772515;5342.732863356836;5368.141097424413;4801.471838097815;4855.150348688965;4878.146324393217;4885.633577481685;5005.224190250498;4934.037862616791;4963.205887058071;4989.176785830334;5013.623978201649;5015.122353588125;4778.116048531033;4782.258749893789;4797.640176986705;4833.709977401332;4961.727105009223;4797.112534181188;4814.15752243356;4816.109019831342;4879.56083952446;4937.827176048857;4853.878653033667;4857.149998750205;4858.1012512685265;4862.659613827033;4895.6083513318845;5192.818251361222;5237.240600113;5255.60582956276;5266.104762190398;5335.706536140511;5605.299337582802;5610.719464026783;5632.267805185341;5681.744321505542;5693.28833895763;5542.473465020817;5724.084146536534;5739.598228124033;5740.4833564978935;5742.08126699726;5282.788688452457;5353.143497040455;5372.91940620891;5402.162664786964;5444.047291723932;5911.231539899785;5973.641581505123;5975;5978.461938425563;5980.940190598125;5376.4085950545405;5723.341815691166;5726.513246374022;5730.19777231188;5731.512821410143;5624.0439125348785;5673.432656734293;5699.686517241508;5750.453706897838;5805.535557155502;5691.544676425876;5693.03218452864;5703.8859222816145;5703.942960570341;5710.65736055838;5424.864378390572;5673.886522269614;5725.885482290331;5731.0543760279925;5739.024365857814;4312.978435107867;4370.8907277317685;4419.40338054365;4426.18115648606;4455.04216593434;3933.252681990413;3937.468441760383;3943.2113577284085;3983.063979964706;3999.260136874629;5487.972560137254;5494;5494.148406996922;5496.587755918322;5501.477359650827;5469.808556700496;5586.692731899784;5730.19777231188;5734.6845923473775;5801.680907550125;5424.674519528841;5448.046591846411;5460.153676180198;5465.6447330923365;5469.15228139639;4957.082939656175;4968.566920354602;4969.602431805447;4974.726390048582;5019.222020586815;5811.476967072984;5854.824355269348;5935.762569497172;5967.522598192048;6061.272647282354;5752.0509115997065;5756.079027355603;5765.798197063083;5795.420457954339;5807.8548036299435;5943.851403714769;5990.910136347871;5991.430814072656;6002.219711437485;6007.699615019319;5468.589855760754;5549.556035517068;5639.54883609302;5672.688002159755;5675.971620141873;5768.423157684198;5783.103618939072;5783.884322313446;5787.710614469175;5845.41545845429;5641.548676105984;5644.294463192101;5650.802221922213;5652.689102099424;5653.886922261614;5399.217113518596;5506.559475242051;5601.159826026129;5643.322801263875;5646.576506762091;5567.081431563746;5568.91646625309;5570.359408667893;5608.747606357642;5624;5620;5668.943310566841;5712.143178523254;5716.485516303553;5723.7996670116345;5355.491228333302;5358.758855851418;5403.8108666196495;5489.286392768914;5492.615516913777 08:38:14 INFO - PROCESS | 24093 | |1;ext.html;583.253435602429;598.4344794169511;600.189743845808;615.9959266395774;624.1418050181;42320.51878184264;42812.78593607028;43887.341689874636;43929.56070439295;44096.11807763843;41981.58018419815;42523;44959.77520112403;45072.54927450733;45103.548964510344;8189.631466583988;8979.057198994093;9106.453612783254;9134.543272836365;9136.360454768168;10527.420991845445;10847.349159050482;10851.837222441669;11142.665720028412;11159.27464714795;10863.565457381696;11060.115190784718;11060.834087488654;11061.557537698482;11072.557097716082;10828.133749300076;10854.45727713619;10881.891181088207;10888.727781805439;10891.237613367068;10830.458477076114;10883.83674244887;10889.401082940434;10890.455477226107;10892.891071089267;42135.57864421347;42317;42482.36276455856;42522.149557009;42571.36142957858;3414.163529935157;3441.2359298175706;3500.702440292578;3542.2030043240065;3619.69232615228;33159.17102072443;33484;33874.79813812095;34307;35098.298034039435;4279.893002674927;4301.204277208695;4414.735115893024;4444.066745983348;4471.105778844211;358560;360083;360276;361359;362239;57227.71386143043;57462.425375745705;57679;57948.420515795144;58008;59116.704416477645;59168.70415647894;59557.40442595519;59652.403475965555;59752.701236493536;14454;14653.706925861423;14682.55952321432;14689.192094434695;14709.485168019068;11162.497687604076;11165.497552610152;11204.66386008421;11234.831477527843;11239.887601124048;15785.447509337118;15829.920850395674;15881;15937.840621593867;16049.438269660506;5972.761089556369;6069.484093851984;6170.629762214192;6233.937660623335;6286.151369565142;938.4463166731524;996.267743208741;1007.5516395204064;1060.0512541275516;1067.957281708723;32528.18357015184;32695.50956735651;32898.83550582232;33022.66977330244;33170;1078.1105587890022;1097.550004498168;1110.1673744691482;1134.2117228526095;1135.6593022093339;16770.496885093467;17125.743113853303;17169.48491545256;17287.13564321779;17378.739318910226;531257;535492;536750;539542;539832;58295.417045828995;58361.70819145877;58390;58431.12353314704;58592;1211.3458732284644;1291.1607455154037;1324.675454513631;1338.0633556510288;1345.2668295778824;32440;33446.16384590405;34024.319513609094;34120.48819267663;34321.14197145091;49189.262161066894;49347.25979110244;49506.504934950186;49572;49576.50423495719;429779;434876;435346;436104;437587;35358.64641353657;40177.39733903935;40522.18955620812;40859.79570102131;40960.38559421551;47824.760876195396;48166.27750583674;48227.75886120547;48444.51555484541;49469.752651236515;40120.59879401168;40363.78908632746;40922.79538602288;41791;42039.36940945827;40478.392824108254;41237;41394;42802.35796462993;42856.35715464333;40039.39940900947;40099.79950100231;41288.38067428931;42046.57953420427;44050.55949440593;35586.46620300646;36623.63376366202;37681.81159094187;37835.432468512445;38132.6186738129;27836.468994204704;28204.576931345637;28325.291867703472;28358.71641283561;28473.572896406986 08:38:14 INFO - PROCESS | 24093 | |2;jquery.html;370.14496513054826;377.51489336202985;392.77219212856545;402.6034356159183;419.1282133163019;14051.578452646425;16976.575585610364;19320.3237886674;19845.801541984576;19885.701714474275;19190.904045479754;19222.711659325123;19227;19427.708584371245;19536.413907582795;5513.09034009389;5723.427657234264;5726.971365143189;5728.742206600713;5756.136579513086;5826.067829147337;6004.849878753044;6023.969880150615;6024.1566180734735;6026.096085587175;5989.730462129215;6016.187814645011;6031.849203769897;6437.645929473877;6518.7392504300005;6542.247641521215;6558.442532384753;6577.539572229922;6580.012998050307;6581.04574836646;5612.07400778871;5781.942180578182;5813.186153938452;5821.912671309934;5824.213731146283;13774.93112534441;14017.299135043208;17957;23833;24030.519389612284;2701.513727529044;2769.6537932758406;2802.971970280312;2847.9145625631263;2848.5869548915293;9790.608375664964;10227.642032528825;10550.683479495627;10733.355998640107;10751.946240268748;1892.5741708115702;1925.5378709109852;1929.2251677099207;2002.8097330753556;2073.523089689365;85376.57311713402;89492;90819;91295;91296.54351728199;11046;11127.72180695489;11211.38337391435;11245.662630121109;11330.490127944262;15523.611909702122;15551.455699050479;15554.688906222038;15558;15571.766423503657;7603.163651998276;7649.732259370895;7814.33578145864;7832.177621349676;7862.253085956825;7215.927840721631;7221.42228621709;7230.783076507713;7376.631168441557;7392.371648409838;4714.434267887876;4740.013791311451;4765.428148622187;4818.301346304836;4913.705177689279;1895.6019235960327;1939.4763413878175;2002.7396438462906;2019.5556977464935;2033.8169564738948;739.5119221313907;850.4387104510993;853.8335024670254;869.7521206456256;927.7263207353847;18407.53981150455;19530.41408757711;19625.21499140047;19791.40625781229;19932.50168745793;944.607987685103;947.1854205383365;963.272729089533;971.7376308396694;1034.8033873564;10024;10920.890791092146;10972.177086718528;10998.285111467729;11012.063974562092;417159;420378;476345;486902;490185;82394;84985.57507212424;93204.53397733104;94282;94732.97743555153;973.3332667123043;1012.6658202793061;1013.6654903881702;1031.56674196836;1032.5921261101973;17823.643527129127;18025.639487210443;18529;18615.627687445904;18674.533136671147;31354;34765.47851782175;40785;43465.34801978036;44415;58100.4189958095;61746.38253617406;65086.349136508026;65154.348456514825;65367.34632653803;8171.591420428836;8409.95795021021;8473.364497662576;8591.140885911358;8666.696665616673;8153.7553873383895;12974.80537791915;12987.480500779862;13060.21638701643;13478.393472293967;11211.66365009051;11357.716057098638;11375.886241137814;11503.309801411942;11622.5350985963;11060.502277397698;11329.660110196708;11340.206185567262;11453.885461145615;11516.596919107791;11485.425728713699;11501.194916355775;11511.53953841837;11890.702732431759;12200.572979945659;8290;8380.958095209486;8577.185167409087;8689.348298877483;8703.042665306937;10822.56709731602;11136.387498687325;11168.609098681507;11192.272502287326;11632.709182270512 08:38:14 INFO - PROCESS | 24093 | |3;mootools.html;1452.346444100155;1518.2332921874454;1653.7023335799552;1788.5886246163375;1809.9366522171717;8620.09489003655;9209.953950230256;9229.861552076716;9236.815263694722;9244.260459163268;7854.371650267979;8046;8047.35621150308;8262.876056859152;9032.774180645487;2346.9295921122393;2425.9029638814513;2426.38127277544;2443.4013666651695;2443.8044956403446;2376.2752360530117;2377.9643305350346;2385.7852793248603;2395.3053614451787;2431.124795073772;2355.3640517060385;2368.5499755046485;2379.1910750344878;2379.8096152307776;2380.9761902381015;2354.7292061412986;2360.9409764755933;2361.7874391304863;2361.9055237790467;2362.303120579433;2334.6031174700342;2388.952220955571;2391.5456063348083;2392.605220138675;2395.1856368834506;9142.497162656051;9174.357794954356;9244.214241789456;9260.861087083698;9263.490508022056;5337.572994160458;5471.644343117685;5483.396826349099;5485.588580856452;5485.6982865942355;3276.6068071831296;3316.1709572606846;3475.669811367916;3477.4783782432582;3478.4086705260165;1090.8091084060336;1111.1166622535104;1111.6498303034518;1113.3709454158375;1149.0577726264466;12569.434375453127;12577.937110314482;12608.369581520887;12646.683832904251;12664.240145591293;4734.07685501324;4749.073930583572;4770.534407392318;4845.9757701211265;4938.950610493849;10478.056974872297;10528.894711052944;10546.630867919586;10549.789004219872;10555.683329500127;5403.972980135153;5408.323959505062;5412.07994640912;5413.377461591888;5413.566914646819;4893.6329775266995;4895.902081958341;4929.211326187865;4949.183384741549;4982.128127577732;3987.720859539804;4029.6776257899296;4096.6313031826685;4120.484939382577;4164.1879833432795;1304.39345704248;1310.9344532773514;1326.3633455941201;1333.2866916199787;1343.1135450602555;851.3274513134554;982.2044144243185;984.1732944326657;1020.7703266764919;1028.4446398944485;6098.512119030467;6119.847003824851;6191.566590338633;6214.906776398358;6293.811185664437;932.0120672087609;932.8880534335923;974.8927617962019;975.4244995452717;1000.3847633705365;4120.587941205916;4283.250431174594;4324.978375108104;4375.496817865923;4400.889977750518;11337.659870203906;11760.470778814974;11792.823107653392;11899.702507437383;11912.10659200546;11376.203665743318;11377.601783937522;11478.827817582744;11557.76884462306;11665.183437159487;8408.201220884128;8438.156184381513;8515.19105684959;8517.531535765593;8521.403501754818;5828.213191219301;5952.791652292149;6011.789587364421;6019.398060193946;6074.7266373012435;10351.482425878525;10533.210009249184;10538.525766340379;10625.521851516545;10674.57301707923;10573.365598064142;10690.893091069302;10794.460276986276;10840.512176952214;10852.891471085188;6298.653574053471;6759.377749340221;7585.506942048749;7588.886166707393;7751.806204844924;8553.914460855312;8668.869966950375;8675.219230269053;8675.392722509363;8684.869726954226;7034;7816.296533312029;7851.685932562634;7912.406569507425;7924.881126783218;7655.311022008046;7727.4204434668745;7771.72798952034;7826.7651970440975;7931.405144614062;6983.860322793617;7070.328318809705;7070.893936590853;7093.113360829896;7093.361597456254;5079.6698214615935;5091.236314552847;5112.207607820794;5171.9482805171465;5283.10187268173;5221.373435187802;5302.920456193237;5312.814051508179;5345.1714984177515;5498.192953762465 08:38:14 INFO - PROCESS | 24093 | |4;prototype.html;325.7328990228014;333.9916502087448;337.70282151706493;341.0433733377877;344.9361868054409;5329.866753331169;5337.70642614656;5376.91934620981;5379.784808607656;5417.810376636819;5025.296458495814;5067.50508599963;5177.119889618764;5186.0033886953515;5320.893582128355;4122.2579935611575;4132.917341653165;4135.800617820828;4137.986193382625;4140.234056699505;4138.896527586804;4148.211839750453;4154.31453810121;4154.418381426588;4155.127423241108;3925.3326934421216;3935.6457918787305;4107.79461026949;4114.938275925863;4120.608542188487;4097.504410890034;4100.671946244323;4101.302778527627;4105.794710264489;4114.855980040699;3637.94543081854;3639.909002274938;3640.4903313536124;3644.3942581054675;3657.5062366580705;5090.872728181788;5118.846434606968;5123.641345105844;5152.124138896396;5153.2270159476;4625.352450656911;4629.675922685414;4654.976725116387;4657.347971284023;4665.813367465297;5408.432114627947;5412.56699464042;5413;5424.186372044185;5449.700266485342;3705.5738590061947;3865.8260378283044;3928.7839168845703;3936.5079365079364;3937.862174823896;5652.9152062719095;5668.234788303609;5670.574706896958;5680.630759000652;5685.459881311269;4008.6793056555407;4009.4186342980106;4011.1777085697363;4020.8994775130855;4048.846078867509;3918.549366822795;4102.446169767103;4107.856225032109;4111.97944010278;4116.300228961024;4606.5854073132905;4610.815567377334;4619.676622636451;4659;4665.136949664323;5454.181872719045;5460.781568737206;5471.316085489314;5491.588130890199;5539.639923405047;1343.7581235377727;1400.9229492377813;1407.6480879780056;1407.9577612671637;1412.491503058898;891.9063498332712;917.7843206846386;921.3136213520836;925.2089463508603;925.3938670171049;4731.574158325767;4756.239001759771;4756.405449318835;4758.476567577563;4783.258594917794;4632.5135860734135;4988.35151430319;4989.700617962933;4991.825286114969;4999.325091112653;4727.054589082198;4727.929081063787;4734.621230301567;4738.739369334719;4741.193997020515;2618.5336211721115;2663.240976321739;2664.588547364638;2667.5061965299496;2673.6123262126885;5155;5168.9741551292;5193.454687257784;5441.428649991693;5853.414658534198;5785.392533783976;5790.449907258803;5799.942000580025;5802.535797136219;5807;5855.443732845373;5870.3249126350165;5875.471207591338;5880.852978675482;5886.94113058864;5499.587530935116;5597.916031259616;5609.88780224385;5659.377468478382;5690.231818704422;5610.4670056344585;5612.5509959202345;5644.532421570503;5669.773209071591;5673.716314184192;5718.599698021265;5902.439268269508;5915.645061296336;5918.260217472816;5936.673482958478;4062.187562487455;4076.0421300994835;4084.223997440477;4090.4047421505043;4093.8157782900435;5412.242286079873;5522.889542209214;5637.774489020393;5701.1756238003445;5706.3152421709665;5572.387037425799;5578.916316255179;5583.776648933997;5590.86022849432;5592.608517403905;5289.47105289468;5505.614606977473;5514.966768277512;5527.917081243704;5530;5476.972615136899;5493.368262649847;5503.834884953458;5505.476979686923;5506.862328441821;5563.916541251965;5569.746806968562;5582;5601.579881508822;5604.243427137448;5201.635885488131;5433.592480563894;5458.4541545845095;5492.642978206404;5499 08:38:14 INFO - PROCESS | 24093 | |5;yui.html;740.0786021403354;743.561298833688;744.8994385757925;764.4037650632508;850.6980022092154;15209;15846.603834904134;15868.761968570481;15902.284397202126;15951;14302.427902883872;14370.712585748304;14411.207383593897;14423.350949207284;14514.92742536286;649.8018104478132;779.9922000780005;801.3909428834085;807.7818988873;817.7178873288735;809.6194788449419;814.4828034198297;820.5897051474263;821.8109834738013;821.8972628421448;868.1318681318681;870.6560908441162;871.1941454154913;871.5772850167664;872.467794645269;684.8253695307715;829.1832544943226;858.0775666158873;865.1305438034735;865.6840253307529;622.710439645567;623.0311865049846;623.4762799248653;624.048326302388;625.69028330976;16070.196490175444;16099.275532601061;16119.758203626954;16128.516144515683;16130.516084517483;13249.13880597758;13476.393562289622;13610.999999999902;13748.518801841887;14150.646233844132;12652.304123273216;12806.42371093303;12830.252552658683;12995;13086.738265234737;4517;4614.561616646413;4694.24892017279;4695.460022097468;4834.540718631724;83289;83385.58307208486;83508;83915.58042209811;85263;11953.70115747096;12170.939145304394;12175.634730958085;12280.078994075302;12308;22973.19593814242;22987.88506057459;23005.88497057504;23105.3068407948;23143;8642.654293828176;8716.346274029473;8760.12398760119;8825.293976481866;9131.086891310815;4675.555822196886;4830.106430310404;4839.758012099381;4937.456879743226;4961.454240033666;3364.966350336514;3452.7410444216785;3504.5268888699698;3513.8594456221463;3558.092686365012;549.8790266141442;552.9087700529448;577.1749067279437;590.5511811023653;594.4204400709274;568.9459501347366;634;676.8240257533076;687.1925487552206;693.4694958356861;9644.228461723045;9813.067758562926;9944.105030547285;10199.13307368882;10223.539940702687;682.8122266376786;703.8381172330393;710.6730903784318;712.4834494991194;723.6345645449014;4432.711873728197;4709.693869898446;4727.669063165546;4748.019585207543;4857.489963553847;73423;96105;100749;101026;117268.41365793288;99415.50292248493;100336;101434.49282753687;101921;101941;85981.57009214914;89163.55418222997;89982.55008725045;90860.99999999868;90893.54553227192;8578.828423431372;8857.424267422597;9046.185843274137;9085.818283634422;9365.311639673819;50155;51106.965050035;52527.47472525226;53711.731441344105;54849.725751370985;75559;76019;77464.61267693626;79178.6041069791;80983.59508202421;11435.199536032398;11606.767864642828;11698.883011169779;12143.210691305037;12304.138710290194;12992.805107923577;13415.731685366043;13458.394372253468;13712.36457231782;13814.861851381358;12844.807327889903;13090.083694141318;13119.475220991435;13407.530736424178;13428.19430834153;12179.634610961686;12287.56993505223;12529.248245105322;13013;13023.674408139872;12116.939415302868;12321.161225076634;12448.813267801172;12597;13011.414486348327;9452.810943781224;9686.660966866126;9725.711945092562;9861.921110627889;9884.85172722424;10159.84760228612;10638.255322127377;10689.625863094754;10794.244402891722;11371.829422558834 08:38:14 INFO - PROCESS | 24093 | __end_tp_report 08:38:14 INFO - PROCESS | 24093 | __start_cc_report 08:38:14 INFO - PROCESS | 24093 | _x_x_mozilla_cycle_collect,1096 08:38:14 INFO - PROCESS | 24093 | __end_cc_report 08:38:14 INFO - PROCESS | 24093 | __startTimestamp1470757094066__endTimestamp 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | ------- Summary: start ------- 08:38:14 INFO - PROCESS | 24093 | Number of tests: 6 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#0] dojo.html Cycles:165 Average:5323.42 Median:5494.15 stddev:605.67 (11.0%) stddev-sans-first:580.44 08:38:14 INFO - PROCESS | 24093 | Values: 3040.6 3056.0 3079.2 3084.7 3100.5 5212.5 5223.3 5264.8 5303.7 5339.8 5270.0 5305.2 5319.8 5342.7 5368.1 4801.5 4855.2 4878.1 4885.6 5005.2 4934.0 4963.2 4989.2 5013.6 5015.1 4778.1 4782.3 4797.6 4833.7 4961.7 4797.1 4814.2 4816.1 4879.6 4937.8 4853.9 4857.1 4858.1 4862.7 4895.6 5192.8 5237.2 5255.6 5266.1 5335.7 5605.3 5610.7 5632.3 5681.7 5693.3 5542.5 5724.1 5739.6 5740.5 5742.1 5282.8 5353.1 5372.9 5402.2 5444.0 5911.2 5973.6 5975.0 5978.5 5980.9 5376.4 5723.3 5726.5 5730.2 5731.5 5624.0 5673.4 5699.7 5750.5 5805.5 5691.5 5693.0 5703.9 5703.9 5710.7 5424.9 5673.9 5725.9 5731.1 5739.0 4313.0 4370.9 4419.4 4426.2 4455.0 3933.3 3937.5 3943.2 3983.1 3999.3 5488.0 5494.0 5494.1 5496.6 5501.5 5469.8 5586.7 5730.2 5734.7 5801.7 5424.7 5448.0 5460.2 5465.6 5469.2 4957.1 4968.6 4969.6 4974.7 5019.2 5811.5 5854.8 5935.8 5967.5 6061.3 5752.1 5756.1 5765.8 5795.4 5807.9 5943.9 5990.9 5991.4 6002.2 6007.7 5468.6 5549.6 5639.5 5672.7 5676.0 5768.4 5783.1 5783.9 5787.7 5845.4 5641.5 5644.3 5650.8 5652.7 5653.9 5399.2 5506.6 5601.2 5643.3 5646.6 5567.1 5568.9 5570.4 5608.7 5624.0 5620.0 5668.9 5712.1 5716.5 5723.8 5355.5 5358.8 5403.8 5489.3 5492.6 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#1] ext.html Cycles:180 Average:60952.67 Median:40110.20 stddev:119075.88 (296.9%) stddev-sans-first:119323.65 08:38:14 INFO - PROCESS | 24093 | Values: 583.3 598.4 600.2 616.0 624.1 42320.5 42812.8 43887.3 43929.6 44096.1 41981.6 42523.0 44959.8 45072.5 45103.5 8189.6 8979.1 9106.5 9134.5 9136.4 10527.4 10847.3 10851.8 11142.7 11159.3 10863.6 11060.1 11060.8 11061.6 11072.6 10828.1 10854.5 10881.9 10888.7 10891.2 10830.5 10883.8 10889.4 10890.5 10892.9 42135.6 42317.0 42482.4 42522.1 42571.4 3414.2 3441.2 3500.7 3542.2 3619.7 33159.2 33484.0 33874.8 34307.0 35098.3 4279.9 4301.2 4414.7 4444.1 4471.1 358560.0 360083.0 360276.0 361359.0 362239.0 57227.7 57462.4 57679.0 57948.4 58008.0 59116.7 59168.7 59557.4 59652.4 59752.7 14454.0 14653.7 14682.6 14689.2 14709.5 11162.5 11165.5 11204.7 11234.8 11239.9 15785.4 15829.9 15881.0 15937.8 16049.4 5972.8 6069.5 6170.6 6233.9 6286.2 938.4 996.3 1007.6 1060.1 1068.0 32528.2 32695.5 32898.8 33022.7 33170.0 1078.1 1097.6 1110.2 1134.2 1135.7 16770.5 17125.7 17169.5 17287.1 17378.7 531257.0 535492.0 536750.0 539542.0 539832.0 58295.4 58361.7 58390.0 58431.1 58592.0 1211.3 1291.2 1324.7 1338.1 1345.3 32440.0 33446.2 34024.3 34120.5 34321.1 49189.3 49347.3 49506.5 49572.0 49576.5 429779.0 434876.0 435346.0 436104.0 437587.0 35358.6 40177.4 40522.2 40859.8 40960.4 47824.8 48166.3 48227.8 48444.5 49469.8 40120.6 40363.8 40922.8 41791.0 42039.4 40478.4 41237.0 41394.0 42802.4 42856.4 40039.4 40099.8 41288.4 42046.6 44050.6 35586.5 36623.6 37681.8 37835.4 38132.6 27836.5 28204.6 28325.3 28358.7 28473.6 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#2] jquery.html Cycles:180 Average:28233.16 Median:373.83 stddev:76137.02 (20366.8%) stddev-sans-first:76321.86 08:38:14 INFO - PROCESS | 24093 | Values: 370.1 377.5 392.8 402.6 419.1 14051.6 16976.6 19320.3 19845.8 19885.7 19190.9 19222.7 19227.0 19427.7 19536.4 5513.1 5723.4 5727.0 5728.7 5756.1 5826.1 6004.8 6024.0 6024.2 6026.1 5989.7 6016.2 6031.8 6437.6 6518.7 6542.2 6558.4 6577.5 6580.0 6581.0 5612.1 5781.9 5813.2 5821.9 5824.2 13774.9 14017.3 17957.0 23833.0 24030.5 2701.5 2769.7 2803.0 2847.9 2848.6 9790.6 10227.6 10550.7 10733.4 10751.9 1892.6 1925.5 1929.2 2002.8 2073.5 85376.6 89492.0 90819.0 91295.0 91296.5 11046.0 11127.7 11211.4 11245.7 11330.5 15523.6 15551.5 15554.7 15558.0 15571.8 7603.2 7649.7 7814.3 7832.2 7862.3 7215.9 7221.4 7230.8 7376.6 7392.4 4714.4 4740.0 4765.4 4818.3 4913.7 1895.6 1939.5 2002.7 2019.6 2033.8 739.5 850.4 853.8 869.8 927.7 18407.5 19530.4 19625.2 19791.4 19932.5 944.6 947.2 963.3 971.7 1034.8 10024.0 10920.9 10972.2 10998.3 11012.1 417159.0 420378.0 476345.0 486902.0 490185.0 82394.0 84985.6 93204.5 94282.0 94733.0 973.3 1012.7 1013.7 1031.6 1032.6 17823.6 18025.6 18529.0 18615.6 18674.5 31354.0 34765.5 40785.0 43465.3 44415.0 58100.4 61746.4 65086.3 65154.3 65367.3 8171.6 8410.0 8473.4 8591.1 8666.7 8153.8 12974.8 12987.5 13060.2 13478.4 11211.7 11357.7 11375.9 11503.3 11622.5 11060.5 11329.7 11340.2 11453.9 11516.6 11485.4 11501.2 11511.5 11890.7 12200.6 8290.0 8381.0 8577.2 8689.3 8703.0 10822.6 11136.4 11168.6 11192.3 11632.7 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#3] mootools.html Cycles:180 Average:5947.29 Median:4808.26 stddev:3411.55 (71.0%) stddev-sans-first:3404.40 08:38:14 INFO - PROCESS | 24093 | Values: 1452.3 1518.2 1653.7 1788.6 1809.9 8620.1 9210.0 9229.9 9236.8 9244.3 7854.4 8046.0 8047.4 8262.9 9032.8 2346.9 2425.9 2426.4 2443.4 2443.8 2376.3 2378.0 2385.8 2395.3 2431.1 2355.4 2368.5 2379.2 2379.8 2381.0 2354.7 2360.9 2361.8 2361.9 2362.3 2334.6 2389.0 2391.5 2392.6 2395.2 9142.5 9174.4 9244.2 9260.9 9263.5 5337.6 5471.6 5483.4 5485.6 5485.7 3276.6 3316.2 3475.7 3477.5 3478.4 1090.8 1111.1 1111.6 1113.4 1149.1 12569.4 12577.9 12608.4 12646.7 12664.2 4734.1 4749.1 4770.5 4846.0 4939.0 10478.1 10528.9 10546.6 10549.8 10555.7 5404.0 5408.3 5412.1 5413.4 5413.6 4893.6 4895.9 4929.2 4949.2 4982.1 3987.7 4029.7 4096.6 4120.5 4164.2 1304.4 1310.9 1326.4 1333.3 1343.1 851.3 982.2 984.2 1020.8 1028.4 6098.5 6119.8 6191.6 6214.9 6293.8 932.0 932.9 974.9 975.4 1000.4 4120.6 4283.3 4325.0 4375.5 4400.9 11337.7 11760.5 11792.8 11899.7 11912.1 11376.2 11377.6 11478.8 11557.8 11665.2 8408.2 8438.2 8515.2 8517.5 8521.4 5828.2 5952.8 6011.8 6019.4 6074.7 10351.5 10533.2 10538.5 10625.5 10674.6 10573.4 10690.9 10794.5 10840.5 10852.9 6298.7 6759.4 7585.5 7588.9 7751.8 8553.9 8668.9 8675.2 8675.4 8684.9 7034.0 7816.3 7851.7 7912.4 7924.9 7655.3 7727.4 7771.7 7826.8 7931.4 6983.9 7070.3 7070.9 7093.1 7093.4 5079.7 5091.2 5112.2 5171.9 5283.1 5221.4 5302.9 5312.8 5345.2 5498.2 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#4] prototype.html Cycles:180 Average:4573.92 Median:5152.68 stddev:1354.92 (26.3%) stddev-sans-first:1320.67 08:38:14 INFO - PROCESS | 24093 | Values: 325.7 334.0 337.7 341.0 344.9 5329.9 5337.7 5376.9 5379.8 5417.8 5025.3 5067.5 5177.1 5186.0 5320.9 4122.3 4132.9 4135.8 4138.0 4140.2 4138.9 4148.2 4154.3 4154.4 4155.1 3925.3 3935.6 4107.8 4114.9 4120.6 4097.5 4100.7 4101.3 4105.8 4114.9 3637.9 3639.9 3640.5 3644.4 3657.5 5090.9 5118.8 5123.6 5152.1 5153.2 4625.4 4629.7 4655.0 4657.3 4665.8 5408.4 5412.6 5413.0 5424.2 5449.7 3705.6 3865.8 3928.8 3936.5 3937.9 5652.9 5668.2 5670.6 5680.6 5685.5 4008.7 4009.4 4011.2 4020.9 4048.8 3918.5 4102.4 4107.9 4112.0 4116.3 4606.6 4610.8 4619.7 4659.0 4665.1 5454.2 5460.8 5471.3 5491.6 5539.6 1343.8 1400.9 1407.6 1408.0 1412.5 891.9 917.8 921.3 925.2 925.4 4731.6 4756.2 4756.4 4758.5 4783.3 4632.5 4988.4 4989.7 4991.8 4999.3 4727.1 4727.9 4734.6 4738.7 4741.2 2618.5 2663.2 2664.6 2667.5 2673.6 5155.0 5169.0 5193.5 5441.4 5853.4 5785.4 5790.4 5799.9 5802.5 5807.0 5855.4 5870.3 5875.5 5880.9 5886.9 5499.6 5597.9 5609.9 5659.4 5690.2 5610.5 5612.6 5644.5 5669.8 5673.7 5718.6 5902.4 5915.6 5918.3 5936.7 4062.2 4076.0 4084.2 4090.4 4093.8 5412.2 5522.9 5637.8 5701.2 5706.3 5572.4 5578.9 5583.8 5590.9 5592.6 5289.5 5505.6 5515.0 5527.9 5530.0 5477.0 5493.4 5503.8 5505.5 5506.9 5563.9 5569.7 5582.0 5601.6 5604.2 5201.6 5433.6 5458.5 5492.6 5499.0 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - PROCESS | 24093 | [#5] yui.html Cycles:180 Average:20733.72 Median:4848.62 stddev:29630.37 (611.1%) stddev-sans-first:29675.46 08:38:14 INFO - PROCESS | 24093 | Values: 740.1 743.6 744.9 764.4 850.7 15209.0 15846.6 15868.8 15902.3 15951.0 14302.4 14370.7 14411.2 14423.4 14514.9 649.8 780.0 801.4 807.8 817.7 809.6 814.5 820.6 821.8 821.9 868.1 870.7 871.2 871.6 872.5 684.8 829.2 858.1 865.1 865.7 622.7 623.0 623.5 624.0 625.7 16070.2 16099.3 16119.8 16128.5 16130.5 13249.1 13476.4 13611.0 13748.5 14150.6 12652.3 12806.4 12830.3 12995.0 13086.7 4517.0 4614.6 4694.2 4695.5 4834.5 83289.0 83385.6 83508.0 83915.6 85263.0 11953.7 12170.9 12175.6 12280.1 12308.0 22973.2 22987.9 23005.9 23105.3 23143.0 8642.7 8716.3 8760.1 8825.3 9131.1 4675.6 4830.1 4839.8 4937.5 4961.5 3365.0 3452.7 3504.5 3513.9 3558.1 549.9 552.9 577.2 590.6 594.4 568.9 634.0 676.8 687.2 693.5 9644.2 9813.1 9944.1 10199.1 10223.5 682.8 703.8 710.7 712.5 723.6 4432.7 4709.7 4727.7 4748.0 4857.5 73423.0 96105.0 100749.0 101026.0 117268.4 99415.5 100336.0 101434.5 101921.0 101941.0 85981.6 89163.6 89982.6 90861.0 90893.5 8578.8 8857.4 9046.2 9085.8 9365.3 50155.0 51107.0 52527.5 53711.7 54849.7 75559.0 76019.0 77464.6 79178.6 80983.6 11435.2 11606.8 11698.9 12143.2 12304.1 12992.8 13415.7 13458.4 13712.4 13814.9 12844.8 13090.1 13119.5 13407.5 13428.2 12179.6 12287.6 12529.2 13013.0 13023.7 12116.9 12321.2 12448.8 12597.0 13011.4 9452.8 9686.7 9725.7 9861.9 9884.9 10159.8 10638.3 10689.6 10794.2 11371.8 08:38:14 INFO - PROCESS | 24093 | -------- Summary: end -------- 08:38:14 INFO - PROCESS | 24093 | 08:38:14 INFO - TEST-INFO | 24093: exit 0 08:38:14 INFO - TEST-OK | dromaeo_css | took 1114868ms 08:38:14 INFO - TEST-START | kraken 08:38:14 INFO - operating with platform_type : linux_ 08:38:14 INFO - Initialising browser for kraken test... 08:38:14 INFO - TEST-INFO | started process 24287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKVvoU/profile http://localhost:51917/getInfo.html) 08:38:18 INFO - PROCESS | 24287 | __metrics Screen width/height:1600/1200 08:38:18 INFO - PROCESS | 24287 | colorDepth:24 08:38:18 INFO - PROCESS | 24287 | Browser inner width/height: 1024/697 08:38:18 INFO - PROCESS | 24287 | __metrics 08:38:19 INFO - PROCESS | 24287 | 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" 08:38:19 INFO - PROCESS | 24287 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:20 INFO - TEST-INFO | 24287: exit 0 08:38:20 INFO - Browser initialized. 08:38:20 INFO - Running cycle 1/1 for kraken test... 08:38:20 INFO - TEST-INFO | started process 24371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKVvoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:32 INFO - PROCESS | 24371 | RSS: Main: 156573696 08:38:32 INFO - PROCESS | 24371 | 08:38:34 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51917/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:35 INFO - PROCESS | 24371 | RSS: Main: 212717568 08:38:35 INFO - PROCESS | 24371 | 08:38:38 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51917/tests/kraken/driver.html?testName=audio-dft) 08:38:38 INFO - PROCESS | 24371 | RSS: Main: 192520192 08:38:38 INFO - PROCESS | 24371 | 08:38:41 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51917/tests/kraken/driver.html?testName=audio-fft) 08:38:42 INFO - PROCESS | 24371 | RSS: Main: 269709312 08:38:42 INFO - PROCESS | 24371 | 08:38:44 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51917/tests/kraken/driver.html?testName=audio-oscillator) 08:38:45 INFO - PROCESS | 24371 | RSS: Main: 179523584 08:38:45 INFO - PROCESS | 24371 | 08:38:47 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:47 INFO - PROCESS | 24371 | RSS: Main: 183480320 08:38:47 INFO - PROCESS | 24371 | 08:38:50 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51917/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:51 INFO - PROCESS | 24371 | RSS: Main: 218771456 08:38:51 INFO - PROCESS | 24371 | 08:38:54 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51917/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:55 INFO - PROCESS | 24371 | RSS: Main: 218980352 08:38:55 INFO - PROCESS | 24371 | 08:38:58 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51917/tests/kraken/driver.html?testName=json-parse-financial) 08:38:58 INFO - PROCESS | 24371 | RSS: Main: 219451392 08:38:58 INFO - PROCESS | 24371 | 08:39:00 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:00 INFO - PROCESS | 24371 | RSS: Main: 183975936 08:39:00 INFO - PROCESS | 24371 | 08:39:02 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:03 INFO - PROCESS | 24371 | RSS: Main: 190590976 08:39:03 INFO - PROCESS | 24371 | 08:39:05 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:06 INFO - PROCESS | 24371 | RSS: Main: 194392064 08:39:06 INFO - PROCESS | 24371 | 08:39:08 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:09 INFO - PROCESS | 24371 | RSS: Main: 189095936 08:39:09 INFO - PROCESS | 24371 | 08:39:11 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:12 INFO - PROCESS | 24371 | RSS: Main: 192692224 08:39:12 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | Cycle 1(1): loaded http://localhost:51917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51917/tests/kraken/driver.html?testName=ai-astar) 08:39:14 INFO - PROCESS | 24371 | RSS: Main: 243044352 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | __start_tp_report 08:39:14 INFO - PROCESS | 24371 | _x_x_mozilla_page_load 08:39:14 INFO - PROCESS | 24371 | _x_x_mozilla_page_load_details 08:39:14 INFO - PROCESS | 24371 | |i|pagename|runs| 08:39:14 INFO - PROCESS | 24371 | |0;ai-astar;101;111;110;109;112;110;109;109;109;109 08:39:14 INFO - PROCESS | 24371 | |1;audio-beat-detection;149;117;119;196;119;119;147;127;161;124 08:39:14 INFO - PROCESS | 24371 | |2;audio-dft;162;163;160;162;161;158;161;161;160;161 08:39:14 INFO - PROCESS | 24371 | |3;audio-fft;73;75;73;117;76;76;74;75;107;76 08:39:14 INFO - PROCESS | 24371 | |4;audio-oscillator;84;84;138;85;83;84;110;84;85;128 08:39:14 INFO - PROCESS | 24371 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;116;117;117 08:39:14 INFO - PROCESS | 24371 | |6;imaging-darkroom;145;147;145;145;145;146;146;146;147;146 08:39:14 INFO - PROCESS | 24371 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;95 08:39:14 INFO - PROCESS | 24371 | |8;json-parse-financial;51;50;49;50;51;51;51;49;51;50 08:39:14 INFO - PROCESS | 24371 | |9;json-stringify-tinderbox;60;61;61;61;62;61;61;62;62;62 08:39:14 INFO - PROCESS | 24371 | |10;stanford-crypto-aes;81;75;76;76;75;77;75;75;75;77 08:39:14 INFO - PROCESS | 24371 | |11;stanford-crypto-ccm;125;133;122;135;129;120;121;119;146;134 08:39:14 INFO - PROCESS | 24371 | |12;stanford-crypto-pbkdf2;157;158;161;162;158;157;156;156;156;161 08:39:14 INFO - PROCESS | 24371 | |13;stanford-crypto-sha256-iterative;65;63;65;63;64;62;63;62;61;61 08:39:14 INFO - PROCESS | 24371 | __end_tp_report 08:39:14 INFO - PROCESS | 24371 | __start_cc_report 08:39:14 INFO - PROCESS | 24371 | _x_x_mozilla_cycle_collect,1657 08:39:14 INFO - PROCESS | 24371 | __end_cc_report 08:39:14 INFO - PROCESS | 24371 | __startTimestamp1470757154410__endTimestamp 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | ------- Summary: start ------- 08:39:14 INFO - PROCESS | 24371 | Number of tests: 14 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:2.96 (2.7%) stddev-sans-first:1.09 08:39:14 INFO - PROCESS | 24371 | Values: 101.0 111.0 110.0 109.0 112.0 110.0 109.0 109.0 109.0 109.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:137.00 stddev:25.68 (18.7%) stddev-sans-first:26.92 08:39:14 INFO - PROCESS | 24371 | Values: 149.0 117.0 119.0 196.0 119.0 119.0 147.0 127.0 161.0 124.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 08:39:14 INFO - PROCESS | 24371 | Values: 162.0 163.0 160.0 162.0 161.0 158.0 161.0 161.0 160.0 161.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.92 (21.2%) stddev-sans-first:16.54 08:39:14 INFO - PROCESS | 24371 | Values: 73.0 75.0 73.0 117.0 76.0 76.0 74.0 75.0 107.0 76.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:21.00 (25.0%) stddev-sans-first:21.78 08:39:14 INFO - PROCESS | 24371 | Values: 84.0 84.0 138.0 85.0 83.0 84.0 110.0 84.0 85.0 128.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 08:39:14 INFO - PROCESS | 24371 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:39:14 INFO - PROCESS | 24371 | Values: 145.0 147.0 145.0 145.0 145.0 146.0 146.0 146.0 147.0 146.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:39:14 INFO - PROCESS | 24371 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:51.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 08:39:14 INFO - PROCESS | 24371 | Values: 51.0 50.0 49.0 50.0 51.0 51.0 51.0 49.0 51.0 50.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 08:39:14 INFO - PROCESS | 24371 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 62.0 62.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.87 (2.5%) stddev-sans-first:0.87 08:39:14 INFO - PROCESS | 24371 | Values: 81.0 75.0 76.0 76.0 75.0 77.0 75.0 75.0 75.0 77.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.00 stddev:8.64 (6.6%) stddev-sans-first:9.08 08:39:14 INFO - PROCESS | 24371 | Values: 125.0 133.0 122.0 135.0 129.0 120.0 121.0 119.0 146.0 134.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:2.30 (1.5%) stddev-sans-first:2.40 08:39:14 INFO - PROCESS | 24371 | Values: 157.0 158.0 161.0 162.0 158.0 157.0 156.0 156.0 156.0 161.0 08:39:14 INFO - PROCESS | 24371 | 08:39:14 INFO - PROCESS | 24371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.32 08:39:14 INFO - PROCESS | 24371 | Values: 65.0 63.0 65.0 63.0 64.0 62.0 63.0 62.0 61.0 61.0 08:39:14 INFO - PROCESS | 24371 | -------- Summary: end -------- 08:39:14 INFO - PROCESS | 24371 | 08:39:15 INFO - TEST-INFO | 24371: exit 0 08:39:15 INFO - TEST-OK | kraken | took 60668ms 08:39:15 INFO - SUITE-END | took 1175s 08:39:15 INFO - Completed test suite (00:19:35) 08:39:15 INFO - javascript benchmark 08:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.5591189277557, 3056.037348235307, 3079.2455848317168, 3084.6915308469142, 3100.4729196036687, 5212.478752124785, 5223.268742376065, 5264.842054738355, 5303.655262407946, 5339.8398048058525, 5270.0250453666, 5305.151175811871, 5319.760610772515, 5342.732863356836, 5368.141097424413, 4801.471838097815, 4855.150348688965, 4878.146324393217, 4885.633577481685, 5005.224190250498, 4934.037862616791, 4963.205887058071, 4989.176785830334, 5013.623978201649, 5015.122353588125, 4778.116048531033, 4782.258749893789, 4797.640176986705, 4833.709977401332, 4961.727105009223, 4797.112534181188, 4814.15752243356, 4816.109019831342, 4879.56083952446, 4937.827176048857, 4853.878653033667, 4857.149998750205, 4858.1012512685265, 4862.659613827033, 4895.6083513318845, 5192.818251361222, 5237.240600113, 5255.60582956276, 5266.104762190398, 5335.706536140511, 5605.299337582802, 5610.719464026783, 5632.267805185341, 5681.744321505542, 5693.28833895763, 5542.473465020817, 5724.084146536534, 5739.598228124033, 5740.4833564978935, 5742.08126699726, 5282.788688452457, 5353.143497040455, 5372.91940620891, 5402.162664786964, 5444.047291723932, 5911.231539899785, 5973.641581505123, 5975.0, 5978.461938425563, 5980.940190598125, 5376.4085950545405, 5723.341815691166, 5726.513246374022, 5730.19777231188, 5731.512821410143, 5624.0439125348785, 5673.432656734293, 5699.686517241508, 5750.453706897838, 5805.535557155502, 5691.544676425876, 5693.03218452864, 5703.8859222816145, 5703.942960570341, 5710.65736055838, 5424.864378390572, 5673.886522269614, 5725.885482290331, 5731.0543760279925, 5739.024365857814, 4312.978435107867, 4370.8907277317685, 4419.40338054365, 4426.18115648606, 4455.04216593434, 3933.252681990413, 3937.468441760383, 3943.2113577284085, 3983.063979964706, 3999.260136874629, 5487.972560137254, 5494.0, 5494.148406996922, 5496.587755918322, 5501.477359650827, 5469.808556700496, 5586.692731899784, 5730.19777231188, 5734.6845923473775, 5801.680907550125, 5424.674519528841, 5448.046591846411, 5460.153676180198, 5465.6447330923365, 5469.15228139639, 4957.082939656175, 4968.566920354602, 4969.602431805447, 4974.726390048582, 5019.222020586815, 5811.476967072984, 5854.824355269348, 5935.762569497172, 5967.522598192048, 6061.272647282354, 5752.0509115997065, 5756.079027355603, 5765.798197063083, 5795.420457954339, 5807.8548036299435, 5943.851403714769, 5990.910136347871, 5991.430814072656, 6002.219711437485, 6007.699615019319, 5468.589855760754, 5549.556035517068, 5639.54883609302, 5672.688002159755, 5675.971620141873, 5768.423157684198, 5783.103618939072, 5783.884322313446, 5787.710614469175, 5845.41545845429, 5641.548676105984, 5644.294463192101, 5650.802221922213, 5652.689102099424, 5653.886922261614, 5399.217113518596, 5506.559475242051, 5601.159826026129, 5643.322801263875, 5646.576506762091, 5567.081431563746, 5568.91646625309, 5570.359408667893, 5608.747606357642, 5624.0, 5620.0, 5668.943310566841, 5712.143178523254, 5716.485516303553, 5723.7996670116345, 5355.491228333302, 5358.758855851418, 5403.8108666196495, 5489.286392768914, 5492.615516913777], "value": 5282.478891855135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.253435602429, 598.4344794169511, 600.189743845808, 615.9959266395774, 624.1418050181, 42320.51878184264, 42812.78593607028, 43887.341689874636, 43929.56070439295, 44096.11807763843, 41981.58018419815, 42523.0, 44959.77520112403, 45072.54927450733, 45103.548964510344, 8189.631466583988, 8979.057198994093, 9106.453612783254, 9134.543272836365, 9136.360454768168, 10527.420991845445, 10847.349159050482, 10851.837222441669, 11142.665720028412, 11159.27464714795, 10863.565457381696, 11060.115190784718, 11060.834087488654, 11061.557537698482, 11072.557097716082, 10828.133749300076, 10854.45727713619, 10881.891181088207, 10888.727781805439, 10891.237613367068, 10830.458477076114, 10883.83674244887, 10889.401082940434, 10890.455477226107, 10892.891071089267, 42135.57864421347, 42317.0, 42482.36276455856, 42522.149557009, 42571.36142957858, 3414.163529935157, 3441.2359298175706, 3500.702440292578, 3542.2030043240065, 3619.69232615228, 33159.17102072443, 33484.0, 33874.79813812095, 34307.0, 35098.298034039435, 4279.893002674927, 4301.204277208695, 4414.735115893024, 4444.066745983348, 4471.105778844211, 358560.0, 360083.0, 360276.0, 361359.0, 362239.0, 57227.71386143043, 57462.425375745705, 57679.0, 57948.420515795144, 58008.0, 59116.704416477645, 59168.70415647894, 59557.40442595519, 59652.403475965555, 59752.701236493536, 14454.0, 14653.706925861423, 14682.55952321432, 14689.192094434695, 14709.485168019068, 11162.497687604076, 11165.497552610152, 11204.66386008421, 11234.831477527843, 11239.887601124048, 15785.447509337118, 15829.920850395674, 15881.0, 15937.840621593867, 16049.438269660506, 5972.761089556369, 6069.484093851984, 6170.629762214192, 6233.937660623335, 6286.151369565142, 938.4463166731524, 996.267743208741, 1007.5516395204064, 1060.0512541275516, 1067.957281708723, 32528.18357015184, 32695.50956735651, 32898.83550582232, 33022.66977330244, 33170.0, 1078.1105587890022, 1097.550004498168, 1110.1673744691482, 1134.2117228526095, 1135.6593022093339, 16770.496885093467, 17125.743113853303, 17169.48491545256, 17287.13564321779, 17378.739318910226, 531257.0, 535492.0, 536750.0, 539542.0, 539832.0, 58295.417045828995, 58361.70819145877, 58390.0, 58431.12353314704, 58592.0, 1211.3458732284644, 1291.1607455154037, 1324.675454513631, 1338.0633556510288, 1345.2668295778824, 32440.0, 33446.16384590405, 34024.319513609094, 34120.48819267663, 34321.14197145091, 49189.262161066894, 49347.25979110244, 49506.504934950186, 49572.0, 49576.50423495719, 429779.0, 434876.0, 435346.0, 436104.0, 437587.0, 35358.64641353657, 40177.39733903935, 40522.18955620812, 40859.79570102131, 40960.38559421551, 47824.760876195396, 48166.27750583674, 48227.75886120547, 48444.51555484541, 49469.752651236515, 40120.59879401168, 40363.78908632746, 40922.79538602288, 41791.0, 42039.36940945827, 40478.392824108254, 41237.0, 41394.0, 42802.35796462993, 42856.35715464333, 40039.39940900947, 40099.79950100231, 41288.38067428931, 42046.57953420427, 44050.55949440593, 35586.46620300646, 36623.63376366202, 37681.81159094187, 37835.432468512445, 38132.6186738129, 27836.468994204704, 28204.576931345637, 28325.291867703472, 28358.71641283561, 28473.572896406986], "value": 20517.37536404998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.14496513054826, 377.51489336202985, 392.77219212856545, 402.6034356159183, 419.1282133163019, 14051.578452646425, 16976.575585610364, 19320.3237886674, 19845.801541984576, 19885.701714474275, 19190.904045479754, 19222.711659325123, 19227.0, 19427.708584371245, 19536.413907582795, 5513.09034009389, 5723.427657234264, 5726.971365143189, 5728.742206600713, 5756.136579513086, 5826.067829147337, 6004.849878753044, 6023.969880150615, 6024.1566180734735, 6026.096085587175, 5989.730462129215, 6016.187814645011, 6031.849203769897, 6437.645929473877, 6518.7392504300005, 6542.247641521215, 6558.442532384753, 6577.539572229922, 6580.012998050307, 6581.04574836646, 5612.07400778871, 5781.942180578182, 5813.186153938452, 5821.912671309934, 5824.213731146283, 13774.93112534441, 14017.299135043208, 17957.0, 23833.0, 24030.519389612284, 2701.513727529044, 2769.6537932758406, 2802.971970280312, 2847.9145625631263, 2848.5869548915293, 9790.608375664964, 10227.642032528825, 10550.683479495627, 10733.355998640107, 10751.946240268748, 1892.5741708115702, 1925.5378709109852, 1929.2251677099207, 2002.8097330753556, 2073.523089689365, 85376.57311713402, 89492.0, 90819.0, 91295.0, 91296.54351728199, 11046.0, 11127.72180695489, 11211.38337391435, 11245.662630121109, 11330.490127944262, 15523.611909702122, 15551.455699050479, 15554.688906222038, 15558.0, 15571.766423503657, 7603.163651998276, 7649.732259370895, 7814.33578145864, 7832.177621349676, 7862.253085956825, 7215.927840721631, 7221.42228621709, 7230.783076507713, 7376.631168441557, 7392.371648409838, 4714.434267887876, 4740.013791311451, 4765.428148622187, 4818.301346304836, 4913.705177689279, 1895.6019235960327, 1939.4763413878175, 2002.7396438462906, 2019.5556977464935, 2033.8169564738948, 739.5119221313907, 850.4387104510993, 853.8335024670254, 869.7521206456256, 927.7263207353847, 18407.53981150455, 19530.41408757711, 19625.21499140047, 19791.40625781229, 19932.50168745793, 944.607987685103, 947.1854205383365, 963.272729089533, 971.7376308396694, 1034.8033873564, 10024.0, 10920.890791092146, 10972.177086718528, 10998.285111467729, 11012.063974562092, 417159.0, 420378.0, 476345.0, 486902.0, 490185.0, 82394.0, 84985.57507212424, 93204.53397733104, 94282.0, 94732.97743555153, 973.3332667123043, 1012.6658202793061, 1013.6654903881702, 1031.56674196836, 1032.5921261101973, 17823.643527129127, 18025.639487210443, 18529.0, 18615.627687445904, 18674.533136671147, 31354.0, 34765.47851782175, 40785.0, 43465.34801978036, 44415.0, 58100.4189958095, 61746.38253617406, 65086.349136508026, 65154.348456514825, 65367.34632653803, 8171.591420428836, 8409.95795021021, 8473.364497662576, 8591.140885911358, 8666.696665616673, 8153.7553873383895, 12974.80537791915, 12987.480500779862, 13060.21638701643, 13478.393472293967, 11211.66365009051, 11357.716057098638, 11375.886241137814, 11503.309801411942, 11622.5350985963, 11060.502277397698, 11329.660110196708, 11340.206185567262, 11453.885461145615, 11516.596919107791, 11485.425728713699, 11501.194916355775, 11511.53953841837, 11890.702732431759, 12200.572979945659, 8290.0, 8380.958095209486, 8577.185167409087, 8689.348298877483, 8703.042665306937, 10822.56709731602, 11136.387498687325, 11168.609098681507, 11192.272502287326, 11632.709182270512], "value": 9188.399131423075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.346444100155, 1518.2332921874454, 1653.7023335799552, 1788.5886246163375, 1809.9366522171717, 8620.09489003655, 9209.953950230256, 9229.861552076716, 9236.815263694722, 9244.260459163268, 7854.371650267979, 8046.0, 8047.35621150308, 8262.876056859152, 9032.774180645487, 2346.9295921122393, 2425.9029638814513, 2426.38127277544, 2443.4013666651695, 2443.8044956403446, 2376.2752360530117, 2377.9643305350346, 2385.7852793248603, 2395.3053614451787, 2431.124795073772, 2355.3640517060385, 2368.5499755046485, 2379.1910750344878, 2379.8096152307776, 2380.9761902381015, 2354.7292061412986, 2360.9409764755933, 2361.7874391304863, 2361.9055237790467, 2362.303120579433, 2334.6031174700342, 2388.952220955571, 2391.5456063348083, 2392.605220138675, 2395.1856368834506, 9142.497162656051, 9174.357794954356, 9244.214241789456, 9260.861087083698, 9263.490508022056, 5337.572994160458, 5471.644343117685, 5483.396826349099, 5485.588580856452, 5485.6982865942355, 3276.6068071831296, 3316.1709572606846, 3475.669811367916, 3477.4783782432582, 3478.4086705260165, 1090.8091084060336, 1111.1166622535104, 1111.6498303034518, 1113.3709454158375, 1149.0577726264466, 12569.434375453127, 12577.937110314482, 12608.369581520887, 12646.683832904251, 12664.240145591293, 4734.07685501324, 4749.073930583572, 4770.534407392318, 4845.9757701211265, 4938.950610493849, 10478.056974872297, 10528.894711052944, 10546.630867919586, 10549.789004219872, 10555.683329500127, 5403.972980135153, 5408.323959505062, 5412.07994640912, 5413.377461591888, 5413.566914646819, 4893.6329775266995, 4895.902081958341, 4929.211326187865, 4949.183384741549, 4982.128127577732, 3987.720859539804, 4029.6776257899296, 4096.6313031826685, 4120.484939382577, 4164.1879833432795, 1304.39345704248, 1310.9344532773514, 1326.3633455941201, 1333.2866916199787, 1343.1135450602555, 851.3274513134554, 982.2044144243185, 984.1732944326657, 1020.7703266764919, 1028.4446398944485, 6098.512119030467, 6119.847003824851, 6191.566590338633, 6214.906776398358, 6293.811185664437, 932.0120672087609, 932.8880534335923, 974.8927617962019, 975.4244995452717, 1000.3847633705365, 4120.587941205916, 4283.250431174594, 4324.978375108104, 4375.496817865923, 4400.889977750518, 11337.659870203906, 11760.470778814974, 11792.823107653392, 11899.702507437383, 11912.10659200546, 11376.203665743318, 11377.601783937522, 11478.827817582744, 11557.76884462306, 11665.183437159487, 8408.201220884128, 8438.156184381513, 8515.19105684959, 8517.531535765593, 8521.403501754818, 5828.213191219301, 5952.791652292149, 6011.789587364421, 6019.398060193946, 6074.7266373012435, 10351.482425878525, 10533.210009249184, 10538.525766340379, 10625.521851516545, 10674.57301707923, 10573.365598064142, 10690.893091069302, 10794.460276986276, 10840.512176952214, 10852.891471085188, 6298.653574053471, 6759.377749340221, 7585.506942048749, 7588.886166707393, 7751.806204844924, 8553.914460855312, 8668.869966950375, 8675.219230269053, 8675.392722509363, 8684.869726954226, 7034.0, 7816.296533312029, 7851.685932562634, 7912.406569507425, 7924.881126783218, 7655.311022008046, 7727.4204434668745, 7771.72798952034, 7826.7651970440975, 7931.405144614062, 6983.860322793617, 7070.328318809705, 7070.893936590853, 7093.113360829896, 7093.361597456254, 5079.6698214615935, 5091.236314552847, 5112.207607820794, 5171.9482805171465, 5283.10187268173, 5221.373435187802, 5302.920456193237, 5312.814051508179, 5345.1714984177515, 5498.192953762465], "value": 4753.04239566314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.7328990228014, 333.9916502087448, 337.70282151706493, 341.0433733377877, 344.9361868054409, 5329.866753331169, 5337.70642614656, 5376.91934620981, 5379.784808607656, 5417.810376636819, 5025.296458495814, 5067.50508599963, 5177.119889618764, 5186.0033886953515, 5320.893582128355, 4122.2579935611575, 4132.917341653165, 4135.800617820828, 4137.986193382625, 4140.234056699505, 4138.896527586804, 4148.211839750453, 4154.31453810121, 4154.418381426588, 4155.127423241108, 3925.3326934421216, 3935.6457918787305, 4107.79461026949, 4114.938275925863, 4120.608542188487, 4097.504410890034, 4100.671946244323, 4101.302778527627, 4105.794710264489, 4114.855980040699, 3637.94543081854, 3639.909002274938, 3640.4903313536124, 3644.3942581054675, 3657.5062366580705, 5090.872728181788, 5118.846434606968, 5123.641345105844, 5152.124138896396, 5153.2270159476, 4625.352450656911, 4629.675922685414, 4654.976725116387, 4657.347971284023, 4665.813367465297, 5408.432114627947, 5412.56699464042, 5413.0, 5424.186372044185, 5449.700266485342, 3705.5738590061947, 3865.8260378283044, 3928.7839168845703, 3936.5079365079364, 3937.862174823896, 5652.9152062719095, 5668.234788303609, 5670.574706896958, 5680.630759000652, 5685.459881311269, 4008.6793056555407, 4009.4186342980106, 4011.1777085697363, 4020.8994775130855, 4048.846078867509, 3918.549366822795, 4102.446169767103, 4107.856225032109, 4111.97944010278, 4116.300228961024, 4606.5854073132905, 4610.815567377334, 4619.676622636451, 4659.0, 4665.136949664323, 5454.181872719045, 5460.781568737206, 5471.316085489314, 5491.588130890199, 5539.639923405047, 1343.7581235377727, 1400.9229492377813, 1407.6480879780056, 1407.9577612671637, 1412.491503058898, 891.9063498332712, 917.7843206846386, 921.3136213520836, 925.2089463508603, 925.3938670171049, 4731.574158325767, 4756.239001759771, 4756.405449318835, 4758.476567577563, 4783.258594917794, 4632.5135860734135, 4988.35151430319, 4989.700617962933, 4991.825286114969, 4999.325091112653, 4727.054589082198, 4727.929081063787, 4734.621230301567, 4738.739369334719, 4741.193997020515, 2618.5336211721115, 2663.240976321739, 2664.588547364638, 2667.5061965299496, 2673.6123262126885, 5155.0, 5168.9741551292, 5193.454687257784, 5441.428649991693, 5853.414658534198, 5785.392533783976, 5790.449907258803, 5799.942000580025, 5802.535797136219, 5807.0, 5855.443732845373, 5870.3249126350165, 5875.471207591338, 5880.852978675482, 5886.94113058864, 5499.587530935116, 5597.916031259616, 5609.88780224385, 5659.377468478382, 5690.231818704422, 5610.4670056344585, 5612.5509959202345, 5644.532421570503, 5669.773209071591, 5673.716314184192, 5718.599698021265, 5902.439268269508, 5915.645061296336, 5918.260217472816, 5936.673482958478, 4062.187562487455, 4076.0421300994835, 4084.223997440477, 4090.4047421505043, 4093.8157782900435, 5412.242286079873, 5522.889542209214, 5637.774489020393, 5701.1756238003445, 5706.3152421709665, 5572.387037425799, 5578.916316255179, 5583.776648933997, 5590.86022849432, 5592.608517403905, 5289.47105289468, 5505.614606977473, 5514.966768277512, 5527.917081243704, 5530.0, 5476.972615136899, 5493.368262649847, 5503.834884953458, 5505.476979686923, 5506.862328441821, 5563.916541251965, 5569.746806968562, 5582.0, 5601.579881508822, 5604.243427137448, 5201.635885488131, 5433.592480563894, 5458.4541545845095, 5492.642978206404, 5499.0], "value": 4144.722238532308, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.0786021403354, 743.561298833688, 744.8994385757925, 764.4037650632508, 850.6980022092154, 15209.0, 15846.603834904134, 15868.761968570481, 15902.284397202126, 15951.0, 14302.427902883872, 14370.712585748304, 14411.207383593897, 14423.350949207284, 14514.92742536286, 649.8018104478132, 779.9922000780005, 801.3909428834085, 807.7818988873, 817.7178873288735, 809.6194788449419, 814.4828034198297, 820.5897051474263, 821.8109834738013, 821.8972628421448, 868.1318681318681, 870.6560908441162, 871.1941454154913, 871.5772850167664, 872.467794645269, 684.8253695307715, 829.1832544943226, 858.0775666158873, 865.1305438034735, 865.6840253307529, 622.710439645567, 623.0311865049846, 623.4762799248653, 624.048326302388, 625.69028330976, 16070.196490175444, 16099.275532601061, 16119.758203626954, 16128.516144515683, 16130.516084517483, 13249.13880597758, 13476.393562289622, 13610.999999999902, 13748.518801841887, 14150.646233844132, 12652.304123273216, 12806.42371093303, 12830.252552658683, 12995.0, 13086.738265234737, 4517.0, 4614.561616646413, 4694.24892017279, 4695.460022097468, 4834.540718631724, 83289.0, 83385.58307208486, 83508.0, 83915.58042209811, 85263.0, 11953.70115747096, 12170.939145304394, 12175.634730958085, 12280.078994075302, 12308.0, 22973.19593814242, 22987.88506057459, 23005.88497057504, 23105.3068407948, 23143.0, 8642.654293828176, 8716.346274029473, 8760.12398760119, 8825.293976481866, 9131.086891310815, 4675.555822196886, 4830.106430310404, 4839.758012099381, 4937.456879743226, 4961.454240033666, 3364.966350336514, 3452.7410444216785, 3504.5268888699698, 3513.8594456221463, 3558.092686365012, 549.8790266141442, 552.9087700529448, 577.1749067279437, 590.5511811023653, 594.4204400709274, 568.9459501347366, 634.0, 676.8240257533076, 687.1925487552206, 693.4694958356861, 9644.228461723045, 9813.067758562926, 9944.105030547285, 10199.13307368882, 10223.539940702687, 682.8122266376786, 703.8381172330393, 710.6730903784318, 712.4834494991194, 723.6345645449014, 4432.711873728197, 4709.693869898446, 4727.669063165546, 4748.019585207543, 4857.489963553847, 73423.0, 96105.0, 100749.0, 101026.0, 117268.41365793288, 99415.50292248493, 100336.0, 101434.49282753687, 101921.0, 101941.0, 85981.57009214914, 89163.55418222997, 89982.55008725045, 90860.99999999868, 90893.54553227192, 8578.828423431372, 8857.424267422597, 9046.185843274137, 9085.818283634422, 9365.311639673819, 50155.0, 51106.965050035, 52527.47472525226, 53711.731441344105, 54849.725751370985, 75559.0, 76019.0, 77464.61267693626, 79178.6041069791, 80983.59508202421, 11435.199536032398, 11606.767864642828, 11698.883011169779, 12143.210691305037, 12304.138710290194, 12992.805107923577, 13415.731685366043, 13458.394372253468, 13712.36457231782, 13814.861851381358, 12844.807327889903, 13090.083694141318, 13119.475220991435, 13407.530736424178, 13428.19430834153, 12179.634610961686, 12287.56993505223, 12529.248245105322, 13013.0, 13023.674408139872, 12116.939415302868, 12321.161225076634, 12448.813267801172, 12597.0, 13011.414486348327, 9452.810943781224, 9686.660966866126, 9725.711945092562, 9861.921110627889, 9884.85172722424, 10159.84760228612, 10638.255322127377, 10689.625863094754, 10794.244402891722, 11371.829422558834], "value": 7499.413668105643, "unit": "score"}], "name": "dromaeo_css", "value": 7265.909557291743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 109.0, 112.0, 110.0, 109.0, 109.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 119.0, 196.0, 119.0, 119.0, 147.0, 127.0, 161.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 162.0, 161.0, 158.0, 161.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 117.0, 76.0, 76.0, 74.0, 75.0, 107.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 138.0, 85.0, 83.0, 84.0, 110.0, 84.0, 85.0, 128.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 51.0, 51.0, 51.0, 49.0, 51.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 76.0, 75.0, 77.0, 75.0, 75.0, 75.0, 77.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 122.0, 135.0, 129.0, 120.0, 121.0, 119.0, 146.0, 134.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 161.0, 162.0, 158.0, 157.0, 156.0, 156.0, 156.0, 161.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 64.0, 62.0, 63.0, 62.0, 61.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1481.1000000000001, "alertThreshold": 2.0}]} 08:39:15 INFO - Return code: 0 08:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:15 INFO - # TBPL SUCCESS # 08:39:15 INFO - Running post-action listener: _resource_record_post_action 08:39:15 INFO - [mozharness: 2016-08-09 15:39:15.693829Z] Finished run-tests step (success) 08:39:15 INFO - Running post-run listener: _resource_record_post_run 08:39:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549466112; Read time: 8; Write time: 415340 08:39:15 INFO - TinderboxPrint: CPU usage
13.0% 08:39:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:39:15 INFO - TinderboxPrint: I/O write bytes / time
549,466,112 / 415,340 08:39:15 INFO - TinderboxPrint: CPU idle
8,281.3 (87.0%) 08:39:15 INFO - TinderboxPrint: CPU user
1,196.0 (12.6%) 08:39:15 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:15 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258785280; Read time: 0; Write time: 238940 08:39:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290258944; Read time: 0; Write time: 176364 08:39:16 INFO - Running post-run listener: _upload_blobber_files 08:39:16 INFO - Blob upload gear active. 08:39:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:17 INFO - (blobuploader) - INFO - Done attempting. 08:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:21 INFO - (blobuploader) - INFO - Done attempting. 08:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:22 INFO - (blobuploader) - INFO - Done attempting. 08:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:22 INFO - Return code: 0 08:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3606d48e513f7581d31483a16de41a576f8b15912fa64da7356750a5b8385d450fd73e500d81fa0518c7a8e6487c55dfefde01c0a7b7cbac4d9f42c6c51eb86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/632c807237bc96920d76cea5c8c0e61d284a4f759f9cd4960bf6e3bd7b50ae72e4fca12b6824ed282e888c234c56eecf79f4e1c151dbfed77d5099ea5141701a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7187ad4b7a09a696ae1f193c94cddec9e83b2b9c7f348ca3f70799ee6a302e3ee5f66bf84fd19fc369d929805a2aedb3427043142bddef6aa87d668d39b57651"} 08:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:22 INFO - Contents: 08:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3606d48e513f7581d31483a16de41a576f8b15912fa64da7356750a5b8385d450fd73e500d81fa0518c7a8e6487c55dfefde01c0a7b7cbac4d9f42c6c51eb86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/632c807237bc96920d76cea5c8c0e61d284a4f759f9cd4960bf6e3bd7b50ae72e4fca12b6824ed282e888c234c56eecf79f4e1c151dbfed77d5099ea5141701a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7187ad4b7a09a696ae1f193c94cddec9e83b2b9c7f348ca3f70799ee6a302e3ee5f66bf84fd19fc369d929805a2aedb3427043142bddef6aa87d668d39b57651"} 08:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:22 INFO - Copying logs to upload dir... 08:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.865859 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-09 08:39:20.496878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:39:20.500819) ========= 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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 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/3606d48e513f7581d31483a16de41a576f8b15912fa64da7356750a5b8385d450fd73e500d81fa0518c7a8e6487c55dfefde01c0a7b7cbac4d9f42c6c51eb86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/632c807237bc96920d76cea5c8c0e61d284a4f759f9cd4960bf6e3bd7b50ae72e4fca12b6824ed282e888c234c56eecf79f4e1c151dbfed77d5099ea5141701a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7187ad4b7a09a696ae1f193c94cddec9e83b2b9c7f348ca3f70799ee6a302e3ee5f66bf84fd19fc369d929805a2aedb3427043142bddef6aa87d668d39b57651"} build_url:https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/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/3606d48e513f7581d31483a16de41a576f8b15912fa64da7356750a5b8385d450fd73e500d81fa0518c7a8e6487c55dfefde01c0a7b7cbac4d9f42c6c51eb86c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/632c807237bc96920d76cea5c8c0e61d284a4f759f9cd4960bf6e3bd7b50ae72e4fca12b6824ed282e888c234c56eecf79f4e1c151dbfed77d5099ea5141701a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7187ad4b7a09a696ae1f193c94cddec9e83b2b9c7f348ca3f70799ee6a302e3ee5f66bf84fd19fc369d929805a2aedb3427043142bddef6aa87d668d39b57651"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:39:20.531377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:39:20.531735) ========= 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=6dbc10da6d83fee962c624be000001a8-1470755930.670953-800311805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:39:20.613247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:39:20.613628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:39:20.613946) ========= ========= Total master_lag: 0.17 =========