builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1468461918.15 results: success (0) buildid: 20160713173001 builduid: 79e950d3dff84e988b9ab4bda7c9991c revision: 31cab0ba8bbf1d88b08abeae45bcdf317645355a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.151561) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.152074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.152402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.208699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.208968) ========= 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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 19:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-07-13 19:05:18 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.310670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.310971) ========= 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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017668 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.363900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:18.364215) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31cab0ba8bbf1d88b08abeae45bcdf317645355a --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 31cab0ba8bbf1d88b08abeae45bcdf317645355a --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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 19:05:18,967 truncating revision to first 12 chars 2016-07-13 19:05:18,968 Setting DEBUG logging. 2016-07-13 19:05:18,968 attempt 1/10 2016-07-13 19:05:18,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31cab0ba8bbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 19:05:19,277 unpacking tar archive at: fx-team-31cab0ba8bbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:19.022697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:19.022965) ========= script_repo_revision: 31cab0ba8bbf1d88b08abeae45bcdf317645355a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:19.023333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:19.023608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 19:05:19.035532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-13 19:05:19.035804) ========= /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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:05:19 INFO - MultiFileLogger online at 20160713 19:05:19 in /builds/slave/test 19:05:19 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 19:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:19 INFO - {'append_to_log': False, 19:05:19 INFO - 'base_work_dir': '/builds/slave/test', 19:05:19 INFO - 'blob_upload_branch': 'Fx-Team', 19:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:19 INFO - 'branch': 'Fx-Team', 19:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:19 INFO - 'config_files': ('talos/linux_config.py',), 19:05:19 INFO - 'default_actions': ('clobber', 19:05:19 INFO - 'read-buildbot-config', 19:05:19 INFO - 'download-and-extract', 19:05:19 INFO - 'populate-webroot', 19:05:19 INFO - 'create-virtualenv', 19:05:19 INFO - 'install', 19:05:19 INFO - 'run-tests'), 19:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:19 INFO - 'download_minidump_stackwalk': True, 19:05:19 INFO - 'download_symbols': 'ondemand', 19:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:19 INFO - 'installer_path': 'installer.exe', 19:05:19 INFO - 'log_level': 'info', 19:05:19 INFO - 'log_name': 'talos', 19:05:19 INFO - 'log_to_console': True, 19:05:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:05:19 INFO - 'opt_config_files': (), 19:05:19 INFO - 'pip_index': False, 19:05:19 INFO - 'sps_profile': False, 19:05:19 INFO - 'sps_profile_interval': 0, 19:05:19 INFO - 'suite': 'dromaeojs-e10s', 19:05:19 INFO - 'system_bits': '32', 19:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:19 INFO - 'title': 'talos-linux64-ix-026', 19:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:19 INFO - 'use_talos_json': True, 19:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:19 INFO - 'work_dir': 'build'} 19:05:19 INFO - ##### 19:05:19 INFO - ##### Running clobber step. 19:05:19 INFO - ##### 19:05:19 INFO - Running pre-action listener: _resource_record_pre_action 19:05:19 INFO - Running main action method: clobber 19:05:19 INFO - rmtree: /builds/slave/test/build 19:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:20 INFO - Running post-action listener: _resource_record_post_action 19:05:20 INFO - ##### 19:05:20 INFO - ##### Finished clobber step (success) 19:05:20 INFO - ##### 19:05:20 INFO - ##### 19:05:20 INFO - ##### Running read-buildbot-config step. 19:05:20 INFO - ##### 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: read_buildbot_config 19:05:20 INFO - Using buildbot properties: 19:05:20 INFO - { 19:05:20 INFO - "project": "", 19:05:20 INFO - "product": "firefox", 19:05:20 INFO - "script_repo_revision": "production", 19:05:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:05:20 INFO - "repository": "", 19:05:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:05:20 INFO - "buildid": "20160713173001", 19:05:20 INFO - "pgo_build": "True", 19:05:20 INFO - "basedir": "/builds/slave/test", 19:05:20 INFO - "buildnumber": 619, 19:05:20 INFO - "slavename": "talos-linux64-ix-026", 19:05:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:05:20 INFO - "platform": "ubuntu64_hw", 19:05:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:05:20 INFO - "branch": "fx-team", 19:05:20 INFO - "repo_path": "integration/fx-team", 19:05:20 INFO - "revision": "31cab0ba8bbf1d88b08abeae45bcdf317645355a", 19:05:20 INFO - "stage_platform": "linux64-pgo", 19:05:20 INFO - "builduid": "79e950d3dff84e988b9ab4bda7c9991c", 19:05:20 INFO - "slavebuilddir": "test" 19:05:20 INFO - } 19:05:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:05:20 INFO - Running post-action listener: _resource_record_post_action 19:05:20 INFO - ##### 19:05:20 INFO - ##### Finished read-buildbot-config step (success) 19:05:20 INFO - ##### 19:05:20 INFO - ##### 19:05:20 INFO - ##### Running download-and-extract step. 19:05:20 INFO - ##### 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: download_and_extract 19:05:20 INFO - mkdir: /builds/slave/test/build/tests 19:05: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')]} 19:05:20 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:25 INFO - Downloaded 1361 bytes. 19:05:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:05:25 INFO - Using the following test package requirements: 19:05:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:05:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:05:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'jsshell-linux-x86_64.zip'], 19:05:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:05:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:05:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:05:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:05:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:05:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:05:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:05: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')]} 19:05:25 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:30 INFO - Downloaded 24326434 bytes. 19:05:30 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'] 19:05:30 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 19:05:32 INFO - Return code: 0 19:05:32 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 19:05: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')]} 19:05:32 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:33 INFO - Downloaded 24326434 bytes. 19:05:33 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'] 19:05:33 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 19:05:35 INFO - Return code: 0 19:05:35 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')]} 19:05:35 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:36 INFO - Downloaded 14403317 bytes. 19:05:36 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'] 19:05:36 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 19:05:36 INFO - Return code: 0 19:05: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')]} 19:05:36 INFO - https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q54gf0HhTlaPGphDdcez8A/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 19:05:37 INFO - Downloaded 60806469 bytes. 19:05:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:05:37 INFO - mkdir: /builds/slave/test/properties 19:05:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:37 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:37 INFO - Contents: 19:05:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:05:38 INFO - Running post-action listener: _resource_record_post_action 19:05:38 INFO - Running post-action listener: set_extra_try_arguments 19:05:38 INFO - ##### 19:05:38 INFO - ##### Finished download-and-extract step (success) 19:05:38 INFO - ##### 19:05:38 INFO - ##### 19:05:38 INFO - ##### Running populate-webroot step. 19:05:38 INFO - ##### 19:05:38 INFO - Running pre-action listener: _resource_record_pre_action 19:05:38 INFO - Running main action method: populate_webroot 19:05:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:38 INFO - '--tppagecycles', 19:05:38 INFO - '7'], 19:05:38 INFO - 'tests': ['tsvgm']}}, 19:05:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['damp', 'tps']}, 19:05:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['damp', 'tps']}, 19:05:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['dromaeo_dom']}, 19:05:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['basic_compositor_video']}, 19:05:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:05:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['a11yr', 19:05:38 INFO - 'ts_paint', 19:05:38 INFO - 'tpaint', 19:05:38 INFO - 'sessionrestore', 19:05:38 INFO - 'sessionrestore_no_auto_restore', 19:05:38 INFO - 'tabpaint']}, 19:05:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['tsvgx', 19:05:38 INFO - 'tsvgr_opacity', 19:05:38 INFO - 'tart', 19:05:38 INFO - 'tscrollx', 19:05:38 INFO - 'cart']}, 19:05:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:38 INFO - 'tsvgr_opacity', 19:05:38 INFO - 'tart', 19:05:38 INFO - 'tscrollx', 19:05:38 INFO - 'cart']}, 19:05:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--disable-e10s'], 19:05:38 INFO - 'tests': ['tp5o']}, 19:05:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'tests': ['tp5o']}, 19:05:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--disable-e10s', 19:05:38 INFO - '--xperf_path', 19:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:38 INFO - 'tests': ['tp5n']}, 19:05:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:38 INFO - 'talos_options': ['--xperf_path', 19:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:38 INFO - 'tests': ['tp5n']}}, 19:05:38 INFO - 'talos.zip': {'path': '', 19:05:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:38 INFO - Running post-action listener: _resource_record_post_action 19:05:38 INFO - ##### 19:05:38 INFO - ##### Finished populate-webroot step (success) 19:05:38 INFO - ##### 19:05:38 INFO - ##### 19:05:38 INFO - ##### Running create-virtualenv step. 19:05:38 INFO - ##### 19:05:38 INFO - Running pre-action listener: _resource_record_pre_action 19:05:38 INFO - Running main action method: create_virtualenv 19:05:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:38 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 19:05:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:38 INFO - Using real prefix '/usr' 19:05:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:41 INFO - Installing pip.................done. 19:05:41 INFO - Return code: 0 19:05:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:05:41 INFO - Using env: {'DISPLAY': ':0', 19:05:41 INFO - 'HOME': '/home/cltbld', 19:05:41 INFO - 'LANG': 'en_US.UTF-8', 19:05:41 INFO - 'LANGUAGE': 'en_US:en', 19:05:41 INFO - 'LOGNAME': 'cltbld', 19:05:41 INFO - 'MAIL': '/var/mail/cltbld', 19:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:41 INFO - 'MOZ_NO_REMOTE': '1', 19:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:41 INFO - 'NO_EM_RESTART': '1', 19:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:41 INFO - 'PWD': '/builds/slave/test', 19:05:41 INFO - 'SHELL': '/bin/bash', 19:05:41 INFO - 'SHLVL': '1', 19:05:41 INFO - 'TERM': 'linux', 19:05:41 INFO - 'TMOUT': '86400', 19:05:41 INFO - 'USER': 'cltbld', 19:05:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:41 INFO - '_': '/tools/buildbot/bin/python'} 19:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:41 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 19:05:41 INFO - Cleaning up... 19:05:41 INFO - Return code: 0 19:05:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:05:41 INFO - Using env: {'DISPLAY': ':0', 19:05:41 INFO - 'HOME': '/home/cltbld', 19:05:41 INFO - 'LANG': 'en_US.UTF-8', 19:05:41 INFO - 'LANGUAGE': 'en_US:en', 19:05:41 INFO - 'LOGNAME': 'cltbld', 19:05:41 INFO - 'MAIL': '/var/mail/cltbld', 19:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:41 INFO - 'MOZ_NO_REMOTE': '1', 19:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:41 INFO - 'NO_EM_RESTART': '1', 19:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:41 INFO - 'PWD': '/builds/slave/test', 19:05:41 INFO - 'SHELL': '/bin/bash', 19:05:41 INFO - 'SHLVL': '1', 19:05:41 INFO - 'TERM': 'linux', 19:05:41 INFO - 'TMOUT': '86400', 19:05:41 INFO - 'USER': 'cltbld', 19:05:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:41 INFO - '_': '/tools/buildbot/bin/python'} 19:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:41 INFO - Downloading/unpacking psutil>=3.1.1 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 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 19:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:43 INFO - Installing collected packages: psutil 19:05:43 INFO - Running setup.py install for psutil 19:05:43 INFO - building 'psutil._psutil_linux' extension 19:05:43 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 19:05:43 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 19:05:43 INFO - building 'psutil._psutil_posix' extension 19:05:43 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 19:05:44 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 19:05:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:44 INFO - Successfully installed psutil 19:05:44 INFO - Cleaning up... 19:05:44 INFO - Return code: 0 19:05:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:05:44 INFO - Using env: {'DISPLAY': ':0', 19:05:44 INFO - 'HOME': '/home/cltbld', 19:05:44 INFO - 'LANG': 'en_US.UTF-8', 19:05:44 INFO - 'LANGUAGE': 'en_US:en', 19:05:44 INFO - 'LOGNAME': 'cltbld', 19:05:44 INFO - 'MAIL': '/var/mail/cltbld', 19:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:44 INFO - 'MOZ_NO_REMOTE': '1', 19:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:44 INFO - 'NO_EM_RESTART': '1', 19:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:44 INFO - 'PWD': '/builds/slave/test', 19:05:44 INFO - 'SHELL': '/bin/bash', 19:05:44 INFO - 'SHLVL': '1', 19:05:44 INFO - 'TERM': 'linux', 19:05:44 INFO - 'TMOUT': '86400', 19:05:44 INFO - 'USER': 'cltbld', 19:05:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:44 INFO - '_': '/tools/buildbot/bin/python'} 19:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:46 INFO - Installing collected packages: mozsystemmonitor 19:05:46 INFO - Running setup.py install for mozsystemmonitor 19:05:46 INFO - Successfully installed mozsystemmonitor 19:05:46 INFO - Cleaning up... 19:05:46 INFO - Return code: 0 19:05:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05:46 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')]} 19:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 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')]} 19:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:46 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:46 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 19:05:46 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 19:05:46 INFO - Using env: {'DISPLAY': ':0', 19:05:46 INFO - 'HOME': '/home/cltbld', 19:05:46 INFO - 'LANG': 'en_US.UTF-8', 19:05:46 INFO - 'LANGUAGE': 'en_US:en', 19:05:46 INFO - 'LOGNAME': 'cltbld', 19:05:46 INFO - 'MAIL': '/var/mail/cltbld', 19:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:46 INFO - 'MOZ_NO_REMOTE': '1', 19:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:46 INFO - 'NO_EM_RESTART': '1', 19:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:46 INFO - 'PWD': '/builds/slave/test', 19:05:46 INFO - 'SHELL': '/bin/bash', 19:05:46 INFO - 'SHLVL': '1', 19:05:46 INFO - 'TERM': 'linux', 19:05:46 INFO - 'TMOUT': '86400', 19:05:46 INFO - 'USER': 'cltbld', 19:05:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:46 INFO - '_': '/tools/buildbot/bin/python'} 19:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:46 INFO - Downloading/unpacking jsonschema==2.5.1 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:46 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 19:05:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:48 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:48 INFO - warning: no files found matching '*.txt' 19:05:48 INFO - no previously-included directories found matching 'build' 19:05:48 INFO - no previously-included directories found matching 'dist' 19:05:48 INFO - no previously-included directories found matching '.git*' 19:05:48 INFO - Installing collected packages: jsonschema, functools32 19:05:48 INFO - Running setup.py install for functools32 19:05:49 INFO - warning: no files found matching '*.txt' 19:05:49 INFO - no previously-included directories found matching 'build' 19:05:49 INFO - no previously-included directories found matching 'dist' 19:05:49 INFO - no previously-included directories found matching '.git*' 19:05:49 INFO - Successfully installed jsonschema functools32 19:05:49 INFO - Cleaning up... 19:05:49 INFO - Return code: 0 19:05:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:49 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:49 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 19:05:49 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 19:05:49 INFO - Using env: {'DISPLAY': ':0', 19:05:49 INFO - 'HOME': '/home/cltbld', 19:05:49 INFO - 'LANG': 'en_US.UTF-8', 19:05:49 INFO - 'LANGUAGE': 'en_US:en', 19:05:49 INFO - 'LOGNAME': 'cltbld', 19:05:49 INFO - 'MAIL': '/var/mail/cltbld', 19:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:49 INFO - 'MOZ_NO_REMOTE': '1', 19:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:49 INFO - 'NO_EM_RESTART': '1', 19:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:49 INFO - 'PWD': '/builds/slave/test', 19:05:49 INFO - 'SHELL': '/bin/bash', 19:05:49 INFO - 'SHLVL': '1', 19:05:49 INFO - 'TERM': 'linux', 19:05:49 INFO - 'TMOUT': '86400', 19:05:49 INFO - 'USER': 'cltbld', 19:05:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:49 INFO - '_': '/tools/buildbot/bin/python'} 19:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:49 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 19:05:49 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 19:05:49 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 19:05:49 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 19:05:49 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 19:05:49 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 19:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 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 19:05:51 INFO - Downloading docopt-0.6.1.tar.gz 19:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:51 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:51 INFO - Running setup.py install for blobuploader 19:05:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:52 INFO - Running setup.py install for requests 19:05:52 INFO - Running setup.py install for docopt 19:05:52 INFO - Successfully installed blobuploader requests docopt 19:05:52 INFO - Cleaning up... 19:05:52 INFO - Return code: 0 19:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:52 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:52 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 19:05:52 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 19:05:52 INFO - Using env: {'DISPLAY': ':0', 19:05:52 INFO - 'HOME': '/home/cltbld', 19:05:52 INFO - 'LANG': 'en_US.UTF-8', 19:05:52 INFO - 'LANGUAGE': 'en_US:en', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MAIL': '/var/mail/cltbld', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SHLVL': '1', 19:05:52 INFO - 'TERM': 'linux', 19:05:52 INFO - 'TMOUT': '86400', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - '_': '/tools/buildbot/bin/python'} 19:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 INFO - Running setup.py (path:/tmp/pip-GnXgq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:52 INFO - Running setup.py (path:/tmp/pip-CeN2ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:52 INFO - Running setup.py (path:/tmp/pip-Uag7ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:53 INFO - Running setup.py (path:/tmp/pip-wnPJy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:53 INFO - Running setup.py (path:/tmp/pip-ovAUiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:53 INFO - Running setup.py (path:/tmp/pip-VD5qbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:53 INFO - Running setup.py (path:/tmp/pip-YPNk98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 INFO - Running setup.py (path:/tmp/pip-LKZ4u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:53 INFO - Running setup.py (path:/tmp/pip-erwO7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:53 INFO - Running setup.py (path:/tmp/pip-JkCVjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 INFO - Running setup.py (path:/tmp/pip-KybUvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 INFO - Running setup.py (path:/tmp/pip-v09Hli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 INFO - Running setup.py (path:/tmp/pip-k1ui6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 INFO - Running setup.py (path:/tmp/pip-3tjZBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 INFO - Running setup.py (path:/tmp/pip-OLOLMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:53 INFO - Running setup.py (path:/tmp/pip-B9JFtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:53 INFO - Running setup.py (path:/tmp/pip-g7FdlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:54 INFO - Running setup.py install for manifestparser 19:05:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Running setup.py install for mozcrash 19:05:54 INFO - Running setup.py install for mozdebug 19:05:54 INFO - Running setup.py install for mozdevice 19:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Running setup.py install for mozfile 19:05:54 INFO - Running setup.py install for mozhttpd 19:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Running setup.py install for mozinfo 19:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Running setup.py install for mozInstall 19:05:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:54 INFO - Running setup.py install for mozleak 19:05:54 INFO - Running setup.py install for mozlog 19:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Running setup.py install for moznetwork 19:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Running setup.py install for mozprocess 19:05:55 INFO - Running setup.py install for mozprofile 19:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Running setup.py install for mozrunner 19:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Running setup.py install for mozscreenshot 19:05:55 INFO - Running setup.py install for moztest 19:05:55 INFO - Running setup.py install for mozversion 19:05:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:55 INFO - Cleaning up... 19:05:55 INFO - Return code: 0 19:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:55 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:55 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 19:05:55 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 19:05:55 INFO - Using env: {'DISPLAY': ':0', 19:05:55 INFO - 'HOME': '/home/cltbld', 19:05:55 INFO - 'LANG': 'en_US.UTF-8', 19:05:55 INFO - 'LANGUAGE': 'en_US:en', 19:05:55 INFO - 'LOGNAME': 'cltbld', 19:05:55 INFO - 'MAIL': '/var/mail/cltbld', 19:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:55 INFO - 'MOZ_NO_REMOTE': '1', 19:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:55 INFO - 'NO_EM_RESTART': '1', 19:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:55 INFO - 'PWD': '/builds/slave/test', 19:05:55 INFO - 'SHELL': '/bin/bash', 19:05:55 INFO - 'SHLVL': '1', 19:05:55 INFO - 'TERM': 'linux', 19:05:55 INFO - 'TMOUT': '86400', 19:05:55 INFO - 'USER': 'cltbld', 19:05:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:55 INFO - '_': '/tools/buildbot/bin/python'} 19:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:56 INFO - Running setup.py (path:/tmp/pip-TrdwxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:56 INFO - Running setup.py (path:/tmp/pip-a1sx9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:56 INFO - Running setup.py (path:/tmp/pip-3uZh7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:56 INFO - Running setup.py (path:/tmp/pip-PcTQE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:56 INFO - Running setup.py (path:/tmp/pip-bcpmFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:56 INFO - Running setup.py (path:/tmp/pip-3UIEQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:56 INFO - Running setup.py (path:/tmp/pip-LxlhNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:56 INFO - Running setup.py (path:/tmp/pip-U_nDuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:56 INFO - Running setup.py (path:/tmp/pip-Zmlfdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:56 INFO - Running setup.py (path:/tmp/pip-iaw7ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:56 INFO - Running setup.py (path:/tmp/pip-2Guo4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:56 INFO - Running setup.py (path:/tmp/pip-lHc6w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:56 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)) 19:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:56 INFO - Running setup.py (path:/tmp/pip-gKEAQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:57 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)) 19:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:57 INFO - Running setup.py (path:/tmp/pip-oQZnu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:57 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)) 19:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:57 INFO - Running setup.py (path:/tmp/pip-200iXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:57 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)) 19:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:57 INFO - Running setup.py (path:/tmp/pip-_KJP2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:57 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)) 19:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:57 INFO - Running setup.py (path:/tmp/pip-Wp_bXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:57 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)) 19:05:57 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)) 19:05:57 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)) 19:05:57 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)) 19:05:57 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)) 19:05:57 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)) 19:05:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:57 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 19:05:57 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 19:05:57 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 19:05:57 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 19:05:57 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 19:05:57 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 19:05:59 INFO - Downloading blessings-1.6.tar.gz 19:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:59 INFO - Installing collected packages: blessings 19:05:59 INFO - Running setup.py install for blessings 19:05:59 INFO - Successfully installed blessings 19:05:59 INFO - Cleaning up... 19:05:59 INFO - Return code: 0 19:05:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:59 INFO - Reading from file tmpfile_stdout 19:05:59 INFO - Current package versions: 19:05:59 INFO - argparse == 1.2.1 19:05:59 INFO - blessings == 1.6 19:05:59 INFO - blobuploader == 1.2.4 19:05:59 INFO - docopt == 0.6.1 19:05:59 INFO - functools32 == 3.2.3-2 19:05:59 INFO - jsonschema == 2.5.1 19:05:59 INFO - manifestparser == 1.1 19:05:59 INFO - mozInstall == 1.12 19:05:59 INFO - mozcrash == 0.17 19:05:59 INFO - mozdebug == 0.1 19:05:59 INFO - mozdevice == 0.48 19:05:59 INFO - mozfile == 1.2 19:05:59 INFO - mozhttpd == 0.7 19:05:59 INFO - mozinfo == 0.9 19:05:59 INFO - mozleak == 0.1 19:05:59 INFO - mozlog == 3.2 19:05:59 INFO - moznetwork == 0.27 19:05:59 INFO - mozprocess == 0.23 19:05:59 INFO - mozprofile == 0.28 19:05:59 INFO - mozrunner == 6.12 19:05:59 INFO - mozscreenshot == 0.1 19:05:59 INFO - mozsystemmonitor == 0.3 19:05:59 INFO - moztest == 0.7 19:05:59 INFO - mozversion == 1.4 19:05:59 INFO - psutil == 3.1.1 19:05:59 INFO - requests == 1.2.3 19:05:59 INFO - wsgiref == 0.1.2 19:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:59 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 19:05:59 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 19:05:59 INFO - Using env: {'DISPLAY': ':0', 19:05:59 INFO - 'HOME': '/home/cltbld', 19:05:59 INFO - 'LANG': 'en_US.UTF-8', 19:05:59 INFO - 'LANGUAGE': 'en_US:en', 19:05:59 INFO - 'LOGNAME': 'cltbld', 19:05:59 INFO - 'MAIL': '/var/mail/cltbld', 19:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:59 INFO - 'MOZ_NO_REMOTE': '1', 19:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:59 INFO - 'NO_EM_RESTART': '1', 19:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:59 INFO - 'PWD': '/builds/slave/test', 19:05:59 INFO - 'SHELL': '/bin/bash', 19:05:59 INFO - 'SHLVL': '1', 19:05:59 INFO - 'TERM': 'linux', 19:05:59 INFO - 'TMOUT': '86400', 19:05:59 INFO - 'USER': 'cltbld', 19:05:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:59 INFO - '_': '/tools/buildbot/bin/python'} 19:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 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)) 19:05:59 INFO - Cleaning up... 19:05:59 INFO - Return code: 0 19:05:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:59 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 0x2264030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2525180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, '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': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', '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 19:05:59 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 19:05:59 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 19:05:59 INFO - Using env: {'DISPLAY': ':0', 19:05:59 INFO - 'HOME': '/home/cltbld', 19:05:59 INFO - 'LANG': 'en_US.UTF-8', 19:05:59 INFO - 'LANGUAGE': 'en_US:en', 19:05:59 INFO - 'LOGNAME': 'cltbld', 19:05:59 INFO - 'MAIL': '/var/mail/cltbld', 19:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:59 INFO - 'MOZ_NO_REMOTE': '1', 19:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:59 INFO - 'NO_EM_RESTART': '1', 19:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:59 INFO - 'PWD': '/builds/slave/test', 19:05:59 INFO - 'SHELL': '/bin/bash', 19:05:59 INFO - 'SHLVL': '1', 19:05:59 INFO - 'TERM': 'linux', 19:05:59 INFO - 'TMOUT': '86400', 19:05:59 INFO - 'USER': 'cltbld', 19:05:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:59 INFO - '_': '/tools/buildbot/bin/python'} 19:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:00 INFO - Cleaning up... 19:06:00 INFO - Return code: 0 19:06:00 INFO - Running post-action listener: _resource_record_post_action 19:06:00 INFO - Running post-action listener: _start_resource_monitoring 19:06:00 INFO - Starting resource monitoring. 19:06:00 INFO - ##### 19:06:00 INFO - ##### Finished create-virtualenv step (success) 19:06:00 INFO - ##### 19:06:00 INFO - ##### 19:06:00 INFO - ##### Running install step. 19:06:00 INFO - ##### 19:06:00 INFO - Running pre-action listener: _resource_record_pre_action 19:06:00 INFO - Running main action method: install 19:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:00 INFO - Reading from file tmpfile_stdout 19:06:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:00 INFO - Reading from file tmpfile_stdout 19:06:00 INFO - Output received: 19:06:00 INFO - Usage: mozinstall [options] installer 19:06:00 INFO - Options: 19:06:00 INFO - -h, --help show this help message and exit 19:06:00 INFO - -d DEST, --destination=DEST 19:06:00 INFO - Directory to install application into. [default: 19:06:00 INFO - "/builds/slave/test"] 19:06:00 INFO - --app=APP Application being installed. [default: firefox] 19:06:00 INFO - mkdir: /builds/slave/test/build/application 19:06:00 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'] 19:06:00 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 19:06:17 INFO - Reading from file tmpfile_stdout 19:06:17 INFO - Output received: 19:06:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:06:17 INFO - Running post-action listener: _resource_record_post_action 19:06:17 INFO - ##### 19:06:17 INFO - ##### Finished install step (success) 19:06:17 INFO - ##### 19:06:17 INFO - ##### 19:06:17 INFO - ##### Running run-tests step. 19:06:17 INFO - ##### 19:06:17 INFO - Running pre-action listener: _resource_record_pre_action 19:06:17 INFO - Running main action method: run_tests 19:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:17 INFO - Python 2.7.3 19:06:17 INFO - Return code: 0 19:06:17 INFO - grabbing minidump binary from tooltool 19:06:17 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')]} 19:06:17 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 0x25233b0>, '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 0x25242b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2524740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:17 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 19:06:17 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 19:06:17 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 19:06:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:17 INFO - Return code: 0 19:06:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:06:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:06:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:17 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/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:06:17 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/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 19:06:17 INFO - Using env: {'DISPLAY': ':0', 19:06:17 INFO - 'HOME': '/home/cltbld', 19:06:17 INFO - 'LANG': 'en_US.UTF-8', 19:06:17 INFO - 'LANGUAGE': 'en_US:en', 19:06:17 INFO - 'LOGNAME': 'cltbld', 19:06:17 INFO - 'MAIL': '/var/mail/cltbld', 19:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:17 INFO - 'MOZ_NO_REMOTE': '1', 19:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:17 INFO - 'NO_EM_RESTART': '1', 19:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:17 INFO - 'PWD': '/builds/slave/test', 19:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:17 INFO - 'SHELL': '/bin/bash', 19:06:17 INFO - 'SHLVL': '1', 19:06:17 INFO - 'TERM': 'linux', 19:06:17 INFO - 'TMOUT': '86400', 19:06:17 INFO - 'USER': 'cltbld', 19:06:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212', 19:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:17 INFO - '_': '/tools/buildbot/bin/python'} 19:06:17 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/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:06:17 INFO - mozversion application_buildid: 20160713173001 19:06:17 INFO - mozversion application_changeset: 31cab0ba8bbf1d88b08abeae45bcdf317645355a 19:06:17 INFO - mozversion application_display_name: Nightly 19:06:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:17 INFO - mozversion application_name: Firefox 19:06:17 INFO - mozversion application_remotingname: firefox 19:06:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:06:17 INFO - mozversion application_vendor: Mozilla 19:06:17 INFO - mozversion application_version: 50.0a1 19:06:17 INFO - mozversion platform_buildid: 20160713173001 19:06:17 INFO - mozversion platform_changeset: 31cab0ba8bbf1d88b08abeae45bcdf317645355a 19:06:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:06:17 INFO - mozversion platform_version: 50.0a1 19:06:17 INFO - using testdate: 1468461977 19:06:17 INFO - actual date: 1468461977 19:06:17 INFO - starting webserver on 'localhost:37491' 19:06:17 INFO - SUITE-START | Running 2 tests 19:06:17 INFO - TEST-START | dromaeo_css 19:06:17 INFO - operating with platform_type : linux_ 19:06:17 INFO - Initialising browser for dromaeo_css test... 19:06:17 INFO - TEST-INFO | started process 11828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK0EUlM/profile http://localhost:37491/getInfo.html) 19:06:22 INFO - PROCESS | 11828 | __metrics Screen width/height:1600/1200 19:06:22 INFO - PROCESS | 11828 | colorDepth:24 19:06:22 INFO - PROCESS | 11828 | Browser inner width/height: 1024/697 19:06:22 INFO - PROCESS | 11828 | __metrics 19:06:22 ERROR - PROCESS | 11828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:06:23 INFO - TEST-INFO | 11828: exit 0 19:06:23 INFO - Browser initialized. 19:06:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:23 INFO - TEST-INFO | started process 11950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK0EUlM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:35 INFO - PROCESS | 11950 | RSS: Main: 167854080 19:06:35 INFO - PROCESS | 11950 | 19:07:25 INFO - PROCESS | 11950 | 1468462045056 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] 19:09:33 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37491/tests/dromaeo/cssquery-ext.html) 19:09:34 INFO - PROCESS | 11950 | RSS: Main: 171335680 19:09:34 INFO - PROCESS | 11950 | 19:12:36 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-ext.html (next: http://localhost:37491/tests/dromaeo/cssquery-jquery.html) 19:12:37 INFO - PROCESS | 11950 | RSS: Main: 167907328 19:12:37 INFO - PROCESS | 11950 | 19:15:39 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37491/tests/dromaeo/cssquery-mootools.html) 19:15:39 INFO - PROCESS | 11950 | RSS: Main: 172011520 19:15:39 INFO - PROCESS | 11950 | 19:18:41 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37491/tests/dromaeo/cssquery-prototype.html) 19:18:42 INFO - PROCESS | 11950 | RSS: Main: 167120896 19:18:42 INFO - PROCESS | 11950 | 19:21:44 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37491/tests/dromaeo/cssquery-yui.html) 19:21:45 INFO - PROCESS | 11950 | RSS: Main: 168828928 19:21:45 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | Cycle 1(1): loaded http://localhost:37491/tests/dromaeo/cssquery-yui.html (next: http://localhost:37491/tests/dromaeo/cssquery-dojo.html) 19:24:47 INFO - PROCESS | 11950 | RSS: Main: 169889792 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | __start_tp_report 19:24:47 INFO - PROCESS | 11950 | _x_x_mozilla_page_load 19:24:47 INFO - PROCESS | 11950 | _x_x_mozilla_page_load_details 19:24:47 INFO - PROCESS | 11950 | |i|pagename|runs| 19:24:47 INFO - PROCESS | 11950 | |0;dojo.html;3094.5048792193247;3143.6856314368565;3151.3067125232456;3162.2252548125684;3182.2521707398755;5576.358718747345;5579.776808927643;5583.441655834425;5609.158626206071;5662.17898404731;5400.405955344909;5567.359753628334;5618.859528511789;5635.436456354362;5691.3170419549715;5035.420926593443;5074.314967479399;5109.054824857395;5218.243354713564;5223.477652234765;5044.697318160904;5218.504242096995;5230.476952304777;5240.895182096356;5252.212168174785;4976.527229913152;5069.340985671839;5084.008618319448;5096.261042148886;5147.691138531682;5134.845954621367;5143.5113664201845;5143.691378517301;5151.793928242866;5166.689998600058;5077.720725360104;5088.6946783193125;5110.310108135392;5115.104856650109;5147.48525147486;5415.891682166374;5422.186671999192;5525.502704756591;5558.249636299089;5586.273784408001;5971;5974;5992.640441573476;6002.549808764316;6009.549283803733;6041.456268935817;6050.304215015286;6052.667103309316;6054.152418661347;6058.575899687024;5413.485718856702;5523.364813046471;5569.610127291091;5597.384287728347;5602.691851948182;6050;6099.146119543268;6132.816015519542;6132.877342453126;6140.969295153495;5773.797917072882;5892.351841297454;5895.882082358329;5897.705114744245;5905.498032667271;5911.3201981772645;5966.522678185735;5984.521238300926;6017.157597936292;6033.5173186145;5684.204211410406;5795.971020144872;5831.0378787499585;5955.34491205967;5957.880842383215;5767.68277744728;5802.506786923074;5805.564582656318;5807.5644326675665;5856.59003869725;4492.528284530143;4537.410136682211;4559.749213793273;4576.610988065985;4591.747453890001;3956.188981258835;4021.135455876942;4041.777702226406;4065.6950728695465;4072.898177545585;5745.2243947067445;5750.971245143747;5769.8557536061935;5770.480656740913;5776.537876969833;6049.425304596057;6050.788222412282;6079.0273556230795;6089.025755879126;6092.421219984094;5611.719414029282;5621.522170615462;5663.235463212413;5682.232898558642;5710;5020.196768517019;5063.088644044034;5063.291139240509;5063.417706963673;5081.720505372166;5962.25471816023;6188.1027251048345;6253.593516421418;6294.622322660655;6316.2736285326855;5971.940280597225;6038.547108966757;6062.454379105901;6076.33160352352;6106.511479081574;6207.047886930545;6247.68761561911;6265.906011409924;6274.623522588659;6283.5287353449585;5703.714814259188;5817.301923769175;5931.881362372815;5964.8964941485965;5987.850303742442;5976.432238937294;6054.061620448838;6055.333913269625;6075.878482430415;6123.663198524124;5891.852703682443;5914.497267732291;5960.165576819162;5969.194158788508;5982.581219314607;5692.4876761090045;5848;5851.765929362778;5909.763609455746;5927.673977931255;5631.971840140937;5771;5784.132380142844;5829.358770535323;5888.381719919518;5797.449242321973;5926.318473375617;5946.524278057832;5972.283326000907;6018.638881667114;5606.747696353756;5752.424757524382;5779.913301300568;5869.647821130746;5876.412358764261 19:24:47 INFO - PROCESS | 11950 | |1;ext.html;549.6865069140254;569.53013763645;587.3245767367526;604.6764980735306;611.5291225756171;39887.40168897465;43075.569244307546;43098.35352469715;43363;43477.34783978243;43932.560674393244;44757.55242447575;44789.77605111978;44838.55161448385;44886.10227795442;8796.120387961217;8970.910290897073;9002.684906028291;9003.279737621007;9020.2783777298;8957.328200384965;8989.865152022692;8991.820163596723;9019.323550733689;9049.049849765779;9004.189622933935;9118.267529169436;9131;9131.726048218565;9161.541922903862;9013.819723605524;9046.547672616376;9064.682736104205;9076.364654474157;9078.727638170865;8835.249003834682;8893.599788009555;8899.288056955427;8921.063288354695;8946.552672366355;32750.672493275;42504.3624345635;42968.78515607433;43010.784946075066;43073.35389969153;3419.3674170278578;3460.359833430798;3502.5972013218297;3881.902952426212;4180.8118634661205;31417.685823141706;31798.841005795053;31940.680593194236;32126.357472850646;32202.355952881044;4146.502419709624;4171.270027745163;4245.448091748053;4266.210751011042;4432.423784907974;343449;343660;345289.73551322334;347262;347376.9999999975;34290.14274643104;34355.31289374198;34379.14052148666;34587.48118778221;34883;35896.461553076726;37532.62467375346;37617;37734.62265377366;37785.244295113946;13270;13306.401211945486;13317.200967941955;13359.599212023655;13372.264525450999;11979.700507487209;12072.577459788865;12075.275483470845;12088.456019479145;12089.395530223454;8359.122292159358;8370.079291277954;8392.412531122885;8434.789130271669;8454.61954212062;3279.622843372995;3287.684926029607;3287.8356082195796;3322.551455553469;3338.130646837779;1021.0606242257142;1044.1333693034762;1075.2795626929976;1158.472894832849;1188.7503624239007;32821.343573128404;32971.50542741861;33081.83459082689;33145.668543314256;33978.15054623605;1100.1528822806395;1108.661858133261;1188.8335633011386;1206.776746301937;1273.961781146567;17093.316267349168;17377.826221737872;17518.737218941726;17626.91186544059;17882.91058544725;949352;955132;971029.303681336;972663;973775;59484.7025764877;60297;60470.395296046474;60518.697406512685;60592.69703651453;1354.8035534847393;1383.7652191710315;1394.2540740703676;1407.3385508810843;1415.058985774469;31475;32796.34407311888;33238.66761332453;33579.3284134311;34556;52291.21563176632;52667.73666131645;52667.73666131645;52748;52799.208011879084;397032;406042;407020;407394;525262;28218.85890570534;28358.71641283561;28400.57399139056;28749.28126796847;28791.568126478538;48748.5125148744;48771.75614121907;48801;49728.25407618816;50199;42597.148057038066;42923.14153716971;46682.76658616685;47248.2912756302;47992.28011579759;43728.088329901424;47792.7610361946;47944.5205547954;47965.76017119892;48710.75644621896;45544.20134434264;45752;46201.53798462107;46292.768536157106;46747.76626116848;45091.77454112709;45626.54373456223;45903.77048114871;46172;46427;30117;30215.2602828558;30603.693963060974;30603.724952604596;30816.383672326876 19:24:47 INFO - PROCESS | 11950 | |2;jquery.html;382.7072289698381;390.7343006755405;392.0675623496329;398.37455195343307;400.0598593305731;18813.529661758446;20567.691484627725;20667.689984650242;20905.581888362223;21109.683354749654;19673.31143409981;19992.700109498368;20055.29806456774;20125.094370753315;20192.29326973556;5217.47825217479;5537.280153580049;5537.418571050042;5595.916061259084;5610.074337734269;5413.593980451462;5465.07093794054;5468.589855760814;6184.412480814338;6193.783217587363;6207.472364848971;6212.78255261066;6222.502199824025;6355.809325720235;6362.1093046973465;5573.27547418833;5669.092945128801;5714.571407144481;5756.079027355624;5833.649981001132;5514.3276089171495;5515.034868897927;5518.558515318765;5540.556755459554;5567.554595632339;14193.929030354886;14384.784228236585;14398.208098554574;14418.279086045655;18819.71770423431;2334.6031174700342;2334.867589219244;2502.5245203411478;2972.613560237177;2997.8201307921595;10788.51451684676;10843.240973131884;10869.45652717361;13609.659758506017;14907;1843.4561804267773;1913.5407502199512;1936.5449119456916;1940.5730739237345;2029.1984666056826;86189;88100.55949720275;89317.55341223317;89572.55213723889;89847.55076224642;10564.577416903392;10644.680659580225;11040.613578524873;11045.889541104487;11093.445327733582;14782.926085369505;15103.244837758068;15106.018108822891;15181.848181518264;15195.316210770541;7351;7678.462507624413;7696.8460630788195;7730.806729831799;7917.366610671133;7372;7449;7545.7358992435;7549.433792465587;7560.6219689016425;4590.219662657356;4597.356370108188;4670.753826090834;4703.223968045303;4725.8582242532775;1833.697439922398;1885.5003424092627;1885.5097674604701;1930.7007413850877;1934.7291379206922;962.4946902876046;1005.2706900764459;1045.3936716704293;1047.9633212837514;1080.2600218850114;20429.69355459669;20515.794842051688;20533.89733051355;20706.58586828255;21203.36389908305;1026.861373714554;1029.27950434696;1034.4103860799273;1034.5396298647029;1064.0370464729433;11090.223684342018;11377;11461;11569.247998880046;11668.88331116695;399122;400932;402234;505113;534107;86645.56677216574;88960.5551972236;90945.54527227322;107336.31659208426;109352.45323773331;1007.8437842134481;1017.3285631483186;1053.073295499955;1059.0521483272428;1064.1327318235767;16700;18780.718289225944;18827.811721882605;18884.527886802938;19202.8079719201;38142.61857381391;39890.40164397594;44505;45509.772451137535;46931;63560.3643963573;63606.363936360045;63814.36185638084;65186.67406663126;65236;8473.406861519634;8495.555919079645;8532.658693652184;8674.30605551567;8761.211490965843;9626.711198664052;13279.468821247043;14041.5085472008;14056.156630602196;14096.647583810487;5657.462541058593;10244.795104097728;12135.575254866037;12238.755224895274;12712.491500339884;11519.8272025918;11648.242864213798;12126.575569855013;12204.206726562745;12433.191842530206;12504.374781261082;12539.310337931136;12572.434240459019;12605.810912836132;12741;8250.38122140854;8293.460925039853;8490.660373585235;8612.224899758801;8995.23540499065;12180.269183848997;12214.816777748518;12244.938775306067;12251.632451026484;12336.259824410565 19:24:47 INFO - PROCESS | 11950 | |3;mootools.html;1480.5854360778978;1492.1420183394548;1671.7074511960404;1787.7675902132721;1799.2443173866975;8009.759707208778;8754.212120909116;8827.867581986267;9356.812863742729;9390.342676012673;8837.558122093902;9019.188273055424;9036.95481522593;9117;9155.90844091559;2301.700778898745;2322.2104484475276;2324.93025209244;2327.476317828492;2340.6957095577636;2252;2306.1351993002622;2371.1700904683394;2376.786089251967;2380.726216485109;2234.5307485427998;2238.68658387825;2252.707148070757;2272.1025195047946;2291.5073259249257;2273.89767460463;2276.7950884420397;2287.1308902617066;2289.725232972054;2293.2203050962585;2096.371088673407;2106.799854013866;2109.831213502916;2110.2930518276394;2114.7568029676477;9024.954875225581;9180.908190918139;9188.540572971324;9195.40229885062;9207.539623018822;5197.870053248661;5265.078611243055;5307.2835167252315;5307.761150748225;5333.413324534298;3287.7205437537837;3402.727781777452;3449.793012419263;3506.824658767077;3553.4492153716214;1102.101787043557;1121.1871393239917;1138.362516990488;1138.49337045015;1141.5547936304847;12675.492980280778;12755.61733148007;12804.80792788109;12830.037747169094;12834.486620535168;4515.367848501212;4665.370175026328;4670.206064968896;4721.079389519011;4733.786979585927;10695.411752353695;10753.892461075446;10766.407847568302;10801.78396432067;10814.405207713495;5247.2129180623215;5254;5259.184826351845;5268.078086334876;5280.9207861882105;4286.357046442996;4730.314104454904;4858.489858564871;4889.217725163957;4895.559399653977;3962.3660214365564;3971.0866500705;4030.4558884550797;4084.4894388201474;4101.671866250693;1210.285931300537;1258.3393718297784;1274.6112435707014;1284.9935750321188;1286.8005459153846;1018.6383833739064;1032.6901929421294;1055.488088277185;1059.7244716373643;1067.8184708599556;6311.684415779193;6403.807885763435;6478.708458119396;6489.221293444817;6490.513211509156;443.5054913771122;459.18953047870536;459.23766547530937;462.3503976912443;464.90237050219156;4390.714603550759;4409.4267745193565;4456.309272062836;4511.796969136331;4565.634749220055;11053.557857685602;11494.540218391337;11564.42177891119;11566.30602163873;11586.188966772244;11295.604653837076;11369.715757106138;11429.371384573928;11457.08343332548;11459.140564457532;8525.531095789791;8591;8624.00823905259;8678.349123815738;8683.609237584324;6357.90463143044;6398.87202255943;6434.678266086583;6483.059956306403;6506.3818937200895;10282.126019288145;10403;10460.372377657364;10608.204384671026;10671.51978161;10213.029762172582;10491.318064325795;10786.352818830896;10802.783944321227;10821.729456763329;7477.364424023801;7584.810379740551;7813.9218607815465;8038.236367545074;8175.67297308101;9084.40951338161;9146.496942668216;9161.633534658538;9211.447313161232;9224.123708247706;8085.434019618806;8252.752417427488;8262.091169971178;8286.792830179053;8351.457155284887;7617.314441700273;7638.732644357421;7647.38820894316;7659.387249020177;7785.961070194613;7475.177730449755;7491.438142139253;7499.400047996256;7562.697492100255;7583.886241706489;5648.802291919763;5692.459216374438;5755.280589926259;5757.683327416865;5829.446202610745;5354.330708661418;5389.622726409114;5445;5480.177973303877;5729.4843464088435 19:24:47 INFO - PROCESS | 11950 | |4;prototype.html;312.3581040960826;319.2959524249031;323.14850369276957;329.0359247405104;329.50574138791814;5315.654482458637;5451.700156491392;5532.367951454321;5590.211132437622;5605.579581531386;5535.142052981784;5571.721413929297;5590.468905453986;5600;5606.719664016803;4363.4327537420095;4364.759938203398;4369.978150109245;4372.89067773305;4373.322135069069;4088.632023117919;4301.118270754488;4308.9353659695125;4348.195583816988;4365.5852693994175;4241.745495270294;4255.553166917475;4259.5740425957465;4271.63691086258;4276.786160691953;4273.9358909616385;4278;4280.6361459275995;4282.7002109852165;4295.548967358413;3484.6515348465205;3728.440733889911;3731.477593136963;3738.513993180869;3746.1758413149064;5415.918761218585;5420.23842251266;5430.945690543083;5435.782568697247;5454.972725136349;4881.365422495089;4886.486918873538;4892.339534162914;4906.165951788169;4907.803687852482;5523.502884740393;5815.912761308584;5833.4749872511675;5834.066549352084;5852.326982397036;4060.1473690525027;4082.408050832613;4086.5084244250934;4092.5088989321175;4100.528439229497;6075.878482430415;6095.481884039862;6119.296280927706;6122.96938515309;6142.355052719445;4000.6399424051974;4088.793805827288;4096.713230073866;4099.159672267178;4121.8969525762095;4143.295639741191;4153.75697123556;4154.338264694146;4171.582841715865;4172.395002724648;4829.903401932012;4852;4852.199387101089;4863.416390033219;4865.197242454955;5264.447233040552;5842.591018628656;5867.860694528492;5895.882082358329;5899.734511946973;1392.5613431768961;1395.0931894268806;1401.3203596255807;1401.8084628066063;1403.8596140386085;877.2630989968329;890.7817584691792;904.0823564082461;913.2191975860676;922.1884741427501;4907.429622520759;4973.532807821629;5041.974790126099;5067.820837040108;5084.745762711849;5132.666376685504;5254.894902101936;5259.684418934876;5289.629725919149;5314.681119132864;4667.673262871566;4975.776090075955;5037.924431133462;5054.7472626368535;5093.923591146136;2785.373291009507;2801.467721132978;2808.9859550702117;2815.873285702148;2830.7735381169455;5377.27406800077;5430.239766432703;5432.75552600134;5433.293671822637;5446;5144.312986423781;5251.317328747238;5361.571074314045;5384.461553844584;5460.116259890331;5384.811531596375;5410.810621628303;5416.377116631559;5432.972835135878;5433.510984011458;5244.659097158673;5249.47505249472;5257.842264732064;5263.499967503081;5310.840674779763;4865.481689663643;5149.665271757323;5170.922436163536;5182.273587685704;5191.584673226208;5357.624966252325;5408.3509978802795;5410.756515956713;5417.593680473901;5440.211169380338;3778.4899038629433;3789.7915614640356;3793.393057110849;3800.6009369015856;3806.8096595170687;5069.518395752398;5212.374515058217;5230.476952304739;5869.413058694096;5993.0710739835395;5923.437273459014;5943.227380440515;5943.881122377442;5944.4352786485215;5960.913680211891;5903.380145084704;5909.134069976144;5916.881662366643;5917.467427931507;5919.556033297434;5583.776648933997;5813.168851811666;5839.620424672383;5846.1815345852465;5874.794382196603;5917.792877249448;5927.170196172453;5942.73257703413;5946.405359464019;5972.163897054503;5630.493255606852;5823.272090988627;5824.650520968756;5835.854103647443;5848.327442344014 19:24:47 INFO - PROCESS | 11950 | |5;yui.html;679.7552880962855;766.3677466090477;773.5822655765887;785.6307535458334;862.4782006885833;14682.63293417665;15702.450414235504;15719.13544755038;15822.129782861937;15906.840931590681;14485.565433037;14560.344784484698;14636.926815365934;14637.926810365932;14651.047681900669;654.231278248059;780.7579650308394;807.5195258821021;808.1110778144024;815.4251252866715;800.7557694903052;803.7990502374406;807.9555624440653;810.1291112054536;812.8008637883727;854.7649396415973;857.1214505132227;862.4954401674996;863.7926897544606;864.8745931839879;852.5012867472536;856.2892798976834;856.4005196362571;856.7087190355278;858.2961971183632;626.2703949898363;628.6416742456802;628.6605233174081;629.4964028777006;629.5876201088295;14375.568732938029;14379.568612941628;14435.494757683431;14482.49311274111;14516.201608911506;14052.648683782987;14301.213433261166;14365.640858978504;14533.128012319188;14535.563933082025;10857.45712714361;11026.889731102747;11082;11273.774524509547;11327.490262938105;3759.4586219649814;3760.1168230082035;3833.8466461341513;3848.8845334640005;3873.4964454621;78859;79006.81489777715;79129.60435197788;79138.20861791365;79481.20518794854;10288.537015834305;10594.205434592437;10684.25210235276;10695.83956240657;10775.407352595683;23099.538009240056;23604.055837766296;23625.7637423627;23644.172453964373;23719.644205336936;8440.366972477088;8523.829523409497;8611.181937715906;8617.138286171457;8686.044535101133;4771.66598338113;4796.616270698406;4828.348172996671;4862.489438608965;4878.780454879539;3592.2097138629983;3686.576043754949;3697.7411581189594;3701.11173318407;3701.833417496219;627.4509803921569;637.8819918315127;638.7700427845972;646.4085361893815;660.211047797877;652.6606164794281;713.1228588835761;722.9096362954631;746.7087835744064;788.5190034079208;9821.656242031495;9960.252981026451;10025;10210.897891021143;10254.179665626732;669.263809809206;687.5668328952728;690.5511417578614;693.9895901561481;701.2216439751871;4879.097366987119;4986.551210391082;5010.624203184776;5036.169032109734;5052.469490703496;87707;118390;119040;120517;121131;86673;104903.75481225908;107352.46323768332;107460;108411.45794271136;89578;90239.54880225557;90245.54877225703;90338;91537;9461.810763784548;9494.85757713621;9494.95252523733;9528.618855245713;9528.761780955254;54252.45747542474;54689.45310547003;54798.72600637131;54853;55774.8168887327;72621.27378726145;79864;80777;81394;81700;12882.35588220604;12956.740865182455;13251.933740331237;13349.933250333686;13350;12806.295653739135;13250.403731832284;13453.529126480918;13874.791878121634;14360.497382591559;11983.28100313984;12062.577809776616;12080.577179798665;12105.878941210474;12370.257784532956;11964.288381773744;12672.74654506923;12687.365631718561;12711.872881271069;12853.678658033625;11872.347020913932;11955.581554645545;11956.521739130685;12104.152709310616;12256.938715306367;10473.738156546147;10761;10994.615188468366;11152.16358773079;11288.209825312479;10571.577136914437;10704.678859634223;10795.136389088697;10826.295695001007;10838.458077095956 19:24:47 INFO - PROCESS | 11950 | __end_tp_report 19:24:47 INFO - PROCESS | 11950 | __start_cc_report 19:24:47 INFO - PROCESS | 11950 | _x_x_mozilla_cycle_collect,341 19:24:47 INFO - PROCESS | 11950 | __end_cc_report 19:24:47 INFO - PROCESS | 11950 | __startTimestamp1468463087815__endTimestamp 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | ------- Summary: start ------- 19:24:47 INFO - PROCESS | 11950 | Number of tests: 6 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#0] dojo.html Cycles:165 Average:5562.36 Median:5773.80 stddev:650.88 (11.3%) stddev-sans-first:623.42 19:24:47 INFO - PROCESS | 11950 | Values: 3094.5 3143.7 3151.3 3162.2 3182.3 5576.4 5579.8 5583.4 5609.2 5662.2 5400.4 5567.4 5618.9 5635.4 5691.3 5035.4 5074.3 5109.1 5218.2 5223.5 5044.7 5218.5 5230.5 5240.9 5252.2 4976.5 5069.3 5084.0 5096.3 5147.7 5134.8 5143.5 5143.7 5151.8 5166.7 5077.7 5088.7 5110.3 5115.1 5147.5 5415.9 5422.2 5525.5 5558.2 5586.3 5971.0 5974.0 5992.6 6002.5 6009.5 6041.5 6050.3 6052.7 6054.2 6058.6 5413.5 5523.4 5569.6 5597.4 5602.7 6050.0 6099.1 6132.8 6132.9 6141.0 5773.8 5892.4 5895.9 5897.7 5905.5 5911.3 5966.5 5984.5 6017.2 6033.5 5684.2 5796.0 5831.0 5955.3 5957.9 5767.7 5802.5 5805.6 5807.6 5856.6 4492.5 4537.4 4559.7 4576.6 4591.7 3956.2 4021.1 4041.8 4065.7 4072.9 5745.2 5751.0 5769.9 5770.5 5776.5 6049.4 6050.8 6079.0 6089.0 6092.4 5611.7 5621.5 5663.2 5682.2 5710.0 5020.2 5063.1 5063.3 5063.4 5081.7 5962.3 6188.1 6253.6 6294.6 6316.3 5971.9 6038.5 6062.5 6076.3 6106.5 6207.0 6247.7 6265.9 6274.6 6283.5 5703.7 5817.3 5931.9 5964.9 5987.9 5976.4 6054.1 6055.3 6075.9 6123.7 5891.9 5914.5 5960.2 5969.2 5982.6 5692.5 5848.0 5851.8 5909.8 5927.7 5632.0 5771.0 5784.1 5829.4 5888.4 5797.4 5926.3 5946.5 5972.3 6018.6 5606.7 5752.4 5779.9 5869.6 5876.4 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#1] ext.html Cycles:180 Average:70946.56 Median:23431.68 stddev:174155.60 (743.2%) stddev-sans-first:174563.95 19:24:47 INFO - PROCESS | 11950 | Values: 549.7 569.5 587.3 604.7 611.5 39887.4 43075.6 43098.4 43363.0 43477.3 43932.6 44757.6 44789.8 44838.6 44886.1 8796.1 8970.9 9002.7 9003.3 9020.3 8957.3 8989.9 8991.8 9019.3 9049.0 9004.2 9118.3 9131.0 9131.7 9161.5 9013.8 9046.5 9064.7 9076.4 9078.7 8835.2 8893.6 8899.3 8921.1 8946.6 32750.7 42504.4 42968.8 43010.8 43073.4 3419.4 3460.4 3502.6 3881.9 4180.8 31417.7 31798.8 31940.7 32126.4 32202.4 4146.5 4171.3 4245.4 4266.2 4432.4 343449.0 343660.0 345289.7 347262.0 347377.0 34290.1 34355.3 34379.1 34587.5 34883.0 35896.5 37532.6 37617.0 37734.6 37785.2 13270.0 13306.4 13317.2 13359.6 13372.3 11979.7 12072.6 12075.3 12088.5 12089.4 8359.1 8370.1 8392.4 8434.8 8454.6 3279.6 3287.7 3287.8 3322.6 3338.1 1021.1 1044.1 1075.3 1158.5 1188.8 32821.3 32971.5 33081.8 33145.7 33978.2 1100.2 1108.7 1188.8 1206.8 1274.0 17093.3 17377.8 17518.7 17626.9 17882.9 949352.0 955132.0 971029.3 972663.0 973775.0 59484.7 60297.0 60470.4 60518.7 60592.7 1354.8 1383.8 1394.3 1407.3 1415.1 31475.0 32796.3 33238.7 33579.3 34556.0 52291.2 52667.7 52667.7 52748.0 52799.2 397032.0 406042.0 407020.0 407394.0 525262.0 28218.9 28358.7 28400.6 28749.3 28791.6 48748.5 48771.8 48801.0 49728.3 50199.0 42597.1 42923.1 46682.8 47248.3 47992.3 43728.1 47792.8 47944.5 47965.8 48710.8 45544.2 45752.0 46201.5 46292.8 46747.8 45091.8 45626.5 45903.8 46172.0 46427.0 30117.0 30215.3 30603.7 30603.7 30816.4 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#2] jquery.html Cycles:180 Average:28370.52 Median:20806.08 stddev:75193.53 (361.4%) stddev-sans-first:75375.10 19:24:47 INFO - PROCESS | 11950 | Values: 382.7 390.7 392.1 398.4 400.1 18813.5 20567.7 20667.7 20905.6 21109.7 19673.3 19992.7 20055.3 20125.1 20192.3 5217.5 5537.3 5537.4 5595.9 5610.1 5413.6 5465.1 5468.6 6184.4 6193.8 6207.5 6212.8 6222.5 6355.8 6362.1 5573.3 5669.1 5714.6 5756.1 5833.6 5514.3 5515.0 5518.6 5540.6 5567.6 14193.9 14384.8 14398.2 14418.3 18819.7 2334.6 2334.9 2502.5 2972.6 2997.8 10788.5 10843.2 10869.5 13609.7 14907.0 1843.5 1913.5 1936.5 1940.6 2029.2 86189.0 88100.6 89317.6 89572.6 89847.6 10564.6 10644.7 11040.6 11045.9 11093.4 14782.9 15103.2 15106.0 15181.8 15195.3 7351.0 7678.5 7696.8 7730.8 7917.4 7372.0 7449.0 7545.7 7549.4 7560.6 4590.2 4597.4 4670.8 4703.2 4725.9 1833.7 1885.5 1885.5 1930.7 1934.7 962.5 1005.3 1045.4 1048.0 1080.3 20429.7 20515.8 20533.9 20706.6 21203.4 1026.9 1029.3 1034.4 1034.5 1064.0 11090.2 11377.0 11461.0 11569.2 11668.9 399122.0 400932.0 402234.0 505113.0 534107.0 86645.6 88960.6 90945.5 107336.3 109352.5 1007.8 1017.3 1053.1 1059.1 1064.1 16700.0 18780.7 18827.8 18884.5 19202.8 38142.6 39890.4 44505.0 45509.8 46931.0 63560.4 63606.4 63814.4 65186.7 65236.0 8473.4 8495.6 8532.7 8674.3 8761.2 9626.7 13279.5 14041.5 14056.2 14096.6 5657.5 10244.8 12135.6 12238.8 12712.5 11519.8 11648.2 12126.6 12204.2 12433.2 12504.4 12539.3 12572.4 12605.8 12741.0 8250.4 8293.5 8490.7 8612.2 8995.2 12180.3 12214.8 12244.9 12251.6 12336.3 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#3] mootools.html Cycles:180 Average:6011.91 Median:4513.58 stddev:3488.60 (77.3%) stddev-sans-first:3481.77 19:24:47 INFO - PROCESS | 11950 | Values: 1480.6 1492.1 1671.7 1787.8 1799.2 8009.8 8754.2 8827.9 9356.8 9390.3 8837.6 9019.2 9037.0 9117.0 9155.9 2301.7 2322.2 2324.9 2327.5 2340.7 2252.0 2306.1 2371.2 2376.8 2380.7 2234.5 2238.7 2252.7 2272.1 2291.5 2273.9 2276.8 2287.1 2289.7 2293.2 2096.4 2106.8 2109.8 2110.3 2114.8 9025.0 9180.9 9188.5 9195.4 9207.5 5197.9 5265.1 5307.3 5307.8 5333.4 3287.7 3402.7 3449.8 3506.8 3553.4 1102.1 1121.2 1138.4 1138.5 1141.6 12675.5 12755.6 12804.8 12830.0 12834.5 4515.4 4665.4 4670.2 4721.1 4733.8 10695.4 10753.9 10766.4 10801.8 10814.4 5247.2 5254.0 5259.2 5268.1 5280.9 4286.4 4730.3 4858.5 4889.2 4895.6 3962.4 3971.1 4030.5 4084.5 4101.7 1210.3 1258.3 1274.6 1285.0 1286.8 1018.6 1032.7 1055.5 1059.7 1067.8 6311.7 6403.8 6478.7 6489.2 6490.5 443.5 459.2 459.2 462.4 464.9 4390.7 4409.4 4456.3 4511.8 4565.6 11053.6 11494.5 11564.4 11566.3 11586.2 11295.6 11369.7 11429.4 11457.1 11459.1 8525.5 8591.0 8624.0 8678.3 8683.6 6357.9 6398.9 6434.7 6483.1 6506.4 10282.1 10403.0 10460.4 10608.2 10671.5 10213.0 10491.3 10786.4 10802.8 10821.7 7477.4 7584.8 7813.9 8038.2 8175.7 9084.4 9146.5 9161.6 9211.4 9224.1 8085.4 8252.8 8262.1 8286.8 8351.5 7617.3 7638.7 7647.4 7659.4 7786.0 7475.2 7491.4 7499.4 7562.7 7583.9 5648.8 5692.5 5755.3 5757.7 5829.4 5354.3 5389.6 5445.0 5480.2 5729.5 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#4] prototype.html Cycles:180 Average:4676.64 Median:5247.07 stddev:1384.52 (26.4%) stddev-sans-first:1349.09 19:24:47 INFO - PROCESS | 11950 | Values: 312.4 319.3 323.1 329.0 329.5 5315.7 5451.7 5532.4 5590.2 5605.6 5535.1 5571.7 5590.5 5600.0 5606.7 4363.4 4364.8 4370.0 4372.9 4373.3 4088.6 4301.1 4308.9 4348.2 4365.6 4241.7 4255.6 4259.6 4271.6 4276.8 4273.9 4278.0 4280.6 4282.7 4295.5 3484.7 3728.4 3731.5 3738.5 3746.2 5415.9 5420.2 5430.9 5435.8 5455.0 4881.4 4886.5 4892.3 4906.2 4907.8 5523.5 5815.9 5833.5 5834.1 5852.3 4060.1 4082.4 4086.5 4092.5 4100.5 6075.9 6095.5 6119.3 6123.0 6142.4 4000.6 4088.8 4096.7 4099.2 4121.9 4143.3 4153.8 4154.3 4171.6 4172.4 4829.9 4852.0 4852.2 4863.4 4865.2 5264.4 5842.6 5867.9 5895.9 5899.7 1392.6 1395.1 1401.3 1401.8 1403.9 877.3 890.8 904.1 913.2 922.2 4907.4 4973.5 5042.0 5067.8 5084.7 5132.7 5254.9 5259.7 5289.6 5314.7 4667.7 4975.8 5037.9 5054.7 5093.9 2785.4 2801.5 2809.0 2815.9 2830.8 5377.3 5430.2 5432.8 5433.3 5446.0 5144.3 5251.3 5361.6 5384.5 5460.1 5384.8 5410.8 5416.4 5433.0 5433.5 5244.7 5249.5 5257.8 5263.5 5310.8 4865.5 5149.7 5170.9 5182.3 5191.6 5357.6 5408.4 5410.8 5417.6 5440.2 3778.5 3789.8 3793.4 3800.6 3806.8 5069.5 5212.4 5230.5 5869.4 5993.1 5923.4 5943.2 5943.9 5944.4 5960.9 5903.4 5909.1 5916.9 5917.5 5919.6 5583.8 5813.2 5839.6 5846.2 5874.8 5917.8 5927.2 5942.7 5946.4 5972.2 5630.5 5823.3 5824.7 5835.9 5848.3 19:24:47 INFO - PROCESS | 11950 | 19:24:47 INFO - PROCESS | 11950 | [#5] yui.html Cycles:180 Average:21152.86 Median:4322.58 stddev:30981.25 (716.7%) stddev-sans-first:31030.02 19:24:47 INFO - PROCESS | 11950 | Values: 679.8 766.4 773.6 785.6 862.5 14682.6 15702.5 15719.1 15822.1 15906.8 14485.6 14560.3 14636.9 14637.9 14651.0 654.2 780.8 807.5 808.1 815.4 800.8 803.8 808.0 810.1 812.8 854.8 857.1 862.5 863.8 864.9 852.5 856.3 856.4 856.7 858.3 626.3 628.6 628.7 629.5 629.6 14375.6 14379.6 14435.5 14482.5 14516.2 14052.6 14301.2 14365.6 14533.1 14535.6 10857.5 11026.9 11082.0 11273.8 11327.5 3759.5 3760.1 3833.8 3848.9 3873.5 78859.0 79006.8 79129.6 79138.2 79481.2 10288.5 10594.2 10684.3 10695.8 10775.4 23099.5 23604.1 23625.8 23644.2 23719.6 8440.4 8523.8 8611.2 8617.1 8686.0 4771.7 4796.6 4828.3 4862.5 4878.8 3592.2 3686.6 3697.7 3701.1 3701.8 627.5 637.9 638.8 646.4 660.2 652.7 713.1 722.9 746.7 788.5 9821.7 9960.3 10025.0 10210.9 10254.2 669.3 687.6 690.6 694.0 701.2 4879.1 4986.6 5010.6 5036.2 5052.5 87707.0 118390.0 119040.0 120517.0 121131.0 86673.0 104903.8 107352.5 107460.0 108411.5 89578.0 90239.5 90245.5 90338.0 91537.0 9461.8 9494.9 9495.0 9528.6 9528.8 54252.5 54689.5 54798.7 54853.0 55774.8 72621.3 79864.0 80777.0 81394.0 81700.0 12882.4 12956.7 13251.9 13349.9 13350.0 12806.3 13250.4 13453.5 13874.8 14360.5 11983.3 12062.6 12080.6 12105.9 12370.3 11964.3 12672.7 12687.4 12711.9 12853.7 11872.3 11955.6 11956.5 12104.2 12256.9 10473.7 10761.0 10994.6 11152.2 11288.2 10571.6 10704.7 10795.1 10826.3 10838.5 19:24:47 INFO - PROCESS | 11950 | -------- Summary: end -------- 19:24:47 INFO - PROCESS | 11950 | 19:24:48 INFO - TEST-INFO | 11950: exit 0 19:24:48 INFO - TEST-OK | dromaeo_css | took 1110687ms 19:24:48 INFO - TEST-START | kraken 19:24:48 INFO - operating with platform_type : linux_ 19:24:48 INFO - Initialising browser for kraken test... 19:24:48 INFO - TEST-INFO | started process 12194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnbHMN6/profile http://localhost:37491/getInfo.html) 19:24:52 INFO - PROCESS | 12194 | __metrics Screen width/height:1600/1200 19:24:52 INFO - PROCESS | 12194 | colorDepth:24 19:24:52 INFO - PROCESS | 12194 | Browser inner width/height: 1024/697 19:24:52 INFO - PROCESS | 12194 | __metrics 19:24:53 ERROR - PROCESS | 12194 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:24:54 INFO - TEST-INFO | 12194: exit 0 19:24:54 INFO - Browser initialized. 19:24:54 INFO - Running cycle 1/1 for kraken test... 19:24:54 INFO - TEST-INFO | started process 12315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnbHMN6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:06 INFO - PROCESS | 12315 | RSS: Main: 167632896 19:25:06 INFO - PROCESS | 12315 | 19:25:08 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37491/tests/kraken/driver.html?testName=audio-beat-detection) 19:25:09 INFO - PROCESS | 12315 | RSS: Main: 172998656 19:25:09 INFO - PROCESS | 12315 | 19:25:12 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37491/tests/kraken/driver.html?testName=audio-dft) 19:25:12 INFO - PROCESS | 12315 | RSS: Main: 172445696 19:25:12 INFO - PROCESS | 12315 | 19:25:15 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37491/tests/kraken/driver.html?testName=audio-fft) 19:25:16 INFO - PROCESS | 12315 | RSS: Main: 167055360 19:25:16 INFO - PROCESS | 12315 | 19:25:18 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37491/tests/kraken/driver.html?testName=audio-oscillator) 19:25:19 INFO - PROCESS | 12315 | RSS: Main: 168599552 19:25:19 INFO - PROCESS | 12315 | 19:25:21 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:21 INFO - PROCESS | 12315 | RSS: Main: 168660992 19:25:21 INFO - PROCESS | 12315 | 19:25:24 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37491/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:25 INFO - PROCESS | 12315 | RSS: Main: 167858176 19:25:25 INFO - PROCESS | 12315 | 19:25:29 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37491/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:29 INFO - PROCESS | 12315 | RSS: Main: 166797312 19:25:29 INFO - PROCESS | 12315 | 19:25:32 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37491/tests/kraken/driver.html?testName=json-parse-financial) 19:25:33 INFO - PROCESS | 12315 | RSS: Main: 167677952 19:25:33 INFO - PROCESS | 12315 | 19:25:34 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:35 INFO - PROCESS | 12315 | RSS: Main: 168390656 19:25:35 INFO - PROCESS | 12315 | 19:25:37 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:37 INFO - PROCESS | 12315 | RSS: Main: 168628224 19:25:37 INFO - PROCESS | 12315 | 19:25:39 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:40 INFO - PROCESS | 12315 | RSS: Main: 168894464 19:25:40 INFO - PROCESS | 12315 | 19:25:43 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:43 INFO - PROCESS | 12315 | RSS: Main: 169201664 19:25:43 INFO - PROCESS | 12315 | 19:25:46 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:47 INFO - PROCESS | 12315 | RSS: Main: 169279488 19:25:47 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | Cycle 1(1): loaded http://localhost:37491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37491/tests/kraken/driver.html?testName=ai-astar) 19:25:48 INFO - PROCESS | 12315 | RSS: Main: 169779200 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | __start_tp_report 19:25:48 INFO - PROCESS | 12315 | _x_x_mozilla_page_load 19:25:48 INFO - PROCESS | 12315 | _x_x_mozilla_page_load_details 19:25:48 INFO - PROCESS | 12315 | |i|pagename|runs| 19:25:48 INFO - PROCESS | 12315 | |0;ai-astar;103;111;105;111;112;113;114;112;111;110 19:25:48 INFO - PROCESS | 12315 | |1;audio-beat-detection;153;116;154;169;121;149;151;121;185;117 19:25:48 INFO - PROCESS | 12315 | |2;audio-dft;162;169;163;161;162;165;191;163;162;163 19:25:48 INFO - PROCESS | 12315 | |3;audio-fft;75;74;76;157;77;76;75;74;169;75 19:25:48 INFO - PROCESS | 12315 | |4;audio-oscillator;85;84;157;85;84;84;129;83;85;150 19:25:48 INFO - PROCESS | 12315 | |5;imaging-gaussian-blur;118;117;117;118;118;117;118;117;117;117 19:25:48 INFO - PROCESS | 12315 | |6;imaging-darkroom;147;147;148;148;149;148;148;147;146;147 19:25:48 INFO - PROCESS | 12315 | |7;imaging-desaturate;95;96;96;95;95;95;96;95;96;95 19:25:48 INFO - PROCESS | 12315 | |8;json-parse-financial;53;54;56;53;53;55;52;54;53;53 19:25:48 INFO - PROCESS | 12315 | |9;json-stringify-tinderbox;64;63;63;64;63;62;62;63;66;63 19:25:48 INFO - PROCESS | 12315 | |10;stanford-crypto-aes;76;77;75;84;75;75;76;77;81;76 19:25:48 INFO - PROCESS | 12315 | |11;stanford-crypto-ccm;128;121;128;122;122;135;133;123;166;131 19:25:48 INFO - PROCESS | 12315 | |12;stanford-crypto-pbkdf2;162;157;158;153;154;167;158;154;154;157 19:25:48 INFO - PROCESS | 12315 | |13;stanford-crypto-sha256-iterative;66;64;64;63;62;62;62;63;63;63 19:25:48 INFO - PROCESS | 12315 | __end_tp_report 19:25:48 INFO - PROCESS | 12315 | __start_cc_report 19:25:48 INFO - PROCESS | 12315 | _x_x_mozilla_cycle_collect,924 19:25:48 INFO - PROCESS | 12315 | __end_cc_report 19:25:48 INFO - PROCESS | 12315 | __startTimestamp1468463148984__endTimestamp 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | ------- Summary: start ------- 19:25:48 INFO - PROCESS | 12315 | Number of tests: 14 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.49 (3.1%) stddev-sans-first:2.55 19:25:48 INFO - PROCESS | 12315 | Values: 103.0 111.0 105.0 111.0 112.0 113.0 114.0 112.0 111.0 110.0 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:152.00 stddev:23.88 (15.7%) stddev-sans-first:25.08 19:25:48 INFO - PROCESS | 12315 | Values: 153.0 116.0 154.0 169.0 121.0 149.0 151.0 121.0 185.0 117.0 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#2] audio-dft Cycles:10 Average:166.10 Median:163.00 stddev:9.04 (5.5%) stddev-sans-first:9.46 19:25:48 INFO - PROCESS | 12315 | Values: 162.0 169.0 163.0 161.0 162.0 165.0 191.0 163.0 162.0 163.0 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:37.12 (49.5%) stddev-sans-first:38.81 19:25:48 INFO - PROCESS | 12315 | Values: 75.0 74.0 76.0 157.0 77.0 76.0 75.0 74.0 169.0 75.0 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:30.28 (36.1%) stddev-sans-first:31.44 19:25:48 INFO - PROCESS | 12315 | Values: 85.0 84.0 157.0 85.0 84.0 84.0 129.0 83.0 85.0 150.0 19:25:48 INFO - PROCESS | 12315 | 19:25:48 INFO - PROCESS | 12315 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:25:48 INFO - PROCESS | 12315 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 19:25:49 INFO - PROCESS | 12315 | Values: 147.0 147.0 148.0 148.0 149.0 148.0 148.0 147.0 146.0 147.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:25:49 INFO - PROCESS | 12315 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:1.22 19:25:49 INFO - PROCESS | 12315 | Values: 53.0 54.0 56.0 53.0 53.0 55.0 52.0 54.0 53.0 53.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 19:25:49 INFO - PROCESS | 12315 | Values: 64.0 63.0 63.0 64.0 63.0 62.0 62.0 63.0 66.0 63.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:2.97 (3.9%) stddev-sans-first:3.12 19:25:49 INFO - PROCESS | 12315 | Values: 76.0 77.0 75.0 84.0 75.0 75.0 76.0 77.0 81.0 76.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:129.50 stddev:13.29 (10.3%) stddev-sans-first:14.05 19:25:49 INFO - PROCESS | 12315 | Values: 128.0 121.0 128.0 122.0 122.0 135.0 133.0 123.0 166.0 131.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.50 stddev:4.33 (2.7%) stddev-sans-first:4.26 19:25:49 INFO - PROCESS | 12315 | Values: 162.0 157.0 158.0 153.0 154.0 167.0 158.0 154.0 154.0 157.0 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - PROCESS | 12315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:0.78 19:25:49 INFO - PROCESS | 12315 | Values: 66.0 64.0 64.0 63.0 62.0 62.0 62.0 63.0 63.0 63.0 19:25:49 INFO - PROCESS | 12315 | -------- Summary: end -------- 19:25:49 INFO - PROCESS | 12315 | 19:25:49 INFO - TEST-INFO | 12315: exit 0 19:25:50 INFO - TEST-OK | kraken | took 61424ms 19:25:50 INFO - SUITE-END | took 1172s 19:25:50 INFO - Completed test suite (00:19:32) 19:25:50 INFO - javascript benchmark 19:25:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.446147667104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.5048792193247, 3143.6856314368565, 3151.3067125232456, 3162.2252548125684, 3182.2521707398755, 5576.358718747345, 5579.776808927643, 5583.441655834425, 5609.158626206071, 5662.17898404731, 5400.405955344909, 5567.359753628334, 5618.859528511789, 5635.436456354362, 5691.3170419549715, 5035.420926593443, 5074.314967479399, 5109.054824857395, 5218.243354713564, 5223.477652234765, 5044.697318160904, 5218.504242096995, 5230.476952304777, 5240.895182096356, 5252.212168174785, 4976.527229913152, 5069.340985671839, 5084.008618319448, 5096.261042148886, 5147.691138531682, 5134.845954621367, 5143.5113664201845, 5143.691378517301, 5151.793928242866, 5166.689998600058, 5077.720725360104, 5088.6946783193125, 5110.310108135392, 5115.104856650109, 5147.48525147486, 5415.891682166374, 5422.186671999192, 5525.502704756591, 5558.249636299089, 5586.273784408001, 5971.0, 5974.0, 5992.640441573476, 6002.549808764316, 6009.549283803733, 6041.456268935817, 6050.304215015286, 6052.667103309316, 6054.152418661347, 6058.575899687024, 5413.485718856702, 5523.364813046471, 5569.610127291091, 5597.384287728347, 5602.691851948182, 6050.0, 6099.146119543268, 6132.816015519542, 6132.877342453126, 6140.969295153495, 5773.797917072882, 5892.351841297454, 5895.882082358329, 5897.705114744245, 5905.498032667271, 5911.3201981772645, 5966.522678185735, 5984.521238300926, 6017.157597936292, 6033.5173186145, 5684.204211410406, 5795.971020144872, 5831.0378787499585, 5955.34491205967, 5957.880842383215, 5767.68277744728, 5802.506786923074, 5805.564582656318, 5807.5644326675665, 5856.59003869725, 4492.528284530143, 4537.410136682211, 4559.749213793273, 4576.610988065985, 4591.747453890001, 3956.188981258835, 4021.135455876942, 4041.777702226406, 4065.6950728695465, 4072.898177545585, 5745.2243947067445, 5750.971245143747, 5769.8557536061935, 5770.480656740913, 5776.537876969833, 6049.425304596057, 6050.788222412282, 6079.0273556230795, 6089.025755879126, 6092.421219984094, 5611.719414029282, 5621.522170615462, 5663.235463212413, 5682.232898558642, 5710.0, 5020.196768517019, 5063.088644044034, 5063.291139240509, 5063.417706963673, 5081.720505372166, 5962.25471816023, 6188.1027251048345, 6253.593516421418, 6294.622322660655, 6316.2736285326855, 5971.940280597225, 6038.547108966757, 6062.454379105901, 6076.33160352352, 6106.511479081574, 6207.047886930545, 6247.68761561911, 6265.906011409924, 6274.623522588659, 6283.5287353449585, 5703.714814259188, 5817.301923769175, 5931.881362372815, 5964.8964941485965, 5987.850303742442, 5976.432238937294, 6054.061620448838, 6055.333913269625, 6075.878482430415, 6123.663198524124, 5891.852703682443, 5914.497267732291, 5960.165576819162, 5969.194158788508, 5982.581219314607, 5692.4876761090045, 5848.0, 5851.765929362778, 5909.763609455746, 5927.673977931255, 5631.971840140937, 5771.0, 5784.132380142844, 5829.358770535323, 5888.381719919518, 5797.449242321973, 5926.318473375617, 5946.524278057832, 5972.283326000907, 6018.638881667114, 5606.747696353756, 5752.424757524382, 5779.913301300568, 5869.647821130746, 5876.412358764261], "value": 5516.562250460332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.6865069140254, 569.53013763645, 587.3245767367526, 604.6764980735306, 611.5291225756171, 39887.40168897465, 43075.569244307546, 43098.35352469715, 43363.0, 43477.34783978243, 43932.560674393244, 44757.55242447575, 44789.77605111978, 44838.55161448385, 44886.10227795442, 8796.120387961217, 8970.910290897073, 9002.684906028291, 9003.279737621007, 9020.2783777298, 8957.328200384965, 8989.865152022692, 8991.820163596723, 9019.323550733689, 9049.049849765779, 9004.189622933935, 9118.267529169436, 9131.0, 9131.726048218565, 9161.541922903862, 9013.819723605524, 9046.547672616376, 9064.682736104205, 9076.364654474157, 9078.727638170865, 8835.249003834682, 8893.599788009555, 8899.288056955427, 8921.063288354695, 8946.552672366355, 32750.672493275, 42504.3624345635, 42968.78515607433, 43010.784946075066, 43073.35389969153, 3419.3674170278578, 3460.359833430798, 3502.5972013218297, 3881.902952426212, 4180.8118634661205, 31417.685823141706, 31798.841005795053, 31940.680593194236, 32126.357472850646, 32202.355952881044, 4146.502419709624, 4171.270027745163, 4245.448091748053, 4266.210751011042, 4432.423784907974, 343449.0, 343660.0, 345289.73551322334, 347262.0, 347376.9999999975, 34290.14274643104, 34355.31289374198, 34379.14052148666, 34587.48118778221, 34883.0, 35896.461553076726, 37532.62467375346, 37617.0, 37734.62265377366, 37785.244295113946, 13270.0, 13306.401211945486, 13317.200967941955, 13359.599212023655, 13372.264525450999, 11979.700507487209, 12072.577459788865, 12075.275483470845, 12088.456019479145, 12089.395530223454, 8359.122292159358, 8370.079291277954, 8392.412531122885, 8434.789130271669, 8454.61954212062, 3279.622843372995, 3287.684926029607, 3287.8356082195796, 3322.551455553469, 3338.130646837779, 1021.0606242257142, 1044.1333693034762, 1075.2795626929976, 1158.472894832849, 1188.7503624239007, 32821.343573128404, 32971.50542741861, 33081.83459082689, 33145.668543314256, 33978.15054623605, 1100.1528822806395, 1108.661858133261, 1188.8335633011386, 1206.776746301937, 1273.961781146567, 17093.316267349168, 17377.826221737872, 17518.737218941726, 17626.91186544059, 17882.91058544725, 949352.0, 955132.0, 971029.303681336, 972663.0, 973775.0, 59484.7025764877, 60297.0, 60470.395296046474, 60518.697406512685, 60592.69703651453, 1354.8035534847393, 1383.7652191710315, 1394.2540740703676, 1407.3385508810843, 1415.058985774469, 31475.0, 32796.34407311888, 33238.66761332453, 33579.3284134311, 34556.0, 52291.21563176632, 52667.73666131645, 52667.73666131645, 52748.0, 52799.208011879084, 397032.0, 406042.0, 407020.0, 407394.0, 525262.0, 28218.85890570534, 28358.71641283561, 28400.57399139056, 28749.28126796847, 28791.568126478538, 48748.5125148744, 48771.75614121907, 48801.0, 49728.25407618816, 50199.0, 42597.148057038066, 42923.14153716971, 46682.76658616685, 47248.2912756302, 47992.28011579759, 43728.088329901424, 47792.7610361946, 47944.5205547954, 47965.76017119892, 48710.75644621896, 45544.20134434264, 45752.0, 46201.53798462107, 46292.768536157106, 46747.76626116848, 45091.77454112709, 45626.54373456223, 45903.77048114871, 46172.0, 46427.0, 30117.0, 30215.2602828558, 30603.693963060974, 30603.724952604596, 30816.383672326876], "value": 19414.39643722816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7072289698381, 390.7343006755405, 392.0675623496329, 398.37455195343307, 400.0598593305731, 18813.529661758446, 20567.691484627725, 20667.689984650242, 20905.581888362223, 21109.683354749654, 19673.31143409981, 19992.700109498368, 20055.29806456774, 20125.094370753315, 20192.29326973556, 5217.47825217479, 5537.280153580049, 5537.418571050042, 5595.916061259084, 5610.074337734269, 5413.593980451462, 5465.07093794054, 5468.589855760814, 6184.412480814338, 6193.783217587363, 6207.472364848971, 6212.78255261066, 6222.502199824025, 6355.809325720235, 6362.1093046973465, 5573.27547418833, 5669.092945128801, 5714.571407144481, 5756.079027355624, 5833.649981001132, 5514.3276089171495, 5515.034868897927, 5518.558515318765, 5540.556755459554, 5567.554595632339, 14193.929030354886, 14384.784228236585, 14398.208098554574, 14418.279086045655, 18819.71770423431, 2334.6031174700342, 2334.867589219244, 2502.5245203411478, 2972.613560237177, 2997.8201307921595, 10788.51451684676, 10843.240973131884, 10869.45652717361, 13609.659758506017, 14907.0, 1843.4561804267773, 1913.5407502199512, 1936.5449119456916, 1940.5730739237345, 2029.1984666056826, 86189.0, 88100.55949720275, 89317.55341223317, 89572.55213723889, 89847.55076224642, 10564.577416903392, 10644.680659580225, 11040.613578524873, 11045.889541104487, 11093.445327733582, 14782.926085369505, 15103.244837758068, 15106.018108822891, 15181.848181518264, 15195.316210770541, 7351.0, 7678.462507624413, 7696.8460630788195, 7730.806729831799, 7917.366610671133, 7372.0, 7449.0, 7545.7358992435, 7549.433792465587, 7560.6219689016425, 4590.219662657356, 4597.356370108188, 4670.753826090834, 4703.223968045303, 4725.8582242532775, 1833.697439922398, 1885.5003424092627, 1885.5097674604701, 1930.7007413850877, 1934.7291379206922, 962.4946902876046, 1005.2706900764459, 1045.3936716704293, 1047.9633212837514, 1080.2600218850114, 20429.69355459669, 20515.794842051688, 20533.89733051355, 20706.58586828255, 21203.36389908305, 1026.861373714554, 1029.27950434696, 1034.4103860799273, 1034.5396298647029, 1064.0370464729433, 11090.223684342018, 11377.0, 11461.0, 11569.247998880046, 11668.88331116695, 399122.0, 400932.0, 402234.0, 505113.0, 534107.0, 86645.56677216574, 88960.5551972236, 90945.54527227322, 107336.31659208426, 109352.45323773331, 1007.8437842134481, 1017.3285631483186, 1053.073295499955, 1059.0521483272428, 1064.1327318235767, 16700.0, 18780.718289225944, 18827.811721882605, 18884.527886802938, 19202.8079719201, 38142.61857381391, 39890.40164397594, 44505.0, 45509.772451137535, 46931.0, 63560.3643963573, 63606.363936360045, 63814.36185638084, 65186.67406663126, 65236.0, 8473.406861519634, 8495.555919079645, 8532.658693652184, 8674.30605551567, 8761.211490965843, 9626.711198664052, 13279.468821247043, 14041.5085472008, 14056.156630602196, 14096.647583810487, 5657.462541058593, 10244.795104097728, 12135.575254866037, 12238.755224895274, 12712.491500339884, 11519.8272025918, 11648.242864213798, 12126.575569855013, 12204.206726562745, 12433.191842530206, 12504.374781261082, 12539.310337931136, 12572.434240459019, 12605.810912836132, 12741.0, 8250.38122140854, 8293.460925039853, 8490.660373585235, 8612.224899758801, 8995.23540499065, 12180.269183848997, 12214.816777748518, 12244.938775306067, 12251.632451026484, 12336.259824410565], "value": 9310.231057699872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.5854360778978, 1492.1420183394548, 1671.7074511960404, 1787.7675902132721, 1799.2443173866975, 8009.759707208778, 8754.212120909116, 8827.867581986267, 9356.812863742729, 9390.342676012673, 8837.558122093902, 9019.188273055424, 9036.95481522593, 9117.0, 9155.90844091559, 2301.700778898745, 2322.2104484475276, 2324.93025209244, 2327.476317828492, 2340.6957095577636, 2252.0, 2306.1351993002622, 2371.1700904683394, 2376.786089251967, 2380.726216485109, 2234.5307485427998, 2238.68658387825, 2252.707148070757, 2272.1025195047946, 2291.5073259249257, 2273.89767460463, 2276.7950884420397, 2287.1308902617066, 2289.725232972054, 2293.2203050962585, 2096.371088673407, 2106.799854013866, 2109.831213502916, 2110.2930518276394, 2114.7568029676477, 9024.954875225581, 9180.908190918139, 9188.540572971324, 9195.40229885062, 9207.539623018822, 5197.870053248661, 5265.078611243055, 5307.2835167252315, 5307.761150748225, 5333.413324534298, 3287.7205437537837, 3402.727781777452, 3449.793012419263, 3506.824658767077, 3553.4492153716214, 1102.101787043557, 1121.1871393239917, 1138.362516990488, 1138.49337045015, 1141.5547936304847, 12675.492980280778, 12755.61733148007, 12804.80792788109, 12830.037747169094, 12834.486620535168, 4515.367848501212, 4665.370175026328, 4670.206064968896, 4721.079389519011, 4733.786979585927, 10695.411752353695, 10753.892461075446, 10766.407847568302, 10801.78396432067, 10814.405207713495, 5247.2129180623215, 5254.0, 5259.184826351845, 5268.078086334876, 5280.9207861882105, 4286.357046442996, 4730.314104454904, 4858.489858564871, 4889.217725163957, 4895.559399653977, 3962.3660214365564, 3971.0866500705, 4030.4558884550797, 4084.4894388201474, 4101.671866250693, 1210.285931300537, 1258.3393718297784, 1274.6112435707014, 1284.9935750321188, 1286.8005459153846, 1018.6383833739064, 1032.6901929421294, 1055.488088277185, 1059.7244716373643, 1067.8184708599556, 6311.684415779193, 6403.807885763435, 6478.708458119396, 6489.221293444817, 6490.513211509156, 443.5054913771122, 459.18953047870536, 459.23766547530937, 462.3503976912443, 464.90237050219156, 4390.714603550759, 4409.4267745193565, 4456.309272062836, 4511.796969136331, 4565.634749220055, 11053.557857685602, 11494.540218391337, 11564.42177891119, 11566.30602163873, 11586.188966772244, 11295.604653837076, 11369.715757106138, 11429.371384573928, 11457.08343332548, 11459.140564457532, 8525.531095789791, 8591.0, 8624.00823905259, 8678.349123815738, 8683.609237584324, 6357.90463143044, 6398.87202255943, 6434.678266086583, 6483.059956306403, 6506.3818937200895, 10282.126019288145, 10403.0, 10460.372377657364, 10608.204384671026, 10671.51978161, 10213.029762172582, 10491.318064325795, 10786.352818830896, 10802.783944321227, 10821.729456763329, 7477.364424023801, 7584.810379740551, 7813.9218607815465, 8038.236367545074, 8175.67297308101, 9084.40951338161, 9146.496942668216, 9161.633534658538, 9211.447313161232, 9224.123708247706, 8085.434019618806, 8252.752417427488, 8262.091169971178, 8286.792830179053, 8351.457155284887, 7617.314441700273, 7638.732644357421, 7647.38820894316, 7659.387249020177, 7785.961070194613, 7475.177730449755, 7491.438142139253, 7499.400047996256, 7562.697492100255, 7583.886241706489, 5648.802291919763, 5692.459216374438, 5755.280589926259, 5757.683327416865, 5829.446202610745, 5354.330708661418, 5389.622726409114, 5445.0, 5480.177973303877, 5729.4843464088435], "value": 4687.164483867169, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3581040960826, 319.2959524249031, 323.14850369276957, 329.0359247405104, 329.50574138791814, 5315.654482458637, 5451.700156491392, 5532.367951454321, 5590.211132437622, 5605.579581531386, 5535.142052981784, 5571.721413929297, 5590.468905453986, 5600.0, 5606.719664016803, 4363.4327537420095, 4364.759938203398, 4369.978150109245, 4372.89067773305, 4373.322135069069, 4088.632023117919, 4301.118270754488, 4308.9353659695125, 4348.195583816988, 4365.5852693994175, 4241.745495270294, 4255.553166917475, 4259.5740425957465, 4271.63691086258, 4276.786160691953, 4273.9358909616385, 4278.0, 4280.6361459275995, 4282.7002109852165, 4295.548967358413, 3484.6515348465205, 3728.440733889911, 3731.477593136963, 3738.513993180869, 3746.1758413149064, 5415.918761218585, 5420.23842251266, 5430.945690543083, 5435.782568697247, 5454.972725136349, 4881.365422495089, 4886.486918873538, 4892.339534162914, 4906.165951788169, 4907.803687852482, 5523.502884740393, 5815.912761308584, 5833.4749872511675, 5834.066549352084, 5852.326982397036, 4060.1473690525027, 4082.408050832613, 4086.5084244250934, 4092.5088989321175, 4100.528439229497, 6075.878482430415, 6095.481884039862, 6119.296280927706, 6122.96938515309, 6142.355052719445, 4000.6399424051974, 4088.793805827288, 4096.713230073866, 4099.159672267178, 4121.8969525762095, 4143.295639741191, 4153.75697123556, 4154.338264694146, 4171.582841715865, 4172.395002724648, 4829.903401932012, 4852.0, 4852.199387101089, 4863.416390033219, 4865.197242454955, 5264.447233040552, 5842.591018628656, 5867.860694528492, 5895.882082358329, 5899.734511946973, 1392.5613431768961, 1395.0931894268806, 1401.3203596255807, 1401.8084628066063, 1403.8596140386085, 877.2630989968329, 890.7817584691792, 904.0823564082461, 913.2191975860676, 922.1884741427501, 4907.429622520759, 4973.532807821629, 5041.974790126099, 5067.820837040108, 5084.745762711849, 5132.666376685504, 5254.894902101936, 5259.684418934876, 5289.629725919149, 5314.681119132864, 4667.673262871566, 4975.776090075955, 5037.924431133462, 5054.7472626368535, 5093.923591146136, 2785.373291009507, 2801.467721132978, 2808.9859550702117, 2815.873285702148, 2830.7735381169455, 5377.27406800077, 5430.239766432703, 5432.75552600134, 5433.293671822637, 5446.0, 5144.312986423781, 5251.317328747238, 5361.571074314045, 5384.461553844584, 5460.116259890331, 5384.811531596375, 5410.810621628303, 5416.377116631559, 5432.972835135878, 5433.510984011458, 5244.659097158673, 5249.47505249472, 5257.842264732064, 5263.499967503081, 5310.840674779763, 4865.481689663643, 5149.665271757323, 5170.922436163536, 5182.273587685704, 5191.584673226208, 5357.624966252325, 5408.3509978802795, 5410.756515956713, 5417.593680473901, 5440.211169380338, 3778.4899038629433, 3789.7915614640356, 3793.393057110849, 3800.6009369015856, 3806.8096595170687, 5069.518395752398, 5212.374515058217, 5230.476952304739, 5869.413058694096, 5993.0710739835395, 5923.437273459014, 5943.227380440515, 5943.881122377442, 5944.4352786485215, 5960.913680211891, 5903.380145084704, 5909.134069976144, 5916.881662366643, 5917.467427931507, 5919.556033297434, 5583.776648933997, 5813.168851811666, 5839.620424672383, 5846.1815345852465, 5874.794382196603, 5917.792877249448, 5927.170196172453, 5942.73257703413, 5946.405359464019, 5972.163897054503, 5630.493255606852, 5823.272090988627, 5824.650520968756, 5835.854103647443, 5848.327442344014], "value": 4228.125210957471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.7552880962855, 766.3677466090477, 773.5822655765887, 785.6307535458334, 862.4782006885833, 14682.63293417665, 15702.450414235504, 15719.13544755038, 15822.129782861937, 15906.840931590681, 14485.565433037, 14560.344784484698, 14636.926815365934, 14637.926810365932, 14651.047681900669, 654.231278248059, 780.7579650308394, 807.5195258821021, 808.1110778144024, 815.4251252866715, 800.7557694903052, 803.7990502374406, 807.9555624440653, 810.1291112054536, 812.8008637883727, 854.7649396415973, 857.1214505132227, 862.4954401674996, 863.7926897544606, 864.8745931839879, 852.5012867472536, 856.2892798976834, 856.4005196362571, 856.7087190355278, 858.2961971183632, 626.2703949898363, 628.6416742456802, 628.6605233174081, 629.4964028777006, 629.5876201088295, 14375.568732938029, 14379.568612941628, 14435.494757683431, 14482.49311274111, 14516.201608911506, 14052.648683782987, 14301.213433261166, 14365.640858978504, 14533.128012319188, 14535.563933082025, 10857.45712714361, 11026.889731102747, 11082.0, 11273.774524509547, 11327.490262938105, 3759.4586219649814, 3760.1168230082035, 3833.8466461341513, 3848.8845334640005, 3873.4964454621, 78859.0, 79006.81489777715, 79129.60435197788, 79138.20861791365, 79481.20518794854, 10288.537015834305, 10594.205434592437, 10684.25210235276, 10695.83956240657, 10775.407352595683, 23099.538009240056, 23604.055837766296, 23625.7637423627, 23644.172453964373, 23719.644205336936, 8440.366972477088, 8523.829523409497, 8611.181937715906, 8617.138286171457, 8686.044535101133, 4771.66598338113, 4796.616270698406, 4828.348172996671, 4862.489438608965, 4878.780454879539, 3592.2097138629983, 3686.576043754949, 3697.7411581189594, 3701.11173318407, 3701.833417496219, 627.4509803921569, 637.8819918315127, 638.7700427845972, 646.4085361893815, 660.211047797877, 652.6606164794281, 713.1228588835761, 722.9096362954631, 746.7087835744064, 788.5190034079208, 9821.656242031495, 9960.252981026451, 10025.0, 10210.897891021143, 10254.179665626732, 669.263809809206, 687.5668328952728, 690.5511417578614, 693.9895901561481, 701.2216439751871, 4879.097366987119, 4986.551210391082, 5010.624203184776, 5036.169032109734, 5052.469490703496, 87707.0, 118390.0, 119040.0, 120517.0, 121131.0, 86673.0, 104903.75481225908, 107352.46323768332, 107460.0, 108411.45794271136, 89578.0, 90239.54880225557, 90245.54877225703, 90338.0, 91537.0, 9461.810763784548, 9494.85757713621, 9494.95252523733, 9528.618855245713, 9528.761780955254, 54252.45747542474, 54689.45310547003, 54798.72600637131, 54853.0, 55774.8168887327, 72621.27378726145, 79864.0, 80777.0, 81394.0, 81700.0, 12882.35588220604, 12956.740865182455, 13251.933740331237, 13349.933250333686, 13350.0, 12806.295653739135, 13250.403731832284, 13453.529126480918, 13874.791878121634, 14360.497382591559, 11983.28100313984, 12062.577809776616, 12080.577179798665, 12105.878941210474, 12370.257784532956, 11964.288381773744, 12672.74654506923, 12687.365631718561, 12711.872881271069, 12853.678658033625, 11872.347020913932, 11955.581554645545, 11956.521739130685, 12104.152709310616, 12256.938715306367, 10473.738156546147, 10761.0, 10994.615188468366, 11152.16358773079, 11288.209825312479, 10571.577136914437, 10704.678859634223, 10795.136389088697, 10826.295695001007, 10838.458077095956], "value": 7528.9825682697765, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 105.0, 111.0, 112.0, 113.0, 114.0, 112.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 116.0, 154.0, 169.0, 121.0, 149.0, 151.0, 121.0, 185.0, 117.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 163.0, 161.0, 162.0, 165.0, 191.0, 163.0, 162.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 157.0, 77.0, 76.0, 75.0, 74.0, 169.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 157.0, 85.0, 84.0, 84.0, 129.0, 83.0, 85.0, 150.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 53.0, 53.0, 55.0, 52.0, 54.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 66.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 84.0, 75.0, 75.0, 76.0, 77.0, 81.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 128.0, 122.0, 122.0, 135.0, 133.0, 123.0, 166.0, 131.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 157.0, 158.0, 153.0, 154.0, 167.0, 158.0, 154.0, 154.0, 157.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}]}]} 19:25:50 INFO - Return code: 0 19:25:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:50 ERROR - # TBPL SUCCESS # 19:25:50 INFO - Running post-action listener: _resource_record_post_action 19:25:50 INFO - ##### 19:25:50 INFO - ##### Finished run-tests step (success) 19:25:50 INFO - ##### 19:25:50 INFO - Running post-run listener: _resource_record_post_run 19:25:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555319296; Read time: 8; Write time: 495596 19:25:50 INFO - TinderboxPrint: CPU usage
13.3% 19:25:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:25:50 INFO - TinderboxPrint: I/O write bytes / time
555,319,296 / 495,596 19:25:50 INFO - TinderboxPrint: CPU idle
8,228.0 (86.7%) 19:25:50 INFO - TinderboxPrint: CPU user
1,211.0 (12.8%) 19:25:50 INFO - TinderboxPrint: Swap in / out
0 / 0 19:25:50 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256778240; Read time: 0; Write time: 262568 19:25:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297926656; Read time: 0; Write time: 233016 19:25:50 INFO - Running post-run listener: _upload_blobber_files 19:25:50 INFO - Blob upload gear active. 19:25:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:50 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 19:25:50 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'] 19:25:50 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 19:25:51 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:52 INFO - (blobuploader) - INFO - Done attempting. 19:25:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:52 INFO - (blobuploader) - INFO - Done attempting. 19:25:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:56 INFO - (blobuploader) - INFO - Done attempting. 19:25:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:56 INFO - Return code: 0 19:25:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ac93712254f4fa66975c91e5414187810d746aa242302b64ba447c3fd77e876e97cc6d4d086eb3dd8b1b68e5029f0c74520d97e79b97982f46236ee2a4c3266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136984ff432a8cde5a3e287ff0f2ad730514d724343bed608807ed5d5bd98e61c0b545076c72857bb2f2db35b5f62e7340049d3bf19931e8a147f22144877887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34541f1dc649ab9724a17906d00ce79b7426473014d410253f88886a82e17d1a608340766460a2a62754afe56a553bec7769115cedc8bfcaad31c8ea52e83f9d"} 19:25:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:56 INFO - Contents: 19:25:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ac93712254f4fa66975c91e5414187810d746aa242302b64ba447c3fd77e876e97cc6d4d086eb3dd8b1b68e5029f0c74520d97e79b97982f46236ee2a4c3266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136984ff432a8cde5a3e287ff0f2ad730514d724343bed608807ed5d5bd98e61c0b545076c72857bb2f2db35b5f62e7340049d3bf19931e8a147f22144877887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34541f1dc649ab9724a17906d00ce79b7426473014d410253f88886a82e17d1a608340766460a2a62754afe56a553bec7769115cedc8bfcaad31c8ea52e83f9d"} 19:25:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:56 INFO - Copying logs to upload dir... 19:25:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.355161 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-13 19:25:56.412086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 19:25:56.415631) ========= 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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 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/3ac93712254f4fa66975c91e5414187810d746aa242302b64ba447c3fd77e876e97cc6d4d086eb3dd8b1b68e5029f0c74520d97e79b97982f46236ee2a4c3266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136984ff432a8cde5a3e287ff0f2ad730514d724343bed608807ed5d5bd98e61c0b545076c72857bb2f2db35b5f62e7340049d3bf19931e8a147f22144877887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34541f1dc649ab9724a17906d00ce79b7426473014d410253f88886a82e17d1a608340766460a2a62754afe56a553bec7769115cedc8bfcaad31c8ea52e83f9d"} build_url:https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/Q54gf0HhTlaPGphDdcez8A/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/3ac93712254f4fa66975c91e5414187810d746aa242302b64ba447c3fd77e876e97cc6d4d086eb3dd8b1b68e5029f0c74520d97e79b97982f46236ee2a4c3266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136984ff432a8cde5a3e287ff0f2ad730514d724343bed608807ed5d5bd98e61c0b545076c72857bb2f2db35b5f62e7340049d3bf19931e8a147f22144877887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34541f1dc649ab9724a17906d00ce79b7426473014d410253f88886a82e17d1a608340766460a2a62754afe56a553bec7769115cedc8bfcaad31c8ea52e83f9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 19:25:56.445567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:25:56.446352) ========= 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=41bf3e9aed84707956354da8000001c5-1468459223.357366-1672586212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 19:25:56.528129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 19:25:56.528430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 19:25:56.528712) ========= ========= Total master_lag: 0.19 =========