builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1469200378.2 results: success (0) buildid: 20160722053022 builduid: ff069ad7b5084a04b0abdfd28e93d1bf revision: e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.200886) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.201470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.201764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.214414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.214690) ========= 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=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 08:12:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-22 08:12:58 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.307550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.307875) ========= 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=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:58.357404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:12:58.357770) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 --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=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 08:12:58,447 truncating revision to first 12 chars 2016-07-22 08:12:58,448 Setting DEBUG logging. 2016-07-22 08:12:58,448 attempt 1/10 2016-07-22 08:12:58,448 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5ebff5eb655?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 08:12:59,385 unpacking tar archive at: fx-team-e5ebff5eb655/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:12:59.630890) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:59.631233) ========= script_repo_revision: e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:59.631683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:59.631976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:12:59.641505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-22 08:12:59.641824) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:59 INFO - MultiFileLogger online at 20160722 08:12:59 in /builds/slave/test 08:12:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:12:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:59 INFO - {'append_to_log': False, 08:12:59 INFO - 'base_work_dir': '/builds/slave/test', 08:12:59 INFO - 'blob_upload_branch': 'Fx-Team', 08:12:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:59 INFO - 'branch': 'Fx-Team', 08:12:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:59 INFO - 'config_files': ('talos/linux_config.py',), 08:12:59 INFO - 'default_actions': ('clobber', 08:12:59 INFO - 'read-buildbot-config', 08:12:59 INFO - 'download-and-extract', 08:12:59 INFO - 'populate-webroot', 08:12:59 INFO - 'create-virtualenv', 08:12:59 INFO - 'install', 08:12:59 INFO - 'run-tests'), 08:12:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:59 INFO - 'download_minidump_stackwalk': True, 08:12:59 INFO - 'download_symbols': 'ondemand', 08:12:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:59 INFO - 'installer_path': 'installer.exe', 08:12:59 INFO - 'log_level': 'info', 08:12:59 INFO - 'log_name': 'talos', 08:12:59 INFO - 'log_to_console': True, 08:12:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:59 INFO - 'opt_config_files': (), 08:12:59 INFO - 'pip_index': False, 08:12:59 INFO - 'sps_profile': False, 08:12:59 INFO - 'sps_profile_interval': 0, 08:12:59 INFO - 'suite': 'dromaeojs-e10s', 08:12:59 INFO - 'system_bits': '32', 08:12:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:59 INFO - 'title': 'talos-linux64-ix-032', 08:12:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:59 INFO - 'use_talos_json': True, 08:12:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:59 INFO - 'work_dir': 'build'} 08:12:59 INFO - [mozharness: 2016-07-22 15:12:59.853914Z] Running clobber step. 08:12:59 INFO - Running pre-action listener: _resource_record_pre_action 08:12:59 INFO - Running main action method: clobber 08:12:59 INFO - rmtree: /builds/slave/test/build 08:12:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:00 INFO - Running post-action listener: _resource_record_post_action 08:13:00 INFO - [mozharness: 2016-07-22 15:13:00.840387Z] Finished clobber step (success) 08:13:00 INFO - [mozharness: 2016-07-22 15:13:00.840488Z] Running read-buildbot-config step. 08:13:00 INFO - Running pre-action listener: _resource_record_pre_action 08:13:00 INFO - Running main action method: read_buildbot_config 08:13:00 INFO - Using buildbot properties: 08:13:00 INFO - { 08:13:00 INFO - "project": "", 08:13:00 INFO - "product": "firefox", 08:13:00 INFO - "script_repo_revision": "production", 08:13:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:13:00 INFO - "repository": "", 08:13:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:13:00 INFO - "buildid": "20160722053022", 08:13:00 INFO - "pgo_build": "True", 08:13:00 INFO - "basedir": "/builds/slave/test", 08:13:00 INFO - "buildnumber": 966, 08:13:00 INFO - "slavename": "talos-linux64-ix-032", 08:13:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:13:00 INFO - "platform": "ubuntu64_hw", 08:13:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:13:00 INFO - "branch": "fx-team", 08:13:00 INFO - "repo_path": "integration/fx-team", 08:13:00 INFO - "revision": "e5ebff5eb655ffefbc777d1ca424b56dc8ce0283", 08:13:00 INFO - "stage_platform": "linux64-pgo", 08:13:00 INFO - "builduid": "ff069ad7b5084a04b0abdfd28e93d1bf", 08:13:00 INFO - "slavebuilddir": "test" 08:13:00 INFO - } 08:13:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:13:00 INFO - Running post-action listener: _resource_record_post_action 08:13:00 INFO - [mozharness: 2016-07-22 15:13:00.842934Z] Finished read-buildbot-config step (success) 08:13:00 INFO - [mozharness: 2016-07-22 15:13:00.843023Z] Running download-and-extract step. 08:13:00 INFO - Running pre-action listener: _resource_record_pre_action 08:13:00 INFO - Running main action method: download_and_extract 08:13:00 INFO - mkdir: /builds/slave/test/build/tests 08:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:00 INFO - https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:13:03 INFO - Downloaded 1361 bytes. 08:13:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:13:03 INFO - Using the following test package requirements: 08:13:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:13:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'jsshell-linux-x86_64.zip'], 08:13:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:03 INFO - https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:05 INFO - Downloaded 24309187 bytes. 08:13:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:13:06 INFO - Return code: 0 08:13:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:06 INFO - https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:09 INFO - Downloaded 24309187 bytes. 08:13:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:13:11 INFO - Return code: 0 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:11 INFO - https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:13:12 INFO - Downloaded 14403289 bytes. 08:13:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:13:12 INFO - Return code: 0 08:13:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:12 INFO - https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:13:14 INFO - Downloaded 60840852 bytes. 08:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:14 INFO - mkdir: /builds/slave/test/properties 08:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:14 INFO - Contents: 08:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:13:15 INFO - Running post-action listener: _resource_record_post_action 08:13:15 INFO - Running post-action listener: set_extra_try_arguments 08:13:15 INFO - [mozharness: 2016-07-22 15:13:15.382534Z] Finished download-and-extract step (success) 08:13:15 INFO - [mozharness: 2016-07-22 15:13:15.382857Z] Running populate-webroot step. 08:13:15 INFO - Running pre-action listener: _resource_record_pre_action 08:13:15 INFO - Running main action method: populate_webroot 08:13:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:15 INFO - '--tppagecycles', 08:13:15 INFO - '7'], 08:13:15 INFO - 'tests': ['tsvgm']}}, 08:13:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['damp', 'tps']}, 08:13:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'tests': ['damp', 'tps']}, 08:13:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['dromaeo_dom']}, 08:13:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['basic_compositor_video']}, 08:13:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:13:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['a11yr', 08:13:15 INFO - 'ts_paint', 08:13:15 INFO - 'tpaint', 08:13:15 INFO - 'sessionrestore', 08:13:15 INFO - 'sessionrestore_no_auto_restore', 08:13:15 INFO - 'tabpaint']}, 08:13:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['tsvgx', 08:13:15 INFO - 'tsvgr_opacity', 08:13:15 INFO - 'tart', 08:13:15 INFO - 'tscrollx', 08:13:15 INFO - 'cart']}, 08:13:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:15 INFO - 'tsvgr_opacity', 08:13:15 INFO - 'tart', 08:13:15 INFO - 'tscrollx', 08:13:15 INFO - 'cart']}, 08:13:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'talos_options': ['--disable-e10s'], 08:13:15 INFO - 'tests': ['tp5o']}, 08:13:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'tests': ['tp5o']}, 08:13:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'talos_options': ['--disable-e10s', 08:13:15 INFO - '--xperf_path', 08:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:15 INFO - 'tests': ['tp5n']}, 08:13:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:15 INFO - 'talos_options': ['--xperf_path', 08:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:15 INFO - 'tests': ['tp5n']}}, 08:13:15 INFO - 'talos.zip': {'path': '', 08:13:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:15 INFO - Running post-action listener: _resource_record_post_action 08:13:15 INFO - [mozharness: 2016-07-22 15:13:15.403314Z] Finished populate-webroot step (success) 08:13:15 INFO - [mozharness: 2016-07-22 15:13:15.403403Z] Running create-virtualenv step. 08:13:15 INFO - Running pre-action listener: _resource_record_pre_action 08:13:15 INFO - Running main action method: create_virtualenv 08:13:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:13:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:15 INFO - Using real prefix '/usr' 08:13:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:18 INFO - Installing pip.................done. 08:13:18 INFO - Return code: 0 08:13:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:13:18 INFO - Using env: {'DISPLAY': ':0', 08:13:18 INFO - 'HOME': '/home/cltbld', 08:13:18 INFO - 'LANG': 'en_US.UTF-8', 08:13:18 INFO - 'LANGUAGE': 'en_US:en', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MAIL': '/var/mail/cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SHLVL': '1', 08:13:18 INFO - 'TERM': 'linux', 08:13:18 INFO - 'TMOUT': '86400', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - '_': '/tools/buildbot/bin/python'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:13:18 INFO - Cleaning up... 08:13:18 INFO - Return code: 0 08:13:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:13:18 INFO - Using env: {'DISPLAY': ':0', 08:13:18 INFO - 'HOME': '/home/cltbld', 08:13:18 INFO - 'LANG': 'en_US.UTF-8', 08:13:18 INFO - 'LANGUAGE': 'en_US:en', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MAIL': '/var/mail/cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SHLVL': '1', 08:13:18 INFO - 'TERM': 'linux', 08:13:18 INFO - 'TMOUT': '86400', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - '_': '/tools/buildbot/bin/python'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 INFO - Downloading/unpacking psutil>=3.1.1 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:20 INFO - Installing collected packages: psutil 08:13:20 INFO - Running setup.py install for psutil 08:13:20 INFO - building 'psutil._psutil_linux' extension 08:13:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:13:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:13:20 INFO - building 'psutil._psutil_posix' extension 08:13:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:13:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:20 INFO - Successfully installed psutil 08:13:20 INFO - Cleaning up... 08:13:20 INFO - Return code: 0 08:13:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:20 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:13:20 INFO - Using env: {'DISPLAY': ':0', 08:13:20 INFO - 'HOME': '/home/cltbld', 08:13:20 INFO - 'LANG': 'en_US.UTF-8', 08:13:20 INFO - 'LANGUAGE': 'en_US:en', 08:13:20 INFO - 'LOGNAME': 'cltbld', 08:13:20 INFO - 'MAIL': '/var/mail/cltbld', 08:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:20 INFO - 'MOZ_NO_REMOTE': '1', 08:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:20 INFO - 'NO_EM_RESTART': '1', 08:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:20 INFO - 'PWD': '/builds/slave/test', 08:13:20 INFO - 'SHELL': '/bin/bash', 08:13:20 INFO - 'SHLVL': '1', 08:13:20 INFO - 'TERM': 'linux', 08:13:20 INFO - 'TMOUT': '86400', 08:13:20 INFO - 'USER': 'cltbld', 08:13:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:20 INFO - '_': '/tools/buildbot/bin/python'} 08:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:23 INFO - Installing collected packages: mozsystemmonitor 08:13:23 INFO - Running setup.py install for mozsystemmonitor 08:13:23 INFO - Successfully installed mozsystemmonitor 08:13:23 INFO - Cleaning up... 08:13:23 INFO - Return code: 0 08:13:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:13:23 INFO - Using env: {'DISPLAY': ':0', 08:13:23 INFO - 'HOME': '/home/cltbld', 08:13:23 INFO - 'LANG': 'en_US.UTF-8', 08:13:23 INFO - 'LANGUAGE': 'en_US:en', 08:13:23 INFO - 'LOGNAME': 'cltbld', 08:13:23 INFO - 'MAIL': '/var/mail/cltbld', 08:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:23 INFO - 'MOZ_NO_REMOTE': '1', 08:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:23 INFO - 'NO_EM_RESTART': '1', 08:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:23 INFO - 'PWD': '/builds/slave/test', 08:13:23 INFO - 'SHELL': '/bin/bash', 08:13:23 INFO - 'SHLVL': '1', 08:13:23 INFO - 'TERM': 'linux', 08:13:23 INFO - 'TMOUT': '86400', 08:13:23 INFO - 'USER': 'cltbld', 08:13:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:23 INFO - '_': '/tools/buildbot/bin/python'} 08:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:25 INFO - warning: no files found matching '*.txt' 08:13:25 INFO - no previously-included directories found matching 'build' 08:13:25 INFO - no previously-included directories found matching 'dist' 08:13:25 INFO - no previously-included directories found matching '.git*' 08:13:25 INFO - Installing collected packages: jsonschema, functools32 08:13:25 INFO - Running setup.py install for functools32 08:13:25 INFO - warning: no files found matching '*.txt' 08:13:25 INFO - no previously-included directories found matching 'build' 08:13:25 INFO - no previously-included directories found matching 'dist' 08:13:25 INFO - no previously-included directories found matching '.git*' 08:13:25 INFO - Successfully installed jsonschema functools32 08:13:25 INFO - Cleaning up... 08:13:25 INFO - Return code: 0 08:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:25 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:13:25 INFO - Using env: {'DISPLAY': ':0', 08:13:25 INFO - 'HOME': '/home/cltbld', 08:13:25 INFO - 'LANG': 'en_US.UTF-8', 08:13:25 INFO - 'LANGUAGE': 'en_US:en', 08:13:25 INFO - 'LOGNAME': 'cltbld', 08:13:25 INFO - 'MAIL': '/var/mail/cltbld', 08:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:25 INFO - 'MOZ_NO_REMOTE': '1', 08:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:25 INFO - 'NO_EM_RESTART': '1', 08:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:25 INFO - 'PWD': '/builds/slave/test', 08:13:25 INFO - 'SHELL': '/bin/bash', 08:13:25 INFO - 'SHLVL': '1', 08:13:25 INFO - 'TERM': 'linux', 08:13:25 INFO - 'TMOUT': '86400', 08:13:25 INFO - 'USER': 'cltbld', 08:13:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:25 INFO - '_': '/tools/buildbot/bin/python'} 08:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:28 INFO - Downloading docopt-0.6.1.tar.gz 08:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:28 INFO - Running setup.py install for blobuploader 08:13:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:28 INFO - Running setup.py install for requests 08:13:29 INFO - Running setup.py install for docopt 08:13:29 INFO - Successfully installed blobuploader requests docopt 08:13:29 INFO - Cleaning up... 08:13:29 INFO - Return code: 0 08:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:29 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:13:29 INFO - Using env: {'DISPLAY': ':0', 08:13:29 INFO - 'HOME': '/home/cltbld', 08:13:29 INFO - 'LANG': 'en_US.UTF-8', 08:13:29 INFO - 'LANGUAGE': 'en_US:en', 08:13:29 INFO - 'LOGNAME': 'cltbld', 08:13:29 INFO - 'MAIL': '/var/mail/cltbld', 08:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:29 INFO - 'MOZ_NO_REMOTE': '1', 08:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:29 INFO - 'NO_EM_RESTART': '1', 08:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:29 INFO - 'PWD': '/builds/slave/test', 08:13:29 INFO - 'SHELL': '/bin/bash', 08:13:29 INFO - 'SHLVL': '1', 08:13:29 INFO - 'TERM': 'linux', 08:13:29 INFO - 'TMOUT': '86400', 08:13:29 INFO - 'USER': 'cltbld', 08:13:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:29 INFO - '_': '/tools/buildbot/bin/python'} 08:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:29 INFO - Running setup.py (path:/tmp/pip-nIWlCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:29 INFO - Running setup.py (path:/tmp/pip-qjZVzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:29 INFO - Running setup.py (path:/tmp/pip-O9DqYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:29 INFO - Running setup.py (path:/tmp/pip-O0h0T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:29 INFO - Running setup.py (path:/tmp/pip-HjBHnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:29 INFO - Running setup.py (path:/tmp/pip-bVx4PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:30 INFO - Running setup.py (path:/tmp/pip-tFfq3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:30 INFO - Running setup.py (path:/tmp/pip-3tSVhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:30 INFO - Running setup.py (path:/tmp/pip-E7sDV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:30 INFO - Running setup.py (path:/tmp/pip-jpZz5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:30 INFO - Running setup.py (path:/tmp/pip-NTppiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:30 INFO - Running setup.py (path:/tmp/pip-tlDgvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:30 INFO - Running setup.py (path:/tmp/pip-CnbVi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:30 INFO - Running setup.py (path:/tmp/pip-ftE713-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:30 INFO - Running setup.py (path:/tmp/pip-trn0V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:30 INFO - Running setup.py (path:/tmp/pip-y4t95z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:30 INFO - Running setup.py (path:/tmp/pip-KYGehN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:30 INFO - Running setup.py install for manifestparser 08:13:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:30 INFO - Running setup.py install for mozcrash 08:13:31 INFO - Running setup.py install for mozdebug 08:13:31 INFO - Running setup.py install for mozdevice 08:13:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for mozfile 08:13:31 INFO - Running setup.py install for mozhttpd 08:13:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for mozinfo 08:13:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for mozInstall 08:13:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for mozleak 08:13:31 INFO - Running setup.py install for mozlog 08:13:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for moznetwork 08:13:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:31 INFO - Running setup.py install for mozprocess 08:13:32 INFO - Running setup.py install for mozprofile 08:13:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:32 INFO - Running setup.py install for mozrunner 08:13:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:32 INFO - Running setup.py install for mozscreenshot 08:13:32 INFO - Running setup.py install for moztest 08:13:32 INFO - Running setup.py install for mozversion 08:13:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:32 INFO - Cleaning up... 08:13:32 INFO - Return code: 0 08:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:32 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:13:32 INFO - Using env: {'DISPLAY': ':0', 08:13:32 INFO - 'HOME': '/home/cltbld', 08:13:32 INFO - 'LANG': 'en_US.UTF-8', 08:13:32 INFO - 'LANGUAGE': 'en_US:en', 08:13:32 INFO - 'LOGNAME': 'cltbld', 08:13:32 INFO - 'MAIL': '/var/mail/cltbld', 08:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:32 INFO - 'MOZ_NO_REMOTE': '1', 08:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:32 INFO - 'NO_EM_RESTART': '1', 08:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:32 INFO - 'PWD': '/builds/slave/test', 08:13:32 INFO - 'SHELL': '/bin/bash', 08:13:32 INFO - 'SHLVL': '1', 08:13:32 INFO - 'TERM': 'linux', 08:13:32 INFO - 'TMOUT': '86400', 08:13:32 INFO - 'USER': 'cltbld', 08:13:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:32 INFO - '_': '/tools/buildbot/bin/python'} 08:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:32 INFO - Running setup.py (path:/tmp/pip-MdoQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:32 INFO - Running setup.py (path:/tmp/pip-31SeAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:32 INFO - Running setup.py (path:/tmp/pip-EONJQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:33 INFO - Running setup.py (path:/tmp/pip-_b2soF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:33 INFO - Running setup.py (path:/tmp/pip-Kv7BB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:33 INFO - Running setup.py (path:/tmp/pip-qLGgWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:33 INFO - Running setup.py (path:/tmp/pip-ZfaKnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:33 INFO - Running setup.py (path:/tmp/pip-j7dUzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:33 INFO - Running setup.py (path:/tmp/pip-PD16AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:33 INFO - Running setup.py (path:/tmp/pip-y8zhgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:33 INFO - Running setup.py (path:/tmp/pip-wSEmv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:33 INFO - Running setup.py (path:/tmp/pip-5YSnhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:33 INFO - Running setup.py (path:/tmp/pip-Sf05sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:33 INFO - Running setup.py (path:/tmp/pip-qHeZt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:33 INFO - Running setup.py (path:/tmp/pip-nn9TXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:33 INFO - Running setup.py (path:/tmp/pip-4IBQ8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:33 INFO - Running setup.py (path:/tmp/pip-HmOQ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:13:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:35 INFO - Downloading blessings-1.6.tar.gz 08:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:36 INFO - Installing collected packages: blessings 08:13:36 INFO - Running setup.py install for blessings 08:13:36 INFO - Successfully installed blessings 08:13:36 INFO - Cleaning up... 08:13:36 INFO - Return code: 0 08:13:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:36 INFO - Reading from file tmpfile_stdout 08:13:36 INFO - Current package versions: 08:13:36 INFO - argparse == 1.2.1 08:13:36 INFO - blessings == 1.6 08:13:36 INFO - blobuploader == 1.2.4 08:13:36 INFO - docopt == 0.6.1 08:13:36 INFO - functools32 == 3.2.3-2 08:13:36 INFO - jsonschema == 2.5.1 08:13:36 INFO - manifestparser == 1.1 08:13:36 INFO - mozInstall == 1.12 08:13:36 INFO - mozcrash == 0.17 08:13:36 INFO - mozdebug == 0.1 08:13:36 INFO - mozdevice == 0.48 08:13:36 INFO - mozfile == 1.2 08:13:36 INFO - mozhttpd == 0.7 08:13:36 INFO - mozinfo == 0.9 08:13:36 INFO - mozleak == 0.1 08:13:36 INFO - mozlog == 3.3 08:13:36 INFO - moznetwork == 0.27 08:13:36 INFO - mozprocess == 0.23 08:13:36 INFO - mozprofile == 0.28 08:13:36 INFO - mozrunner == 6.12 08:13:36 INFO - mozscreenshot == 0.1 08:13:36 INFO - mozsystemmonitor == 0.3 08:13:36 INFO - moztest == 0.7 08:13:36 INFO - mozversion == 1.4 08:13:36 INFO - psutil == 3.1.1 08:13:36 INFO - requests == 1.2.3 08:13:36 INFO - wsgiref == 0.1.2 08:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:36 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:13:36 INFO - Using env: {'DISPLAY': ':0', 08:13:36 INFO - 'HOME': '/home/cltbld', 08:13:36 INFO - 'LANG': 'en_US.UTF-8', 08:13:36 INFO - 'LANGUAGE': 'en_US:en', 08:13:36 INFO - 'LOGNAME': 'cltbld', 08:13:36 INFO - 'MAIL': '/var/mail/cltbld', 08:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:36 INFO - 'MOZ_NO_REMOTE': '1', 08:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:36 INFO - 'NO_EM_RESTART': '1', 08:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:36 INFO - 'PWD': '/builds/slave/test', 08:13:36 INFO - 'SHELL': '/bin/bash', 08:13:36 INFO - 'SHLVL': '1', 08:13:36 INFO - 'TERM': 'linux', 08:13:36 INFO - 'TMOUT': '86400', 08:13:36 INFO - 'USER': 'cltbld', 08:13:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:36 INFO - '_': '/tools/buildbot/bin/python'} 08:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:13:36 INFO - Cleaning up... 08:13:36 INFO - Return code: 0 08:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:36 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 0x2667030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2928180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, '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': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:13:36 INFO - Using env: {'DISPLAY': ':0', 08:13:36 INFO - 'HOME': '/home/cltbld', 08:13:36 INFO - 'LANG': 'en_US.UTF-8', 08:13:36 INFO - 'LANGUAGE': 'en_US:en', 08:13:36 INFO - 'LOGNAME': 'cltbld', 08:13:36 INFO - 'MAIL': '/var/mail/cltbld', 08:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:36 INFO - 'MOZ_NO_REMOTE': '1', 08:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:36 INFO - 'NO_EM_RESTART': '1', 08:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:36 INFO - 'PWD': '/builds/slave/test', 08:13:36 INFO - 'SHELL': '/bin/bash', 08:13:36 INFO - 'SHLVL': '1', 08:13:36 INFO - 'TERM': 'linux', 08:13:36 INFO - 'TMOUT': '86400', 08:13:36 INFO - 'USER': 'cltbld', 08:13:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:36 INFO - '_': '/tools/buildbot/bin/python'} 08:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:13:36 INFO - Cleaning up... 08:13:36 INFO - Return code: 0 08:13:36 INFO - Running post-action listener: _resource_record_post_action 08:13:36 INFO - Running post-action listener: _start_resource_monitoring 08:13:36 INFO - Starting resource monitoring. 08:13:36 INFO - [mozharness: 2016-07-22 15:13:36.910848Z] Finished create-virtualenv step (success) 08:13:36 INFO - [mozharness: 2016-07-22 15:13:36.911283Z] Running install step. 08:13:36 INFO - Running pre-action listener: _resource_record_pre_action 08:13:36 INFO - Running main action method: install 08:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:37 INFO - Reading from file tmpfile_stdout 08:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:37 INFO - Reading from file tmpfile_stdout 08:13:37 INFO - Output received: 08:13:37 INFO - Usage: mozinstall [options] installer 08:13:37 INFO - Options: 08:13:37 INFO - -h, --help show this help message and exit 08:13:37 INFO - -d DEST, --destination=DEST 08:13:37 INFO - Directory to install application into. [default: 08:13:37 INFO - "/builds/slave/test"] 08:13:37 INFO - --app=APP Application being installed. [default: firefox] 08:13:37 INFO - mkdir: /builds/slave/test/build/application 08:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:13:55 INFO - Reading from file tmpfile_stdout 08:13:55 INFO - Output received: 08:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:55 INFO - Running post-action listener: _resource_record_post_action 08:13:55 INFO - [mozharness: 2016-07-22 15:13:55.999430Z] Finished install step (success) 08:13:55 INFO - [mozharness: 2016-07-22 15:13:55.999704Z] Running run-tests step. 08:13:55 INFO - Running pre-action listener: _resource_record_pre_action 08:13:56 INFO - Running main action method: run_tests 08:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:56 INFO - Python 2.7.3 08:13:56 INFO - Return code: 0 08:13:56 INFO - grabbing minidump binary from tooltool 08:13: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:56 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 0x29263b0>, '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 0x29272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2927740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:13:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:13:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:13:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:56 INFO - Return code: 0 08:13:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 08:13:56 INFO - Using env: {'DISPLAY': ':0', 08:13:56 INFO - 'HOME': '/home/cltbld', 08:13:56 INFO - 'LANG': 'en_US.UTF-8', 08:13:56 INFO - 'LANGUAGE': 'en_US:en', 08:13:56 INFO - 'LOGNAME': 'cltbld', 08:13:56 INFO - 'MAIL': '/var/mail/cltbld', 08:13:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:56 INFO - 'MOZ_NO_REMOTE': '1', 08:13:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:56 INFO - 'NO_EM_RESTART': '1', 08:13:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:56 INFO - 'PWD': '/builds/slave/test', 08:13:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:56 INFO - 'SHELL': '/bin/bash', 08:13:56 INFO - 'SHLVL': '1', 08:13:56 INFO - 'TERM': 'linux', 08:13:56 INFO - 'TMOUT': '86400', 08:13:56 INFO - 'USER': 'cltbld', 08:13:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469200355.719788-495032910', 08:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:56 INFO - '_': '/tools/buildbot/bin/python'} 08:13:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:13:56 INFO - mozversion application_buildid: 20160722053022 08:13:56 INFO - mozversion application_changeset: e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 08:13:56 INFO - mozversion application_display_name: Nightly 08:13:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:56 INFO - mozversion application_name: Firefox 08:13:56 INFO - mozversion application_remotingname: firefox 08:13:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:13:56 INFO - mozversion application_vendor: Mozilla 08:13:56 INFO - mozversion application_version: 50.0a1 08:13:56 INFO - mozversion platform_buildid: 20160722053022 08:13:56 INFO - mozversion platform_changeset: e5ebff5eb655ffefbc777d1ca424b56dc8ce0283 08:13:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:13:56 INFO - mozversion platform_version: 50.0a1 08:13:56 INFO - using testdate: 1469200436 08:13:56 INFO - actual date: 1469200436 08:13:56 INFO - starting webserver on 'localhost:35016' 08:13:56 INFO - SUITE-START | Running 2 tests 08:13:56 INFO - TEST-START | dromaeo_css 08:13:56 INFO - operating with platform_type : linux_ 08:13:56 INFO - Initialising browser for dromaeo_css test... 08:13:56 INFO - TEST-INFO | started process 13564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprSEBvE/profile http://localhost:35016/getInfo.html) 08:14:00 INFO - PROCESS | 13564 | JavaScript error: , line 0: uncaught exception: undefined 08:14:01 INFO - PROCESS | 13564 | __metrics Screen width/height:1600/1200 08:14:01 INFO - PROCESS | 13564 | colorDepth:24 08:14:01 INFO - PROCESS | 13564 | Browser inner width/height: 1024/697 08:14:01 INFO - PROCESS | 13564 | __metrics 08:14:02 ERROR - PROCESS | 13564 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:14:03 INFO - TEST-INFO | 13564: exit 0 08:14:03 INFO - Browser initialized. 08:14:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:03 INFO - TEST-INFO | started process 13686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprSEBvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:15 INFO - PROCESS | 13686 | RSS: Main: 167534592 08:14:15 INFO - PROCESS | 13686 | 08:15:04 INFO - PROCESS | 13686 | 1469200504756 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:17:13 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35016/tests/dromaeo/cssquery-ext.html) 08:17:14 INFO - PROCESS | 13686 | RSS: Main: 172179456 08:17:14 INFO - PROCESS | 13686 | 08:20:16 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-ext.html (next: http://localhost:35016/tests/dromaeo/cssquery-jquery.html) 08:20:16 INFO - PROCESS | 13686 | RSS: Main: 169021440 08:20:16 INFO - PROCESS | 13686 | 08:23:18 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35016/tests/dromaeo/cssquery-mootools.html) 08:23:19 INFO - PROCESS | 13686 | RSS: Main: 173498368 08:23:19 INFO - PROCESS | 13686 | 08:26:21 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35016/tests/dromaeo/cssquery-prototype.html) 08:26:21 INFO - PROCESS | 13686 | RSS: Main: 168284160 08:26:21 INFO - PROCESS | 13686 | 08:29:24 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35016/tests/dromaeo/cssquery-yui.html) 08:29:24 INFO - PROCESS | 13686 | RSS: Main: 169914368 08:29:24 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | Cycle 1(1): loaded http://localhost:35016/tests/dromaeo/cssquery-yui.html (next: http://localhost:35016/tests/dromaeo/cssquery-dojo.html) 08:32:27 INFO - PROCESS | 13686 | RSS: Main: 173490176 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | __start_tp_report 08:32:27 INFO - PROCESS | 13686 | _x_x_mozilla_page_load 08:32:27 INFO - PROCESS | 13686 | _x_x_mozilla_page_load_details 08:32:27 INFO - PROCESS | 13686 | |i|pagename|runs| 08:32:27 INFO - PROCESS | 13686 | |0;dojo.html;3111.1288839125045;3123.687631236875;3172.9841350793245;3179.8728050877953;3187.1235410262184;5522.420145884685;5540.473655002768;5550.222968784368;5561.833145005657;5584.078627026536;5386.069855270575;5499.835004949848;5531.751071201796;5578.107502799553;5600.85997850054;4960.2311641695505;4991.251312303148;5085.720285384303;5113.309703190059;5134.178531434971;5030.974845125769;5236.162214045753;5240.213967904807;5241.030409374259;5241.449647786984;4925.3597032385915;4965.702057876539;5034.647574669792;5059.949400505985;5122.103631864427;4931.876703082416;4934.25986102084;4951.777170027357;4958.652894297401;4996.225585034289;4889.168841296952;4924.039812236615;4966.404031516241;4984.053029924339;5044.54599086084;5436.10304299794;5438.646487978269;5461.399246082928;5488.204210389471;5491.945080549183;5882.823515294548;5897.4692277694785;5911.556633252523;5911.940880591182;5981.461668449861;5915.5859089863725;5946.910796338058;5948.196993405878;5951.880962380728;5954.612950158225;5387.353517577876;5430.3755068167275;5462.535684466785;5510.834674959758;5514.834554963358;6001.849953751192;6022.247219097613;6032.034874420072;6052.969735151296;6063.818085457443;5759.366469688331;5761.596688231783;5764.048931926269;5765;5778.6821724804695;5790.10253410722;5805.912911306334;5828.067509198592;5874.353821079678;5874.970625146932;5674.517665998436;5780.942190578125;5852;5860.09168578871;5903.0260007099205;5879.323877754113;5901.970490147522;5923.08192230205;5926.822195334147;5947.078202878561;4360.280553708666;4378.08060307339;4457.621102206349;4473.977630111829;4501.504834468205;3925.6270654287796;3970.82131304092;3972.145988612462;3998.7600743955454;4020.5979402060143;5714.0571805652435;5755.942440575541;5762.250907382014;5769.307683078057;5798.449147330997;5779.855503612359;6000.489958353502;6004.249468816398;6016.067509536029;6035.155078289043;5720.08478643415;5743.9425605744245;5758.539316854725;5778.566607504454;5831.708414579254;5070.898582028339;5071.568916642127;5075.771590278447;5084.13569693153;5090.745462726849;6041.670832416861;6254.530910181755;6255.343188965184;6262.3111457739615;6269.561130720897;5977.432143946318;6012.6392416455155;6014.308354539284;6014.9097763534455;6064.363241859542;6187.474064704551;6209.099680546386;6242;6246.9062964054665;6250.1874756281395;5710.685912274698;5870.7945221918735;5948;5949.286085669747;5984.700764961647;5829.446202610745;5830.53355731549;5914.319853216935;5941.079132734433;5965.224520812267;5744.080947048452;5756.1941328214925;5758.366579676149;5763.049096899133;5765.971170144123;5688.971555142198;5766.855828604151;5776.306843178845;5780.450857168562;5790.1893734877995;5713.05734553794;5745.885082298414;5757.453041961007;5783.334916484658;5798.362180160263;5783.392743761844;5841.4450627190345;5868.618539794899;5888.646681199141;5895.20414744004;5533.446655334435;5664.291963504562;5726.685032323096;5733.541316694571;5744.540436765133 08:32:27 INFO - PROCESS | 13686 | |1;ext.html;550.9126029881343;596.7612954818073;600.7326739600877;612.3784358875741;639.7536948274912;33947.15132121698;35597.28805423893;35759.4636080459;35838;36001.45997810035;43928;44360.77819610897;44558.1088378233;44639.330410043796;44805.103897922025;8793.032766395707;8888.999999999967;8967.327450441211;8977.506237156953;8998.910010899872;8777.605007774633;8914.687985920495;8931.50876701781;8954.462732236087;8959.328050396214;8957.19385255327;8963.507007114606;8963.955180224122;8966.193042626162;8996.505192214425;8888.288936885034;8920.643174273053;8946.41848279863;8978.730638080802;8995.910040899638;8783.429077110031;8799.868001979976;8836.690715824916;8869.600867960893;8889.955550222272;41309.793451032856;41442.171156577;41610.1677966442;41863.1627367454;41878.79060604708;3171.31816659417;3369.444041733111;3691.9261614767825;3779.8866034019024;3838.980805095957;33238.16904577381;33346.83326583376;33365.33269334624;33422.49866252008;33556.49665255023;4287.399764033038;4316.266234740102;4341.196878577473;4351.4995775485595;4430.556944305576;346297;346385;348587;349101;349503;58213.70893145592;58650.70674646685;58764;58772.41227587755;58826.11760823591;35235.29529409449;36315.27369452649;36379.636203638154;37740.811295943895;61507;15930;15992.600184995468;16116.919415403083;16119.597010074842;16120.75818862718;11898.821517677241;11964.521419143312;12011.699707507381;12042.09684273683;12115.878841211652;19542.609147816966;19581.25862379268;19665.606687866162;19675.8032419674;19705.70441443351;7119.608421536762;7232.42140628759;7308.59802710856;7417;7521.699132034657;943.7451887990342;981.3670182732097;1025.3898930136556;1033.1115240892825;1076.9353838769698;32361.838190808896;32600.83699581487;32906.341873162404;33010.83494582512;33029.3394132116;1107.479484642217;1113.7661091170783;1128.3230061962756;1130.949107290174;1166.7549814538872;17181.828181718272;17224.224909879085;17400.129993500275;17648;17703.38038168658;157949.210253948;158609;158966;159508;160036;60715;61246;61315.38684613097;61375.38624613786;61443.69278153581;1319.7426501832051;1332.5221172739143;1354.73582651384;1360.9183448993092;1368.7604669182854;30969.225769355045;31849.68150318467;32276.19309517281;32539.34921301608;32720.34559308848;53313.73343133415;53598.64013598609;53599.464005361006;53671.73164134155;53673.853045877724;485757;487485;487875;489165;491898;28198.43603127885;28654.85672571624;28825.71174288314;28996.420071598874;29262;48762.756186218845;49257.507424925294;49457.25814112719;49743.50256497389;50326;41451;42684.359734603386;43421;43654.56345436632;44705;41480;42141.78929105335;42221;42661;42864.35703464388;41833.79083104565;42277.1544569113;43461.782691086344;43887.56112438835;44463.55536444594;34574.65425345714;38102.80948595239;38420.42369364518;39045.80477097596;39447.2110557793;29453.85273073621;29578.260543486584;29853;30123.397532049676;30130.096097116246 08:32:27 INFO - PROCESS | 13686 | |2;jquery.html;384.5923321279444;386.6307676169259;402.8207447685779;409.2224772931431;415.8128842021091;13788.724225515483;18953.905230473847;19823.405297841087;20625.27811526597;20629.896850515765;18319.17563709633;18454.72317915229;18676.53308667284;19016.90491547544;19191.80808191918;5717.628354156987;5773.942260577403;5783.884322313572;5804.477597016267;6002.339742628307;5748.505388598974;5925.229720136376;5947.197128387677;5963.463288304052;5991.85020374492;5729.140628905656;5800.53595712342;5803.73883175256;5818.883622327551;5955.88088238235;5827.912581311284;5839.532837373021;5851.180834683148;5879.235699359077;5887.735051922674;5029.471905449948;5281.8151364702435;5291.708956007418;5377.489138531872;5377.51602355786;13485.932570337183;13514.391852366667;13603.115797473132;13648.112872663345;13811.585652430444;2126.7554231263293;2323.615972001268;2541.8729063546934;2861.1273561563717;2882.6396700412447;9727.56225969833;10017.148542373907;10315.690529284133;10797.244192906499;14407.78388324176;1912.6174765046908;1914.6936490161506;1927.2291083566545;1953.384683824605;1954.1499447740277;88513;99334;101920.49039754753;103252.99999999924;105312.47343763309;17237.655246894992;17529.386471473437;17781.644367112844;17896;18115.456536303933;33217.335653287286;33225.16937076592;33399.66600334014;33503.497447538306;33696;9471.952640236892;9594;9732.854007189897;9832.213422926148;10241.795164096677;7882.211778822187;7918.445708800444;7936.289585646519;8314.501129932223;8603.397762156714;8992.190702836646;9126.81746365069;9157.587908544132;9202.539873006457;9237.168654821098;3146.1819926819194;3253.9349213015607;3386.356592247465;3546.9359192242223;3636.9818150909077;943.6225509796;1035.6271742172812;1043.2071625564474;1073.0932362153967;1073.640330489295;19705.01474926248;20010.89994550018;20412;20578.176872925214;20889;989.7773001074845;1004.8090862736057;1015.0610685116385;1016.3038318751679;1022.412113034993;10723.678289651323;11476.254043487146;11563.017143542893;11602.187846850808;11669.649910502698;507639;516190;528252;537191;537727;98998.50500747451;99481.97916926813;101024;102156;102331;900.9009009009004;931.8648795924688;959.0457494792587;960.70698436976;964.1226483899758;17449.825501745327;17959.371422000168;17979.550511237325;18129.45611631653;18568.164432600297;45844.31233531566;46255.306170406795;46432;46692.299615506476;46750.298745518165;62829.68585157228;62960.37039629545;63935.36064639294;64181.679091604245;64231.67884160549;8066.314363279187;8123.18768123183;8331.16688331162;8370.37222208349;8674.609642566225;9313.86029209576;12745;12979.805302920275;13044.54344097952;13320.533781317607;11496.712582185512;11536.884631153582;12153.878461215629;12221.572244971383;12314;10817.837732433862;11543;11683.123765717775;11949.880501194877;12284.754304914031;11524.94237528807;11817.704557386134;11861.881381186078;12213.328266945404;12220;8235.29999949987;8255.876161857457;8387.370947178864;8531.786705332417;8712.041675415572;11497.482613282255;11506.194566380273;11555.2489088209;11683.707907302385;11770.470328835394 08:32:27 INFO - PROCESS | 13686 | |3;mootools.html;1400.2018849255921;1490.1729540105237;1656.287796247613;1796.2096677461923;1800.1089460716946;7899.92100078999;8227.588620568977;8566.143385661439;9143.405678630892;9204.447733136016;8594.355423343242;8735.301175905928;8837.072107428723;8860.911390886089;8871.024187339388;2380.464395511009;2459.594166962458;2459.9139030133947;2461.1755062054144;2461.963070553943;2402.795762360193;2433.1605596069417;2497.6003839385703;2503.924882253535;2516.6099254615474;2447.3269850791;2452.546278938402;2459.4958033603157;2486.465409936863;2488.415222422729;2393.090625562284;2405.5068710914306;2419.758024197584;2433.221369161869;2450.3506570758764;2346.636271377939;2348.612478940973;2353.5528249632516;2357.116081469449;2372.205311220743;8939.64241430342;8963.68627098055;9003.729888103302;9009.954950225272;9039.819203615956;5117.795288188468;5229.241759944786;5230.686158830483;5230.8692282692855;5237.921431178535;3464.6188919218866;3600.567931848195;3648.1791596890753;3650.6166852480637;3660.8535658573624;1087.9238453308271;1128.841962125303;1137.181229514748;1145.6734830573246;1158.866730326015;12501.624951251386;12650.430730617052;12666.556670516487;12670.873291267153;12835.93582032084;4691.225947718588;4708.105459962596;4746.897580898534;4813.061453016699;4935.383077115361;10591.470426478645;10637.202209834293;10638.680839574825;10720.678379648623;10735.892641073646;5293;5298.947010529845;5301.867453313698;5326.307580014573;5344.358676958712;4074.8370065197655;4795.664303498722;4821.083994041121;4887.780049897763;4907.631927605373;4105.1544251745945;4161.667066634662;4176;4244.469441319835;4277.080427708058;1284.466946217328;1321.3855557165964;1324.6820763016806;1335.2589312931223;1336.7593833110134;983.8475036369374;999.3204620857887;1008.2992320337295;1017.5878769098526;1017.5980487707315;5988.580799344004;6014.488768454643;6112.480439162721;6257.43683068526;6312.810615681537;452.69669321554636;453.41509452806173;457.8855286178455;460.83179639431364;466.9369635099286;3983.183447393277;4134.627883490441;4187.183499217624;4210.200061988213;4224.78876056196;10625.787484250272;10864.674059778219;10868.130549556017;10871.945640271906;10972.890271097347;10597.788044239072;10801.297915635458;10853.51159197838;10883.564657413615;10885.782284354269;8070.192980701883;8179.754607361789;8228.670853165926;8230.753077407688;8240.464369815943;6023.759049637965;6068.939310606837;6071.51427885777;6092.512598992159;6163.075538669235;9851.605935762489;10007.899921000697;10073.848892266475;10159.54282057324;10185.134263587677;10261.538230779484;10512.10647094975;10588.841167382341;10591.258611897401;10630.096441802534;6823.38589526945;7901.328387087162;7965.4822436541435;8028.879566806386;8151.83696326082;8719.084496128069;8843.336749743667;8853.335999800169;8856.158664926821;8904.376693631384;7799.025121859768;7818.140004599603;7863.449558530848;7891.408144389308;8244.340452763645;7515.173330933483;7545.962270188614;7557.470977031555;7712.190220026816;7855.803604909923;7088.787336379917;7167.211606723152;7220.855582888418;7257.2742725727;7276.490645654753;5334.839954801362;5353.705546194997;5358.4105748366865;5428.104362780255;5473.042217611982;5134.152864777419;5303.15149576066;5328.307320048369;5328.893422131613;5406.918896216638 08:32:27 INFO - PROCESS | 13686 | |4;prototype.html;308.23403841453967;320.5272223470381;327.86231775738196;328.1091835666166;329.2066120649236;5415.160650099231;5429.918551221725;5589.161625756138;5606.953461986376;5631.971840140799;5463;5465.781368745255;5487.670739755617;5508.862278443031;5509.696966666832;4295.720778149426;4308.547602501739;4326.74039557626;4336.197803406364;4375.912481750379;4190.559991200926;4289.849855255066;4324.956750432502;4352.303631418974;4374.60628543431;4288.506821715511;4290.313549832027;4297.419848320484;4307.418498502693;4329.242382583036;4282.957170428287;4298.763568003774;4305.117450922553;4319.308910574293;4328.935065974013;3485.1635607454027;3751.2309976455035;3792.412176112707;3807.371783655721;3832.581944680458;5366.8926621467745;5369;5386.649867758622;5424.593155513313;5434.402215756264;4856.538628830255;4859.052484765472;4865;4867.8783030424165;4876.829310974099;5520.558355331564;5675.404082571312;5702.857428564277;5782.595218334718;5788.6816225107605;4006.639402453764;4018.9349822297113;4018.9503353290033;4033.233685599727;4049.898752531181;5985.850353741148;6010.467330830654;6016.2479690038745;6026.638401695912;6039.849003774941;4012.0170558213426;4110.547839737626;4124.319487284564;4126.154138401621;4167.416561681367;4176.9582304177175;4181.895452613709;4195.937060944088;4202.411662367271;4206.85276015338;4864.586510146677;4865.781039853215;4868.95131048692;4881.560659540658;4884.242942343943;5729.255196824386;5812.331581868055;5839.211706419664;5839.678817665069;5855.121731740273;1434.9210793406255;1445.6530432696077;1458.555140682102;1461.1744364434273;1461.5469204546625;880.8634661627458;916.8212198621338;925.7731855695398;932.7434955387323;941.1999800169801;5048.460219633047;5064.999325266573;5112.060565175039;5122.615803814729;5168.586513078944;5297.596137023692;5339.652922560022;5373.623846330719;5376.973115134399;5401.243825864382;4955.776990035385;5075.670081444694;5084.51697088776;5324.92012619811;5753.252077229933;3178.8092714437207;3198.568193293922;3228.3543291341825;3234.563333949887;3243.5459035735016;6101.078160379467;6276.152719382916;6295.779647712308;6298.7480500780375;6330.335314791881;6059.545534084961;6073.665948372882;6074.90887636677;6106.755729770759;6142.232220972379;6214.533909956681;6242.750289988349;6243.843903902439;6255.24685188883;6274.40393162658;5736.856578585402;5920.822375328747;5935.516120969757;5981.671008094597;6049.062395328731;5895.20414744004;5901.970490147522;5903.7048147593305;5920.703964801656;5925.762969481172;5952.642841429528;6144.56988010835;6148.538859585459;6168.686742471573;6210.347913469021;4023.9195216094927;4145.419641250288;4147.564505726976;4150.460440142762;4159.230542349675;5960.493358064613;5961.658626808933;5962.970185149046;5979.880402392015;5991.370906054975;5656.038473459604;5794.72516046486;5813.534917206529;5822.73797679097;5845.240118784531;5799.681017543907;5840.357560668238;5843.240378750906;5850.3857095006115;5868.444862111459;5738.196652468741;5759.107338362561;5767.221425107557;5786.971065144816;5806.2451881255165;5650.982823091883;5842.737076831468;5869.273011637555;5916.26046744157;5921.4966727826895;5771.518247153765;5775.364709881994;5775.884482310246;5777.364489906023;5783.31076049639 08:32:27 INFO - PROCESS | 13686 | |5;yui.html;681.9488538359624;709.2198581560283;723.8335182907931;730.5653136383853;787.4251796188782;15141.924290378547;15488.922555387207;15489.69020619587;15639.452619158317;15693.293801778918;13342.66643333917;13620.18278903264;13631.795523067138;13634.250116243602;13686.931565342184;648.8410339466838;782.788647065292;787.3032366355787;793.9841203175934;801.767487428645;792.2829838995718;796.0924546017544;796.366888323784;797.0873350014231;797.4935915693518;857.0101532729707;857.2841677199515;857.6055014693218;857.7383897911135;859.5014891363026;845.4969293270525;851.3657325292666;852.0244320253337;852.9061803201643;853.8420392227458;620.295964080767;623.0342968398963;624.4286477872787;624.8625302433458;626.1015442839495;13801.861981380158;13861.029727919049;13866.168029918237;13900.860991390058;13946.651333716636;13725.725485490335;14874.776878346833;15693.764593531107;15801.051936883823;16092.59768505785;11410.942945285304;11590.536378544848;11708.121890858134;12290.446929888176;14513.492027778977;4331.588499092612;4471.910561788779;4544.159330523864;4556.111558246143;4606.907861842745;84322;88438.55780721056;89370.5531472345;89686;89924.44329259773;11395.202335836577;11486.655400337837;11584.42077896102;11589.188756787113;11653.475593598308;21646.134154633637;21710.89144554267;21717.891410542845;21794.673079903812;21807.890960545097;8128.39037072222;8170.346372290202;8289.58552072394;8461.875286109504;8723.956380218058;4789.177495650954;4871.342368780241;4929.704217746947;4946.876328091755;5037.01778153264;3592.550931133608;3615.6384361563632;3670.082479380155;3672.338978983755;3694.833732482045;633.3444884544474;641.0543107175343;648.7317294688872;652.1880259077384;652.2955208374943;556.774506324939;662.4832630548084;665.2748504130521;704.2957042957042;707.306839297481;9007.144321289466;9338.299627527962;9348.626054957726;9504.477253750973;9613.471259080818;557.2477155839665;658.4949819508902;700.9579425234502;707.6426404665611;710.1761956130863;4250.468691413574;4544.318352247189;4594.264917613166;4611.746353950498;4628.282616194495;126350.36824816001;129763.97006254386;130379;134408.3279583596;136285;109446;110993.44503277594;111551.44224278827;111885.44057279824;112526;95382.52308738412;96439;98337;99288;100073;8634.654613815628;8688.652453902027;8750.824983500166;8979.191872731486;9058.50178240203;55943.72028139996;56839;56967.430325696216;58279;59417.70291148517;77422;85602.14397855941;85818.57090714507;87549;91339;10909.945450272699;10936.179786516203;11063.446827658745;11116.666500005012;11205.88794112081;11990.160688751703;12118.878811211775;12598.748025039264;12625.305608191638;12817.23096614206;11718.707032323919;11859.58491452795;11861.406929653655;12062.577809776616;12312.445939932546;11667.824982625098;11819.586314479297;12212.511499539918;12545.31000794965;12740.235585864877;11307.886921131012;11331.093512519143;11573.18987670855;11580.768384632429;11635.185537012328;9247;9314.115159059878;9523.23814094857;9596.616135354509;9605.37565058297;8839.51382673959;8885.866711999455;8903.643854245758;9020.503872287087;9699.030096990527 08:32:27 INFO - PROCESS | 13686 | __end_tp_report 08:32:27 INFO - PROCESS | 13686 | __start_cc_report 08:32:27 INFO - PROCESS | 13686 | _x_x_mozilla_cycle_collect,369 08:32:27 INFO - PROCESS | 13686 | __end_cc_report 08:32:27 INFO - PROCESS | 13686 | __startTimestamp1469201547644__endTimestamp 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | ------- Summary: start ------- 08:32:27 INFO - PROCESS | 13686 | Number of tests: 6 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#0] dojo.html Cycles:165 Average:5503.51 Median:5758.37 stddev:648.05 (11.3%) stddev-sans-first:622.27 08:32:27 INFO - PROCESS | 13686 | Values: 3111.1 3123.7 3173.0 3179.9 3187.1 5522.4 5540.5 5550.2 5561.8 5584.1 5386.1 5499.8 5531.8 5578.1 5600.9 4960.2 4991.3 5085.7 5113.3 5134.2 5031.0 5236.2 5240.2 5241.0 5241.4 4925.4 4965.7 5034.6 5059.9 5122.1 4931.9 4934.3 4951.8 4958.7 4996.2 4889.2 4924.0 4966.4 4984.1 5044.5 5436.1 5438.6 5461.4 5488.2 5491.9 5882.8 5897.5 5911.6 5911.9 5981.5 5915.6 5946.9 5948.2 5951.9 5954.6 5387.4 5430.4 5462.5 5510.8 5514.8 6001.8 6022.2 6032.0 6053.0 6063.8 5759.4 5761.6 5764.0 5765.0 5778.7 5790.1 5805.9 5828.1 5874.4 5875.0 5674.5 5780.9 5852.0 5860.1 5903.0 5879.3 5902.0 5923.1 5926.8 5947.1 4360.3 4378.1 4457.6 4474.0 4501.5 3925.6 3970.8 3972.1 3998.8 4020.6 5714.1 5755.9 5762.3 5769.3 5798.4 5779.9 6000.5 6004.2 6016.1 6035.2 5720.1 5743.9 5758.5 5778.6 5831.7 5070.9 5071.6 5075.8 5084.1 5090.7 6041.7 6254.5 6255.3 6262.3 6269.6 5977.4 6012.6 6014.3 6014.9 6064.4 6187.5 6209.1 6242.0 6246.9 6250.2 5710.7 5870.8 5948.0 5949.3 5984.7 5829.4 5830.5 5914.3 5941.1 5965.2 5744.1 5756.2 5758.4 5763.0 5766.0 5689.0 5766.9 5776.3 5780.5 5790.2 5713.1 5745.9 5757.5 5783.3 5798.4 5783.4 5841.4 5868.6 5888.6 5895.2 5533.4 5664.3 5726.7 5733.5 5744.5 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#1] ext.html Cycles:180 Average:50937.88 Median:41545.08 stddev:95178.02 (229.1%) stddev-sans-first:95369.83 08:32:27 INFO - PROCESS | 13686 | Values: 550.9 596.8 600.7 612.4 639.8 33947.2 35597.3 35759.5 35838.0 36001.5 43928.0 44360.8 44558.1 44639.3 44805.1 8793.0 8889.0 8967.3 8977.5 8998.9 8777.6 8914.7 8931.5 8954.5 8959.3 8957.2 8963.5 8964.0 8966.2 8996.5 8888.3 8920.6 8946.4 8978.7 8995.9 8783.4 8799.9 8836.7 8869.6 8890.0 41309.8 41442.2 41610.2 41863.2 41878.8 3171.3 3369.4 3691.9 3779.9 3839.0 33238.2 33346.8 33365.3 33422.5 33556.5 4287.4 4316.3 4341.2 4351.5 4430.6 346297.0 346385.0 348587.0 349101.0 349503.0 58213.7 58650.7 58764.0 58772.4 58826.1 35235.3 36315.3 36379.6 37740.8 61507.0 15930.0 15992.6 16116.9 16119.6 16120.8 11898.8 11964.5 12011.7 12042.1 12115.9 19542.6 19581.3 19665.6 19675.8 19705.7 7119.6 7232.4 7308.6 7417.0 7521.7 943.7 981.4 1025.4 1033.1 1076.9 32361.8 32600.8 32906.3 33010.8 33029.3 1107.5 1113.8 1128.3 1130.9 1166.8 17181.8 17224.2 17400.1 17648.0 17703.4 157949.2 158609.0 158966.0 159508.0 160036.0 60715.0 61246.0 61315.4 61375.4 61443.7 1319.7 1332.5 1354.7 1360.9 1368.8 30969.2 31849.7 32276.2 32539.3 32720.3 53313.7 53598.6 53599.5 53671.7 53673.9 485757.0 487485.0 487875.0 489165.0 491898.0 28198.4 28654.9 28825.7 28996.4 29262.0 48762.8 49257.5 49457.3 49743.5 50326.0 41451.0 42684.4 43421.0 43654.6 44705.0 41480.0 42141.8 42221.0 42661.0 42864.4 41833.8 42277.2 43461.8 43887.6 44463.6 34574.7 38102.8 38420.4 39045.8 39447.2 29453.9 29578.3 29853.0 30123.4 30130.1 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#2] jquery.html Cycles:180 Average:31723.69 Median:33221.25 stddev:86986.96 (261.8%) stddev-sans-first:87199.16 08:32:27 INFO - PROCESS | 13686 | Values: 384.6 386.6 402.8 409.2 415.8 13788.7 18953.9 19823.4 20625.3 20629.9 18319.2 18454.7 18676.5 19016.9 19191.8 5717.6 5773.9 5783.9 5804.5 6002.3 5748.5 5925.2 5947.2 5963.5 5991.9 5729.1 5800.5 5803.7 5818.9 5955.9 5827.9 5839.5 5851.2 5879.2 5887.7 5029.5 5281.8 5291.7 5377.5 5377.5 13485.9 13514.4 13603.1 13648.1 13811.6 2126.8 2323.6 2541.9 2861.1 2882.6 9727.6 10017.1 10315.7 10797.2 14407.8 1912.6 1914.7 1927.2 1953.4 1954.1 88513.0 99334.0 101920.5 103253.0 105312.5 17237.7 17529.4 17781.6 17896.0 18115.5 33217.3 33225.2 33399.7 33503.5 33696.0 9472.0 9594.0 9732.9 9832.2 10241.8 7882.2 7918.4 7936.3 8314.5 8603.4 8992.2 9126.8 9157.6 9202.5 9237.2 3146.2 3253.9 3386.4 3546.9 3637.0 943.6 1035.6 1043.2 1073.1 1073.6 19705.0 20010.9 20412.0 20578.2 20889.0 989.8 1004.8 1015.1 1016.3 1022.4 10723.7 11476.3 11563.0 11602.2 11669.6 507639.0 516190.0 528252.0 537191.0 537727.0 98998.5 99482.0 101024.0 102156.0 102331.0 900.9 931.9 959.0 960.7 964.1 17449.8 17959.4 17979.6 18129.5 18568.2 45844.3 46255.3 46432.0 46692.3 46750.3 62829.7 62960.4 63935.4 64181.7 64231.7 8066.3 8123.2 8331.2 8370.4 8674.6 9313.9 12745.0 12979.8 13044.5 13320.5 11496.7 11536.9 12153.9 12221.6 12314.0 10817.8 11543.0 11683.1 11949.9 12284.8 11524.9 11817.7 11861.9 12213.3 12220.0 8235.3 8255.9 8387.4 8531.8 8712.0 11497.5 11506.2 11555.2 11683.7 11770.5 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#3] mootools.html Cycles:180 Average:5890.20 Median:459.36 stddev:3337.86 (726.6%) stddev-sans-first:3330.16 08:32:27 INFO - PROCESS | 13686 | Values: 1400.2 1490.2 1656.3 1796.2 1800.1 7899.9 8227.6 8566.1 9143.4 9204.4 8594.4 8735.3 8837.1 8860.9 8871.0 2380.5 2459.6 2459.9 2461.2 2462.0 2402.8 2433.2 2497.6 2503.9 2516.6 2447.3 2452.5 2459.5 2486.5 2488.4 2393.1 2405.5 2419.8 2433.2 2450.4 2346.6 2348.6 2353.6 2357.1 2372.2 8939.6 8963.7 9003.7 9010.0 9039.8 5117.8 5229.2 5230.7 5230.9 5237.9 3464.6 3600.6 3648.2 3650.6 3660.9 1087.9 1128.8 1137.2 1145.7 1158.9 12501.6 12650.4 12666.6 12670.9 12835.9 4691.2 4708.1 4746.9 4813.1 4935.4 10591.5 10637.2 10638.7 10720.7 10735.9 5293.0 5298.9 5301.9 5326.3 5344.4 4074.8 4795.7 4821.1 4887.8 4907.6 4105.2 4161.7 4176.0 4244.5 4277.1 1284.5 1321.4 1324.7 1335.3 1336.8 983.8 999.3 1008.3 1017.6 1017.6 5988.6 6014.5 6112.5 6257.4 6312.8 452.7 453.4 457.9 460.8 466.9 3983.2 4134.6 4187.2 4210.2 4224.8 10625.8 10864.7 10868.1 10871.9 10972.9 10597.8 10801.3 10853.5 10883.6 10885.8 8070.2 8179.8 8228.7 8230.8 8240.5 6023.8 6068.9 6071.5 6092.5 6163.1 9851.6 10007.9 10073.8 10159.5 10185.1 10261.5 10512.1 10588.8 10591.3 10630.1 6823.4 7901.3 7965.5 8028.9 8151.8 8719.1 8843.3 8853.3 8856.2 8904.4 7799.0 7818.1 7863.4 7891.4 8244.3 7515.2 7546.0 7557.5 7712.2 7855.8 7088.8 7167.2 7220.9 7257.3 7276.5 5334.8 5353.7 5358.4 5428.1 5473.0 5134.2 5303.2 5328.3 5328.9 5406.9 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#4] prototype.html Cycles:180 Average:4840.73 Median:5448.70 stddev:1445.09 (26.5%) stddev-sans-first:1408.53 08:32:27 INFO - PROCESS | 13686 | Values: 308.2 320.5 327.9 328.1 329.2 5415.2 5429.9 5589.2 5607.0 5632.0 5463.0 5465.8 5487.7 5508.9 5509.7 4295.7 4308.5 4326.7 4336.2 4375.9 4190.6 4289.8 4325.0 4352.3 4374.6 4288.5 4290.3 4297.4 4307.4 4329.2 4283.0 4298.8 4305.1 4319.3 4328.9 3485.2 3751.2 3792.4 3807.4 3832.6 5366.9 5369.0 5386.6 5424.6 5434.4 4856.5 4859.1 4865.0 4867.9 4876.8 5520.6 5675.4 5702.9 5782.6 5788.7 4006.6 4018.9 4019.0 4033.2 4049.9 5985.9 6010.5 6016.2 6026.6 6039.8 4012.0 4110.5 4124.3 4126.2 4167.4 4177.0 4181.9 4195.9 4202.4 4206.9 4864.6 4865.8 4869.0 4881.6 4884.2 5729.3 5812.3 5839.2 5839.7 5855.1 1434.9 1445.7 1458.6 1461.2 1461.5 880.9 916.8 925.8 932.7 941.2 5048.5 5065.0 5112.1 5122.6 5168.6 5297.6 5339.7 5373.6 5377.0 5401.2 4955.8 5075.7 5084.5 5324.9 5753.3 3178.8 3198.6 3228.4 3234.6 3243.5 6101.1 6276.2 6295.8 6298.7 6330.3 6059.5 6073.7 6074.9 6106.8 6142.2 6214.5 6242.8 6243.8 6255.2 6274.4 5736.9 5920.8 5935.5 5981.7 6049.1 5895.2 5902.0 5903.7 5920.7 5925.8 5952.6 6144.6 6148.5 6168.7 6210.3 4023.9 4145.4 4147.6 4150.5 4159.2 5960.5 5961.7 5963.0 5979.9 5991.4 5656.0 5794.7 5813.5 5822.7 5845.2 5799.7 5840.4 5843.2 5850.4 5868.4 5738.2 5759.1 5767.2 5787.0 5806.2 5651.0 5842.7 5869.3 5916.3 5921.5 5771.5 5775.4 5775.9 5777.4 5783.3 08:32:27 INFO - PROCESS | 13686 | 08:32:27 INFO - PROCESS | 13686 | [#5] yui.html Cycles:180 Average:22337.29 Median:2796.90 stddev:34476.52 (1232.7%) stddev-sans-first:34534.89 08:32:27 INFO - PROCESS | 13686 | Values: 681.9 709.2 723.8 730.6 787.4 15141.9 15488.9 15489.7 15639.5 15693.3 13342.7 13620.2 13631.8 13634.3 13686.9 648.8 782.8 787.3 794.0 801.8 792.3 796.1 796.4 797.1 797.5 857.0 857.3 857.6 857.7 859.5 845.5 851.4 852.0 852.9 853.8 620.3 623.0 624.4 624.9 626.1 13801.9 13861.0 13866.2 13900.9 13946.7 13725.7 14874.8 15693.8 15801.1 16092.6 11410.9 11590.5 11708.1 12290.4 14513.5 4331.6 4471.9 4544.2 4556.1 4606.9 84322.0 88438.6 89370.6 89686.0 89924.4 11395.2 11486.7 11584.4 11589.2 11653.5 21646.1 21710.9 21717.9 21794.7 21807.9 8128.4 8170.3 8289.6 8461.9 8724.0 4789.2 4871.3 4929.7 4946.9 5037.0 3592.6 3615.6 3670.1 3672.3 3694.8 633.3 641.1 648.7 652.2 652.3 556.8 662.5 665.3 704.3 707.3 9007.1 9338.3 9348.6 9504.5 9613.5 557.2 658.5 701.0 707.6 710.2 4250.5 4544.3 4594.3 4611.7 4628.3 126350.4 129764.0 130379.0 134408.3 136285.0 109446.0 110993.4 111551.4 111885.4 112526.0 95382.5 96439.0 98337.0 99288.0 100073.0 8634.7 8688.7 8750.8 8979.2 9058.5 55943.7 56839.0 56967.4 58279.0 59417.7 77422.0 85602.1 85818.6 87549.0 91339.0 10909.9 10936.2 11063.4 11116.7 11205.9 11990.2 12118.9 12598.7 12625.3 12817.2 11718.7 11859.6 11861.4 12062.6 12312.4 11667.8 11819.6 12212.5 12545.3 12740.2 11307.9 11331.1 11573.2 11580.8 11635.2 9247.0 9314.1 9523.2 9596.6 9605.4 8839.5 8885.9 8903.6 9020.5 9699.0 08:32:27 INFO - PROCESS | 13686 | -------- Summary: end -------- 08:32:27 INFO - PROCESS | 13686 | 08:32:28 INFO - TEST-INFO | 13686: exit 0 08:32:28 INFO - TEST-OK | dromaeo_css | took 1112222ms 08:32:28 INFO - TEST-START | kraken 08:32:28 INFO - operating with platform_type : linux_ 08:32:28 INFO - Initialising browser for kraken test... 08:32:28 INFO - TEST-INFO | started process 13929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvPcFi/profile http://localhost:35016/getInfo.html) 08:32:32 INFO - PROCESS | 13929 | JavaScript error: , line 0: uncaught exception: undefined 08:32:33 INFO - PROCESS | 13929 | __metrics Screen width/height:1600/1200 08:32:33 INFO - PROCESS | 13929 | colorDepth:24 08:32:33 INFO - PROCESS | 13929 | Browser inner width/height: 1024/697 08:32:33 INFO - PROCESS | 13929 | __metrics 08:32:34 ERROR - PROCESS | 13929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:32:35 INFO - TEST-INFO | 13929: exit 0 08:32:35 INFO - Browser initialized. 08:32:35 INFO - Running cycle 1/1 for kraken test... 08:32:35 INFO - TEST-INFO | started process 14049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvPcFi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:47 INFO - PROCESS | 14049 | RSS: Main: 167866368 08:32:47 INFO - PROCESS | 14049 | 08:32:49 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35016/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:50 INFO - PROCESS | 14049 | RSS: Main: 173412352 08:32:50 INFO - PROCESS | 14049 | 08:32:53 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35016/tests/kraken/driver.html?testName=audio-dft) 08:32:53 INFO - PROCESS | 14049 | RSS: Main: 172060672 08:32:53 INFO - PROCESS | 14049 | 08:32:56 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35016/tests/kraken/driver.html?testName=audio-fft) 08:32:57 INFO - PROCESS | 14049 | RSS: Main: 168833024 08:32:57 INFO - PROCESS | 14049 | 08:32:59 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35016/tests/kraken/driver.html?testName=audio-oscillator) 08:32:59 INFO - PROCESS | 14049 | RSS: Main: 169459712 08:32:59 INFO - PROCESS | 14049 | 08:33:02 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:02 INFO - PROCESS | 14049 | RSS: Main: 169848832 08:33:02 INFO - PROCESS | 14049 | 08:33:05 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35016/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:06 INFO - PROCESS | 14049 | RSS: Main: 169238528 08:33:06 INFO - PROCESS | 14049 | 08:33:09 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35016/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:10 INFO - PROCESS | 14049 | RSS: Main: 170946560 08:33:10 INFO - PROCESS | 14049 | 08:33:13 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35016/tests/kraken/driver.html?testName=json-parse-financial) 08:33:14 INFO - PROCESS | 14049 | RSS: Main: 170225664 08:33:14 INFO - PROCESS | 14049 | 08:33:15 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:16 INFO - PROCESS | 14049 | RSS: Main: 170319872 08:33:16 INFO - PROCESS | 14049 | 08:33:17 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:18 INFO - PROCESS | 14049 | RSS: Main: 170524672 08:33:18 INFO - PROCESS | 14049 | 08:33:20 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:21 INFO - PROCESS | 14049 | RSS: Main: 170434560 08:33:21 INFO - PROCESS | 14049 | 08:33:23 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:24 INFO - PROCESS | 14049 | RSS: Main: 170815488 08:33:24 INFO - PROCESS | 14049 | 08:33:27 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:27 INFO - PROCESS | 14049 | RSS: Main: 170606592 08:33:27 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | Cycle 1(1): loaded http://localhost:35016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35016/tests/kraken/driver.html?testName=ai-astar) 08:33:29 INFO - PROCESS | 14049 | RSS: Main: 171569152 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | __start_tp_report 08:33:29 INFO - PROCESS | 14049 | _x_x_mozilla_page_load 08:33:29 INFO - PROCESS | 14049 | _x_x_mozilla_page_load_details 08:33:29 INFO - PROCESS | 14049 | |i|pagename|runs| 08:33:29 INFO - PROCESS | 14049 | |0;ai-astar;102;111;105;110;111;111;112;111;110;110 08:33:29 INFO - PROCESS | 14049 | |1;audio-beat-detection;151;118;148;177;124;150;156;120;181;119 08:33:29 INFO - PROCESS | 14049 | |2;audio-dft;162;161;164;164;161;164;172;168;162;162 08:33:29 INFO - PROCESS | 14049 | |3;audio-fft;76;74;75;158;77;77;75;75;172;75 08:33:29 INFO - PROCESS | 14049 | |4;audio-oscillator;83;84;151;88;83;83;153;83;84;164 08:33:29 INFO - PROCESS | 14049 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;117;118 08:33:29 INFO - PROCESS | 14049 | |6;imaging-darkroom;146;146;148;147;149;147;150;147;148;147 08:33:29 INFO - PROCESS | 14049 | |7;imaging-desaturate;95;106;95;95;96;96;96;98;96;96 08:33:29 INFO - PROCESS | 14049 | |8;json-parse-financial;55;54;53;52;53;54;53;53;53;54 08:33:29 INFO - PROCESS | 14049 | |9;json-stringify-tinderbox;62;62;63;62;62;62;62;62;62;63 08:33:29 INFO - PROCESS | 14049 | |10;stanford-crypto-aes;77;83;77;76;77;77;76;75;81;76 08:33:29 INFO - PROCESS | 14049 | |11;stanford-crypto-ccm;123;132;136;128;121;131;127;128;157;132 08:33:29 INFO - PROCESS | 14049 | |12;stanford-crypto-pbkdf2;157;156;157;156;161;156;156;155;155;160 08:33:29 INFO - PROCESS | 14049 | |13;stanford-crypto-sha256-iterative;67;64;69;64;66;64;63;63;67;63 08:33:29 INFO - PROCESS | 14049 | __end_tp_report 08:33:29 INFO - PROCESS | 14049 | __start_cc_report 08:33:29 INFO - PROCESS | 14049 | _x_x_mozilla_cycle_collect,937 08:33:29 INFO - PROCESS | 14049 | __end_cc_report 08:33:29 INFO - PROCESS | 14049 | __startTimestamp1469201609882__endTimestamp 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | ------- Summary: start ------- 08:33:29 INFO - PROCESS | 14049 | Number of tests: 14 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:2.03 08:33:29 INFO - PROCESS | 14049 | Values: 102.0 111.0 105.0 110.0 111.0 111.0 112.0 111.0 110.0 110.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.50 stddev:23.52 (15.6%) stddev-sans-first:24.82 08:33:29 INFO - PROCESS | 14049 | Values: 151.0 118.0 148.0 177.0 124.0 150.0 156.0 120.0 181.0 119.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.63 08:33:29 INFO - PROCESS | 14049 | Values: 162.0 161.0 164.0 164.0 161.0 164.0 172.0 168.0 162.0 162.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:37.89 (50.5%) stddev-sans-first:39.66 08:33:29 INFO - PROCESS | 14049 | Values: 76.0 74.0 75.0 158.0 77.0 77.0 75.0 75.0 172.0 75.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:83.00 stddev:34.97 (42.1%) stddev-sans-first:36.12 08:33:29 INFO - PROCESS | 14049 | Values: 83.0 84.0 151.0 88.0 83.0 83.0 153.0 83.0 84.0 164.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:33:29 INFO - PROCESS | 14049 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.27 (0.9%) stddev-sans-first:1.22 08:33:29 INFO - PROCESS | 14049 | Values: 146.0 146.0 148.0 147.0 149.0 147.0 150.0 147.0 148.0 147.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:3.31 (3.5%) stddev-sans-first:3.44 08:33:29 INFO - PROCESS | 14049 | Values: 95.0 106.0 95.0 95.0 96.0 96.0 96.0 98.0 96.0 96.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.67 08:33:29 INFO - PROCESS | 14049 | Values: 55.0 54.0 53.0 52.0 53.0 54.0 53.0 53.0 53.0 54.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:33:29 INFO - PROCESS | 14049 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.51 (3.3%) stddev-sans-first:2.65 08:33:29 INFO - PROCESS | 14049 | Values: 77.0 83.0 77.0 76.0 77.0 77.0 76.0 75.0 81.0 76.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:131.50 stddev:9.99 (7.6%) stddev-sans-first:10.11 08:33:29 INFO - PROCESS | 14049 | Values: 123.0 132.0 136.0 128.0 121.0 131.0 127.0 128.0 157.0 132.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.50 stddev:2.02 (1.3%) stddev-sans-first:2.15 08:33:29 INFO - PROCESS | 14049 | Values: 157.0 156.0 157.0 156.0 161.0 156.0 156.0 155.0 155.0 160.0 08:33:29 INFO - PROCESS | 14049 | 08:33:29 INFO - PROCESS | 14049 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.11 08:33:29 INFO - PROCESS | 14049 | Values: 67.0 64.0 69.0 64.0 66.0 64.0 63.0 63.0 67.0 63.0 08:33:29 INFO - PROCESS | 14049 | -------- Summary: end -------- 08:33:29 INFO - PROCESS | 14049 | 08:33:30 INFO - TEST-INFO | 14049: exit 0 08:33:30 INFO - TEST-OK | kraken | took 62480ms 08:33:30 INFO - SUITE-END | took 1174s 08:33:31 INFO - Completed test suite (00:19:34) 08:33:31 INFO - javascript benchmark 08:33:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7373.6398612542525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.1288839125045, 3123.687631236875, 3172.9841350793245, 3179.8728050877953, 3187.1235410262184, 5522.420145884685, 5540.473655002768, 5550.222968784368, 5561.833145005657, 5584.078627026536, 5386.069855270575, 5499.835004949848, 5531.751071201796, 5578.107502799553, 5600.85997850054, 4960.2311641695505, 4991.251312303148, 5085.720285384303, 5113.309703190059, 5134.178531434971, 5030.974845125769, 5236.162214045753, 5240.213967904807, 5241.030409374259, 5241.449647786984, 4925.3597032385915, 4965.702057876539, 5034.647574669792, 5059.949400505985, 5122.103631864427, 4931.876703082416, 4934.25986102084, 4951.777170027357, 4958.652894297401, 4996.225585034289, 4889.168841296952, 4924.039812236615, 4966.404031516241, 4984.053029924339, 5044.54599086084, 5436.10304299794, 5438.646487978269, 5461.399246082928, 5488.204210389471, 5491.945080549183, 5882.823515294548, 5897.4692277694785, 5911.556633252523, 5911.940880591182, 5981.461668449861, 5915.5859089863725, 5946.910796338058, 5948.196993405878, 5951.880962380728, 5954.612950158225, 5387.353517577876, 5430.3755068167275, 5462.535684466785, 5510.834674959758, 5514.834554963358, 6001.849953751192, 6022.247219097613, 6032.034874420072, 6052.969735151296, 6063.818085457443, 5759.366469688331, 5761.596688231783, 5764.048931926269, 5765.0, 5778.6821724804695, 5790.10253410722, 5805.912911306334, 5828.067509198592, 5874.353821079678, 5874.970625146932, 5674.517665998436, 5780.942190578125, 5852.0, 5860.09168578871, 5903.0260007099205, 5879.323877754113, 5901.970490147522, 5923.08192230205, 5926.822195334147, 5947.078202878561, 4360.280553708666, 4378.08060307339, 4457.621102206349, 4473.977630111829, 4501.504834468205, 3925.6270654287796, 3970.82131304092, 3972.145988612462, 3998.7600743955454, 4020.5979402060143, 5714.0571805652435, 5755.942440575541, 5762.250907382014, 5769.307683078057, 5798.449147330997, 5779.855503612359, 6000.489958353502, 6004.249468816398, 6016.067509536029, 6035.155078289043, 5720.08478643415, 5743.9425605744245, 5758.539316854725, 5778.566607504454, 5831.708414579254, 5070.898582028339, 5071.568916642127, 5075.771590278447, 5084.13569693153, 5090.745462726849, 6041.670832416861, 6254.530910181755, 6255.343188965184, 6262.3111457739615, 6269.561130720897, 5977.432143946318, 6012.6392416455155, 6014.308354539284, 6014.9097763534455, 6064.363241859542, 6187.474064704551, 6209.099680546386, 6242.0, 6246.9062964054665, 6250.1874756281395, 5710.685912274698, 5870.7945221918735, 5948.0, 5949.286085669747, 5984.700764961647, 5829.446202610745, 5830.53355731549, 5914.319853216935, 5941.079132734433, 5965.224520812267, 5744.080947048452, 5756.1941328214925, 5758.366579676149, 5763.049096899133, 5765.971170144123, 5688.971555142198, 5766.855828604151, 5776.306843178845, 5780.450857168562, 5790.1893734877995, 5713.05734553794, 5745.885082298414, 5757.453041961007, 5783.334916484658, 5798.362180160263, 5783.392743761844, 5841.4450627190345, 5868.618539794899, 5888.646681199141, 5895.20414744004, 5533.446655334435, 5664.291963504562, 5726.685032323096, 5733.541316694571, 5744.540436765133], "value": 5457.901134792621, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9126029881343, 596.7612954818073, 600.7326739600877, 612.3784358875741, 639.7536948274912, 33947.15132121698, 35597.28805423893, 35759.4636080459, 35838.0, 36001.45997810035, 43928.0, 44360.77819610897, 44558.1088378233, 44639.330410043796, 44805.103897922025, 8793.032766395707, 8888.999999999967, 8967.327450441211, 8977.506237156953, 8998.910010899872, 8777.605007774633, 8914.687985920495, 8931.50876701781, 8954.462732236087, 8959.328050396214, 8957.19385255327, 8963.507007114606, 8963.955180224122, 8966.193042626162, 8996.505192214425, 8888.288936885034, 8920.643174273053, 8946.41848279863, 8978.730638080802, 8995.910040899638, 8783.429077110031, 8799.868001979976, 8836.690715824916, 8869.600867960893, 8889.955550222272, 41309.793451032856, 41442.171156577, 41610.1677966442, 41863.1627367454, 41878.79060604708, 3171.31816659417, 3369.444041733111, 3691.9261614767825, 3779.8866034019024, 3838.980805095957, 33238.16904577381, 33346.83326583376, 33365.33269334624, 33422.49866252008, 33556.49665255023, 4287.399764033038, 4316.266234740102, 4341.196878577473, 4351.4995775485595, 4430.556944305576, 346297.0, 346385.0, 348587.0, 349101.0, 349503.0, 58213.70893145592, 58650.70674646685, 58764.0, 58772.41227587755, 58826.11760823591, 35235.29529409449, 36315.27369452649, 36379.636203638154, 37740.811295943895, 61507.0, 15930.0, 15992.600184995468, 16116.919415403083, 16119.597010074842, 16120.75818862718, 11898.821517677241, 11964.521419143312, 12011.699707507381, 12042.09684273683, 12115.878841211652, 19542.609147816966, 19581.25862379268, 19665.606687866162, 19675.8032419674, 19705.70441443351, 7119.608421536762, 7232.42140628759, 7308.59802710856, 7417.0, 7521.699132034657, 943.7451887990342, 981.3670182732097, 1025.3898930136556, 1033.1115240892825, 1076.9353838769698, 32361.838190808896, 32600.83699581487, 32906.341873162404, 33010.83494582512, 33029.3394132116, 1107.479484642217, 1113.7661091170783, 1128.3230061962756, 1130.949107290174, 1166.7549814538872, 17181.828181718272, 17224.224909879085, 17400.129993500275, 17648.0, 17703.38038168658, 157949.210253948, 158609.0, 158966.0, 159508.0, 160036.0, 60715.0, 61246.0, 61315.38684613097, 61375.38624613786, 61443.69278153581, 1319.7426501832051, 1332.5221172739143, 1354.73582651384, 1360.9183448993092, 1368.7604669182854, 30969.225769355045, 31849.68150318467, 32276.19309517281, 32539.34921301608, 32720.34559308848, 53313.73343133415, 53598.64013598609, 53599.464005361006, 53671.73164134155, 53673.853045877724, 485757.0, 487485.0, 487875.0, 489165.0, 491898.0, 28198.43603127885, 28654.85672571624, 28825.71174288314, 28996.420071598874, 29262.0, 48762.756186218845, 49257.507424925294, 49457.25814112719, 49743.50256497389, 50326.0, 41451.0, 42684.359734603386, 43421.0, 43654.56345436632, 44705.0, 41480.0, 42141.78929105335, 42221.0, 42661.0, 42864.35703464388, 41833.79083104565, 42277.1544569113, 43461.782691086344, 43887.56112438835, 44463.55536444594, 34574.65425345714, 38102.80948595239, 38420.42369364518, 39045.80477097596, 39447.2110557793, 29453.85273073621, 29578.260543486584, 29853.0, 30123.397532049676, 30130.096097116246], "value": 19439.37166992098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5923321279444, 386.6307676169259, 402.8207447685779, 409.2224772931431, 415.8128842021091, 13788.724225515483, 18953.905230473847, 19823.405297841087, 20625.27811526597, 20629.896850515765, 18319.17563709633, 18454.72317915229, 18676.53308667284, 19016.90491547544, 19191.80808191918, 5717.628354156987, 5773.942260577403, 5783.884322313572, 5804.477597016267, 6002.339742628307, 5748.505388598974, 5925.229720136376, 5947.197128387677, 5963.463288304052, 5991.85020374492, 5729.140628905656, 5800.53595712342, 5803.73883175256, 5818.883622327551, 5955.88088238235, 5827.912581311284, 5839.532837373021, 5851.180834683148, 5879.235699359077, 5887.735051922674, 5029.471905449948, 5281.8151364702435, 5291.708956007418, 5377.489138531872, 5377.51602355786, 13485.932570337183, 13514.391852366667, 13603.115797473132, 13648.112872663345, 13811.585652430444, 2126.7554231263293, 2323.615972001268, 2541.8729063546934, 2861.1273561563717, 2882.6396700412447, 9727.56225969833, 10017.148542373907, 10315.690529284133, 10797.244192906499, 14407.78388324176, 1912.6174765046908, 1914.6936490161506, 1927.2291083566545, 1953.384683824605, 1954.1499447740277, 88513.0, 99334.0, 101920.49039754753, 103252.99999999924, 105312.47343763309, 17237.655246894992, 17529.386471473437, 17781.644367112844, 17896.0, 18115.456536303933, 33217.335653287286, 33225.16937076592, 33399.66600334014, 33503.497447538306, 33696.0, 9471.952640236892, 9594.0, 9732.854007189897, 9832.213422926148, 10241.795164096677, 7882.211778822187, 7918.445708800444, 7936.289585646519, 8314.501129932223, 8603.397762156714, 8992.190702836646, 9126.81746365069, 9157.587908544132, 9202.539873006457, 9237.168654821098, 3146.1819926819194, 3253.9349213015607, 3386.356592247465, 3546.9359192242223, 3636.9818150909077, 943.6225509796, 1035.6271742172812, 1043.2071625564474, 1073.0932362153967, 1073.640330489295, 19705.01474926248, 20010.89994550018, 20412.0, 20578.176872925214, 20889.0, 989.7773001074845, 1004.8090862736057, 1015.0610685116385, 1016.3038318751679, 1022.412113034993, 10723.678289651323, 11476.254043487146, 11563.017143542893, 11602.187846850808, 11669.649910502698, 507639.0, 516190.0, 528252.0, 537191.0, 537727.0, 98998.50500747451, 99481.97916926813, 101024.0, 102156.0, 102331.0, 900.9009009009004, 931.8648795924688, 959.0457494792587, 960.70698436976, 964.1226483899758, 17449.825501745327, 17959.371422000168, 17979.550511237325, 18129.45611631653, 18568.164432600297, 45844.31233531566, 46255.306170406795, 46432.0, 46692.299615506476, 46750.298745518165, 62829.68585157228, 62960.37039629545, 63935.36064639294, 64181.679091604245, 64231.67884160549, 8066.314363279187, 8123.18768123183, 8331.16688331162, 8370.37222208349, 8674.609642566225, 9313.86029209576, 12745.0, 12979.805302920275, 13044.54344097952, 13320.533781317607, 11496.712582185512, 11536.884631153582, 12153.878461215629, 12221.572244971383, 12314.0, 10817.837732433862, 11543.0, 11683.123765717775, 11949.880501194877, 12284.754304914031, 11524.94237528807, 11817.704557386134, 11861.881381186078, 12213.328266945404, 12220.0, 8235.29999949987, 8255.876161857457, 8387.370947178864, 8531.786705332417, 8712.041675415572, 11497.482613282255, 11506.194566380273, 11555.2489088209, 11683.707907302385, 11770.470328835394], "value": 10000.829821990581, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.2018849255921, 1490.1729540105237, 1656.287796247613, 1796.2096677461923, 1800.1089460716946, 7899.92100078999, 8227.588620568977, 8566.143385661439, 9143.405678630892, 9204.447733136016, 8594.355423343242, 8735.301175905928, 8837.072107428723, 8860.911390886089, 8871.024187339388, 2380.464395511009, 2459.594166962458, 2459.9139030133947, 2461.1755062054144, 2461.963070553943, 2402.795762360193, 2433.1605596069417, 2497.6003839385703, 2503.924882253535, 2516.6099254615474, 2447.3269850791, 2452.546278938402, 2459.4958033603157, 2486.465409936863, 2488.415222422729, 2393.090625562284, 2405.5068710914306, 2419.758024197584, 2433.221369161869, 2450.3506570758764, 2346.636271377939, 2348.612478940973, 2353.5528249632516, 2357.116081469449, 2372.205311220743, 8939.64241430342, 8963.68627098055, 9003.729888103302, 9009.954950225272, 9039.819203615956, 5117.795288188468, 5229.241759944786, 5230.686158830483, 5230.8692282692855, 5237.921431178535, 3464.6188919218866, 3600.567931848195, 3648.1791596890753, 3650.6166852480637, 3660.8535658573624, 1087.9238453308271, 1128.841962125303, 1137.181229514748, 1145.6734830573246, 1158.866730326015, 12501.624951251386, 12650.430730617052, 12666.556670516487, 12670.873291267153, 12835.93582032084, 4691.225947718588, 4708.105459962596, 4746.897580898534, 4813.061453016699, 4935.383077115361, 10591.470426478645, 10637.202209834293, 10638.680839574825, 10720.678379648623, 10735.892641073646, 5293.0, 5298.947010529845, 5301.867453313698, 5326.307580014573, 5344.358676958712, 4074.8370065197655, 4795.664303498722, 4821.083994041121, 4887.780049897763, 4907.631927605373, 4105.1544251745945, 4161.667066634662, 4176.0, 4244.469441319835, 4277.080427708058, 1284.466946217328, 1321.3855557165964, 1324.6820763016806, 1335.2589312931223, 1336.7593833110134, 983.8475036369374, 999.3204620857887, 1008.2992320337295, 1017.5878769098526, 1017.5980487707315, 5988.580799344004, 6014.488768454643, 6112.480439162721, 6257.43683068526, 6312.810615681537, 452.69669321554636, 453.41509452806173, 457.8855286178455, 460.83179639431364, 466.9369635099286, 3983.183447393277, 4134.627883490441, 4187.183499217624, 4210.200061988213, 4224.78876056196, 10625.787484250272, 10864.674059778219, 10868.130549556017, 10871.945640271906, 10972.890271097347, 10597.788044239072, 10801.297915635458, 10853.51159197838, 10883.564657413615, 10885.782284354269, 8070.192980701883, 8179.754607361789, 8228.670853165926, 8230.753077407688, 8240.464369815943, 6023.759049637965, 6068.939310606837, 6071.51427885777, 6092.512598992159, 6163.075538669235, 9851.605935762489, 10007.899921000697, 10073.848892266475, 10159.54282057324, 10185.134263587677, 10261.538230779484, 10512.10647094975, 10588.841167382341, 10591.258611897401, 10630.096441802534, 6823.38589526945, 7901.328387087162, 7965.4822436541435, 8028.879566806386, 8151.83696326082, 8719.084496128069, 8843.336749743667, 8853.335999800169, 8856.158664926821, 8904.376693631384, 7799.025121859768, 7818.140004599603, 7863.449558530848, 7891.408144389308, 8244.340452763645, 7515.173330933483, 7545.962270188614, 7557.470977031555, 7712.190220026816, 7855.803604909923, 7088.787336379917, 7167.211606723152, 7220.855582888418, 7257.2742725727, 7276.490645654753, 5334.839954801362, 5353.705546194997, 5358.4105748366865, 5428.104362780255, 5473.042217611982, 5134.152864777419, 5303.15149576066, 5328.307320048369, 5328.893422131613, 5406.918896216638], "value": 4654.767880702695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.23403841453967, 320.5272223470381, 327.86231775738196, 328.1091835666166, 329.2066120649236, 5415.160650099231, 5429.918551221725, 5589.161625756138, 5606.953461986376, 5631.971840140799, 5463.0, 5465.781368745255, 5487.670739755617, 5508.862278443031, 5509.696966666832, 4295.720778149426, 4308.547602501739, 4326.74039557626, 4336.197803406364, 4375.912481750379, 4190.559991200926, 4289.849855255066, 4324.956750432502, 4352.303631418974, 4374.60628543431, 4288.506821715511, 4290.313549832027, 4297.419848320484, 4307.418498502693, 4329.242382583036, 4282.957170428287, 4298.763568003774, 4305.117450922553, 4319.308910574293, 4328.935065974013, 3485.1635607454027, 3751.2309976455035, 3792.412176112707, 3807.371783655721, 3832.581944680458, 5366.8926621467745, 5369.0, 5386.649867758622, 5424.593155513313, 5434.402215756264, 4856.538628830255, 4859.052484765472, 4865.0, 4867.8783030424165, 4876.829310974099, 5520.558355331564, 5675.404082571312, 5702.857428564277, 5782.595218334718, 5788.6816225107605, 4006.639402453764, 4018.9349822297113, 4018.9503353290033, 4033.233685599727, 4049.898752531181, 5985.850353741148, 6010.467330830654, 6016.2479690038745, 6026.638401695912, 6039.849003774941, 4012.0170558213426, 4110.547839737626, 4124.319487284564, 4126.154138401621, 4167.416561681367, 4176.9582304177175, 4181.895452613709, 4195.937060944088, 4202.411662367271, 4206.85276015338, 4864.586510146677, 4865.781039853215, 4868.95131048692, 4881.560659540658, 4884.242942343943, 5729.255196824386, 5812.331581868055, 5839.211706419664, 5839.678817665069, 5855.121731740273, 1434.9210793406255, 1445.6530432696077, 1458.555140682102, 1461.1744364434273, 1461.5469204546625, 880.8634661627458, 916.8212198621338, 925.7731855695398, 932.7434955387323, 941.1999800169801, 5048.460219633047, 5064.999325266573, 5112.060565175039, 5122.615803814729, 5168.586513078944, 5297.596137023692, 5339.652922560022, 5373.623846330719, 5376.973115134399, 5401.243825864382, 4955.776990035385, 5075.670081444694, 5084.51697088776, 5324.92012619811, 5753.252077229933, 3178.8092714437207, 3198.568193293922, 3228.3543291341825, 3234.563333949887, 3243.5459035735016, 6101.078160379467, 6276.152719382916, 6295.779647712308, 6298.7480500780375, 6330.335314791881, 6059.545534084961, 6073.665948372882, 6074.90887636677, 6106.755729770759, 6142.232220972379, 6214.533909956681, 6242.750289988349, 6243.843903902439, 6255.24685188883, 6274.40393162658, 5736.856578585402, 5920.822375328747, 5935.516120969757, 5981.671008094597, 6049.062395328731, 5895.20414744004, 5901.970490147522, 5903.7048147593305, 5920.703964801656, 5925.762969481172, 5952.642841429528, 6144.56988010835, 6148.538859585459, 6168.686742471573, 6210.347913469021, 4023.9195216094927, 4145.419641250288, 4147.564505726976, 4150.460440142762, 4159.230542349675, 5960.493358064613, 5961.658626808933, 5962.970185149046, 5979.880402392015, 5991.370906054975, 5656.038473459604, 5794.72516046486, 5813.534917206529, 5822.73797679097, 5845.240118784531, 5799.681017543907, 5840.357560668238, 5843.240378750906, 5850.3857095006115, 5868.444862111459, 5738.196652468741, 5759.107338362561, 5767.221425107557, 5786.971065144816, 5806.2451881255165, 5650.982823091883, 5842.737076831468, 5869.273011637555, 5916.26046744157, 5921.4966727826895, 5771.518247153765, 5775.364709881994, 5775.884482310246, 5777.364489906023, 5783.31076049639], "value": 4370.079179135935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9488538359624, 709.2198581560283, 723.8335182907931, 730.5653136383853, 787.4251796188782, 15141.924290378547, 15488.922555387207, 15489.69020619587, 15639.452619158317, 15693.293801778918, 13342.66643333917, 13620.18278903264, 13631.795523067138, 13634.250116243602, 13686.931565342184, 648.8410339466838, 782.788647065292, 787.3032366355787, 793.9841203175934, 801.767487428645, 792.2829838995718, 796.0924546017544, 796.366888323784, 797.0873350014231, 797.4935915693518, 857.0101532729707, 857.2841677199515, 857.6055014693218, 857.7383897911135, 859.5014891363026, 845.4969293270525, 851.3657325292666, 852.0244320253337, 852.9061803201643, 853.8420392227458, 620.295964080767, 623.0342968398963, 624.4286477872787, 624.8625302433458, 626.1015442839495, 13801.861981380158, 13861.029727919049, 13866.168029918237, 13900.860991390058, 13946.651333716636, 13725.725485490335, 14874.776878346833, 15693.764593531107, 15801.051936883823, 16092.59768505785, 11410.942945285304, 11590.536378544848, 11708.121890858134, 12290.446929888176, 14513.492027778977, 4331.588499092612, 4471.910561788779, 4544.159330523864, 4556.111558246143, 4606.907861842745, 84322.0, 88438.55780721056, 89370.5531472345, 89686.0, 89924.44329259773, 11395.202335836577, 11486.655400337837, 11584.42077896102, 11589.188756787113, 11653.475593598308, 21646.134154633637, 21710.89144554267, 21717.891410542845, 21794.673079903812, 21807.890960545097, 8128.39037072222, 8170.346372290202, 8289.58552072394, 8461.875286109504, 8723.956380218058, 4789.177495650954, 4871.342368780241, 4929.704217746947, 4946.876328091755, 5037.01778153264, 3592.550931133608, 3615.6384361563632, 3670.082479380155, 3672.338978983755, 3694.833732482045, 633.3444884544474, 641.0543107175343, 648.7317294688872, 652.1880259077384, 652.2955208374943, 556.774506324939, 662.4832630548084, 665.2748504130521, 704.2957042957042, 707.306839297481, 9007.144321289466, 9338.299627527962, 9348.626054957726, 9504.477253750973, 9613.471259080818, 557.2477155839665, 658.4949819508902, 700.9579425234502, 707.6426404665611, 710.1761956130863, 4250.468691413574, 4544.318352247189, 4594.264917613166, 4611.746353950498, 4628.282616194495, 126350.36824816001, 129763.97006254386, 130379.0, 134408.3279583596, 136285.0, 109446.0, 110993.44503277594, 111551.44224278827, 111885.44057279824, 112526.0, 95382.52308738412, 96439.0, 98337.0, 99288.0, 100073.0, 8634.654613815628, 8688.652453902027, 8750.824983500166, 8979.191872731486, 9058.50178240203, 55943.72028139996, 56839.0, 56967.430325696216, 58279.0, 59417.70291148517, 77422.0, 85602.14397855941, 85818.57090714507, 87549.0, 91339.0, 10909.945450272699, 10936.179786516203, 11063.446827658745, 11116.666500005012, 11205.88794112081, 11990.160688751703, 12118.878811211775, 12598.748025039264, 12625.305608191638, 12817.23096614206, 11718.707032323919, 11859.58491452795, 11861.406929653655, 12062.577809776616, 12312.445939932546, 11667.824982625098, 11819.586314479297, 12212.511499539918, 12545.31000794965, 12740.235585864877, 11307.886921131012, 11331.093512519143, 11573.18987670855, 11580.768384632429, 11635.185537012328, 9247.0, 9314.115159059878, 9523.23814094857, 9596.616135354509, 9605.37565058297, 8839.51382673959, 8885.866711999455, 8903.643854245758, 9020.503872287087, 9699.030096990527], "value": 7445.90223063087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 110.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 148.0, 177.0, 124.0, 150.0, 156.0, 120.0, 181.0, 119.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 164.0, 161.0, 164.0, 172.0, 168.0, 162.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 158.0, 77.0, 77.0, 75.0, 75.0, 172.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 151.0, 88.0, 83.0, 83.0, 153.0, 83.0, 84.0, 164.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 149.0, 147.0, 150.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 95.0, 95.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 77.0, 76.0, 77.0, 77.0, 76.0, 75.0, 81.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 136.0, 128.0, 121.0, 131.0, 127.0, 128.0, 157.0, 132.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 157.0, 156.0, 161.0, 156.0, 156.0, 155.0, 155.0, 160.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 69.0, 64.0, 66.0, 64.0, 63.0, 63.0, 67.0, 63.0], "value": 65.0, "unit": "score"}]}]} 08:33:31 INFO - Return code: 0 08:33:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:33:31 ERROR - # TBPL SUCCESS # 08:33:31 INFO - Running post-action listener: _resource_record_post_action 08:33:31 INFO - [mozharness: 2016-07-22 15:33:31.186958Z] Finished run-tests step (success) 08:33:31 INFO - Running post-run listener: _resource_record_post_run 08:33:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560304128; Read time: 20; Write time: 1485792 08:33:31 INFO - TinderboxPrint: CPU usage
13.4% 08:33:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 08:33:31 INFO - TinderboxPrint: I/O write bytes / time
560,304,128 / 1,485,792 08:33:31 INFO - TinderboxPrint: CPU idle
8,245.2 (86.5%) 08:33:31 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 08:33:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:33:31 INFO - install - Wall time: 19s; CPU: 19.0%; Read bytes: 0; Write bytes: 264298496; Read time: 0; Write time: 892716 08:33:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295579648; Read time: 0; Write time: 592932 08:33:31 INFO - Running post-run listener: _upload_blobber_files 08:33:31 INFO - Blob upload gear active. 08:33:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:48 INFO - (blobuploader) - INFO - Done attempting. 08:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:49 INFO - (blobuploader) - INFO - Done attempting. 08:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:50 INFO - (blobuploader) - INFO - Done attempting. 08:33:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:50 INFO - Return code: 0 08:33:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9bbe6766896ae5412126e258fadab2e08b96ac7a7d9e334b16970e4a0d5cb2b8e9ba71f74a063aed3afa5d834f9960b9b00017ece2269ab4d0b30c92da860c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e21b1648aa4fbbe2bf4b9b6801a672d0511effc12196de306f15c830fd0a0652ce0a1395545f0ef47555a8bf6d0d2ea11735d019e696338b1f3ac945135e5929", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eab46c6f7bf62b847dab0dc70d9c3aaf89a8f81d890f9ac1a084ad9a27c529bbe0230fe98dea881236d18ccc0d3ecf68200e48a16cd09da0d530abd46af8e0f"} 08:33:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:50 INFO - Contents: 08:33:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9bbe6766896ae5412126e258fadab2e08b96ac7a7d9e334b16970e4a0d5cb2b8e9ba71f74a063aed3afa5d834f9960b9b00017ece2269ab4d0b30c92da860c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e21b1648aa4fbbe2bf4b9b6801a672d0511effc12196de306f15c830fd0a0652ce0a1395545f0ef47555a8bf6d0d2ea11735d019e696338b1f3ac945135e5929", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eab46c6f7bf62b847dab0dc70d9c3aaf89a8f81d890f9ac1a084ad9a27c529bbe0230fe98dea881236d18ccc0d3ecf68200e48a16cd09da0d530abd46af8e0f"} 08:33:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:50 INFO - Copying logs to upload dir... 08:33:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.654027 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-22 08:33:50.338011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 08:33:50.341728) ========= 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=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9bbe6766896ae5412126e258fadab2e08b96ac7a7d9e334b16970e4a0d5cb2b8e9ba71f74a063aed3afa5d834f9960b9b00017ece2269ab4d0b30c92da860c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e21b1648aa4fbbe2bf4b9b6801a672d0511effc12196de306f15c830fd0a0652ce0a1395545f0ef47555a8bf6d0d2ea11735d019e696338b1f3ac945135e5929", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eab46c6f7bf62b847dab0dc70d9c3aaf89a8f81d890f9ac1a084ad9a27c529bbe0230fe98dea881236d18ccc0d3ecf68200e48a16cd09da0d530abd46af8e0f"} build_url:https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/E-5ZZw7HRcGBVTENm7Qw2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9bbe6766896ae5412126e258fadab2e08b96ac7a7d9e334b16970e4a0d5cb2b8e9ba71f74a063aed3afa5d834f9960b9b00017ece2269ab4d0b30c92da860c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e21b1648aa4fbbe2bf4b9b6801a672d0511effc12196de306f15c830fd0a0652ce0a1395545f0ef47555a8bf6d0d2ea11735d019e696338b1f3ac945135e5929", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eab46c6f7bf62b847dab0dc70d9c3aaf89a8f81d890f9ac1a084ad9a27c529bbe0230fe98dea881236d18ccc0d3ecf68200e48a16cd09da0d530abd46af8e0f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 08:33:50.366562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:33:50.366852) ========= 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=745a4373a2a16df560f216e000000264-1469200355.719788-495032910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:33:50.450007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 08:33:50.450305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 08:33:50.450591) ========= ========= Total master_lag: 0.19 =========