builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1470700788.08 results: success (0) buildid: 20160808154720 builduid: 747a3ee8729f4ef5b4590f221113758a revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.079584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.080005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.080344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.103364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.103644) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 16:59:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.9M=0s 2016-08-08 16:59:48 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.250377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.250700) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014762 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.299906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.300290) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b5d2c84d5b253d4dfde4897e13384dc97a46a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 720b5d2c84d5b253d4dfde4897e13384dc97a46a --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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 16:59:48,406 truncating revision to first 12 chars 2016-08-08 16:59:48,406 Setting DEBUG logging. 2016-08-08 16:59:48,406 attempt 1/10 2016-08-08 16:59:48,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b5d2c84d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 16:59:48,720 unpacking tar archive at: mozilla-central-720b5d2c84d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.967719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.968003) ========= script_repo_revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.968970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.969263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 16:59:48.983278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 16:59:48.983564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:49 INFO - MultiFileLogger online at 20160808 16:59:49 in /builds/slave/test 16:59:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:59:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:59:49 INFO - {'append_to_log': False, 16:59:49 INFO - 'base_work_dir': '/builds/slave/test', 16:59:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:59:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:59:49 INFO - 'branch': 'Firefox-Non-PGO', 16:59:49 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:49 INFO - 'config_files': ('talos/linux_config.py',), 16:59:49 INFO - 'default_actions': ('clobber', 16:59:49 INFO - 'read-buildbot-config', 16:59:49 INFO - 'download-and-extract', 16:59:49 INFO - 'populate-webroot', 16:59:49 INFO - 'create-virtualenv', 16:59:49 INFO - 'install', 16:59:49 INFO - 'run-tests'), 16:59:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:49 INFO - 'download_minidump_stackwalk': True, 16:59:49 INFO - 'download_symbols': 'ondemand', 16:59:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:49 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:49 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:49 INFO - 'installer_path': 'installer.exe', 16:59:49 INFO - 'log_level': 'info', 16:59:49 INFO - 'log_name': 'talos', 16:59:49 INFO - 'log_to_console': True, 16:59:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:49 INFO - 'opt_config_files': (), 16:59:49 INFO - 'pip_index': False, 16:59:49 INFO - 'sps_profile': False, 16:59:49 INFO - 'sps_profile_interval': 0, 16:59:49 INFO - 'suite': 'dromaeojs-e10s', 16:59:49 INFO - 'system_bits': '32', 16:59:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:49 INFO - 'title': 'talos-linux64-ix-014', 16:59:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:49 INFO - 'use_talos_json': True, 16:59:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:59:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:49 INFO - 'work_dir': 'build'} 16:59:49 INFO - [mozharness: 2016-08-08 23:59:49.177261Z] Running clobber step. 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: clobber 16:59:49 INFO - rmtree: /builds/slave/test/build 16:59:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:49 INFO - Running post-action listener: _resource_record_post_action 16:59:49 INFO - [mozharness: 2016-08-08 23:59:49.636135Z] Finished clobber step (success) 16:59:49 INFO - [mozharness: 2016-08-08 23:59:49.636236Z] Running read-buildbot-config step. 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: read_buildbot_config 16:59:49 INFO - Using buildbot properties: 16:59:49 INFO - { 16:59:49 INFO - "project": "", 16:59:49 INFO - "product": "firefox", 16:59:49 INFO - "script_repo_revision": "production", 16:59:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:59:49 INFO - "repository": "", 16:59:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:59:49 INFO - "buildid": "20160808154720", 16:59:49 INFO - "pgo_build": "False", 16:59:49 INFO - "basedir": "/builds/slave/test", 16:59:49 INFO - "buildnumber": 411, 16:59:49 INFO - "slavename": "talos-linux64-ix-014", 16:59:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:59:49 INFO - "platform": "ubuntu64_hw", 16:59:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:59:49 INFO - "branch": "mozilla-central", 16:59:49 INFO - "repo_path": "mozilla-central", 16:59:49 INFO - "revision": "720b5d2c84d5b253d4dfde4897e13384dc97a46a", 16:59:49 INFO - "stage_platform": "linux64", 16:59:49 INFO - "builduid": "747a3ee8729f4ef5b4590f221113758a", 16:59:49 INFO - "slavebuilddir": "test" 16:59:49 INFO - } 16:59:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:59:49 INFO - Running post-action listener: _resource_record_post_action 16:59:49 INFO - [mozharness: 2016-08-08 23:59:49.638680Z] Finished read-buildbot-config step (success) 16:59:49 INFO - [mozharness: 2016-08-08 23:59:49.638769Z] Running download-and-extract step. 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: download_and_extract 16:59:49 INFO - mkdir: /builds/slave/test/build/tests 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:49 INFO - trying https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:59:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:50 INFO - Downloaded 1361 bytes. 16:59:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:59:50 INFO - Using the following test package requirements: 16:59:50 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:59:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'jsshell-linux-x86_64.zip'], 16:59:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:50 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:50 INFO - trying https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:59:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:51 INFO - Downloaded 20257838 bytes. 16:59:51 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'] 16:59:51 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 16:59:52 INFO - Return code: 0 16:59:52 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 16:59: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')]} 16:59:52 INFO - trying https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:59:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:53 INFO - Downloaded 20257838 bytes. 16:59:53 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'] 16:59:53 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 16:59:54 INFO - Return code: 0 16:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:54 INFO - trying https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:55 INFO - Downloaded 14413723 bytes. 16:59:55 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'] 16:59:55 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 16:59:56 INFO - Return code: 0 16:59:56 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')]} 16:59:56 INFO - trying https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:59:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 16:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/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 17:00:00 INFO - Downloaded 56134318 bytes. 17:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:00:00 INFO - mkdir: /builds/slave/test/properties 17:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:00:00 INFO - Contents: 17:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:00:00 INFO - Running post-action listener: _resource_record_post_action 17:00:00 INFO - Running post-action listener: set_extra_try_arguments 17:00:00 INFO - [mozharness: 2016-08-09 00:00:00.836239Z] Finished download-and-extract step (success) 17:00:00 INFO - [mozharness: 2016-08-09 00:00:00.836471Z] Running populate-webroot step. 17:00:00 INFO - Running pre-action listener: _resource_record_pre_action 17:00:00 INFO - Running main action method: populate_webroot 17:00:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:00 INFO - '--tppagecycles', 17:00:00 INFO - '7'], 17:00:00 INFO - 'tests': ['tsvgm']}}, 17:00:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:00:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:00:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:00:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['damp', 'tps']}, 17:00:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'tests': ['damp', 'tps']}, 17:00:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['dromaeo_dom']}, 17:00:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['basic_compositor_video']}, 17:00:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:00:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['a11yr', 17:00:00 INFO - 'ts_paint', 17:00:00 INFO - 'tpaint', 17:00:00 INFO - 'sessionrestore', 17:00:00 INFO - 'sessionrestore_no_auto_restore', 17:00:00 INFO - 'tabpaint']}, 17:00:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['tsvgx', 17:00:00 INFO - 'tsvgr_opacity', 17:00:00 INFO - 'tart', 17:00:00 INFO - 'tscrollx', 17:00:00 INFO - 'cart']}, 17:00:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:00:00 INFO - 'tsvgr_opacity', 17:00:00 INFO - 'tart', 17:00:00 INFO - 'tscrollx', 17:00:00 INFO - 'cart']}, 17:00:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'talos_options': ['--disable-e10s'], 17:00:00 INFO - 'tests': ['tp5o']}, 17:00:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'tests': ['tp5o']}, 17:00:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'talos_options': ['--disable-e10s', 17:00:00 INFO - '--xperf_path', 17:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:00 INFO - 'tests': ['tp5n']}, 17:00:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:00 INFO - 'talos_options': ['--xperf_path', 17:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:00 INFO - 'tests': ['tp5n']}}, 17:00:00 INFO - 'talos.zip': {'path': '', 17:00:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:00 INFO - Running post-action listener: _resource_record_post_action 17:00:00 INFO - [mozharness: 2016-08-09 00:00:00.859684Z] Finished populate-webroot step (success) 17:00:00 INFO - [mozharness: 2016-08-09 00:00:00.859773Z] Running create-virtualenv step. 17:00:00 INFO - Running pre-action listener: _resource_record_pre_action 17:00:00 INFO - Running main action method: create_virtualenv 17:00:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:00: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 17:00:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:00:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:00 INFO - Using real prefix '/usr' 17:00:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:00:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:03 INFO - Installing pip.................done. 17:00:03 INFO - Return code: 0 17:00:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:03 INFO - Using env: {'DISPLAY': ':0', 17:00:03 INFO - 'HOME': '/home/cltbld', 17:00:03 INFO - 'LANG': 'en_US.UTF-8', 17:00:03 INFO - 'LANGUAGE': 'en_US:en', 17:00:03 INFO - 'LOGNAME': 'cltbld', 17:00:03 INFO - 'MAIL': '/var/mail/cltbld', 17:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:03 INFO - 'MOZ_NO_REMOTE': '1', 17:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:03 INFO - 'NO_EM_RESTART': '1', 17:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:03 INFO - 'PWD': '/builds/slave/test', 17:00:03 INFO - 'SHELL': '/bin/bash', 17:00:03 INFO - 'SHLVL': '1', 17:00:03 INFO - 'TERM': 'linux', 17:00:03 INFO - 'TMOUT': '86400', 17:00:03 INFO - 'USER': 'cltbld', 17:00:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:03 INFO - '_': '/tools/buildbot/bin/python'} 17:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00: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 17:00:03 INFO - Cleaning up... 17:00:03 INFO - Return code: 0 17:00:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:03 INFO - Using env: {'DISPLAY': ':0', 17:00:03 INFO - 'HOME': '/home/cltbld', 17:00:03 INFO - 'LANG': 'en_US.UTF-8', 17:00:03 INFO - 'LANGUAGE': 'en_US:en', 17:00:03 INFO - 'LOGNAME': 'cltbld', 17:00:03 INFO - 'MAIL': '/var/mail/cltbld', 17:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:03 INFO - 'MOZ_NO_REMOTE': '1', 17:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:03 INFO - 'NO_EM_RESTART': '1', 17:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:03 INFO - 'PWD': '/builds/slave/test', 17:00:03 INFO - 'SHELL': '/bin/bash', 17:00:03 INFO - 'SHLVL': '1', 17:00:03 INFO - 'TERM': 'linux', 17:00:03 INFO - 'TMOUT': '86400', 17:00:03 INFO - 'USER': 'cltbld', 17:00:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:03 INFO - '_': '/tools/buildbot/bin/python'} 17:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:03 INFO - Downloading/unpacking psutil>=3.1.1 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:05 INFO - Installing collected packages: psutil 17:00:05 INFO - Running setup.py install for psutil 17:00:05 INFO - building 'psutil._psutil_linux' extension 17:00: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 17:00: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:00:06 INFO - building 'psutil._psutil_posix' extension 17:00:06 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 17:00: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 17:00:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:06 INFO - Successfully installed psutil 17:00:06 INFO - Cleaning up... 17:00:06 INFO - Return code: 0 17:00:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:06 INFO - Using env: {'DISPLAY': ':0', 17:00:06 INFO - 'HOME': '/home/cltbld', 17:00:06 INFO - 'LANG': 'en_US.UTF-8', 17:00:06 INFO - 'LANGUAGE': 'en_US:en', 17:00:06 INFO - 'LOGNAME': 'cltbld', 17:00:06 INFO - 'MAIL': '/var/mail/cltbld', 17:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:06 INFO - 'MOZ_NO_REMOTE': '1', 17:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:06 INFO - 'NO_EM_RESTART': '1', 17:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:06 INFO - 'PWD': '/builds/slave/test', 17:00:06 INFO - 'SHELL': '/bin/bash', 17:00:06 INFO - 'SHLVL': '1', 17:00:06 INFO - 'TERM': 'linux', 17:00:06 INFO - 'TMOUT': '86400', 17:00:06 INFO - 'USER': 'cltbld', 17:00:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:06 INFO - '_': '/tools/buildbot/bin/python'} 17:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:00:08 INFO - Installing collected packages: mozsystemmonitor 17:00:08 INFO - Running setup.py install for mozsystemmonitor 17:00:08 INFO - Successfully installed mozsystemmonitor 17:00:08 INFO - Cleaning up... 17:00:08 INFO - Return code: 0 17:00:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:08 INFO - Using env: {'DISPLAY': ':0', 17:00:08 INFO - 'HOME': '/home/cltbld', 17:00:08 INFO - 'LANG': 'en_US.UTF-8', 17:00:08 INFO - 'LANGUAGE': 'en_US:en', 17:00:08 INFO - 'LOGNAME': 'cltbld', 17:00:08 INFO - 'MAIL': '/var/mail/cltbld', 17:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:08 INFO - 'MOZ_NO_REMOTE': '1', 17:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:08 INFO - 'NO_EM_RESTART': '1', 17:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:08 INFO - 'PWD': '/builds/slave/test', 17:00:08 INFO - 'SHELL': '/bin/bash', 17:00:08 INFO - 'SHLVL': '1', 17:00:08 INFO - 'TERM': 'linux', 17:00:08 INFO - 'TMOUT': '86400', 17:00:08 INFO - 'USER': 'cltbld', 17:00:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:08 INFO - '_': '/tools/buildbot/bin/python'} 17:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:09 INFO - Downloading/unpacking jsonschema==2.5.1 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:09 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 17:00:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:11 INFO - warning: no files found matching '*.txt' 17:00:11 INFO - no previously-included directories found matching 'build' 17:00:11 INFO - no previously-included directories found matching 'dist' 17:00:11 INFO - no previously-included directories found matching '.git*' 17:00:11 INFO - Installing collected packages: jsonschema, functools32 17:00:11 INFO - Running setup.py install for functools32 17:00:11 INFO - warning: no files found matching '*.txt' 17:00:11 INFO - no previously-included directories found matching 'build' 17:00:11 INFO - no previously-included directories found matching 'dist' 17:00:11 INFO - no previously-included directories found matching '.git*' 17:00:11 INFO - Successfully installed jsonschema functools32 17:00:11 INFO - Cleaning up... 17:00:11 INFO - Return code: 0 17:00:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:11 INFO - Using env: {'DISPLAY': ':0', 17:00:11 INFO - 'HOME': '/home/cltbld', 17:00:11 INFO - 'LANG': 'en_US.UTF-8', 17:00:11 INFO - 'LANGUAGE': 'en_US:en', 17:00:11 INFO - 'LOGNAME': 'cltbld', 17:00:11 INFO - 'MAIL': '/var/mail/cltbld', 17:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:11 INFO - 'MOZ_NO_REMOTE': '1', 17:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:11 INFO - 'NO_EM_RESTART': '1', 17:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:11 INFO - 'PWD': '/builds/slave/test', 17:00:11 INFO - 'SHELL': '/bin/bash', 17:00:11 INFO - 'SHLVL': '1', 17:00:11 INFO - 'TERM': 'linux', 17:00:11 INFO - 'TMOUT': '86400', 17:00:11 INFO - 'USER': 'cltbld', 17:00:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:11 INFO - '_': '/tools/buildbot/bin/python'} 17:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:00:11 INFO - Cleaning up... 17:00:11 INFO - Return code: 0 17:00:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:11 INFO - Using env: {'DISPLAY': ':0', 17:00:11 INFO - 'HOME': '/home/cltbld', 17:00:11 INFO - 'LANG': 'en_US.UTF-8', 17:00:11 INFO - 'LANGUAGE': 'en_US:en', 17:00:11 INFO - 'LOGNAME': 'cltbld', 17:00:11 INFO - 'MAIL': '/var/mail/cltbld', 17:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:11 INFO - 'MOZ_NO_REMOTE': '1', 17:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:11 INFO - 'NO_EM_RESTART': '1', 17:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:11 INFO - 'PWD': '/builds/slave/test', 17:00:11 INFO - 'SHELL': '/bin/bash', 17:00:11 INFO - 'SHLVL': '1', 17:00:11 INFO - 'TERM': 'linux', 17:00:11 INFO - 'TMOUT': '86400', 17:00:11 INFO - 'USER': 'cltbld', 17:00:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:11 INFO - '_': '/tools/buildbot/bin/python'} 17:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:00:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:14 INFO - Downloading docopt-0.6.1.tar.gz 17:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:14 INFO - Running setup.py install for blobuploader 17:00:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:00:14 INFO - Running setup.py install for requests 17:00:14 INFO - Running setup.py install for docopt 17:00:15 INFO - Successfully installed blobuploader requests docopt 17:00:15 INFO - Cleaning up... 17:00:15 INFO - Return code: 0 17:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00:15 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 17:00:15 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 17:00:15 INFO - Using env: {'DISPLAY': ':0', 17:00:15 INFO - 'HOME': '/home/cltbld', 17:00:15 INFO - 'LANG': 'en_US.UTF-8', 17:00:15 INFO - 'LANGUAGE': 'en_US:en', 17:00:15 INFO - 'LOGNAME': 'cltbld', 17:00:15 INFO - 'MAIL': '/var/mail/cltbld', 17:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:15 INFO - 'MOZ_NO_REMOTE': '1', 17:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:15 INFO - 'NO_EM_RESTART': '1', 17:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:15 INFO - 'PWD': '/builds/slave/test', 17:00:15 INFO - 'SHELL': '/bin/bash', 17:00:15 INFO - 'SHLVL': '1', 17:00:15 INFO - 'TERM': 'linux', 17:00:15 INFO - 'TMOUT': '86400', 17:00:15 INFO - 'USER': 'cltbld', 17:00:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:15 INFO - '_': '/tools/buildbot/bin/python'} 17:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:15 INFO - Running setup.py (path:/tmp/pip-4QNcNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:15 INFO - Running setup.py (path:/tmp/pip-DIECWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:15 INFO - Running setup.py (path:/tmp/pip-9M1CKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:15 INFO - Running setup.py (path:/tmp/pip-sK_rss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:15 INFO - Running setup.py (path:/tmp/pip-uHcQKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:15 INFO - Running setup.py (path:/tmp/pip-bMnBjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:15 INFO - Running setup.py (path:/tmp/pip-sKGSW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:15 INFO - Running setup.py (path:/tmp/pip-z6MNkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:15 INFO - Running setup.py (path:/tmp/pip-vtrWWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:16 INFO - Running setup.py (path:/tmp/pip-oFsT4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:16 INFO - Running setup.py (path:/tmp/pip-aLRfc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:16 INFO - Running setup.py (path:/tmp/pip-VIhjRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:16 INFO - Running setup.py (path:/tmp/pip-1mKjfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:16 INFO - Running setup.py (path:/tmp/pip-6afYHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:16 INFO - Running setup.py (path:/tmp/pip-rPug9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:16 INFO - Running setup.py (path:/tmp/pip-2ufgjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:16 INFO - Running setup.py (path:/tmp/pip-tfPIhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:16 INFO - Running setup.py install for manifestparser 17:00:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:00:16 INFO - Running setup.py install for mozcrash 17:00:16 INFO - Running setup.py install for mozdebug 17:00:16 INFO - Running setup.py install for mozdevice 17:00:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozfile 17:00:17 INFO - Running setup.py install for mozhttpd 17:00:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozinfo 17:00:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozInstall 17:00:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozleak 17:00:17 INFO - Running setup.py install for mozlog 17:00:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for moznetwork 17:00:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozprocess 17:00:17 INFO - Running setup.py install for mozprofile 17:00:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:00:17 INFO - Running setup.py install for mozrunner 17:00:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:00:18 INFO - Running setup.py install for mozscreenshot 17:00:18 INFO - Running setup.py install for moztest 17:00:18 INFO - Running setup.py install for mozversion 17:00:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:00:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:18 INFO - Cleaning up... 17:00:18 INFO - Return code: 0 17:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:18 INFO - Using env: {'DISPLAY': ':0', 17:00:18 INFO - 'HOME': '/home/cltbld', 17:00:18 INFO - 'LANG': 'en_US.UTF-8', 17:00:18 INFO - 'LANGUAGE': 'en_US:en', 17:00:18 INFO - 'LOGNAME': 'cltbld', 17:00:18 INFO - 'MAIL': '/var/mail/cltbld', 17:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:18 INFO - 'MOZ_NO_REMOTE': '1', 17:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:18 INFO - 'NO_EM_RESTART': '1', 17:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:18 INFO - 'PWD': '/builds/slave/test', 17:00:18 INFO - 'SHELL': '/bin/bash', 17:00:18 INFO - 'SHLVL': '1', 17:00:18 INFO - 'TERM': 'linux', 17:00:18 INFO - 'TMOUT': '86400', 17:00:18 INFO - 'USER': 'cltbld', 17:00:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:18 INFO - '_': '/tools/buildbot/bin/python'} 17:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:00:18 INFO - Running setup.py (path:/tmp/pip-N85gbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:00: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)) 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:00:18 INFO - Running setup.py (path:/tmp/pip-jUKk0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:00: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)) 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:00:18 INFO - Running setup.py (path:/tmp/pip-PQ3sY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:00: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)) 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:00:18 INFO - Running setup.py (path:/tmp/pip-jhrbej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:00: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)) 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:00:18 INFO - Running setup.py (path:/tmp/pip-eSo01z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:00: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)) 17:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:00:18 INFO - Running setup.py (path:/tmp/pip-LgbBko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:00:19 INFO - Running setup.py (path:/tmp/pip-B7gYXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:00:19 INFO - Running setup.py (path:/tmp/pip-EGYmoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:00:19 INFO - Running setup.py (path:/tmp/pip-Ca3bKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:00:19 INFO - Running setup.py (path:/tmp/pip-igrxz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:00:19 INFO - Running setup.py (path:/tmp/pip-u3EPbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:00:19 INFO - Running setup.py (path:/tmp/pip-07HUfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:00:19 INFO - Running setup.py (path:/tmp/pip-R1IvMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:00:19 INFO - Running setup.py (path:/tmp/pip-1h4OJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:00:19 INFO - Running setup.py (path:/tmp/pip-8et0X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:00:19 INFO - Running setup.py (path:/tmp/pip-MG74sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:00: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)) 17:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:00:19 INFO - Running setup.py (path:/tmp/pip-a7wWJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:21 INFO - Downloading blessings-1.6.tar.gz 17:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:21 INFO - Installing collected packages: blessings 17:00:21 INFO - Running setup.py install for blessings 17:00:21 INFO - Successfully installed blessings 17:00:21 INFO - Cleaning up... 17:00:21 INFO - Return code: 0 17:00:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:22 INFO - Reading from file tmpfile_stdout 17:00:22 INFO - Current package versions: 17:00:22 INFO - argparse == 1.2.1 17:00:22 INFO - blessings == 1.6 17:00:22 INFO - blobuploader == 1.2.4 17:00:22 INFO - docopt == 0.6.1 17:00:22 INFO - functools32 == 3.2.3-2 17:00:22 INFO - jsonschema == 2.5.1 17:00:22 INFO - manifestparser == 1.1 17:00:22 INFO - mozInstall == 1.12 17:00:22 INFO - mozcrash == 0.17 17:00:22 INFO - mozdebug == 0.1 17:00:22 INFO - mozdevice == 0.48 17:00:22 INFO - mozfile == 1.2 17:00:22 INFO - mozhttpd == 0.7 17:00:22 INFO - mozinfo == 0.9 17:00:22 INFO - mozleak == 0.1 17:00:22 INFO - mozlog == 3.3 17:00:22 INFO - moznetwork == 0.27 17:00:22 INFO - mozprocess == 0.23 17:00:22 INFO - mozprofile == 0.28 17:00:22 INFO - mozrunner == 6.12 17:00:22 INFO - mozscreenshot == 0.1 17:00:22 INFO - mozsystemmonitor == 0.3 17:00:22 INFO - moztest == 0.7 17:00:22 INFO - mozversion == 1.4 17:00:22 INFO - psutil == 3.1.1 17:00:22 INFO - requests == 1.2.3 17:00:22 INFO - wsgiref == 0.1.2 17:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00:22 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 17:00:22 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 17:00:22 INFO - Using env: {'DISPLAY': ':0', 17:00:22 INFO - 'HOME': '/home/cltbld', 17:00:22 INFO - 'LANG': 'en_US.UTF-8', 17:00:22 INFO - 'LANGUAGE': 'en_US:en', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MAIL': '/var/mail/cltbld', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SHLVL': '1', 17:00:22 INFO - 'TERM': 'linux', 17:00:22 INFO - 'TMOUT': '86400', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - '_': '/tools/buildbot/bin/python'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00: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)) 17:00:22 INFO - Cleaning up... 17:00:22 INFO - Return code: 0 17:00:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:00: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')]} 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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')]} 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00: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 0xf1c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x114b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, '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': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', '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 17:00: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 17:00: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 17:00:22 INFO - Using env: {'DISPLAY': ':0', 17:00:22 INFO - 'HOME': '/home/cltbld', 17:00:22 INFO - 'LANG': 'en_US.UTF-8', 17:00:22 INFO - 'LANGUAGE': 'en_US:en', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MAIL': '/var/mail/cltbld', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SHLVL': '1', 17:00:22 INFO - 'TERM': 'linux', 17:00:22 INFO - 'TMOUT': '86400', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - '_': '/tools/buildbot/bin/python'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:00:22 INFO - Cleaning up... 17:00:22 INFO - Return code: 0 17:00:22 INFO - Running post-action listener: _resource_record_post_action 17:00:22 INFO - Running post-action listener: _start_resource_monitoring 17:00:22 INFO - Starting resource monitoring. 17:00:22 INFO - [mozharness: 2016-08-09 00:00:22.672731Z] Finished create-virtualenv step (success) 17:00:22 INFO - [mozharness: 2016-08-09 00:00:22.673211Z] Running install step. 17:00:22 INFO - Running pre-action listener: _resource_record_pre_action 17:00:22 INFO - Running main action method: install 17:00:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:00:22 INFO - Reading from file tmpfile_stdout 17:00:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:00:22 INFO - Reading from file tmpfile_stdout 17:00:22 INFO - Output received: 17:00:22 INFO - Usage: mozinstall [options] installer 17:00:22 INFO - Options: 17:00:22 INFO - -h, --help show this help message and exit 17:00:22 INFO - -d DEST, --destination=DEST 17:00:22 INFO - Directory to install application into. [default: 17:00:22 INFO - "/builds/slave/test"] 17:00:22 INFO - --app=APP Application being installed. [default: firefox] 17:00:22 INFO - mkdir: /builds/slave/test/build/application 17:00: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'] 17:00: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 17:00:39 INFO - Reading from file tmpfile_stdout 17:00:39 INFO - Output received: 17:00:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:39 INFO - Running post-action listener: _resource_record_post_action 17:00:39 INFO - [mozharness: 2016-08-09 00:00:39.156257Z] Finished install step (success) 17:00:39 INFO - [mozharness: 2016-08-09 00:00:39.156507Z] Running run-tests step. 17:00:39 INFO - Running pre-action listener: _resource_record_pre_action 17:00:39 INFO - Running main action method: run_tests 17:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:39 INFO - Python 2.7.3 17:00:39 INFO - Return code: 0 17:00:39 INFO - grabbing minidump binary from tooltool 17:00: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')]} 17:00: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 0x11da570>, '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 0x11db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11db900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00: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 17:00: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 17:00: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 17:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:39 INFO - Return code: 0 17:00:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:00:39 INFO - Using env: {'DISPLAY': ':0', 17:00:39 INFO - 'HOME': '/home/cltbld', 17:00:39 INFO - 'LANG': 'en_US.UTF-8', 17:00:39 INFO - 'LANGUAGE': 'en_US:en', 17:00:39 INFO - 'LOGNAME': 'cltbld', 17:00:39 INFO - 'MAIL': '/var/mail/cltbld', 17:00:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:39 INFO - 'MOZ_NO_REMOTE': '1', 17:00:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:39 INFO - 'NO_EM_RESTART': '1', 17:00:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:39 INFO - 'PWD': '/builds/slave/test', 17:00:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:39 INFO - 'SHELL': '/bin/bash', 17:00:39 INFO - 'SHLVL': '1', 17:00:39 INFO - 'TERM': 'linux', 17:00:39 INFO - 'TMOUT': '86400', 17:00:39 INFO - 'USER': 'cltbld', 17:00:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719', 17:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:39 INFO - '_': '/tools/buildbot/bin/python'} 17:00:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:00:39 INFO - mozversion application_buildid: 20160808154720 17:00:39 INFO - mozversion application_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 17:00:39 INFO - mozversion application_display_name: Nightly 17:00:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:39 INFO - mozversion application_name: Firefox 17:00:39 INFO - mozversion application_remotingname: firefox 17:00:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:39 INFO - mozversion application_vendor: Mozilla 17:00:39 INFO - mozversion application_version: 51.0a1 17:00:39 INFO - mozversion platform_buildid: 20160808154720 17:00:39 INFO - mozversion platform_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 17:00:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:39 INFO - mozversion platform_version: 51.0a1 17:00:39 INFO - using testdate: 1470700839 17:00:39 INFO - actual date: 1470700839 17:00:39 INFO - starting webserver on 'localhost:41376' 17:00:39 INFO - SUITE-START | Running 2 tests 17:00:39 INFO - TEST-START | dromaeo_css 17:00:39 INFO - operating with platform_type : linux_ 17:00:39 INFO - Initialising browser for dromaeo_css test... 17:00:39 INFO - TEST-INFO | started process 19321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pRi7Y/profile http://localhost:41376/getInfo.html) 17:00:43 INFO - PROCESS | 19321 | __metrics Screen width/height:1600/1200 17:00:43 INFO - PROCESS | 19321 | colorDepth:24 17:00:43 INFO - PROCESS | 19321 | Browser inner width/height: 1024/697 17:00:43 INFO - PROCESS | 19321 | __metrics 17:00:44 ERROR - PROCESS | 19321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:00:45 INFO - TEST-INFO | 19321: exit 0 17:00:45 INFO - Browser initialized. 17:00:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:45 INFO - TEST-INFO | started process 19441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pRi7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:57 INFO - PROCESS | 19441 | RSS: Main: 164950016 17:00:57 INFO - PROCESS | 19441 | 17:01:46 INFO - PROCESS | 19441 | 1470700906889 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] 17:03:59 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41376/tests/dromaeo/cssquery-ext.html) 17:04:00 INFO - PROCESS | 19441 | RSS: Main: 166920192 17:04:00 INFO - PROCESS | 19441 | 17:07:02 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-ext.html (next: http://localhost:41376/tests/dromaeo/cssquery-jquery.html) 17:07:03 INFO - PROCESS | 19441 | RSS: Main: 166121472 17:07:03 INFO - PROCESS | 19441 | 17:10:05 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41376/tests/dromaeo/cssquery-mootools.html) 17:10:06 INFO - PROCESS | 19441 | RSS: Main: 170795008 17:10:06 INFO - PROCESS | 19441 | 17:13:08 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41376/tests/dromaeo/cssquery-prototype.html) 17:13:08 INFO - PROCESS | 19441 | RSS: Main: 165326848 17:13:08 INFO - PROCESS | 19441 | 17:16:11 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41376/tests/dromaeo/cssquery-yui.html) 17:16:12 INFO - PROCESS | 19441 | RSS: Main: 166473728 17:16:12 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-yui.html (next: http://localhost:41376/tests/dromaeo/cssquery-dojo.html) 17:19:15 INFO - PROCESS | 19441 | RSS: Main: 170496000 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | __start_tp_report 17:19:15 INFO - PROCESS | 19441 | _x_x_mozilla_page_load 17:19:15 INFO - PROCESS | 19441 | _x_x_mozilla_page_load_details 17:19:15 INFO - PROCESS | 19441 | |i|pagename|runs| 17:19:15 INFO - PROCESS | 19441 | |0;dojo.html;2663.600459931011;2679.263202619278;2689.0857108583077;2699.9055033073832;2710.891564337428;4712.293156026589;4800.855974320767;4850.927236091457;4852.9514704852945;4873.171560834658;4716.8207948013;4772.761361931907;4828.106800241958;4834.975825120879;4839.032193561285;4379.167958087961;4424.3142312941545;4449.199144154051;4557.658175636824;4557.794899229542;4475.418195634563;4533.433320834895;4564.543545645425;4568.063546972862;4584.404027476424;4310.137972405531;4374.803133858984;4468.687191896569;4472.82108715651;4536.070105628355;4429.867103986853;4491.663125265618;4556.951901062774;4557.248054071074;4560.429946256718;4450.910981780346;4468.709533880287;4471.664625153094;4494.011317510142;4526.230540808037;4652.046330502239;4832.154372984749;4887.828925987574;4909.288153217799;4913.975430122862;5115.258287548322;5155.40712818027;5174.249733788617;5227.3465816772905;5244.737763111829;5224.111900976805;5227.764750586232;5230.712310822903;5247.10799164143;5295.285136506561;4675.18184317743;4858.246971719389;4868.294097355934;4876.926846097312;4877.829275975324;5302.28419163408;5316.574674026068;5330.840074797762;5386.353637563439;5432.320959880015;5136.768845401966;5145.511176438233;5149.510796474329;5180;5190.2214667800135;4961.280614310905;5114.181730923035;5250.894982100336;5255.185446255837;5256.842294731164;5110.207917772751;5187.221916712448;5191.766370513336;5214.97392513035;5233.398159211663;5153.433122356538;5173.120569503193;5181.844544663666;5187.688738675692;5236.476352364733;4322.7190232634775;4409.603135717801;4409.691321607456;4468.3074123510905;4497.033137875307;3844.2119365529998;3891.5524714658177;3925.803709814498;3937.8031098445535;3960.8019599019935;4490.12442573695;4514.074614703978;4519.322101684708;4524.705894116872;4556.3393307970155;5005.949940500621;5198.0643484173215;5279.894402112013;5283.894322113613;5296.549793267615;4479.664025198123;4488.730676159441;4504.391907092566;4544.840930567414;4548.7725613719185;4750.786214620351;4751.596114330251;4751.762411879392;4761.357216775691;4773.188557945157;4692;4829.058333624909;4931.50684931504;4940.90118197634;4969.850904472872;5175.534201921845;5219.712915789668;5259.60552958522;5295.814646487354;5296.7351632418995;4885.633577481632;4885.95114048855;4892.2661600760175;4892.68197567157;4918.532739389752;4933.827316043921;5098.923516147187;5150.356205474316;5157.6647517911215;5166.974165129301;5195.116830138961;5276.944611077723;5281.6302858801055;5300.5494532963585;5317.308749862493;5087.542121209109;5089.389273287081;5096.05722941257;5103.489651034867;5154;4833.10587541306;5016.172331565251;5087.847364579068;5099.56653684441;5118.38579370478;5005.6996580205305;5021.322121513549;5062.949370506248;5067.543921047123;5108.131617624938;5125.538701516882;5133.178691409356;5151.845444636517;5151.974240128925;5181.792728290826;4824.49342818999;4924.50754924519;5021.7740201690285;5037.143685573388;5049.798008079636 17:19:15 INFO - PROCESS | 19441 | |1;ext.html;474.4662254963167;486.53292838874677;487.5904240438031;489.740437568089;587.5886879184571;35202.47196292058;38683.41974870376;38722;38738.61261387392;38809.22381552371;39014.21971560567;39568;39607.20785584287;39666.603333966654;39747.602523974754;7608.7336943207;7741.3419859312025;7778.027746531684;7818.296353328199;7822.33510151635;7644.388448924073;7728.536287822721;7742.303192712655;7759.922400775977;7800.180980996999;7745.457817952745;7783.961080194591;7803.921960780376;7809.414293927978;7817.530948143101;7622.4664273500875;7725.961370193169;7764.262395072459;7764.961175194145;7787.922120778776;7242.348188662993;7619.504732192389;7620.847583048363;7636.236376362375;7640.847183056308;36355.818220908994;36712;36862.44706329407;36938.630613694055;37004;2512.346789834638;2908.403777225664;2910.825350478978;3010.6086208792935;3107.1765982014786;25223.24330270095;26489.205323840124;27441.17676469689;27638.86180569084;28065;3249.5938007749032;3291.1607540077125;3308.933821323584;3370.5281260623533;3397.7281817454545;157369.2131539335;160185;160225;160546;161259.1937040319;30880.227994299872;52652;53361;53375.466245337826;53652.46347536475;31665.8416707915;32879;33269.3346133076;33293;33380.499292510634;12145.149839511327;12231.938840305742;12236.510539578318;12244.632661020183;12265.938670306592;10316.1747060235;10347.068763811292;10423.791524169474;10428.739281517872;10431.113355364727;6724.66376681164;6762.830929226809;6779.559328643721;6780.118584583973;6803.727850885909;3039.878404863781;3040.635123785116;3087.1664650544226;3096.535519672067;3126.609173853268;873.3711727556149;884.4560595233885;900.3022657440536;902.6144867628291;926.9258459323238;27476.862615687194;27800.30499237495;27929.46387948642;28641.283967900552;28853.134405967856;813.2436833744674;909.5770466733001;936.3539157980971;968.1770495079268;976.2287792643732;13702.45190192381;14409.78385324221;14431.567052988426;14602.48891288821;14745.262736863115;403334;403593;405806;407841;409753;47793.28310075351;48037;48631.75684121557;48699.513004870205;48755.512444875094;1170.4966864248454;1198.2690558759325;1199.2984104298907;1220.6094049904123;1227.6930767308172;21400.678989814853;21485;22325.218617348313;22385.77614223837;22555.323340299816;41072.79463602663;41555.584444155174;41560.16879662329;41613.79193104136;41675.583244167174;332259;334555;334615;335965;337392;24788.132415365377;24840.875795620905;24907.87546062258;24940;24945.126920557694;39007;39461.80269098636;39557.60442395539;40263.597364027155;40787.79606101951;35293.47059794054;35869.1032724184;36060.81969590135;36167.457488137174;36922;32740;33196.66803331936;33273.33453330968;33519.329613407106;34399.65600344064;23302;23583.29250122499;23740.287791366285;35077.64922350744;36602.45096323504;31549.36901261916;33056.645261238045;33090.66909330972;33159.834200829806;33451.83274083614;25333.746662533875;25472.745272547036;25799.226023219333;25799.484010319313;25899 17:19:15 INFO - PROCESS | 19441 | |2;jquery.html;359.75896149579796;367.6342039670528;368.7824183731599;374.10961910652645;382.3175631497775;15901.52295431136;16415.671686566275;17411.477655670333;17496.912515437405;17556.385526506543;14370.784438233408;15206.771898421504;15220.39118435264;15280.84719152808;15424.383024679028;4941.258811178325;5150.690958542481;5161.329027226455;5166.664166829163;5210.635255532115;5087.949120508784;5098.311727916721;5118.181091025437;5118.462561431052;5120.667156634807;4978.950210497885;5032.82385116521;5088.745562721868;5092.490750924915;5093.541581257686;4983.925241121368;4993.251012348159;4993.750312484398;5035.219540971156;5065.569426598743;4687.531246875319;4930.112579735646;4976.303317535511;5026.195808670595;5039.269305950654;12373.505059797688;12609.243445393215;18922.716159257623;20579.89710051455;20799;1963.9116239769244;1966.2528239268986;2054.8869812160324;2059.258666879922;2110.2403134871433;9165.679201227926;9263.722088337361;9326.72019839406;9627.422354658744;9684.806303873953;1622.9026258424533;1701.4895531340549;1716.862650987918;1719.785026871641;1751.4132765523566;68544.6572767138;72830;73133.26866731318;73573.2642673577;75516.86724699188;9887.851682224773;9897.773001074844;10199.949000254952;10268.435236062089;10341.793164136676;14098.295085245696;14140.222287774272;14184.148951062969;14190.503332383318;14226.644333891736;6842.4868134890085;7130.679119439637;7192.065031545865;7348.706051757977;7370.631468426557;6651.66741662915;6663.733450662016;6844.828879277959;6848.486363522656;6903.5167538271835;4229.767362795076;4342.240107981091;4379.9781001095425;4427.158839820424;4470.262406702923;1760.251892945493;1902.8477721782224;1927.4892153579312;1928.5757133430623;1948.0941362266615;802.2899733735686;827.4456114403364;848.5333066813228;868.1188593577524;892.3352102683542;16577;16891.746623800653;16928;17082.914585427243;17455;805.9476134051268;820.6963423533211;822.946508476959;847.499975014732;858.733792524307;9341.439513629068;9986.700398988041;10007.14939230159;10029.699109026595;10109.241806864515;301766;304680;307360;399465;400429.9720518157;81441.18558814336;87059;87291.56354218189;87529;88363.55818220868;897.4435849773182;907.2469850024464;943.127606963556;943.773494361362;951.8619800128943;13572.457101715821;15863.841361586236;16213.513594592181;16251.3499460025;16573.58566035859;34615.30769384649;38795;39224.60775392209;40143.1971360577;40537.18925621412;51472.48527514677;52761.94476110533;53554.46445535651;53596.732016339665;54349;7354.4484163689;7595;7624.199459056941;7721.845563088819;7733.574653394117;9773.31586788918;11534.653960380867;11752;11888.167828252286;12089.758204835678;5045.394552653705;6368.9044664330995;10219.437930913573;10238.795224095626;10550.366977981346;10131.189504839447;10160;10566.735831604272;10629.25595208328;10741.301815381976;9583.424994500352;10398.74003149897;10489.160867130764;10733.516991735547;11018.559257629606;7643.57960312166;7702;7794.72718454874;7867.17394673551;7942.364610831004;9639.518024098907;9713.465759383302;9962.501874906371;10027.197824174194;10053.949730251303 17:19:15 INFO - PROCESS | 19441 | |3;mootools.html;1334.8331458567675;1381.675306303019;1447.8769304609114;1670.1565709316808;1676.2373120230297;6523.9347606523925;7381.114266288047;7492.88760668589;7988.560629165394;8008.239217274364;7590.203028681978;7774.611269436534;7850.92149078509;7862.292393684567;7863.095743989443;2102.169642991014;2131.424515380846;2135.626265403556;2150.9139634414605;2165.7509386420606;2101.7898210179014;2131.3712454825863;2138.2409244718133;2138.9251376201837;2155.277981876073;2109.799569040939;2113.74635043795;2114.7568029676554;2121.946951326214;2170.2078741259406;2128.31893793986;2133.9893300533554;2138.946526336846;2140.6896000080055;2140.8501404901663;2049.836013118947;2102.29573093014;2107.683847422899;2112;2112.1129125767216;7885.408594355446;7900.881486777703;7903.3282171015535;7910.723124690666;7922.841543169162;4320.503142138663;4431.556844315543;4440.267355886275;4440.511543730187;4442.666799990014;2655.176895162506;2763.737444942727;2828.9858550707113;2845.8150220235825;2872.0809341010677;887.7070566712969;913.5569248914338;931.1433481197315;935.2237642756496;939.497368907638;10479.790404191874;10567.048965593056;10583.523741431578;10587.629432969808;10656.147508199248;3861.227754449121;4012.1775036117524;4068.7355321904574;4110.938335924963;4149.813258403379;9057.456552606733;9117.81764364709;9125.771855703528;9129.406588571721;9170.633174672937;4275.0594869128745;4296.37702533131;4299.6775241856985;4300.268954277781;4303.354496825501;3427.880024199141;3883.3204189266767;3950.249452603996;3962.980185099056;3996.2806694794635;3512.9297414051575;3582.7850328980344;3623.456481527739;3636.9818150909077;3694.7783133012103;1135.5117299561102;1167.2471256039807;1168.0363699947577;1170.3855475875064;1171.308927732642;646.7800947677719;677.6273049822578;680.9353111454404;688.102026854959;695.8573492434039;4870.951290487121;4924.8768780780765;4971.90056198874;5006.849794506171;5069.923951140736;407.1449955094278;412.6368795460036;415.67161942066036;417.21771678103556;421.9029623186684;3367.6463971282665;3397.8980630581123;3420.486926960976;3429.5713035870517;3502.8949131526097;9316.44101353921;9590.952045239728;9642.517874106266;9674.274429417821;9720.368176068532;9569.186619137312;9601.423914565148;9629.759256018655;9631.951840240894;9640.325177237526;7346.449016323797;7392.519486233377;7424.628768561658;7425.071866016748;7479.177290498041;4905.583025442877;4962.826301079445;5020.3724534433195;5025.3718285214345;5182.170852663556;8794;8810;8839.69061082859;8850.247728943112;8907.955460222658;8870;8935.419197752126;9125.5437228137;9220.216281616138;9221.953890230507;6439.098526206241;6442.742290308335;6474.805755827333;6571.835704107436;6577.309382514767;7085.645717713991;7107.111611048619;7114.822129446805;7124.893126603001;7136.643167841483;6290.874182516415;6324;6418.133551970424;6577.046328282277;6582.967085164735;6277.623342599459;6330.272018717722;6336.20797400325;6341.49268058545;6416.871662566816;5954.97022514902;6050.394960503914;6053.636781793107;6054.152418661303;6062.878742425215;4440.2673558862425;4568.383268258875;4579.427571553556;4590.173768721528;4625.514320996247;4363.759993200404;4389.7248217358065;4393.714408563433;4491.281394976788;4518.68369214165 17:19:15 INFO - PROCESS | 19441 | |4;prototype.html;295.3325484405244;299.11909426738254;303.83896534836515;304.7059587498065;308.05427338072116;5069.467705890884;5092.618053645978;5098.464661210575;5104.33643626328;5119.718415487156;4992.725400102993;4996.475370086143;4999;5001.499850014997;5018.54833065025;3717.646823551758;3826.7129965252716;3900.726949113563;3938.1532970411354;3941.4284928685324;3927.882163535084;3927.9018024549327;3928.921421571567;3937.5471820740554;3942.014496375906;3888.949983504452;3906.667933225679;3908.257431088098;3911.2177564487074;3924.4505769192338;3809.580946095955;3874.9031274218087;3901.1612503311926;3919.5492518360325;3925.2934471795065;3438.157651375404;3450.6894379505966;3460.5155278261063;3464.34177506273;3465.930681386383;4881.292212629149;4895.192293271606;4895.804167833282;4902.681325713853;4909.631777616693;4397.47230332359;4495.707778994355;4496.190685676577;4508.827704796744;4515.096980603892;5244.79020839166;5258.290130832327;5266.104762190398;5268.1834315681135;5281.498257665516;3794.146317078663;3800.410936304877;3800.4869342638945;3803.7527560708463;3806.5622453417936;5325.866853328659;5544.722763861791;5556.16657501374;5556.86107847303;5557.833265002057;3855.479510266134;3877.7673339599714;3884.747491413049;3905.414187871785;3909.3354129798004;3969.64273215412;3975.940360894589;3978.6817054635558;3981.4472355781268;3982.7012974027066;4468.642508599304;4470;4480.955190448119;4481.484629267676;4490.797914093809;4995.550400463903;5282.709450980156;5284.7093409862055;5285.68285902847;5307.946920530822;1318.9142705724098;1332.7001424679563;1335.6594068512468;1336.832895888014;1339.77223871942;797.6131576185545;834.3241974000957;834.6953362022819;835.4193835284419;846.734132471946;4371.846985355497;4408.7575183365225;4577;4578.198815207325;4583.541645835457;5369.838904832861;5394.676319420847;5406.513413792777;5428.4028756836715;5443.679355593085;4576.244919588231;4595.862124136282;4610.487284429993;4618.584327410549;4623.12160689468;2735.097417852104;2891.3349929515907;2905.244636394553;2908.3165456117795;2920.5765164051095;5089.618278629117;5089.618278629117;5108.322008154123;5127.794888204505;5156.767945442464;5363.570914326844;5534.1975413564805;5599.80400685974;5605.747741351649;5617.820257745919;5108;5111.849833787368;5119.3088932994315;5120.385553733501;5126.846194614168;5433.510984011458;5444.754986025718;5445.618806683494;5446.945530544644;5465;5076.771545280545;5338.946610533845;5346.78612855497;5351;5411.2153737708595;5097.847064588068;5097.92353114711;5133.820316288912;5149.562287205629;5156.56169225605;3791.374423220138;3804.4483549885667;3805.8477660894364;3828.617138286149;3830.3871380578976;5147.253648221062;5370.785168593213;5457.317835270591;5461;5461.399246082849;5281.788728450819;5282.841514754564;5283.894322113613;5292.761825717929;5293.232481290114;5223.2948551945;5284.207368894543;5290.81482148123;5310.309659744208;5318.468153184651;5083.339165908408;5153.613478989016;5202.765875535686;5208.270842082187;5210.47895210476;5027.396712394389;5162.767675454688;5225.895482090413;5239.607029472881;5281.1550151977035;5156.458571849902;5162.541097464783;5163.760697432514;5175.275461435327;5184.711594173997 17:19:15 INFO - PROCESS | 19441 | |5;yui.html;674.6559254780063;678.6708446403491;695.1014270492047;710.5772065620955;757.2843662738711;12573.622791316253;13226.603201903934;13257.867421325796;13270.137441066325;13289;13820.654483637889;13914.582562523115;13944.302784860742;13976.091554049006;14008.64978375541;618.3013195089543;738.3391864281465;740.4446665001249;742.621263155789;761.756238003839;754.1289810269147;754.4417131322809;754.8565772503234;755.2938002967243;755.2938002967243;791.6398038892319;794.6066696985;798.6166640012798;799.588212070784;799.6841247707152;787.8660627693306;788.6096382290774;788.7949133225403;789.8696715042012;793.111714879336;582.4204916108457;582.5077809251176;582.7406803972234;584.4272612839441;584.6083124306725;12257.754844903053;12398.442070106777;12398.504059837596;12406.81389779154;12429.440675169639;13166;13540.05219634626;13660.61262945413;13917.512887048904;14115;10862.185336099745;10884.836727449094;10953.123750099972;11080.279781814157;11097.944510277477;3288.983555082233;3319.0208888377747;3358.042957757052;3368.6126095499085;3416.40212962733;47128;63845;64360.999999999534;69091.309086909;69914;10556.683299501028;10626.893731062744;10645.680629581126;10759.7088349397;10899.564017439372;18474.445766626755;18639.440816775517;18701.90649046746;18781.24875005012;18826.341078062203;6779.423748981293;6783.966080169567;6948.166220053525;7142.92857071433;7223.674934627954;3770.792606406674;3877.6703980161437;3893.649571538575;3947.9013024674036;3967.861124860616;2790.121111849761;2863.498887694645;2916.6500019997734;2916.7958242923214;2925.551851833314;468.7000319795334;471.54260367443527;471.8490083173352;481.55937317354926;481.5954598137581;488.5285699300192;493.5730593036997;510.54494690133566;522.9947700523022;533.6237952243658;7922.366210703245;7969.760907172794;8087.716929907425;8164.83670326602;8325.333973282122;509.701824432711;533.906566350887;534.4762133109574;546.469924173551;550.4962958892648;3928.744631598994;3995.260876737813;4079.91840163201;4119.340905455113;4162.063535704442;104523;106394.46802765937;106485.46757266164;109217;110210;86463.56768216245;86645;86662.13337866667;86811;87223.56388218145;79139.60430197812;79452.64378849677;80372.19627803763;81313.59343203246;81831.5908420454;7792.727254546064;7847.2152784721075;7922;7924.84150317002;8109.553974531457;47765.761171193924;49025;49075.75462122667;49411.50588494069;49570.752146239036;65476;70369;71287.64356178186;71369;73093;9897.802043958936;9985.700428987142;10056.54745536438;10086;10243.463480477987;10687.358758474516;10823.458827058774;11144.387058711849;11482.196246262682;11511.481983310603;10626.36241825493;10636.255462117577;10734.302270352402;10994.505247263733;11201.103911686883;10505.264631475724;10820.945895270474;10996.780064398827;11045.171612128961;11049.889501104886;10482.109020733324;10771.19216058783;11036.558537658724;11262;11279.210455268381;8788.868166977629;9125.45247285165;9130.77173070652;9361.344705870524;9554.85667714971;8866.689665861664;9185.862212066691;9249.676261331091;9274.948012050221;9616.663416780379 17:19:15 INFO - PROCESS | 19441 | __end_tp_report 17:19:15 INFO - PROCESS | 19441 | __start_cc_report 17:19:15 INFO - PROCESS | 19441 | _x_x_mozilla_cycle_collect,359 17:19:15 INFO - PROCESS | 19441 | __end_cc_report 17:19:15 INFO - PROCESS | 19441 | __startTimestamp1470701955482__endTimestamp 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | ------- Summary: start ------- 17:19:15 INFO - PROCESS | 19441 | Number of tests: 6 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#0] dojo.html Cycles:165 Average:4816.80 Median:4913.98 stddev:507.08 (10.3%) stddev-sans-first:479.68 17:19:15 INFO - PROCESS | 19441 | Values: 2663.6 2679.3 2689.1 2699.9 2710.9 4712.3 4800.9 4850.9 4853.0 4873.2 4716.8 4772.8 4828.1 4835.0 4839.0 4379.2 4424.3 4449.2 4557.7 4557.8 4475.4 4533.4 4564.5 4568.1 4584.4 4310.1 4374.8 4468.7 4472.8 4536.1 4429.9 4491.7 4557.0 4557.2 4560.4 4450.9 4468.7 4471.7 4494.0 4526.2 4652.0 4832.2 4887.8 4909.3 4914.0 5115.3 5155.4 5174.2 5227.3 5244.7 5224.1 5227.8 5230.7 5247.1 5295.3 4675.2 4858.2 4868.3 4876.9 4877.8 5302.3 5316.6 5330.8 5386.4 5432.3 5136.8 5145.5 5149.5 5180.0 5190.2 4961.3 5114.2 5250.9 5255.2 5256.8 5110.2 5187.2 5191.8 5215.0 5233.4 5153.4 5173.1 5181.8 5187.7 5236.5 4322.7 4409.6 4409.7 4468.3 4497.0 3844.2 3891.6 3925.8 3937.8 3960.8 4490.1 4514.1 4519.3 4524.7 4556.3 5005.9 5198.1 5279.9 5283.9 5296.5 4479.7 4488.7 4504.4 4544.8 4548.8 4750.8 4751.6 4751.8 4761.4 4773.2 4692.0 4829.1 4931.5 4940.9 4969.9 5175.5 5219.7 5259.6 5295.8 5296.7 4885.6 4886.0 4892.3 4892.7 4918.5 4933.8 5098.9 5150.4 5157.7 5167.0 5195.1 5276.9 5281.6 5300.5 5317.3 5087.5 5089.4 5096.1 5103.5 5154.0 4833.1 5016.2 5087.8 5099.6 5118.4 5005.7 5021.3 5062.9 5067.5 5108.1 5125.5 5133.2 5151.8 5152.0 5181.8 4824.5 4924.5 5021.8 5037.1 5049.8 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#1] ext.html Cycles:180 Average:43896.88 Median:35247.97 stddev:84450.80 (239.6%) stddev-sans-first:84624.77 17:19:15 INFO - PROCESS | 19441 | Values: 474.5 486.5 487.6 489.7 587.6 35202.5 38683.4 38722.0 38738.6 38809.2 39014.2 39568.0 39607.2 39666.6 39747.6 7608.7 7741.3 7778.0 7818.3 7822.3 7644.4 7728.5 7742.3 7759.9 7800.2 7745.5 7784.0 7803.9 7809.4 7817.5 7622.5 7726.0 7764.3 7765.0 7787.9 7242.3 7619.5 7620.8 7636.2 7640.8 36355.8 36712.0 36862.4 36938.6 37004.0 2512.3 2908.4 2910.8 3010.6 3107.2 25223.2 26489.2 27441.2 27638.9 28065.0 3249.6 3291.2 3308.9 3370.5 3397.7 157369.2 160185.0 160225.0 160546.0 161259.2 30880.2 52652.0 53361.0 53375.5 53652.5 31665.8 32879.0 33269.3 33293.0 33380.5 12145.1 12231.9 12236.5 12244.6 12265.9 10316.2 10347.1 10423.8 10428.7 10431.1 6724.7 6762.8 6779.6 6780.1 6803.7 3039.9 3040.6 3087.2 3096.5 3126.6 873.4 884.5 900.3 902.6 926.9 27476.9 27800.3 27929.5 28641.3 28853.1 813.2 909.6 936.4 968.2 976.2 13702.5 14409.8 14431.6 14602.5 14745.3 403334.0 403593.0 405806.0 407841.0 409753.0 47793.3 48037.0 48631.8 48699.5 48755.5 1170.5 1198.3 1199.3 1220.6 1227.7 21400.7 21485.0 22325.2 22385.8 22555.3 41072.8 41555.6 41560.2 41613.8 41675.6 332259.0 334555.0 334615.0 335965.0 337392.0 24788.1 24840.9 24907.9 24940.0 24945.1 39007.0 39461.8 39557.6 40263.6 40787.8 35293.5 35869.1 36060.8 36167.5 36922.0 32740.0 33196.7 33273.3 33519.3 34399.7 23302.0 23583.3 23740.3 35077.6 36602.5 31549.4 33056.6 33090.7 33159.8 33451.8 25333.7 25472.7 25799.2 25799.5 25899.0 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#2] jquery.html Cycles:180 Average:23256.34 Median:4935.69 stddev:57898.68 (1173.1%) stddev-sans-first:58035.58 17:19:15 INFO - PROCESS | 19441 | Values: 359.8 367.6 368.8 374.1 382.3 15901.5 16415.7 17411.5 17496.9 17556.4 14370.8 15206.8 15220.4 15280.8 15424.4 4941.3 5150.7 5161.3 5166.7 5210.6 5087.9 5098.3 5118.2 5118.5 5120.7 4979.0 5032.8 5088.7 5092.5 5093.5 4983.9 4993.3 4993.8 5035.2 5065.6 4687.5 4930.1 4976.3 5026.2 5039.3 12373.5 12609.2 18922.7 20579.9 20799.0 1963.9 1966.3 2054.9 2059.3 2110.2 9165.7 9263.7 9326.7 9627.4 9684.8 1622.9 1701.5 1716.9 1719.8 1751.4 68544.7 72830.0 73133.3 73573.3 75516.9 9887.9 9897.8 10199.9 10268.4 10341.8 14098.3 14140.2 14184.1 14190.5 14226.6 6842.5 7130.7 7192.1 7348.7 7370.6 6651.7 6663.7 6844.8 6848.5 6903.5 4229.8 4342.2 4380.0 4427.2 4470.3 1760.3 1902.8 1927.5 1928.6 1948.1 802.3 827.4 848.5 868.1 892.3 16577.0 16891.7 16928.0 17082.9 17455.0 805.9 820.7 822.9 847.5 858.7 9341.4 9986.7 10007.1 10029.7 10109.2 301766.0 304680.0 307360.0 399465.0 400430.0 81441.2 87059.0 87291.6 87529.0 88363.6 897.4 907.2 943.1 943.8 951.9 13572.5 15863.8 16213.5 16251.3 16573.6 34615.3 38795.0 39224.6 40143.2 40537.2 51472.5 52761.9 53554.5 53596.7 54349.0 7354.4 7595.0 7624.2 7721.8 7733.6 9773.3 11534.7 11752.0 11888.2 12089.8 5045.4 6368.9 10219.4 10238.8 10550.4 10131.2 10160.0 10566.7 10629.3 10741.3 9583.4 10398.7 10489.2 10733.5 11018.6 7643.6 7702.0 7794.7 7867.2 7942.4 9639.5 9713.5 9962.5 10027.2 10053.9 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#3] mootools.html Cycles:180 Average:5014.97 Median:4888.27 stddev:2892.79 (59.2%) stddev-sans-first:2887.69 17:19:15 INFO - PROCESS | 19441 | Values: 1334.8 1381.7 1447.9 1670.2 1676.2 6523.9 7381.1 7492.9 7988.6 8008.2 7590.2 7774.6 7850.9 7862.3 7863.1 2102.2 2131.4 2135.6 2150.9 2165.8 2101.8 2131.4 2138.2 2138.9 2155.3 2109.8 2113.7 2114.8 2121.9 2170.2 2128.3 2134.0 2138.9 2140.7 2140.9 2049.8 2102.3 2107.7 2112.0 2112.1 7885.4 7900.9 7903.3 7910.7 7922.8 4320.5 4431.6 4440.3 4440.5 4442.7 2655.2 2763.7 2829.0 2845.8 2872.1 887.7 913.6 931.1 935.2 939.5 10479.8 10567.0 10583.5 10587.6 10656.1 3861.2 4012.2 4068.7 4110.9 4149.8 9057.5 9117.8 9125.8 9129.4 9170.6 4275.1 4296.4 4299.7 4300.3 4303.4 3427.9 3883.3 3950.2 3963.0 3996.3 3512.9 3582.8 3623.5 3637.0 3694.8 1135.5 1167.2 1168.0 1170.4 1171.3 646.8 677.6 680.9 688.1 695.9 4871.0 4924.9 4971.9 5006.8 5069.9 407.1 412.6 415.7 417.2 421.9 3367.6 3397.9 3420.5 3429.6 3502.9 9316.4 9591.0 9642.5 9674.3 9720.4 9569.2 9601.4 9629.8 9632.0 9640.3 7346.4 7392.5 7424.6 7425.1 7479.2 4905.6 4962.8 5020.4 5025.4 5182.2 8794.0 8810.0 8839.7 8850.2 8908.0 8870.0 8935.4 9125.5 9220.2 9222.0 6439.1 6442.7 6474.8 6571.8 6577.3 7085.6 7107.1 7114.8 7124.9 7136.6 6290.9 6324.0 6418.1 6577.0 6583.0 6277.6 6330.3 6336.2 6341.5 6416.9 5955.0 6050.4 6053.6 6054.2 6062.9 4440.3 4568.4 4579.4 4590.2 4625.5 4363.8 4389.7 4393.7 4491.3 4518.7 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#4] prototype.html Cycles:180 Average:4374.28 Median:5022.97 stddev:1276.81 (25.4%) stddev-sans-first:1243.15 17:19:15 INFO - PROCESS | 19441 | Values: 295.3 299.1 303.8 304.7 308.1 5069.5 5092.6 5098.5 5104.3 5119.7 4992.7 4996.5 4999.0 5001.5 5018.5 3717.6 3826.7 3900.7 3938.2 3941.4 3927.9 3927.9 3928.9 3937.5 3942.0 3888.9 3906.7 3908.3 3911.2 3924.5 3809.6 3874.9 3901.2 3919.5 3925.3 3438.2 3450.7 3460.5 3464.3 3465.9 4881.3 4895.2 4895.8 4902.7 4909.6 4397.5 4495.7 4496.2 4508.8 4515.1 5244.8 5258.3 5266.1 5268.2 5281.5 3794.1 3800.4 3800.5 3803.8 3806.6 5325.9 5544.7 5556.2 5556.9 5557.8 3855.5 3877.8 3884.7 3905.4 3909.3 3969.6 3975.9 3978.7 3981.4 3982.7 4468.6 4470.0 4481.0 4481.5 4490.8 4995.6 5282.7 5284.7 5285.7 5307.9 1318.9 1332.7 1335.7 1336.8 1339.8 797.6 834.3 834.7 835.4 846.7 4371.8 4408.8 4577.0 4578.2 4583.5 5369.8 5394.7 5406.5 5428.4 5443.7 4576.2 4595.9 4610.5 4618.6 4623.1 2735.1 2891.3 2905.2 2908.3 2920.6 5089.6 5089.6 5108.3 5127.8 5156.8 5363.6 5534.2 5599.8 5605.7 5617.8 5108.0 5111.8 5119.3 5120.4 5126.8 5433.5 5444.8 5445.6 5446.9 5465.0 5076.8 5338.9 5346.8 5351.0 5411.2 5097.8 5097.9 5133.8 5149.6 5156.6 3791.4 3804.4 3805.8 3828.6 3830.4 5147.3 5370.8 5457.3 5461.0 5461.4 5281.8 5282.8 5283.9 5292.8 5293.2 5223.3 5284.2 5290.8 5310.3 5318.5 5083.3 5153.6 5202.8 5208.3 5210.5 5027.4 5162.8 5225.9 5239.6 5281.2 5156.5 5162.5 5163.8 5175.3 5184.7 17:19:15 INFO - PROCESS | 19441 | 17:19:15 INFO - PROCESS | 19441 | [#5] yui.html Cycles:180 Average:18486.65 Median:24756.76 stddev:27395.97 (110.7%) stddev-sans-first:27440.18 17:19:15 INFO - PROCESS | 19441 | Values: 674.7 678.7 695.1 710.6 757.3 12573.6 13226.6 13257.9 13270.1 13289.0 13820.7 13914.6 13944.3 13976.1 14008.6 618.3 738.3 740.4 742.6 761.8 754.1 754.4 754.9 755.3 755.3 791.6 794.6 798.6 799.6 799.7 787.9 788.6 788.8 789.9 793.1 582.4 582.5 582.7 584.4 584.6 12257.8 12398.4 12398.5 12406.8 12429.4 13166.0 13540.1 13660.6 13917.5 14115.0 10862.2 10884.8 10953.1 11080.3 11097.9 3289.0 3319.0 3358.0 3368.6 3416.4 47128.0 63845.0 64361.0 69091.3 69914.0 10556.7 10626.9 10645.7 10759.7 10899.6 18474.4 18639.4 18701.9 18781.2 18826.3 6779.4 6784.0 6948.2 7142.9 7223.7 3770.8 3877.7 3893.6 3947.9 3967.9 2790.1 2863.5 2916.7 2916.8 2925.6 468.7 471.5 471.8 481.6 481.6 488.5 493.6 510.5 523.0 533.6 7922.4 7969.8 8087.7 8164.8 8325.3 509.7 533.9 534.5 546.5 550.5 3928.7 3995.3 4079.9 4119.3 4162.1 104523.0 106394.5 106485.5 109217.0 110210.0 86463.6 86645.0 86662.1 86811.0 87223.6 79139.6 79452.6 80372.2 81313.6 81831.6 7792.7 7847.2 7922.0 7924.8 8109.6 47765.8 49025.0 49075.8 49411.5 49570.8 65476.0 70369.0 71287.6 71369.0 73093.0 9897.8 9985.7 10056.5 10086.0 10243.5 10687.4 10823.5 11144.4 11482.2 11511.5 10626.4 10636.3 10734.3 10994.5 11201.1 10505.3 10820.9 10996.8 11045.2 11049.9 10482.1 10771.2 11036.6 11262.0 11279.2 8788.9 9125.5 9130.8 9361.3 9554.9 8866.7 9185.9 9249.7 9274.9 9616.7 17:19:15 INFO - PROCESS | 19441 | -------- Summary: end -------- 17:19:15 INFO - PROCESS | 19441 | 17:19:16 INFO - TEST-INFO | 19441: exit 0 17:19:16 INFO - TEST-OK | dromaeo_css | took 1116861ms 17:19:16 INFO - TEST-START | kraken 17:19:16 INFO - operating with platform_type : linux_ 17:19:16 INFO - Initialising browser for kraken test... 17:19:16 INFO - TEST-INFO | started process 19692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvF5hFt/profile http://localhost:41376/getInfo.html) 17:19:20 INFO - PROCESS | 19692 | __metrics Screen width/height:1600/1200 17:19:20 INFO - PROCESS | 19692 | colorDepth:24 17:19:20 INFO - PROCESS | 19692 | Browser inner width/height: 1024/697 17:19:20 INFO - PROCESS | 19692 | __metrics 17:19:21 ERROR - PROCESS | 19692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:19:22 INFO - TEST-INFO | 19692: exit 0 17:19:22 INFO - Browser initialized. 17:19:22 INFO - Running cycle 1/1 for kraken test... 17:19:22 INFO - TEST-INFO | started process 19812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvF5hFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:34 INFO - PROCESS | 19812 | RSS: Main: 164892672 17:19:34 INFO - PROCESS | 19812 | 17:19:36 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:37 INFO - PROCESS | 19812 | RSS: Main: 169844736 17:19:37 INFO - PROCESS | 19812 | 17:19:40 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-dft) 17:19:41 INFO - PROCESS | 19812 | RSS: Main: 168865792 17:19:41 INFO - PROCESS | 19812 | 17:19:44 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-fft) 17:19:44 INFO - PROCESS | 19812 | RSS: Main: 165220352 17:19:44 INFO - PROCESS | 19812 | 17:19:47 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-oscillator) 17:19:47 INFO - PROCESS | 19812 | RSS: Main: 165691392 17:19:47 INFO - PROCESS | 19812 | 17:19:49 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:50 INFO - PROCESS | 19812 | RSS: Main: 166076416 17:19:50 INFO - PROCESS | 19812 | 17:19:53 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:54 INFO - PROCESS | 19812 | RSS: Main: 166367232 17:19:54 INFO - PROCESS | 19812 | 17:19:57 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:58 INFO - PROCESS | 19812 | RSS: Main: 163733504 17:19:58 INFO - PROCESS | 19812 | 17:20:01 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41376/tests/kraken/driver.html?testName=json-parse-financial) 17:20:02 INFO - PROCESS | 19812 | RSS: Main: 165330944 17:20:02 INFO - PROCESS | 19812 | 17:20:03 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:04 INFO - PROCESS | 19812 | RSS: Main: 165863424 17:20:04 INFO - PROCESS | 19812 | 17:20:06 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:07 INFO - PROCESS | 19812 | RSS: Main: 165912576 17:20:07 INFO - PROCESS | 19812 | 17:20:09 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:10 INFO - PROCESS | 19812 | RSS: Main: 166457344 17:20:10 INFO - PROCESS | 19812 | 17:20:12 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:13 INFO - PROCESS | 19812 | RSS: Main: 166879232 17:20:13 INFO - PROCESS | 19812 | 17:20:16 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:17 INFO - PROCESS | 19812 | RSS: Main: 167022592 17:20:17 INFO - PROCESS | 19812 | 17:20:18 INFO - PROCESS | 19812 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41376/tests/kraken/driver.html?testName=ai-astar) 17:20:19 INFO - PROCESS | 19812 | RSS: Main: 167477248 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | __start_tp_report 17:20:19 INFO - PROCESS | 19812 | _x_x_mozilla_page_load 17:20:19 INFO - PROCESS | 19812 | _x_x_mozilla_page_load_details 17:20:19 INFO - PROCESS | 19812 | |i|pagename|runs| 17:20:19 INFO - PROCESS | 19812 | |0;ai-astar;106;122;111;116;114;115;116;114;115;115 17:20:19 INFO - PROCESS | 19812 | |1;audio-beat-detection;146;121;151;194;124;150;147;125;198;123 17:20:19 INFO - PROCESS | 19812 | |2;audio-dft;164;164;166;171;165;163;163;166;164;163 17:20:19 INFO - PROCESS | 19812 | |3;audio-fft;76;76;78;181;76;86;75;75;167;85 17:20:19 INFO - PROCESS | 19812 | |4;audio-oscillator;86;86;135;85;86;86;149;87;86;149 17:20:19 INFO - PROCESS | 19812 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;118;117;118 17:20:19 INFO - PROCESS | 19812 | |6;imaging-darkroom;149;147;148;147;150;151;147;149;148;147 17:20:19 INFO - PROCESS | 19812 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;95;95 17:20:19 INFO - PROCESS | 19812 | |8;json-parse-financial;64;64;64;65;64;65;65;63;64;63 17:20:19 INFO - PROCESS | 19812 | |9;json-stringify-tinderbox;65;65;65;65;66;67;66;65;65;65 17:20:19 INFO - PROCESS | 19812 | |10;stanford-crypto-aes;90;90;80;85;90;88;82;81;88;80 17:20:19 INFO - PROCESS | 19812 | |11;stanford-crypto-ccm;136;134;140;141;132;135;134;132;156;141 17:20:19 INFO - PROCESS | 19812 | |12;stanford-crypto-pbkdf2;169;174;172;174;176;173;172;169;171;168 17:20:19 INFO - PROCESS | 19812 | |13;stanford-crypto-sha256-iterative;75;69;68;69;69;70;73;72;68;73 17:20:19 INFO - PROCESS | 19812 | __end_tp_report 17:20:19 INFO - PROCESS | 19812 | __start_cc_report 17:20:19 INFO - PROCESS | 19812 | _x_x_mozilla_cycle_collect,966 17:20:19 INFO - PROCESS | 19812 | __end_cc_report 17:20:19 INFO - PROCESS | 19812 | __startTimestamp1470702019193__endTimestamp 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | ------- Summary: start ------- 17:20:19 INFO - PROCESS | 19812 | Number of tests: 14 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:4.03 (3.5%) stddev-sans-first:2.92 17:20:19 INFO - PROCESS | 19812 | Values: 106.0 122.0 111.0 116.0 114.0 115.0 116.0 114.0 115.0 115.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:148.50 stddev:28.07 (18.9%) stddev-sans-first:29.77 17:20:19 INFO - PROCESS | 19812 | Values: 146.0 121.0 151.0 194.0 124.0 150.0 147.0 125.0 198.0 123.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:2.42 (1.5%) stddev-sans-first:2.55 17:20:19 INFO - PROCESS | 19812 | Values: 164.0 164.0 166.0 171.0 165.0 163.0 163.0 166.0 164.0 163.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#3] audio-fft Cycles:10 Average:97.50 Median:76.00 stddev:40.65 (53.5%) stddev-sans-first:42.36 17:20:19 INFO - PROCESS | 19812 | Values: 76.0 76.0 78.0 181.0 76.0 86.0 75.0 75.0 167.0 85.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:28.44 (33.1%) stddev-sans-first:29.45 17:20:19 INFO - PROCESS | 19812 | Values: 86.0 86.0 135.0 85.0 86.0 86.0 149.0 87.0 86.0 149.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:20:19 INFO - PROCESS | 19812 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.42 (1.0%) stddev-sans-first:1.48 17:20:19 INFO - PROCESS | 19812 | Values: 149.0 147.0 148.0 147.0 150.0 151.0 147.0 149.0 148.0 147.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:20:19 INFO - PROCESS | 19812 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 17:20:19 INFO - PROCESS | 19812 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 63.0 64.0 63.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 17:20:19 INFO - PROCESS | 19812 | Values: 65.0 65.0 65.0 65.0 66.0 67.0 66.0 65.0 65.0 65.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:88.00 stddev:4.30 (4.9%) stddev-sans-first:4.23 17:20:19 INFO - PROCESS | 19812 | Values: 90.0 90.0 80.0 85.0 90.0 88.0 82.0 81.0 88.0 80.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:138.00 stddev:7.17 (5.2%) stddev-sans-first:7.57 17:20:19 INFO - PROCESS | 19812 | Values: 136.0 134.0 140.0 141.0 132.0 135.0 134.0 132.0 156.0 141.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.50 stddev:2.57 (1.5%) stddev-sans-first:2.52 17:20:19 INFO - PROCESS | 19812 | Values: 169.0 174.0 172.0 174.0 176.0 173.0 172.0 169.0 171.0 168.0 17:20:19 INFO - PROCESS | 19812 | 17:20:19 INFO - PROCESS | 19812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:2.46 (3.5%) stddev-sans-first:2.03 17:20:19 INFO - PROCESS | 19812 | Values: 75.0 69.0 68.0 69.0 69.0 70.0 73.0 72.0 68.0 73.0 17:20:19 INFO - PROCESS | 19812 | -------- Summary: end -------- 17:20:19 INFO - PROCESS | 19812 | 17:20:20 INFO - TEST-INFO | 19812: exit 0 17:20:20 INFO - TEST-OK | kraken | took 64034ms 17:20:20 INFO - SUITE-END | took 1180s 17:20:20 INFO - Completed test suite (00:19:40) 17:20:20 INFO - javascript benchmark 17:20:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6277.090802139804, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.600459931011, 2679.263202619278, 2689.0857108583077, 2699.9055033073832, 2710.891564337428, 4712.293156026589, 4800.855974320767, 4850.927236091457, 4852.9514704852945, 4873.171560834658, 4716.8207948013, 4772.761361931907, 4828.106800241958, 4834.975825120879, 4839.032193561285, 4379.167958087961, 4424.3142312941545, 4449.199144154051, 4557.658175636824, 4557.794899229542, 4475.418195634563, 4533.433320834895, 4564.543545645425, 4568.063546972862, 4584.404027476424, 4310.137972405531, 4374.803133858984, 4468.687191896569, 4472.82108715651, 4536.070105628355, 4429.867103986853, 4491.663125265618, 4556.951901062774, 4557.248054071074, 4560.429946256718, 4450.910981780346, 4468.709533880287, 4471.664625153094, 4494.011317510142, 4526.230540808037, 4652.046330502239, 4832.154372984749, 4887.828925987574, 4909.288153217799, 4913.975430122862, 5115.258287548322, 5155.40712818027, 5174.249733788617, 5227.3465816772905, 5244.737763111829, 5224.111900976805, 5227.764750586232, 5230.712310822903, 5247.10799164143, 5295.285136506561, 4675.18184317743, 4858.246971719389, 4868.294097355934, 4876.926846097312, 4877.829275975324, 5302.28419163408, 5316.574674026068, 5330.840074797762, 5386.353637563439, 5432.320959880015, 5136.768845401966, 5145.511176438233, 5149.510796474329, 5180.0, 5190.2214667800135, 4961.280614310905, 5114.181730923035, 5250.894982100336, 5255.185446255837, 5256.842294731164, 5110.207917772751, 5187.221916712448, 5191.766370513336, 5214.97392513035, 5233.398159211663, 5153.433122356538, 5173.120569503193, 5181.844544663666, 5187.688738675692, 5236.476352364733, 4322.7190232634775, 4409.603135717801, 4409.691321607456, 4468.3074123510905, 4497.033137875307, 3844.2119365529998, 3891.5524714658177, 3925.803709814498, 3937.8031098445535, 3960.8019599019935, 4490.12442573695, 4514.074614703978, 4519.322101684708, 4524.705894116872, 4556.3393307970155, 5005.949940500621, 5198.0643484173215, 5279.894402112013, 5283.894322113613, 5296.549793267615, 4479.664025198123, 4488.730676159441, 4504.391907092566, 4544.840930567414, 4548.7725613719185, 4750.786214620351, 4751.596114330251, 4751.762411879392, 4761.357216775691, 4773.188557945157, 4692.0, 4829.058333624909, 4931.50684931504, 4940.90118197634, 4969.850904472872, 5175.534201921845, 5219.712915789668, 5259.60552958522, 5295.814646487354, 5296.7351632418995, 4885.633577481632, 4885.95114048855, 4892.2661600760175, 4892.68197567157, 4918.532739389752, 4933.827316043921, 5098.923516147187, 5150.356205474316, 5157.6647517911215, 5166.974165129301, 5195.116830138961, 5276.944611077723, 5281.6302858801055, 5300.5494532963585, 5317.308749862493, 5087.542121209109, 5089.389273287081, 5096.05722941257, 5103.489651034867, 5154.0, 4833.10587541306, 5016.172331565251, 5087.847364579068, 5099.56653684441, 5118.38579370478, 5005.6996580205305, 5021.322121513549, 5062.949370506248, 5067.543921047123, 5108.131617624938, 5125.538701516882, 5133.178691409356, 5151.845444636517, 5151.974240128925, 5181.792728290826, 4824.49342818999, 4924.50754924519, 5021.7740201690285, 5037.143685573388, 5049.798008079636], "value": 4784.216976180628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.4662254963167, 486.53292838874677, 487.5904240438031, 489.740437568089, 587.5886879184571, 35202.47196292058, 38683.41974870376, 38722.0, 38738.61261387392, 38809.22381552371, 39014.21971560567, 39568.0, 39607.20785584287, 39666.603333966654, 39747.602523974754, 7608.7336943207, 7741.3419859312025, 7778.027746531684, 7818.296353328199, 7822.33510151635, 7644.388448924073, 7728.536287822721, 7742.303192712655, 7759.922400775977, 7800.180980996999, 7745.457817952745, 7783.961080194591, 7803.921960780376, 7809.414293927978, 7817.530948143101, 7622.4664273500875, 7725.961370193169, 7764.262395072459, 7764.961175194145, 7787.922120778776, 7242.348188662993, 7619.504732192389, 7620.847583048363, 7636.236376362375, 7640.847183056308, 36355.818220908994, 36712.0, 36862.44706329407, 36938.630613694055, 37004.0, 2512.346789834638, 2908.403777225664, 2910.825350478978, 3010.6086208792935, 3107.1765982014786, 25223.24330270095, 26489.205323840124, 27441.17676469689, 27638.86180569084, 28065.0, 3249.5938007749032, 3291.1607540077125, 3308.933821323584, 3370.5281260623533, 3397.7281817454545, 157369.2131539335, 160185.0, 160225.0, 160546.0, 161259.1937040319, 30880.227994299872, 52652.0, 53361.0, 53375.466245337826, 53652.46347536475, 31665.8416707915, 32879.0, 33269.3346133076, 33293.0, 33380.499292510634, 12145.149839511327, 12231.938840305742, 12236.510539578318, 12244.632661020183, 12265.938670306592, 10316.1747060235, 10347.068763811292, 10423.791524169474, 10428.739281517872, 10431.113355364727, 6724.66376681164, 6762.830929226809, 6779.559328643721, 6780.118584583973, 6803.727850885909, 3039.878404863781, 3040.635123785116, 3087.1664650544226, 3096.535519672067, 3126.609173853268, 873.3711727556149, 884.4560595233885, 900.3022657440536, 902.6144867628291, 926.9258459323238, 27476.862615687194, 27800.30499237495, 27929.46387948642, 28641.283967900552, 28853.134405967856, 813.2436833744674, 909.5770466733001, 936.3539157980971, 968.1770495079268, 976.2287792643732, 13702.45190192381, 14409.78385324221, 14431.567052988426, 14602.48891288821, 14745.262736863115, 403334.0, 403593.0, 405806.0, 407841.0, 409753.0, 47793.28310075351, 48037.0, 48631.75684121557, 48699.513004870205, 48755.512444875094, 1170.4966864248454, 1198.2690558759325, 1199.2984104298907, 1220.6094049904123, 1227.6930767308172, 21400.678989814853, 21485.0, 22325.218617348313, 22385.77614223837, 22555.323340299816, 41072.79463602663, 41555.584444155174, 41560.16879662329, 41613.79193104136, 41675.583244167174, 332259.0, 334555.0, 334615.0, 335965.0, 337392.0, 24788.132415365377, 24840.875795620905, 24907.87546062258, 24940.0, 24945.126920557694, 39007.0, 39461.80269098636, 39557.60442395539, 40263.597364027155, 40787.79606101951, 35293.47059794054, 35869.1032724184, 36060.81969590135, 36167.457488137174, 36922.0, 32740.0, 33196.66803331936, 33273.33453330968, 33519.329613407106, 34399.65600344064, 23302.0, 23583.29250122499, 23740.287791366285, 35077.64922350744, 36602.45096323504, 31549.36901261916, 33056.645261238045, 33090.66909330972, 33159.834200829806, 33451.83274083614, 25333.746662533875, 25472.745272547036, 25799.226023219333, 25799.484010319313, 25899.0], "value": 15618.433518780183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.75896149579796, 367.6342039670528, 368.7824183731599, 374.10961910652645, 382.3175631497775, 15901.52295431136, 16415.671686566275, 17411.477655670333, 17496.912515437405, 17556.385526506543, 14370.784438233408, 15206.771898421504, 15220.39118435264, 15280.84719152808, 15424.383024679028, 4941.258811178325, 5150.690958542481, 5161.329027226455, 5166.664166829163, 5210.635255532115, 5087.949120508784, 5098.311727916721, 5118.181091025437, 5118.462561431052, 5120.667156634807, 4978.950210497885, 5032.82385116521, 5088.745562721868, 5092.490750924915, 5093.541581257686, 4983.925241121368, 4993.251012348159, 4993.750312484398, 5035.219540971156, 5065.569426598743, 4687.531246875319, 4930.112579735646, 4976.303317535511, 5026.195808670595, 5039.269305950654, 12373.505059797688, 12609.243445393215, 18922.716159257623, 20579.89710051455, 20799.0, 1963.9116239769244, 1966.2528239268986, 2054.8869812160324, 2059.258666879922, 2110.2403134871433, 9165.679201227926, 9263.722088337361, 9326.72019839406, 9627.422354658744, 9684.806303873953, 1622.9026258424533, 1701.4895531340549, 1716.862650987918, 1719.785026871641, 1751.4132765523566, 68544.6572767138, 72830.0, 73133.26866731318, 73573.2642673577, 75516.86724699188, 9887.851682224773, 9897.773001074844, 10199.949000254952, 10268.435236062089, 10341.793164136676, 14098.295085245696, 14140.222287774272, 14184.148951062969, 14190.503332383318, 14226.644333891736, 6842.4868134890085, 7130.679119439637, 7192.065031545865, 7348.706051757977, 7370.631468426557, 6651.66741662915, 6663.733450662016, 6844.828879277959, 6848.486363522656, 6903.5167538271835, 4229.767362795076, 4342.240107981091, 4379.9781001095425, 4427.158839820424, 4470.262406702923, 1760.251892945493, 1902.8477721782224, 1927.4892153579312, 1928.5757133430623, 1948.0941362266615, 802.2899733735686, 827.4456114403364, 848.5333066813228, 868.1188593577524, 892.3352102683542, 16577.0, 16891.746623800653, 16928.0, 17082.914585427243, 17455.0, 805.9476134051268, 820.6963423533211, 822.946508476959, 847.499975014732, 858.733792524307, 9341.439513629068, 9986.700398988041, 10007.14939230159, 10029.699109026595, 10109.241806864515, 301766.0, 304680.0, 307360.0, 399465.0, 400429.9720518157, 81441.18558814336, 87059.0, 87291.56354218189, 87529.0, 88363.55818220868, 897.4435849773182, 907.2469850024464, 943.127606963556, 943.773494361362, 951.8619800128943, 13572.457101715821, 15863.841361586236, 16213.513594592181, 16251.3499460025, 16573.58566035859, 34615.30769384649, 38795.0, 39224.60775392209, 40143.1971360577, 40537.18925621412, 51472.48527514677, 52761.94476110533, 53554.46445535651, 53596.732016339665, 54349.0, 7354.4484163689, 7595.0, 7624.199459056941, 7721.845563088819, 7733.574653394117, 9773.31586788918, 11534.653960380867, 11752.0, 11888.167828252286, 12089.758204835678, 5045.394552653705, 6368.9044664330995, 10219.437930913573, 10238.795224095626, 10550.366977981346, 10131.189504839447, 10160.0, 10566.735831604272, 10629.25595208328, 10741.301815381976, 9583.424994500352, 10398.74003149897, 10489.160867130764, 10733.516991735547, 11018.559257629606, 7643.57960312166, 7702.0, 7794.72718454874, 7867.17394673551, 7942.364610831004, 9639.518024098907, 9713.465759383302, 9962.501874906371, 10027.197824174194, 10053.949730251303], "value": 8084.145694122605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.8331458567675, 1381.675306303019, 1447.8769304609114, 1670.1565709316808, 1676.2373120230297, 6523.9347606523925, 7381.114266288047, 7492.88760668589, 7988.560629165394, 8008.239217274364, 7590.203028681978, 7774.611269436534, 7850.92149078509, 7862.292393684567, 7863.095743989443, 2102.169642991014, 2131.424515380846, 2135.626265403556, 2150.9139634414605, 2165.7509386420606, 2101.7898210179014, 2131.3712454825863, 2138.2409244718133, 2138.9251376201837, 2155.277981876073, 2109.799569040939, 2113.74635043795, 2114.7568029676554, 2121.946951326214, 2170.2078741259406, 2128.31893793986, 2133.9893300533554, 2138.946526336846, 2140.6896000080055, 2140.8501404901663, 2049.836013118947, 2102.29573093014, 2107.683847422899, 2112.0, 2112.1129125767216, 7885.408594355446, 7900.881486777703, 7903.3282171015535, 7910.723124690666, 7922.841543169162, 4320.503142138663, 4431.556844315543, 4440.267355886275, 4440.511543730187, 4442.666799990014, 2655.176895162506, 2763.737444942727, 2828.9858550707113, 2845.8150220235825, 2872.0809341010677, 887.7070566712969, 913.5569248914338, 931.1433481197315, 935.2237642756496, 939.497368907638, 10479.790404191874, 10567.048965593056, 10583.523741431578, 10587.629432969808, 10656.147508199248, 3861.227754449121, 4012.1775036117524, 4068.7355321904574, 4110.938335924963, 4149.813258403379, 9057.456552606733, 9117.81764364709, 9125.771855703528, 9129.406588571721, 9170.633174672937, 4275.0594869128745, 4296.37702533131, 4299.6775241856985, 4300.268954277781, 4303.354496825501, 3427.880024199141, 3883.3204189266767, 3950.249452603996, 3962.980185099056, 3996.2806694794635, 3512.9297414051575, 3582.7850328980344, 3623.456481527739, 3636.9818150909077, 3694.7783133012103, 1135.5117299561102, 1167.2471256039807, 1168.0363699947577, 1170.3855475875064, 1171.308927732642, 646.7800947677719, 677.6273049822578, 680.9353111454404, 688.102026854959, 695.8573492434039, 4870.951290487121, 4924.8768780780765, 4971.90056198874, 5006.849794506171, 5069.923951140736, 407.1449955094278, 412.6368795460036, 415.67161942066036, 417.21771678103556, 421.9029623186684, 3367.6463971282665, 3397.8980630581123, 3420.486926960976, 3429.5713035870517, 3502.8949131526097, 9316.44101353921, 9590.952045239728, 9642.517874106266, 9674.274429417821, 9720.368176068532, 9569.186619137312, 9601.423914565148, 9629.759256018655, 9631.951840240894, 9640.325177237526, 7346.449016323797, 7392.519486233377, 7424.628768561658, 7425.071866016748, 7479.177290498041, 4905.583025442877, 4962.826301079445, 5020.3724534433195, 5025.3718285214345, 5182.170852663556, 8794.0, 8810.0, 8839.69061082859, 8850.247728943112, 8907.955460222658, 8870.0, 8935.419197752126, 9125.5437228137, 9220.216281616138, 9221.953890230507, 6439.098526206241, 6442.742290308335, 6474.805755827333, 6571.835704107436, 6577.309382514767, 7085.645717713991, 7107.111611048619, 7114.822129446805, 7124.893126603001, 7136.643167841483, 6290.874182516415, 6324.0, 6418.133551970424, 6577.046328282277, 6582.967085164735, 6277.623342599459, 6330.272018717722, 6336.20797400325, 6341.49268058545, 6416.871662566816, 5954.97022514902, 6050.394960503914, 6053.636781793107, 6054.152418661303, 6062.878742425215, 4440.2673558862425, 4568.383268258875, 4579.427571553556, 4590.173768721528, 4625.514320996247, 4363.759993200404, 4389.7248217358065, 4393.714408563433, 4491.281394976788, 4518.68369214165], "value": 3942.6019937384394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3325484405244, 299.11909426738254, 303.83896534836515, 304.7059587498065, 308.05427338072116, 5069.467705890884, 5092.618053645978, 5098.464661210575, 5104.33643626328, 5119.718415487156, 4992.725400102993, 4996.475370086143, 4999.0, 5001.499850014997, 5018.54833065025, 3717.646823551758, 3826.7129965252716, 3900.726949113563, 3938.1532970411354, 3941.4284928685324, 3927.882163535084, 3927.9018024549327, 3928.921421571567, 3937.5471820740554, 3942.014496375906, 3888.949983504452, 3906.667933225679, 3908.257431088098, 3911.2177564487074, 3924.4505769192338, 3809.580946095955, 3874.9031274218087, 3901.1612503311926, 3919.5492518360325, 3925.2934471795065, 3438.157651375404, 3450.6894379505966, 3460.5155278261063, 3464.34177506273, 3465.930681386383, 4881.292212629149, 4895.192293271606, 4895.804167833282, 4902.681325713853, 4909.631777616693, 4397.47230332359, 4495.707778994355, 4496.190685676577, 4508.827704796744, 4515.096980603892, 5244.79020839166, 5258.290130832327, 5266.104762190398, 5268.1834315681135, 5281.498257665516, 3794.146317078663, 3800.410936304877, 3800.4869342638945, 3803.7527560708463, 3806.5622453417936, 5325.866853328659, 5544.722763861791, 5556.16657501374, 5556.86107847303, 5557.833265002057, 3855.479510266134, 3877.7673339599714, 3884.747491413049, 3905.414187871785, 3909.3354129798004, 3969.64273215412, 3975.940360894589, 3978.6817054635558, 3981.4472355781268, 3982.7012974027066, 4468.642508599304, 4470.0, 4480.955190448119, 4481.484629267676, 4490.797914093809, 4995.550400463903, 5282.709450980156, 5284.7093409862055, 5285.68285902847, 5307.946920530822, 1318.9142705724098, 1332.7001424679563, 1335.6594068512468, 1336.832895888014, 1339.77223871942, 797.6131576185545, 834.3241974000957, 834.6953362022819, 835.4193835284419, 846.734132471946, 4371.846985355497, 4408.7575183365225, 4577.0, 4578.198815207325, 4583.541645835457, 5369.838904832861, 5394.676319420847, 5406.513413792777, 5428.4028756836715, 5443.679355593085, 4576.244919588231, 4595.862124136282, 4610.487284429993, 4618.584327410549, 4623.12160689468, 2735.097417852104, 2891.3349929515907, 2905.244636394553, 2908.3165456117795, 2920.5765164051095, 5089.618278629117, 5089.618278629117, 5108.322008154123, 5127.794888204505, 5156.767945442464, 5363.570914326844, 5534.1975413564805, 5599.80400685974, 5605.747741351649, 5617.820257745919, 5108.0, 5111.849833787368, 5119.3088932994315, 5120.385553733501, 5126.846194614168, 5433.510984011458, 5444.754986025718, 5445.618806683494, 5446.945530544644, 5465.0, 5076.771545280545, 5338.946610533845, 5346.78612855497, 5351.0, 5411.2153737708595, 5097.847064588068, 5097.92353114711, 5133.820316288912, 5149.562287205629, 5156.56169225605, 3791.374423220138, 3804.4483549885667, 3805.8477660894364, 3828.617138286149, 3830.3871380578976, 5147.253648221062, 5370.785168593213, 5457.317835270591, 5461.0, 5461.399246082849, 5281.788728450819, 5282.841514754564, 5283.894322113613, 5292.761825717929, 5293.232481290114, 5223.2948551945, 5284.207368894543, 5290.81482148123, 5310.309659744208, 5318.468153184651, 5083.339165908408, 5153.613478989016, 5202.765875535686, 5208.270842082187, 5210.47895210476, 5027.396712394389, 5162.767675454688, 5225.895482090413, 5239.607029472881, 5281.1550151977035, 5156.458571849902, 5162.541097464783, 5163.760697432514, 5175.275461435327, 5184.711594173997], "value": 3959.9987422754407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.6559254780063, 678.6708446403491, 695.1014270492047, 710.5772065620955, 757.2843662738711, 12573.622791316253, 13226.603201903934, 13257.867421325796, 13270.137441066325, 13289.0, 13820.654483637889, 13914.582562523115, 13944.302784860742, 13976.091554049006, 14008.64978375541, 618.3013195089543, 738.3391864281465, 740.4446665001249, 742.621263155789, 761.756238003839, 754.1289810269147, 754.4417131322809, 754.8565772503234, 755.2938002967243, 755.2938002967243, 791.6398038892319, 794.6066696985, 798.6166640012798, 799.588212070784, 799.6841247707152, 787.8660627693306, 788.6096382290774, 788.7949133225403, 789.8696715042012, 793.111714879336, 582.4204916108457, 582.5077809251176, 582.7406803972234, 584.4272612839441, 584.6083124306725, 12257.754844903053, 12398.442070106777, 12398.504059837596, 12406.81389779154, 12429.440675169639, 13166.0, 13540.05219634626, 13660.61262945413, 13917.512887048904, 14115.0, 10862.185336099745, 10884.836727449094, 10953.123750099972, 11080.279781814157, 11097.944510277477, 3288.983555082233, 3319.0208888377747, 3358.042957757052, 3368.6126095499085, 3416.40212962733, 47128.0, 63845.0, 64360.999999999534, 69091.309086909, 69914.0, 10556.683299501028, 10626.893731062744, 10645.680629581126, 10759.7088349397, 10899.564017439372, 18474.445766626755, 18639.440816775517, 18701.90649046746, 18781.24875005012, 18826.341078062203, 6779.423748981293, 6783.966080169567, 6948.166220053525, 7142.92857071433, 7223.674934627954, 3770.792606406674, 3877.6703980161437, 3893.649571538575, 3947.9013024674036, 3967.861124860616, 2790.121111849761, 2863.498887694645, 2916.6500019997734, 2916.7958242923214, 2925.551851833314, 468.7000319795334, 471.54260367443527, 471.8490083173352, 481.55937317354926, 481.5954598137581, 488.5285699300192, 493.5730593036997, 510.54494690133566, 522.9947700523022, 533.6237952243658, 7922.366210703245, 7969.760907172794, 8087.716929907425, 8164.83670326602, 8325.333973282122, 509.701824432711, 533.906566350887, 534.4762133109574, 546.469924173551, 550.4962958892648, 3928.744631598994, 3995.260876737813, 4079.91840163201, 4119.340905455113, 4162.063535704442, 104523.0, 106394.46802765937, 106485.46757266164, 109217.0, 110210.0, 86463.56768216245, 86645.0, 86662.13337866667, 86811.0, 87223.56388218145, 79139.60430197812, 79452.64378849677, 80372.19627803763, 81313.59343203246, 81831.5908420454, 7792.727254546064, 7847.2152784721075, 7922.0, 7924.84150317002, 8109.553974531457, 47765.761171193924, 49025.0, 49075.75462122667, 49411.50588494069, 49570.752146239036, 65476.0, 70369.0, 71287.64356178186, 71369.0, 73093.0, 9897.802043958936, 9985.700428987142, 10056.54745536438, 10086.0, 10243.463480477987, 10687.358758474516, 10823.458827058774, 11144.387058711849, 11482.196246262682, 11511.481983310603, 10626.36241825493, 10636.255462117577, 10734.302270352402, 10994.505247263733, 11201.103911686883, 10505.264631475724, 10820.945895270474, 10996.780064398827, 11045.171612128961, 11049.889501104886, 10482.109020733324, 10771.19216058783, 11036.558537658724, 11262.0, 11279.210455268381, 8788.868166977629, 9125.45247285165, 9130.77173070652, 9361.344705870524, 9554.85667714971, 8866.689665861664, 9185.862212066691, 9249.676261331091, 9274.948012050221, 9616.663416780379], "value": 6485.538654943981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 111.0, 116.0, 114.0, 115.0, 116.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 151.0, 194.0, 124.0, 150.0, 147.0, 125.0, 198.0, 123.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 171.0, 165.0, 163.0, 163.0, 166.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 181.0, 76.0, 86.0, 75.0, 75.0, 167.0, 85.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 135.0, 85.0, 86.0, 86.0, 149.0, 87.0, 86.0, 149.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 147.0, 150.0, 151.0, 147.0, 149.0, 148.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 63.0, 64.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 80.0, 85.0, 90.0, 88.0, 82.0, 81.0, 88.0, 80.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 140.0, 141.0, 132.0, 135.0, 134.0, 132.0, 156.0, 141.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 172.0, 174.0, 176.0, 173.0, 172.0, 169.0, 171.0, 168.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 68.0, 69.0, 69.0, 70.0, 73.0, 72.0, 68.0, 73.0], "value": 70.6, "unit": "score"}]}]} 17:20:20 INFO - Return code: 0 17:20:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:20 ERROR - # TBPL SUCCESS # 17:20:20 INFO - Running post-action listener: _resource_record_post_action 17:20:20 INFO - [mozharness: 2016-08-09 00:20:20.487669Z] Finished run-tests step (success) 17:20:20 INFO - Running post-run listener: _resource_record_post_run 17:20:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 538103808; Read time: 0; Write time: 470524 17:20:20 INFO - TinderboxPrint: CPU usage
13.3% 17:20:20 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:20:20 INFO - TinderboxPrint: I/O write bytes / time
538,103,808 / 470,524 17:20:20 INFO - TinderboxPrint: CPU idle
8,279.1 (86.7%) 17:20:20 INFO - TinderboxPrint: CPU user
1,216.2 (12.7%) 17:20:20 INFO - TinderboxPrint: Swap in / out
0 / 0 17:20:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247152640; Read time: 0; Write time: 245932 17:20:20 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286511104; Read time: 0; Write time: 224036 17:20:21 INFO - Running post-run listener: _upload_blobber_files 17:20:21 INFO - Blob upload gear active. 17:20:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:21 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 17:20:21 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:20:21 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:20:21 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:24 INFO - (blobuploader) - INFO - Done attempting. 17:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:25 INFO - (blobuploader) - INFO - Done attempting. 17:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:27 INFO - (blobuploader) - INFO - Done attempting. 17:20:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:27 INFO - Return code: 0 17:20:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe246149708c80664cb0efed54a62ce33ce16d5706eec7269b836a618d644745a561c07ee74ca548cb67e1d5f408d3143a3b7625c9ef05861d0f7c06db5caf39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fbba2c1feacf87773a0a105f1987b1ba01d5ebec6c34253ee387e597e5c4de0b9e0d3895222ad57174fb7c002e4c1a395e75cbdc69c0bf2d1f6d7fa9ea1cc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef230ca5035bdcb9442f405ea5ac8235a585b8312d003a935fd383ea5a41587ff059776684b8b4afccd470fc931c5d244d3a08bb570c1d9af2add6e38b553b92"} 17:20:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:27 INFO - Contents: 17:20:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe246149708c80664cb0efed54a62ce33ce16d5706eec7269b836a618d644745a561c07ee74ca548cb67e1d5f408d3143a3b7625c9ef05861d0f7c06db5caf39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fbba2c1feacf87773a0a105f1987b1ba01d5ebec6c34253ee387e597e5c4de0b9e0d3895222ad57174fb7c002e4c1a395e75cbdc69c0bf2d1f6d7fa9ea1cc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef230ca5035bdcb9442f405ea5ac8235a585b8312d003a935fd383ea5a41587ff059776684b8b4afccd470fc931c5d244d3a08bb570c1d9af2add6e38b553b92"} 17:20:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:27 INFO - Copying logs to upload dir... 17:20:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.039079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 17:20:27.038019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:20:27.041640) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe246149708c80664cb0efed54a62ce33ce16d5706eec7269b836a618d644745a561c07ee74ca548cb67e1d5f408d3143a3b7625c9ef05861d0f7c06db5caf39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fbba2c1feacf87773a0a105f1987b1ba01d5ebec6c34253ee387e597e5c4de0b9e0d3895222ad57174fb7c002e4c1a395e75cbdc69c0bf2d1f6d7fa9ea1cc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef230ca5035bdcb9442f405ea5ac8235a585b8312d003a935fd383ea5a41587ff059776684b8b4afccd470fc931c5d244d3a08bb570c1d9af2add6e38b553b92"} build_url:https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/Yqozyl6eRPWvNCVKqyVsbw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe246149708c80664cb0efed54a62ce33ce16d5706eec7269b836a618d644745a561c07ee74ca548cb67e1d5f408d3143a3b7625c9ef05861d0f7c06db5caf39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fbba2c1feacf87773a0a105f1987b1ba01d5ebec6c34253ee387e597e5c4de0b9e0d3895222ad57174fb7c002e4c1a395e75cbdc69c0bf2d1f6d7fa9ea1cc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef230ca5035bdcb9442f405ea5ac8235a585b8312d003a935fd383ea5a41587ff059776684b8b4afccd470fc931c5d244d3a08bb570c1d9af2add6e38b553b92"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:20:27.067483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:20:27.068077) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470700517.974599-846376719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:20:27.152477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:20:27.152981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:20:27.153336) ========= ========= Total master_lag: 0.17 =========