builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1474395253.36 results: success (0) buildid: 20160920110610 builduid: 98b1fa5e5b214722b6ea209941f5d5dd revision: ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.361145) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.362055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.362553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.378768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.379426) ========= 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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 11:14:13-- 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% 41.1M=0s 2016-09-20 11:14:13 (41.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.537409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.537775) ========= 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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020206 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.588500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:13.588904) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 --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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 11:14:13,839 truncating revision to first 12 chars 2016-09-20 11:14:13,840 Setting DEBUG logging. 2016-09-20 11:14:13,840 attempt 1/10 2016-09-20 11:14:13,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ba84914a7e70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 11:14:14,143 unpacking tar archive at: autoland-ba84914a7e70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:14.238532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:14.239278) ========= script_repo_revision: ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:14.239865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:14.240203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 11:14:14.252184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-20 11:14:14.252503) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:14 INFO - MultiFileLogger online at 20160920 11:14:14 in /builds/slave/test 11:14:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 11:14:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:14 INFO - {'append_to_log': False, 11:14:14 INFO - 'base_work_dir': '/builds/slave/test', 11:14:14 INFO - 'blob_upload_branch': 'Autoland', 11:14:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:14 INFO - 'branch': 'Autoland', 11:14:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:14 INFO - 'config_files': ('talos/linux_config.py',), 11:14:14 INFO - 'default_actions': ('clobber', 11:14:14 INFO - 'read-buildbot-config', 11:14:14 INFO - 'download-and-extract', 11:14:14 INFO - 'populate-webroot', 11:14:14 INFO - 'create-virtualenv', 11:14:14 INFO - 'install', 11:14:14 INFO - 'run-tests'), 11:14:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:14 INFO - 'download_minidump_stackwalk': True, 11:14:14 INFO - 'download_symbols': 'ondemand', 11:14:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:14 INFO - 'installer_path': 'installer.exe', 11:14:14 INFO - 'log_level': 'info', 11:14:14 INFO - 'log_name': 'talos', 11:14:14 INFO - 'log_to_console': True, 11:14:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:14 INFO - 'opt_config_files': (), 11:14:14 INFO - 'pip_index': False, 11:14:14 INFO - 'sps_profile': False, 11:14:14 INFO - 'sps_profile_interval': 0, 11:14:14 INFO - 'suite': 'dromaeojs', 11:14:14 INFO - 'system_bits': '32', 11:14:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:14 INFO - 'title': 'talos-linux64-ix-026', 11:14:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:14 INFO - 'use_talos_json': True, 11:14:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:14 INFO - 'work_dir': 'build'} 11:14:14 INFO - [mozharness: 2016-09-20 18:14:14.597876Z] Running clobber step. 11:14:14 INFO - Running pre-action listener: _resource_record_pre_action 11:14:14 INFO - Running main action method: clobber 11:14:14 INFO - rmtree: /builds/slave/test/build 11:14:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:15 INFO - Running post-action listener: _resource_record_post_action 11:14:15 INFO - [mozharness: 2016-09-20 18:14:15.050685Z] Finished clobber step (success) 11:14:15 INFO - [mozharness: 2016-09-20 18:14:15.050785Z] Running read-buildbot-config step. 11:14:15 INFO - Running pre-action listener: _resource_record_pre_action 11:14:15 INFO - Running main action method: read_buildbot_config 11:14:15 INFO - Using buildbot properties: 11:14:15 INFO - { 11:14:15 INFO - "project": "", 11:14:15 INFO - "product": "firefox", 11:14:15 INFO - "script_repo_revision": "production", 11:14:15 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:14:15 INFO - "repository": "", 11:14:15 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 11:14:15 INFO - "buildid": "20160920110610", 11:14:15 INFO - "stage_platform": "linux64-pgo", 11:14:15 INFO - "basedir": "/builds/slave/test", 11:14:15 INFO - "buildnumber": 239, 11:14:15 INFO - "platform": "ubuntu64_hw", 11:14:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:14:15 INFO - "slavebuilddir": "test", 11:14:15 INFO - "branch": "autoland", 11:14:15 INFO - "revision": "ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7", 11:14:15 INFO - "slavename": "talos-linux64-ix-026", 11:14:15 INFO - "builduid": "98b1fa5e5b214722b6ea209941f5d5dd", 11:14:15 INFO - "repo_path": "integration/autoland" 11:14:15 INFO - } 11:14:15 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:14:15 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 11:14:15 INFO - Running post-action listener: _resource_record_post_action 11:14:15 INFO - [mozharness: 2016-09-20 18:14:15.053712Z] Finished read-buildbot-config step (success) 11:14:15 INFO - [mozharness: 2016-09-20 18:14:15.053800Z] Running download-and-extract step. 11:14:15 INFO - Running pre-action listener: _resource_record_pre_action 11:14:15 INFO - Running main action method: download_and_extract 11:14:15 INFO - mkdir: /builds/slave/test/build/tests 11:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:14:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:14:15 INFO - Downloaded 1361 bytes. 11:14:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:14:15 INFO - Using the following test package requirements: 11:14:15 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:14:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'jsshell-linux-x86_64.zip'], 11:14:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:15 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:15 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:14:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:15 INFO - Downloaded 21905609 bytes. 11:14:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:14:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:19 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:14:19 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:19 INFO - Downloaded 21905609 bytes. 11:14:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:24 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:24 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:14:24 INFO - Downloaded 14413981 bytes. 11:14:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:14:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:14:25 INFO - Downloaded 59605052 bytes. 11:14:25 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:14:25 INFO - mkdir: /builds/slave/test/properties 11:14:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:25 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:25 INFO - Contents: 11:14:25 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:14:26 INFO - Running post-action listener: _resource_record_post_action 11:14:26 INFO - Running post-action listener: set_extra_try_arguments 11:14:26 INFO - [mozharness: 2016-09-20 18:14:26.157255Z] Finished download-and-extract step (success) 11:14:26 INFO - [mozharness: 2016-09-20 18:14:26.157479Z] Running populate-webroot step. 11:14:26 INFO - Running pre-action listener: _resource_record_pre_action 11:14:26 INFO - Running main action method: populate_webroot 11:14:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:26 INFO - '--tppagecycles', 11:14:26 INFO - '7'], 11:14:26 INFO - 'tests': ['tsvgm']}}, 11:14:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:14:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:14:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['damp', 'tps']}, 11:14:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'tests': ['damp', 'tps']}, 11:14:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['dromaeo_dom']}, 11:14:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['basic_compositor_video']}, 11:14:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:14:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['a11yr', 11:14:26 INFO - 'ts_paint', 11:14:26 INFO - 'tpaint', 11:14:26 INFO - 'sessionrestore', 11:14:26 INFO - 'sessionrestore_no_auto_restore', 11:14:26 INFO - 'tabpaint']}, 11:14:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['tsvgx', 11:14:26 INFO - 'tsvgr_opacity', 11:14:26 INFO - 'tart', 11:14:26 INFO - 'tscrollx', 11:14:26 INFO - 'cart']}, 11:14:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:14:26 INFO - 'tsvgr_opacity', 11:14:26 INFO - 'tart', 11:14:26 INFO - 'tscrollx', 11:14:26 INFO - 'cart']}, 11:14:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'talos_options': ['--disable-e10s'], 11:14:26 INFO - 'tests': ['tp5o']}, 11:14:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'tests': ['tp5o']}, 11:14:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'talos_options': ['--disable-e10s', 11:14:26 INFO - '--xperf_path', 11:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:26 INFO - 'tests': ['tp5n']}, 11:14:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:26 INFO - 'talos_options': ['--xperf_path', 11:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:26 INFO - 'tests': ['tp5n']}}, 11:14:26 INFO - 'talos.zip': {'path': '', 11:14:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:26 INFO - Running post-action listener: _resource_record_post_action 11:14:26 INFO - [mozharness: 2016-09-20 18:14:26.174849Z] Finished populate-webroot step (success) 11:14:26 INFO - [mozharness: 2016-09-20 18:14:26.174937Z] Running create-virtualenv step. 11:14:26 INFO - Running pre-action listener: _resource_record_pre_action 11:14:26 INFO - Running main action method: create_virtualenv 11:14:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:26 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 11:14:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:26 INFO - Using real prefix '/usr' 11:14:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:28 INFO - Installing pip.................done. 11:14:28 INFO - Return code: 0 11:14:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:28 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 11:14:28 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 11:14:28 INFO - Using env: {'DISPLAY': ':0', 11:14:28 INFO - 'HOME': '/home/cltbld', 11:14:28 INFO - 'LANG': 'en_US.UTF-8', 11:14:28 INFO - 'LANGUAGE': 'en_US:en', 11:14:28 INFO - 'LOGNAME': 'cltbld', 11:14:28 INFO - 'MAIL': '/var/mail/cltbld', 11:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:28 INFO - 'MOZ_NO_REMOTE': '1', 11:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:28 INFO - 'NO_EM_RESTART': '1', 11:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:28 INFO - 'PWD': '/builds/slave/test', 11:14:28 INFO - 'SHELL': '/bin/bash', 11:14:28 INFO - 'SHLVL': '1', 11:14:28 INFO - 'TERM': 'linux', 11:14:28 INFO - 'TMOUT': '86400', 11:14:28 INFO - 'USER': 'cltbld', 11:14:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:28 INFO - '_': '/tools/buildbot/bin/python'} 11:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:28 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 11:14:28 INFO - Cleaning up... 11:14:28 INFO - Return code: 0 11:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:28 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:28 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 11:14:28 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 11:14:28 INFO - Using env: {'DISPLAY': ':0', 11:14:28 INFO - 'HOME': '/home/cltbld', 11:14:28 INFO - 'LANG': 'en_US.UTF-8', 11:14:28 INFO - 'LANGUAGE': 'en_US:en', 11:14:28 INFO - 'LOGNAME': 'cltbld', 11:14:28 INFO - 'MAIL': '/var/mail/cltbld', 11:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:28 INFO - 'MOZ_NO_REMOTE': '1', 11:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:28 INFO - 'NO_EM_RESTART': '1', 11:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:28 INFO - 'PWD': '/builds/slave/test', 11:14:28 INFO - 'SHELL': '/bin/bash', 11:14:28 INFO - 'SHLVL': '1', 11:14:28 INFO - 'TERM': 'linux', 11:14:28 INFO - 'TMOUT': '86400', 11:14:28 INFO - 'USER': 'cltbld', 11:14:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:28 INFO - '_': '/tools/buildbot/bin/python'} 11:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:29 INFO - Downloading/unpacking psutil>=3.1.1 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:29 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 11:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:31 INFO - Installing collected packages: psutil 11:14:31 INFO - Running setup.py install for psutil 11:14:31 INFO - building 'psutil._psutil_linux' extension 11:14:31 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 11:14:31 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 11:14:31 INFO - building 'psutil._psutil_posix' extension 11:14:31 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 11:14:31 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 11:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:31 INFO - Successfully installed psutil 11:14:31 INFO - Cleaning up... 11:14:31 INFO - Return code: 0 11:14:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:31 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:31 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 11:14:31 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 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:31 INFO - '_': '/tools/buildbot/bin/python'} 11:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:31 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 11:14:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:14:33 INFO - Installing collected packages: mozsystemmonitor 11:14:33 INFO - Running setup.py install for mozsystemmonitor 11:14:33 INFO - Successfully installed mozsystemmonitor 11:14:33 INFO - Cleaning up... 11:14:33 INFO - Return code: 0 11:14:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:34 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:34 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 11:14:34 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 11:14:34 INFO - Using env: {'DISPLAY': ':0', 11:14:34 INFO - 'HOME': '/home/cltbld', 11:14:34 INFO - 'LANG': 'en_US.UTF-8', 11:14:34 INFO - 'LANGUAGE': 'en_US:en', 11:14:34 INFO - 'LOGNAME': 'cltbld', 11:14:34 INFO - 'MAIL': '/var/mail/cltbld', 11:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:34 INFO - 'MOZ_NO_REMOTE': '1', 11:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:34 INFO - 'NO_EM_RESTART': '1', 11:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:34 INFO - 'PWD': '/builds/slave/test', 11:14:34 INFO - 'SHELL': '/bin/bash', 11:14:34 INFO - 'SHLVL': '1', 11:14:34 INFO - 'TERM': 'linux', 11:14:34 INFO - 'TMOUT': '86400', 11:14:34 INFO - 'USER': 'cltbld', 11:14:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:34 INFO - '_': '/tools/buildbot/bin/python'} 11:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:36 INFO - warning: no files found matching '*.txt' 11:14:36 INFO - no previously-included directories found matching 'build' 11:14:36 INFO - no previously-included directories found matching 'dist' 11:14:36 INFO - no previously-included directories found matching '.git*' 11:14:36 INFO - Installing collected packages: jsonschema, functools32 11:14:36 INFO - Running setup.py install for functools32 11:14:36 INFO - warning: no files found matching '*.txt' 11:14:36 INFO - no previously-included directories found matching 'build' 11:14:36 INFO - no previously-included directories found matching 'dist' 11:14:36 INFO - no previously-included directories found matching '.git*' 11:14:36 INFO - Successfully installed jsonschema functools32 11:14:36 INFO - Cleaning up... 11:14:36 INFO - Return code: 0 11:14:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:14:36 INFO - Using env: {'DISPLAY': ':0', 11:14:36 INFO - 'HOME': '/home/cltbld', 11:14:36 INFO - 'LANG': 'en_US.UTF-8', 11:14:36 INFO - 'LANGUAGE': 'en_US:en', 11:14:36 INFO - 'LOGNAME': 'cltbld', 11:14:36 INFO - 'MAIL': '/var/mail/cltbld', 11:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:36 INFO - 'MOZ_NO_REMOTE': '1', 11:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:36 INFO - 'NO_EM_RESTART': '1', 11:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:36 INFO - 'PWD': '/builds/slave/test', 11:14:36 INFO - 'SHELL': '/bin/bash', 11:14:36 INFO - 'SHLVL': '1', 11:14:36 INFO - 'TERM': 'linux', 11:14:36 INFO - 'TMOUT': '86400', 11:14:36 INFO - 'USER': 'cltbld', 11:14:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:36 INFO - '_': '/tools/buildbot/bin/python'} 11:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:14:36 INFO - Cleaning up... 11:14:36 INFO - Return code: 0 11:14:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:14:36 INFO - Using env: {'DISPLAY': ':0', 11:14:36 INFO - 'HOME': '/home/cltbld', 11:14:36 INFO - 'LANG': 'en_US.UTF-8', 11:14:36 INFO - 'LANGUAGE': 'en_US:en', 11:14:36 INFO - 'LOGNAME': 'cltbld', 11:14:36 INFO - 'MAIL': '/var/mail/cltbld', 11:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:36 INFO - 'MOZ_NO_REMOTE': '1', 11:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:36 INFO - 'NO_EM_RESTART': '1', 11:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:36 INFO - 'PWD': '/builds/slave/test', 11:14:36 INFO - 'SHELL': '/bin/bash', 11:14:36 INFO - 'SHLVL': '1', 11:14:36 INFO - 'TERM': 'linux', 11:14:36 INFO - 'TMOUT': '86400', 11:14:36 INFO - 'USER': 'cltbld', 11:14:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:36 INFO - '_': '/tools/buildbot/bin/python'} 11:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:36 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 11:14:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:38 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 11:14:38 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 11:14:38 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 11:14:38 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 11:14:38 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 11:14:38 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 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:39 INFO - Downloading docopt-0.6.1.tar.gz 11:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:39 INFO - Running setup.py install for blobuploader 11:14:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:39 INFO - Running setup.py install for requests 11:14:40 INFO - Running setup.py install for docopt 11:14:40 INFO - Successfully installed blobuploader requests docopt 11:14:40 INFO - Cleaning up... 11:14:40 INFO - Return code: 0 11:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:40 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:40 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 11:14:40 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 11:14:40 INFO - Using env: {'DISPLAY': ':0', 11:14:40 INFO - 'HOME': '/home/cltbld', 11:14:40 INFO - 'LANG': 'en_US.UTF-8', 11:14:40 INFO - 'LANGUAGE': 'en_US:en', 11:14:40 INFO - 'LOGNAME': 'cltbld', 11:14:40 INFO - 'MAIL': '/var/mail/cltbld', 11:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:40 INFO - 'MOZ_NO_REMOTE': '1', 11:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:40 INFO - 'NO_EM_RESTART': '1', 11:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:40 INFO - 'PWD': '/builds/slave/test', 11:14:40 INFO - 'SHELL': '/bin/bash', 11:14:40 INFO - 'SHLVL': '1', 11:14:40 INFO - 'TERM': 'linux', 11:14:40 INFO - 'TMOUT': '86400', 11:14:40 INFO - 'USER': 'cltbld', 11:14:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:40 INFO - '_': '/tools/buildbot/bin/python'} 11:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:40 INFO - Running setup.py (path:/tmp/pip-jQuziC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:40 INFO - Running setup.py (path:/tmp/pip-cv5VPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:40 INFO - Running setup.py (path:/tmp/pip-HVNF7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:40 INFO - Running setup.py (path:/tmp/pip-pHIpNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:40 INFO - Running setup.py (path:/tmp/pip-QEOgUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:40 INFO - Running setup.py (path:/tmp/pip-JoBOlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:40 INFO - Running setup.py (path:/tmp/pip-QTGIhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:40 INFO - Running setup.py (path:/tmp/pip-3Ms8u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:41 INFO - Running setup.py (path:/tmp/pip-xOhEwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:41 INFO - Running setup.py (path:/tmp/pip-V6lqu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:41 INFO - Running setup.py (path:/tmp/pip-AzG5yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:41 INFO - Running setup.py (path:/tmp/pip-yDclMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:41 INFO - Running setup.py (path:/tmp/pip-qx85fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:41 INFO - Running setup.py (path:/tmp/pip-VPD3hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:41 INFO - Running setup.py (path:/tmp/pip-EyHPNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:41 INFO - Running setup.py (path:/tmp/pip-fOSGMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:41 INFO - Running setup.py (path:/tmp/pip-4l5NP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:41 INFO - Running setup.py install for manifestparser 11:14:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:41 INFO - Running setup.py install for mozcrash 11:14:41 INFO - Running setup.py install for mozdebug 11:14:41 INFO - Running setup.py install for mozdevice 11:14:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozfile 11:14:42 INFO - Running setup.py install for mozhttpd 11:14:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozinfo 11:14:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozInstall 11:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozleak 11:14:42 INFO - Running setup.py install for mozlog 11:14:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for moznetwork 11:14:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozprocess 11:14:42 INFO - Running setup.py install for mozprofile 11:14:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:42 INFO - Running setup.py install for mozrunner 11:14:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Running setup.py install for mozscreenshot 11:14:43 INFO - Running setup.py install for moztest 11:14:43 INFO - Running setup.py install for mozversion 11:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:43 INFO - Cleaning up... 11:14:43 INFO - Return code: 0 11:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:43 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:43 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 11:14:43 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 11:14:43 INFO - Using env: {'DISPLAY': ':0', 11:14:43 INFO - 'HOME': '/home/cltbld', 11:14:43 INFO - 'LANG': 'en_US.UTF-8', 11:14:43 INFO - 'LANGUAGE': 'en_US:en', 11:14:43 INFO - 'LOGNAME': 'cltbld', 11:14:43 INFO - 'MAIL': '/var/mail/cltbld', 11:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:43 INFO - 'MOZ_NO_REMOTE': '1', 11:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:43 INFO - 'NO_EM_RESTART': '1', 11:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:43 INFO - 'PWD': '/builds/slave/test', 11:14:43 INFO - 'SHELL': '/bin/bash', 11:14:43 INFO - 'SHLVL': '1', 11:14:43 INFO - 'TERM': 'linux', 11:14:43 INFO - 'TMOUT': '86400', 11:14:43 INFO - 'USER': 'cltbld', 11:14:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:43 INFO - '_': '/tools/buildbot/bin/python'} 11:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:43 INFO - Running setup.py (path:/tmp/pip-LDYiyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:43 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)) 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:43 INFO - Running setup.py (path:/tmp/pip-zZgakn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:43 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)) 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:43 INFO - Running setup.py (path:/tmp/pip-W7L7LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:43 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)) 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:43 INFO - Running setup.py (path:/tmp/pip-1mysWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:43 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)) 11:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:43 INFO - Running setup.py (path:/tmp/pip-k88FS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:44 INFO - Running setup.py (path:/tmp/pip-sef_Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:44 INFO - Running setup.py (path:/tmp/pip-raQHqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:44 INFO - Running setup.py (path:/tmp/pip-YnBTfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:44 INFO - Running setup.py (path:/tmp/pip-kUZH5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:44 INFO - Running setup.py (path:/tmp/pip-QFr5SI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:44 INFO - Running setup.py (path:/tmp/pip-iPtUoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:44 INFO - Running setup.py (path:/tmp/pip-KJhTK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:44 INFO - Running setup.py (path:/tmp/pip-g0rTHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:44 INFO - Running setup.py (path:/tmp/pip-uNI6Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:44 INFO - Running setup.py (path:/tmp/pip-g2hocj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:44 INFO - Running setup.py (path:/tmp/pip-YrAyYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:44 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)) 11:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:44 INFO - Running setup.py (path:/tmp/pip-Z_LnK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:44 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)) 11:14:44 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)) 11:14:44 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)) 11:14:44 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)) 11:14:44 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)) 11:14:44 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)) 11:14:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:46 INFO - Downloading blessings-1.6.tar.gz 11:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:46 INFO - Installing collected packages: blessings 11:14:46 INFO - Running setup.py install for blessings 11:14:46 INFO - Successfully installed blessings 11:14:46 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:47 INFO - Reading from file tmpfile_stdout 11:14:47 INFO - Current package versions: 11:14:47 INFO - argparse == 1.2.1 11:14:47 INFO - blessings == 1.6 11:14:47 INFO - blobuploader == 1.2.4 11:14:47 INFO - docopt == 0.6.1 11:14:47 INFO - functools32 == 3.2.3-2 11:14:47 INFO - jsonschema == 2.5.1 11:14:47 INFO - manifestparser == 1.1 11:14:47 INFO - mozInstall == 1.12 11:14:47 INFO - mozcrash == 0.17 11:14:47 INFO - mozdebug == 0.1 11:14:47 INFO - mozdevice == 0.48 11:14:47 INFO - mozfile == 1.2 11:14:47 INFO - mozhttpd == 0.7 11:14:47 INFO - mozinfo == 0.9 11:14:47 INFO - mozleak == 0.1 11:14:47 INFO - mozlog == 3.3 11:14:47 INFO - moznetwork == 0.27 11:14:47 INFO - mozprocess == 0.23 11:14:47 INFO - mozprofile == 0.28 11:14:47 INFO - mozrunner == 6.12 11:14:47 INFO - mozscreenshot == 0.1 11:14:47 INFO - mozsystemmonitor == 0.3 11:14:47 INFO - moztest == 0.7 11:14:47 INFO - mozversion == 1.4 11:14:47 INFO - psutil == 3.1.1 11:14:47 INFO - requests == 1.2.3 11:14:47 INFO - wsgiref == 0.1.2 11:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 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 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:47 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 11:14:47 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 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 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)) 11:14:47 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dcb5eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a9850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, '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-1474395252.820367-854620852', '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 11:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:47 INFO - Using env: {'DISPLAY': ':0', 11:14:47 INFO - 'HOME': '/home/cltbld', 11:14:47 INFO - 'LANG': 'en_US.UTF-8', 11:14:47 INFO - 'LANGUAGE': 'en_US:en', 11:14:47 INFO - 'LOGNAME': 'cltbld', 11:14:47 INFO - 'MAIL': '/var/mail/cltbld', 11:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:47 INFO - 'MOZ_NO_REMOTE': '1', 11:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:47 INFO - 'NO_EM_RESTART': '1', 11:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:47 INFO - 'PWD': '/builds/slave/test', 11:14:47 INFO - 'SHELL': '/bin/bash', 11:14:47 INFO - 'SHLVL': '1', 11:14:47 INFO - 'TERM': 'linux', 11:14:47 INFO - 'TMOUT': '86400', 11:14:47 INFO - 'USER': 'cltbld', 11:14:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:47 INFO - '_': '/tools/buildbot/bin/python'} 11:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:47 INFO - Cleaning up... 11:14:47 INFO - Return code: 0 11:14:47 INFO - Running post-action listener: _resource_record_post_action 11:14:47 INFO - Running post-action listener: _start_resource_monitoring 11:14:47 INFO - Starting resource monitoring. 11:14:47 INFO - [mozharness: 2016-09-20 18:14:47.735069Z] Finished create-virtualenv step (success) 11:14:47 INFO - [mozharness: 2016-09-20 18:14:47.735528Z] Running install step. 11:14:47 INFO - Running pre-action listener: _resource_record_pre_action 11:14:47 INFO - Running main action method: install 11:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:47 INFO - Reading from file tmpfile_stdout 11:14:47 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:48 INFO - Reading from file tmpfile_stdout 11:14:48 INFO - Output received: 11:14:48 INFO - Usage: mozinstall [options] installer 11:14:48 INFO - Options: 11:14:48 INFO - -h, --help show this help message and exit 11:14:48 INFO - -d DEST, --destination=DEST 11:14:48 INFO - Directory to install application into. [default: 11:14:48 INFO - "/builds/slave/test"] 11:14:48 INFO - --app=APP Application being installed. [default: firefox] 11:14:48 INFO - mkdir: /builds/slave/test/build/application 11:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:15:04 INFO - Reading from file tmpfile_stdout 11:15:04 INFO - Output received: 11:15:04 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:04 INFO - Running post-action listener: _resource_record_post_action 11:15:04 INFO - [mozharness: 2016-09-20 18:15:04.975573Z] Finished install step (success) 11:15:04 INFO - [mozharness: 2016-09-20 18:15:04.975848Z] Running run-tests step. 11:15:04 INFO - Running pre-action listener: _resource_record_pre_action 11:15:04 INFO - Running main action method: run_tests 11:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:04 INFO - Python 2.7.3 11:15:04 INFO - Return code: 0 11:15:04 INFO - grabbing minidump binary from tooltool 11:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:04 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 0x27a4370>, '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 0x27a78f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a7d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:04 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 11:15:04 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 11:15:04 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 11:15:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:05 INFO - Return code: 0 11:15:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:15:05 INFO - Using env: {'DISPLAY': ':0', 11:15:05 INFO - 'HOME': '/home/cltbld', 11:15:05 INFO - 'LANG': 'en_US.UTF-8', 11:15:05 INFO - 'LANGUAGE': 'en_US:en', 11:15:05 INFO - 'LOGNAME': 'cltbld', 11:15:05 INFO - 'MAIL': '/var/mail/cltbld', 11:15:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:05 INFO - 'MOZ_NO_REMOTE': '1', 11:15:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:05 INFO - 'NO_EM_RESTART': '1', 11:15:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:05 INFO - 'PWD': '/builds/slave/test', 11:15:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:05 INFO - 'SHELL': '/bin/bash', 11:15:05 INFO - 'SHLVL': '1', 11:15:05 INFO - 'TERM': 'linux', 11:15:05 INFO - 'TMOUT': '86400', 11:15:05 INFO - 'USER': 'cltbld', 11:15:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1474395252.820367-854620852', 11:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:05 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:15:05 INFO - mozversion application_buildid: 20160920081529 11:15:05 INFO - mozversion application_changeset: ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 11:15:05 INFO - mozversion application_display_name: Nightly 11:15:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:05 INFO - mozversion application_name: Firefox 11:15:05 INFO - mozversion application_remotingname: firefox 11:15:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:15:05 INFO - mozversion application_vendor: Mozilla 11:15:05 INFO - mozversion application_version: 51.0a1 11:15:05 INFO - mozversion platform_buildid: 20160920081529 11:15:05 INFO - mozversion platform_changeset: ba84914a7e70aa4d61aa1b8ca4796fae7172dfa7 11:15:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:15:05 INFO - mozversion platform_version: 51.0a1 11:15:05 INFO - using testdate: 1474395305 11:15:05 INFO - actual date: 1474395305 11:15:05 INFO - starting webserver on 'localhost:53343' 11:15:05 INFO - SUITE-START | Running 2 tests 11:15:05 INFO - TEST-START | dromaeo_css 11:15:05 INFO - operating with platform_type : linux_ 11:15:05 INFO - Initialising browser for dromaeo_css test... 11:15:05 INFO - TEST-INFO | started process 22738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLfvje3/profile http://localhost:53343/getInfo.html) 11:15:09 INFO - PROCESS | 22738 | __metrics Screen width/height:1600/1200 11:15:09 INFO - PROCESS | 22738 | colorDepth:24 11:15:09 INFO - PROCESS | 22738 | Browser inner width/height: 1024/697 11:15:09 INFO - PROCESS | 22738 | __metrics 11:15:09 INFO - PROCESS | 22738 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:15:09 INFO - PROCESS | 22738 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:10 INFO - PROCESS | 22738 | console.error: PushService: 11:15:10 INFO - PROCESS | 22738 | stateChangeProcessEnqueue: Error transitioning state 11:15:10 INFO - PROCESS | 22738 | UnknownError 11:15:10 INFO - TEST-INFO | 22738: exit 0 11:15:10 INFO - Browser initialized. 11:15:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:10 INFO - TEST-INFO | started process 22819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLfvje3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:22 INFO - PROCESS | 22819 | RSS: Main: 155820032 11:15:22 INFO - PROCESS | 22819 | 11:16:14 INFO - PROCESS | 22819 | 1474395374178 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] 11:18:23 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53343/tests/dromaeo/cssquery-ext.html) 11:18:24 INFO - PROCESS | 22819 | RSS: Main: 256835584 11:18:24 INFO - PROCESS | 22819 | 11:21:27 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-ext.html (next: http://localhost:53343/tests/dromaeo/cssquery-jquery.html) 11:21:27 INFO - PROCESS | 22819 | RSS: Main: 253431808 11:21:27 INFO - PROCESS | 22819 | 11:24:30 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53343/tests/dromaeo/cssquery-mootools.html) 11:24:30 INFO - PROCESS | 22819 | RSS: Main: 244457472 11:24:30 INFO - PROCESS | 22819 | 11:27:32 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53343/tests/dromaeo/cssquery-prototype.html) 11:27:33 INFO - PROCESS | 22819 | RSS: Main: 220856320 11:27:33 INFO - PROCESS | 22819 | 11:30:36 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53343/tests/dromaeo/cssquery-yui.html) 11:30:36 INFO - PROCESS | 22819 | RSS: Main: 188821504 11:30:36 INFO - PROCESS | 22819 | 11:33:39 INFO - PROCESS | 22819 | Cycle 1(1): loaded http://localhost:53343/tests/dromaeo/cssquery-yui.html (next: http://localhost:53343/tests/dromaeo/cssquery-dojo.html) 11:33:40 INFO - PROCESS | 22819 | RSS: Main: 282406912 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | __start_tp_report 11:33:40 INFO - PROCESS | 22819 | _x_x_mozilla_page_load 11:33:40 INFO - PROCESS | 22819 | _x_x_mozilla_page_load_details 11:33:40 INFO - PROCESS | 22819 | |i|pagename|runs| 11:33:40 INFO - PROCESS | 22819 | |0;dojo.html;3007.8796848126076;3017.336186039071;3052.9389412211763;3058.1437197584683;3063.1116976076937;5210.55710264627;5225.8954820903555;5257.369115706111;5383.59623028273;5393.649412788166;5260.710660913648;5319.760610772515;5349.144136938091;5368;5446.101393270115;4762.095201911626;4826.469088400273;4838.201696720037;4843.951560484403;5015.824446144386;4927.6550641455115;4939.703617782944;4969.105560999019;4983.053219888227;5004.899902001957;4777.450593181794;4823;4832.710037397767;4916.532929371704;4958.132326842806;4844.927326090112;4849.981503884189;4863.683860549053;4977.601791856643;4980.77586508608;4867.756612169413;4887.7311747853855;4919.188333924898;4944.851654450372;4972.254161875711;5202.76587553561;5338.359396872362;5401.5948803839865;5412.188171774226;5458.181272809111;5743.368229494752;5821;5823.359430462646;5833.095870140135;5834.941650583482;5792.82621521355;5797.855053623651;5823.767049318022;5865.85335366615;5871.735771890275;5141.53726164647;5233.162693969023;5383.703896285702;5388.541973932221;5395.352557693062;5733.913991290134;5846.970765146147;5890.1164825276555;5893.9999999999145;5894.115882617642;5650.802221922295;5666.97166514173;5710.685912274865;5711.457411545896;5712.685802280831;5574.386817450078;5642.04085305499;5732.942670573324;5774.422557744192;5778.479936805707;5684.602077854511;5729.3984131665575;5735.0250457422335;5773.509251713567;5773.653580785166;5697.544196464273;5742.0238559445;5748.798792042258;5759.078547432391;5764.74058667361;4346.304591265382;4389.078293558388;4405.801738921757;4448.755318457516;4491.618212451913;3926.371780515104;3967.2263908538134;3988.7806170660892;4006.579309172495;4049.5140583130215;5525.668459892339;5526.696031718214;5528;5531.557475401958;5585.916211256835;5533.391326954032;5730.713464326767;5803;5809.767609295665;5810.070388737781;5476.91784623231;5522.723863806794;5527;5553.389127196006;5553.777848885999;4988;5009.924851127236;5013.298138260647;5016.498350165028;5036.420811606639;5780.7398667060925;6015.639061656315;6088.11722300264;6093.177421048191;6098.786542471081;5757.366689664217;5823.679697616672;5843.853903652443;5858.47273745365;5876.853078673067;6015.518758499397;6016.42843929826;6021.578489505692;6027.427394397525;6112.358202388863;5502.944970550243;5656.632318899258;5664.971675141598;5723.971380143239;5728.684922329312;5704.401037890962;5741.0527263002805;5750.367459579526;5798.304203495439;5805.448482394166;5549.112142057252;5573.832785016456;5600.243967064394;5601.7759289629585;5604.943950560442;5449.972750136224;5540.224368588481;5592.3009623797025;5600.691961942132;5603.915941260966;5506.03644362243;5558.388577256579;5560.805371811967;5598;5607.523360514402;5633.8591535211945;5638.60529762929;5683.948469533149;5688.345840228427;5694.572907031907;5358.142697168434;5363.115086010765;5494.780208791603;5501.257330260363;5502.889942201214 11:33:40 INFO - PROCESS | 22819 | |1;ext.html;563.9520640745536;587.3744462147815;593.5459373579215;599.4455129005669;600.8557946092939;32422.67577324226;42416.575834241645;43825.12349753003;43866.99999999996;47035.76482117593;44617.330740038924;45037.09925801482;45053.7747311263;45057.09885802282;45063.32405013927;8063.395245356593;8893.333000025008;9004.189622933935;9019.774505637379;9023.684171054014;10516.631917882876;10791.352518848855;10806.891931080707;11139.665810025672;11155.944220278887;10781.191410644233;10833.458327083654;10842.295250808673;10855.457227138651;10884.183686223525;10607.257491975526;10679.839802403008;10687.038166565046;10688.839667404995;10724;10585.311954722918;10623.150147988143;10639.148868090611;10646.307989980627;10655.360678359324;42910.57089429097;43317;43396.566034339565;43429.13141737179;43494.34758478594;3821.407681809324;4101.2207680540605;4148.191102734968;4175.227582897173;4205.684573656988;32941.6705832941;33057.6694233057;33089.43008383743;33420.83289583537;33943.624802696984;4238.21593005295;4320.632746216544;4338.349247612883;4471.0610771737975;4510.300903359985;351950.99999999744;352307;352430;353029;353056;58343.70828145917;58641.706791466626;58884.41115588875;58986.82026359535;59061.40938590645;60988.39011609916;61687.383126169065;61749.69125154345;61885.38114618886;61970;13928.721425571635;13961.79057314141;13970;13970.371333289822;13978.440862365595;10961.287516311415;11701.180917335874;12033.819492707617;12072.396380181131;12077.577284795167;17118.572035699206;17193.312267509158;17273.222704978307;17408.912955435142;17519.29922803099;6574.934250657432;6718.328167183243;6803.353681400259;6842.418394436529;6933.93066069343;923.4367036107968;993.0516356879164;998.3261298623545;999.3703966501058;1003.5433877585681;33312.50031249533;33531.66468335286;33591.49612755811;33646.663533364845;33791.324173516885;1111.1333160135107;1118.5637601335486;1140.230344517464;1196.9281843089443;1207.5230284037757;17077.7438338425;17284.22221000058;17446.738298925527;17485.65028699419;17518.29926802939;591282;595474;599152;600138;600550;59174.704126479955;59192;59288.40711592915;59301;59382.70308648429;1222.706550427891;1323.1201251168059;1355.1936597724339;1374.8212732344732;1385.9722805543834;32846.507302390004;34207;34751.82624086965;35149.64850351566;35199.47200791939;51331.84017917724;51574.484255158466;51878;51884.22173667322;51949.7402512985;440772;441961;442238;443317;443957;27500.862495687394;28889;28924.42151157007;30018.69981300159;30298.394032118795;48453.515464846314;48802.511974879795;49076.50923490719;49335.75332123316;50614.2407863875;39661.405078924414;40729;40895.591044089175;42121.36817947672;42166.51835261519;41442.792786035876;41627;42583.787081064394;42936;43423.56576434321;41593;41909;43382.34926476042;43424.78287608542;43512.34731478967;35000.64999350076;37618.43572346362;37990.620093799815;38050.42924356192;38627;28800.423991519634;28825;28885;29067.563986539797;29272.414551709273 11:33:40 INFO - PROCESS | 22819 | |2;jquery.html;375.583102755941;394.86969300130943;410.29224587586407;412.6884202427167;428.31683464873515;15738.763918541217;19709.90145049273;19793.802061979393;20182.798172018276;20380.388588342335;19354.51613709658;19633.11650975706;19786.30747923823;19877.900610496963;20126.194952201895;5710.086386178213;5823.359430462646;5954.672493012882;5996;6053.788117415891;3995.9400608990745;6018.42824931633;6055.182550355712;6058.697065146725;6059.182010428602;5720.8283751487525;5929.970350148244;5960.225170727799;6056.545759068065;6065.0902364645435;5749.942500574983;5976.581639285252;6027;6038.57729958903;6060.727267272983;5855.941440585582;5857.179994800731;5860.677662728548;5862.618929769551;5864.882702345972;16053;23218.18736344237;23728.40678983022;23832.523349532912;23910.641340379734;2460.274219105368;2740.931476713078;3004.3390454100063;3039.1794215561895;3108.7202151806446;10535.578576856917;10584.735381615445;10734.78530429387;10735.51690173944;10842.566297348096;1931.5364312565023;1953.7264782930401;1957.4812674641232;1993.2226431691652;2014.3252010576475;57321.71339143278;65724.3427565723;75176.62411687906;82804;85463.57268213619;11072;11225.94387028076;11447.25592836463;11455.54177832894;11642.126840486828;16091.275892584861;16119.032858028555;16119.27463264156;16138.273777680033;16143.596410089607;7716.958210641492;7807.336376407955;8098.75703728889;8104.5137291762685;8295.294899933573;7519.774406767806;7625.580593067434;7803.960980195063;7834.216578342121;7838.725644602411;4772.618190544748;4834.226523756182;4862.7326291942445;4882.389701287339;4983.127952608352;2001.3295545991964;2023.5548179400507;2053.219776484926;2072.958540829175;2125.2136709417614;900.5812297281665;996.6461906023402;1023.6417253961054;1034.384541197986;1082.3235477826358;19446.319378821674;20377.79622203759;20511.794882051287;20549.48626284325;20736.688949665768;980.8038392321564;988.6342053440274;993.965211217604;1025.9894004405655;1048.8531605575226;10577.524011419504;11405;11497.655070347902;11523.423828808525;11523.76952460946;495727;500519;501715;502093;502793;91122.54438727764;94086.52956735309;97109;97738;99181;948.8292107420731;981.2934687025188;984.5028260728286;1006.582268358623;1022.3405903192399;17480.737788932922;17697.292108315523;18172.182251798436;18367.54081147982;18642.53393665115;42617.57382426136;42964;44376.55623443853;44941.550584495046;45321;60935.69532152311;61192.38807612045;61359.38640613715;63125.684371577845;64993.67503162454;8377.45546539473;8730.257928076184;8954.149355811187;9067.954660226656;9211.677591284273;12310.938445307716;12527.401516092954;13088.869111308764;13510.662233443849;13813.654658633213;11027.283226590245;11035.22753407286;11532.654020379403;11770.3526306054;11887.167898247386;11617.6514704559;11638.825417618911;11682.824757628472;11778.882211178121;11808.468618912342;12022.699432513908;12114.636560903187;12148;12204.755904881675;12275.815862761887;8705.129487051245;8715.484643554526;8942.86585701202;9074.637014519345;9151.496667683341;6018;10669.89330106689;10990.230683852054;11431.428428578703;11594.594189203337 11:33:40 INFO - PROCESS | 22819 | |3;mootools.html;1294.3786982248514;1423.1816705394394;1465.3845384938327;1519.2479722537346;1691.9238634261465;8406.78983025424;8800.427972181811;8836.513991730451;8843.734687959364;8846.071162527938;8557.272631826303;8658.783530411743;8660.610272537735;8668.609912553935;8677.305815534757;2080.7503099628066;2347.9178228762;2353.752855950126;2393.186316652338;2395.652630368604;2426.114468219096;2448.3511869354634;2456.3981824453035;2460.372604985726;2460.729319774832;2380.464395511005;2381.476075263448;2399.628057651058;2401.2796161151673;2421.0436877433403;2274.65880117982;2329.2779238436055;2332.1720789119872;2353.682252895854;2391.5097405031925;2377.346229786805;2400.663907053014;2401.3756423329887;2403.71155461344;2406.2660888429023;8899.37704360695;8955.686550970684;8971.730848074569;8973.685920992799;9074.63701451941;5290.365156181283;5394.433584473652;5420;5422.6475279106735;5425.7287135643455;3285.983570082134;3302.108430723691;3452.896413107611;3454;3466.4280393735003;1096.5010920031366;1102.3165637304921;1112.8608923884515;1143.5082914346829;1156.468024708635;12093.57672481459;12141.817872731828;12164.695882602917;12174.452149653287;12185.207961482563;4386.934195986999;4518.864434066983;4626.606738427204;4677.906441871143;4687.226607609774;9640.566174522164;9640.855387169198;9644.95177524108;9650.613975440903;9738.123568878835;5258.894822103536;5272.551833094153;5274.97362513185;5279.736013199402;5283.4452382499285;4297.613214810682;4785.258284965836;4867.537583929521;4953;4953.23224900141;3684.299983003221;3727.161388687578;3810.3331916914985;3861.1505468796818;3884.5726970033274;1139.732162941708;1144.4964215745047;1146.7591805720724;1148.9540418383338;1149.0635132367095;929.6374413978554;939.6805086270564;943.8395472769646;959.7744530035436;979.1285755677453;5707.486326230659;5762.654240745569;5775.509081728016;5802.33273173582;6144.5084393248435;489.22946359483956;489.49581930611527;495.27442297035014;498.27749762843297;499.49301459019125;3858.266929283427;3906.8632597858937;3940.5468371137686;3941.2905676977844;4047.129867078533;10588.682339529827;10907.618233361794;11018.559257629766;11111.72220694489;11169.38568378747;10901.83647245292;10991.175661825395;11007.394593297286;11008.284461509977;11037.227394082498;8201.343892488587;8234.958825205835;8271.296939760188;8273.544955027532;8280.130586288473;5827.5337972961215;5862.325832529314;5862.560307977004;5872.94127058741;6052.122442245762;10153.593856245667;10199.490025498548;10224.335418197794;10227.539760710935;10265.332753371305;9762.951185244312;10171.338862973884;10173.135283500986;10427.895721042692;10432;6707.865842683022;7791.415643826849;7944.483608565425;8051.677932882619;8252.793680158044;8230.135835737161;8637.740867773977;8637.870431943651;8641.870371944551;8647.87028194565;7488.288612581796;7515.210902855121;7527.134379546423;7567.091948966159;7657.6554055066545;7388.963055184689;7504.699812007459;7550.584717840571;7601.6579253934815;7692.6922923084685;6516.413522782972;6645.734170633314;6647.268800431852;6647.60114393138;6657.201135863727;4934.259861020875;5052.570531504716;5076.644634875671;5186.040582492251;5196.792128314825;4801.423829140525;5032.119379108714;5035.169197082587;5039.168537191323;5212.296339994053 11:33:40 INFO - PROCESS | 22819 | |4;prototype.html;329.05625109523163;340.3176630855135;344.5331575714906;350.1054804973292;350.9350770107529;5115.258287548303;5211.478852114787;5221.295125158103;5244.816431424901;5255.316808814859;4900.166971614825;4955.950440495594;5098.439171691111;5102;5201;4068.6808519144174;4091.8772436826944;4104.261232978063;4119.485064366954;4122.8969275768195;4100.876973690779;4108.958910410903;4130.834766609332;4136.937945930814;4147;3823.8661646842365;3909.8045097745;4073.5926407359175;4081.3877918312196;4083.591640835922;4079.3473044313064;4084.101497670508;4099.282625540519;4099.651529619986;4108.658064903007;3660.762050466711;3670.853165873362;3671.94492082619;3672.981635091807;3682.815859207056;4897.559219670211;4935.904997837295;5027.572656324217;5071.746412679351;5074.2895994560795;4668;4675.919215948904;4699.130660827758;4710.152172608929;4722.669413141081;5355.598330125217;5356.35723713153;5370;5370.7046112463795;5386.1920711893135;3783.9621603784162;4011.277969965405;4022.5172979242384;4039.97980010101;4050.797460127011;5531.474509921551;5565.805196818092;5576.888462230773;5580.581456390746;5582.162675598652;4133.132042271097;4149.834006639761;4151.6886233532005;4154.875353739392;4172.290710579209;3963.742356746802;4208.705390622627;4241.172971270573;4255.638120842962;4256.808443620044;4649.837255696102;4668.6965347253;4684.718916864999;4708.741019243975;4712.6229901607785;5449.100898351807;5459.863503412446;5465.043617366945;5517.69652669107;5525.502704756591;1365.9726805463836;1467.1710483576744;1467.7871708602192;1468.5300703774903;1475.9335829887682;934.6495064350869;960.4045491795132;972.1153750087528;972.2416515118219;976.6679329028022;4497.370368148462;4680.906381872343;4691.859244222679;4698.875247960136;4746.359241502422;4830.903381932341;4852.441969173519;4866.31871537985;4882.511748825089;4896.36347274852;4708.516817202571;4716.764161791965;4725.196716558194;4727.338172655831;4751.548602882721;2490.302715239736;2564.371728926425;2581.3030481769815;2596.610508423714;2599.584066549343;5045.468172279346;5054.519820617035;5063.708754267638;5072.365954255718;5090.032893750175;4924.532169443897;4954.606094825056;4959.702417854868;4970.378702662168;4995.625328100335;5056.84829455117;5082.974585127125;5102.8214012510125;5403;5854.795082172103;5509.752061157177;5537.5569954402745;5569.164625306236;5570.693611851387;5585.888282234414;5540.695261760642;5541.251930989426;5555.388907220122;5568.081266590967;5568.470995255444;5734.19372897536;5830.387809280134;5869.090291004901;5879.382664820132;5888.440598143169;4031.254217969568;4034.8789536313957;4035.5157381114454;4053.6554392876938;4070.470838790938;5317.8404647860625;5404.405515393382;5527.695976721319;5544.445555444423;5591.524720398649;5392.7573259202645;5400.729963501888;5400.9459905400445;5404.297441332602;5414.891702166014;5241.580673546184;5415.323084614423;5445.428230035789;5453.918191227214;5465.496988328083;5327.866803329948;5339.893202136013;5352.4915133062295;5371.973140134274;5381.919271210857;5397.3523177218985;5439.5920305976415;5443.482869127427;5450.236966824568;5456.48163424474;5078.415982162099;5312.1766126250495;5339.759710812945;5342.1452567589;5367.060764366299 11:33:40 INFO - PROCESS | 22819 | |5;yui.html;734.8787450070738;742.9665665045072;760.9961950190249;807.8263173417714;865.9307255419567;14241.216733079676;15654.295556699948;15706.37174513021;15716.528504144866;15810.288537015833;14915.552533423988;15023.399064037452;15027.173505457196;15065.62335941602;15070.095794252353;646.0922404022356;769.7152053740124;773.6441237030958;787.7164220880478;789.4868335581889;798.0662624729081;799.8200404908907;802.1417083720421;802.7832485229014;802.863513202754;839.0518713853337;839.8446287436814;840.0549381945311;840.9747707568782;841.0286119531951;674.6356967237685;685.1948959972013;686.543448606676;805.5609692717483;837.6105111123327;608.6226539545465;610.487190759764;614.929283132441;615.2616859768251;615.4614712126889;14614.634634134125;14636.41454341825;14640.926795366062;14658.41366345345;14672.779908301383;13219.86780132196;13228.669283267898;13535.18788872661;13572.864271357259;13679.400913826341;12674.683132921658;12870.742585148339;12877.549285775047;12909.935450322688;12928.83640472362;4428.977855110704;4443.400140980959;4508.594226519596;4516.954830451687;4517.299818528133;81080;82482;82879;83910.58044709737;84776;10993.340399576051;11504.39397028915;11654.53381864716;11711.414429278502;11796.233244839059;21876.45308867291;21947.122115115217;21970.231041913456;21976.230831920806;21989.560208795734;8347.916520834835;8530.74407767768;8567.228949394585;8908.821823563492;8939.463632182089;4645.419322584677;4755.548222918817;4796.5203479651755;4925.975370123198;5044.066847633199;3223.129754966146;3252.3820474109843;3268.9836550817568;3295.0938491914917;3319.203391186098;585.1690599348934;610.9786157484467;616.5160349125914;627.1627377451063;654.1790053482848;618.5670030978333;639.5267502048544;674.2684187656448;709.1773542690454;718.4467959671024;9730.318877678636;9936.304458687822;9972.578655305224;10032.598696052077;10240.436775977243;628.230417738267;630.7634637011121;655.672163918041;672.2974491656231;673.9123913891162;4946.830562062653;4961.578265847371;4961.8776501502825;4988.488104374532;4998.100341938486;91025.54487227522;96804;98044.50977745066;113183.43408282906;117285.41357293329;95492;97876.51061744646;98246;98271.50864245633;100674.49662751786;82229;88524.55737721141;88811.23425869;90570.54714726385;91646.54176729074;9462.526873656152;9767.120959113714;9867.753306167404;10033.548490317808;10145.9492702536;48875.755621221666;48904.51095489142;49534.50465495299;50818;52311.47688523066;62321.37678623156;63846.36153638404;65719.34280657132;71441.64279178779;71796;13503.797443038166;13581.660458488617;13742.381592828147;14250.786238206643;14278.785818212527;15608.375664973273;15659.765103523685;15935.442259520862;16006.199690015686;16613.50159495217;12057.095717821374;12711.36443177819;12793.80661638551;13063.216207027608;14867.776983345475;13828.723425531634;13942.58172254834;14147.787783183467;14626.780598291247;15129.47046853355;13940.442382304595;14137.646558836112;14409.13545187292;14441.214454178671;15109.773353399489;11747.236429632047;12076.637700868989;12109.455074521491;12125.757484850077;12325.137240393087;10842.837357439486;11338.355938389052;12540.24758514492;12707.491700332253;12747.61757147287 11:33:40 INFO - PROCESS | 22819 | __end_tp_report 11:33:40 INFO - PROCESS | 22819 | __start_cc_report 11:33:40 INFO - PROCESS | 22819 | _x_x_mozilla_cycle_collect,989 11:33:40 INFO - PROCESS | 22819 | __end_cc_report 11:33:40 INFO - PROCESS | 22819 | __startTimestamp1474396420235__endTimestamp 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | ------- Summary: start ------- 11:33:40 INFO - PROCESS | 22819 | Number of tests: 6 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#0] dojo.html Cycles:165 Average:5350.57 Median:5549.11 stddev:615.74 (11.1%) stddev-sans-first:589.57 11:33:40 INFO - PROCESS | 22819 | Values: 3007.9 3017.3 3052.9 3058.1 3063.1 5210.6 5225.9 5257.4 5383.6 5393.6 5260.7 5319.8 5349.1 5368.0 5446.1 4762.1 4826.5 4838.2 4844.0 5015.8 4927.7 4939.7 4969.1 4983.1 5004.9 4777.5 4823.0 4832.7 4916.5 4958.1 4844.9 4850.0 4863.7 4977.6 4980.8 4867.8 4887.7 4919.2 4944.9 4972.3 5202.8 5338.4 5401.6 5412.2 5458.2 5743.4 5821.0 5823.4 5833.1 5834.9 5792.8 5797.9 5823.8 5865.9 5871.7 5141.5 5233.2 5383.7 5388.5 5395.4 5733.9 5847.0 5890.1 5894.0 5894.1 5650.8 5667.0 5710.7 5711.5 5712.7 5574.4 5642.0 5732.9 5774.4 5778.5 5684.6 5729.4 5735.0 5773.5 5773.7 5697.5 5742.0 5748.8 5759.1 5764.7 4346.3 4389.1 4405.8 4448.8 4491.6 3926.4 3967.2 3988.8 4006.6 4049.5 5525.7 5526.7 5528.0 5531.6 5585.9 5533.4 5730.7 5803.0 5809.8 5810.1 5476.9 5522.7 5527.0 5553.4 5553.8 4988.0 5009.9 5013.3 5016.5 5036.4 5780.7 6015.6 6088.1 6093.2 6098.8 5757.4 5823.7 5843.9 5858.5 5876.9 6015.5 6016.4 6021.6 6027.4 6112.4 5502.9 5656.6 5665.0 5724.0 5728.7 5704.4 5741.1 5750.4 5798.3 5805.4 5549.1 5573.8 5600.2 5601.8 5604.9 5450.0 5540.2 5592.3 5600.7 5603.9 5506.0 5558.4 5560.8 5598.0 5607.5 5633.9 5638.6 5683.9 5688.3 5694.6 5358.1 5363.1 5494.8 5501.3 5502.9 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#1] ext.html Cycles:180 Average:62718.26 Median:22498.41 stddev:126203.49 (560.9%) stddev-sans-first:126471.25 11:33:40 INFO - PROCESS | 22819 | Values: 564.0 587.4 593.5 599.4 600.9 32422.7 42416.6 43825.1 43867.0 47035.8 44617.3 45037.1 45053.8 45057.1 45063.3 8063.4 8893.3 9004.2 9019.8 9023.7 10516.6 10791.4 10806.9 11139.7 11155.9 10781.2 10833.5 10842.3 10855.5 10884.2 10607.3 10679.8 10687.0 10688.8 10724.0 10585.3 10623.2 10639.1 10646.3 10655.4 42910.6 43317.0 43396.6 43429.1 43494.3 3821.4 4101.2 4148.2 4175.2 4205.7 32941.7 33057.7 33089.4 33420.8 33943.6 4238.2 4320.6 4338.3 4471.1 4510.3 351951.0 352307.0 352430.0 353029.0 353056.0 58343.7 58641.7 58884.4 58986.8 59061.4 60988.4 61687.4 61749.7 61885.4 61970.0 13928.7 13961.8 13970.0 13970.4 13978.4 10961.3 11701.2 12033.8 12072.4 12077.6 17118.6 17193.3 17273.2 17408.9 17519.3 6574.9 6718.3 6803.4 6842.4 6933.9 923.4 993.1 998.3 999.4 1003.5 33312.5 33531.7 33591.5 33646.7 33791.3 1111.1 1118.6 1140.2 1196.9 1207.5 17077.7 17284.2 17446.7 17485.7 17518.3 591282.0 595474.0 599152.0 600138.0 600550.0 59174.7 59192.0 59288.4 59301.0 59382.7 1222.7 1323.1 1355.2 1374.8 1386.0 32846.5 34207.0 34751.8 35149.6 35199.5 51331.8 51574.5 51878.0 51884.2 51949.7 440772.0 441961.0 442238.0 443317.0 443957.0 27500.9 28889.0 28924.4 30018.7 30298.4 48453.5 48802.5 49076.5 49335.8 50614.2 39661.4 40729.0 40895.6 42121.4 42166.5 41442.8 41627.0 42583.8 42936.0 43423.6 41593.0 41909.0 43382.3 43424.8 43512.3 35000.6 37618.4 37990.6 38050.4 38627.0 28800.4 28825.0 28885.0 29067.6 29272.4 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#2] jquery.html Cycles:180 Average:29487.06 Median:1742.15 stddev:82489.94 (4734.9%) stddev-sans-first:82692.38 11:33:40 INFO - PROCESS | 22819 | Values: 375.6 394.9 410.3 412.7 428.3 15738.8 19709.9 19793.8 20182.8 20380.4 19354.5 19633.1 19786.3 19877.9 20126.2 5710.1 5823.4 5954.7 5996.0 6053.8 3995.9 6018.4 6055.2 6058.7 6059.2 5720.8 5930.0 5960.2 6056.5 6065.1 5749.9 5976.6 6027.0 6038.6 6060.7 5855.9 5857.2 5860.7 5862.6 5864.9 16053.0 23218.2 23728.4 23832.5 23910.6 2460.3 2740.9 3004.3 3039.2 3108.7 10535.6 10584.7 10734.8 10735.5 10842.6 1931.5 1953.7 1957.5 1993.2 2014.3 57321.7 65724.3 75176.6 82804.0 85463.6 11072.0 11225.9 11447.3 11455.5 11642.1 16091.3 16119.0 16119.3 16138.3 16143.6 7717.0 7807.3 8098.8 8104.5 8295.3 7519.8 7625.6 7804.0 7834.2 7838.7 4772.6 4834.2 4862.7 4882.4 4983.1 2001.3 2023.6 2053.2 2073.0 2125.2 900.6 996.6 1023.6 1034.4 1082.3 19446.3 20377.8 20511.8 20549.5 20736.7 980.8 988.6 994.0 1026.0 1048.9 10577.5 11405.0 11497.7 11523.4 11523.8 495727.0 500519.0 501715.0 502093.0 502793.0 91122.5 94086.5 97109.0 97738.0 99181.0 948.8 981.3 984.5 1006.6 1022.3 17480.7 17697.3 18172.2 18367.5 18642.5 42617.6 42964.0 44376.6 44941.6 45321.0 60935.7 61192.4 61359.4 63125.7 64993.7 8377.5 8730.3 8954.1 9068.0 9211.7 12310.9 12527.4 13088.9 13510.7 13813.7 11027.3 11035.2 11532.7 11770.4 11887.2 11617.7 11638.8 11682.8 11778.9 11808.5 12022.7 12114.6 12148.0 12204.8 12275.8 8705.1 8715.5 8942.9 9074.6 9151.5 6018.0 10669.9 10990.2 11431.4 11594.6 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#3] mootools.html Cycles:180 Average:5747.06 Median:2714.77 stddev:3296.55 (121.4%) stddev-sans-first:3288.82 11:33:40 INFO - PROCESS | 22819 | Values: 1294.4 1423.2 1465.4 1519.2 1691.9 8406.8 8800.4 8836.5 8843.7 8846.1 8557.3 8658.8 8660.6 8668.6 8677.3 2080.8 2347.9 2353.8 2393.2 2395.7 2426.1 2448.4 2456.4 2460.4 2460.7 2380.5 2381.5 2399.6 2401.3 2421.0 2274.7 2329.3 2332.2 2353.7 2391.5 2377.3 2400.7 2401.4 2403.7 2406.3 8899.4 8955.7 8971.7 8973.7 9074.6 5290.4 5394.4 5420.0 5422.6 5425.7 3286.0 3302.1 3452.9 3454.0 3466.4 1096.5 1102.3 1112.9 1143.5 1156.5 12093.6 12141.8 12164.7 12174.5 12185.2 4386.9 4518.9 4626.6 4677.9 4687.2 9640.6 9640.9 9645.0 9650.6 9738.1 5258.9 5272.6 5275.0 5279.7 5283.4 4297.6 4785.3 4867.5 4953.0 4953.2 3684.3 3727.2 3810.3 3861.2 3884.6 1139.7 1144.5 1146.8 1149.0 1149.1 929.6 939.7 943.8 959.8 979.1 5707.5 5762.7 5775.5 5802.3 6144.5 489.2 489.5 495.3 498.3 499.5 3858.3 3906.9 3940.5 3941.3 4047.1 10588.7 10907.6 11018.6 11111.7 11169.4 10901.8 10991.2 11007.4 11008.3 11037.2 8201.3 8235.0 8271.3 8273.5 8280.1 5827.5 5862.3 5862.6 5872.9 6052.1 10153.6 10199.5 10224.3 10227.5 10265.3 9763.0 10171.3 10173.1 10427.9 10432.0 6707.9 7791.4 7944.5 8051.7 8252.8 8230.1 8637.7 8637.9 8641.9 8647.9 7488.3 7515.2 7527.1 7567.1 7657.7 7389.0 7504.7 7550.6 7601.7 7692.7 6516.4 6645.7 6647.3 6647.6 6657.2 4934.3 5052.6 5076.6 5186.0 5196.8 4801.4 5032.1 5035.2 5039.2 5212.3 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#4] prototype.html Cycles:180 Average:4489.70 Median:4957.83 stddev:1287.49 (26.0%) stddev-sans-first:1252.65 11:33:40 INFO - PROCESS | 22819 | Values: 329.1 340.3 344.5 350.1 350.9 5115.3 5211.5 5221.3 5244.8 5255.3 4900.2 4956.0 5098.4 5102.0 5201.0 4068.7 4091.9 4104.3 4119.5 4122.9 4100.9 4109.0 4130.8 4136.9 4147.0 3823.9 3909.8 4073.6 4081.4 4083.6 4079.3 4084.1 4099.3 4099.7 4108.7 3660.8 3670.9 3671.9 3673.0 3682.8 4897.6 4935.9 5027.6 5071.7 5074.3 4668.0 4675.9 4699.1 4710.2 4722.7 5355.6 5356.4 5370.0 5370.7 5386.2 3784.0 4011.3 4022.5 4040.0 4050.8 5531.5 5565.8 5576.9 5580.6 5582.2 4133.1 4149.8 4151.7 4154.9 4172.3 3963.7 4208.7 4241.2 4255.6 4256.8 4649.8 4668.7 4684.7 4708.7 4712.6 5449.1 5459.9 5465.0 5517.7 5525.5 1366.0 1467.2 1467.8 1468.5 1475.9 934.6 960.4 972.1 972.2 976.7 4497.4 4680.9 4691.9 4698.9 4746.4 4830.9 4852.4 4866.3 4882.5 4896.4 4708.5 4716.8 4725.2 4727.3 4751.5 2490.3 2564.4 2581.3 2596.6 2599.6 5045.5 5054.5 5063.7 5072.4 5090.0 4924.5 4954.6 4959.7 4970.4 4995.6 5056.8 5083.0 5102.8 5403.0 5854.8 5509.8 5537.6 5569.2 5570.7 5585.9 5540.7 5541.3 5555.4 5568.1 5568.5 5734.2 5830.4 5869.1 5879.4 5888.4 4031.3 4034.9 4035.5 4053.7 4070.5 5317.8 5404.4 5527.7 5544.4 5591.5 5392.8 5400.7 5400.9 5404.3 5414.9 5241.6 5415.3 5445.4 5453.9 5465.5 5327.9 5339.9 5352.5 5372.0 5381.9 5397.4 5439.6 5443.5 5450.2 5456.5 5078.4 5312.2 5339.8 5342.1 5367.1 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - PROCESS | 22819 | [#5] yui.html Cycles:180 Average:20640.77 Median:48890.13 stddev:29000.42 (59.3%) stddev-sans-first:29043.25 11:33:40 INFO - PROCESS | 22819 | Values: 734.9 743.0 761.0 807.8 865.9 14241.2 15654.3 15706.4 15716.5 15810.3 14915.6 15023.4 15027.2 15065.6 15070.1 646.1 769.7 773.6 787.7 789.5 798.1 799.8 802.1 802.8 802.9 839.1 839.8 840.1 841.0 841.0 674.6 685.2 686.5 805.6 837.6 608.6 610.5 614.9 615.3 615.5 14614.6 14636.4 14640.9 14658.4 14672.8 13219.9 13228.7 13535.2 13572.9 13679.4 12674.7 12870.7 12877.5 12909.9 12928.8 4429.0 4443.4 4508.6 4517.0 4517.3 81080.0 82482.0 82879.0 83910.6 84776.0 10993.3 11504.4 11654.5 11711.4 11796.2 21876.5 21947.1 21970.2 21976.2 21989.6 8347.9 8530.7 8567.2 8908.8 8939.5 4645.4 4755.5 4796.5 4926.0 5044.1 3223.1 3252.4 3269.0 3295.1 3319.2 585.2 611.0 616.5 627.2 654.2 618.6 639.5 674.3 709.2 718.4 9730.3 9936.3 9972.6 10032.6 10240.4 628.2 630.8 655.7 672.3 673.9 4946.8 4961.6 4961.9 4988.5 4998.1 91025.5 96804.0 98044.5 113183.4 117285.4 95492.0 97876.5 98246.0 98271.5 100674.5 82229.0 88524.6 88811.2 90570.5 91646.5 9462.5 9767.1 9867.8 10033.5 10145.9 48875.8 48904.5 49534.5 50818.0 52311.5 62321.4 63846.4 65719.3 71441.6 71796.0 13503.8 13581.7 13742.4 14250.8 14278.8 15608.4 15659.8 15935.4 16006.2 16613.5 12057.1 12711.4 12793.8 13063.2 14867.8 13828.7 13942.6 14147.8 14626.8 15129.5 13940.4 14137.6 14409.1 14441.2 15109.8 11747.2 12076.6 12109.5 12125.8 12325.1 10842.8 11338.4 12540.2 12707.5 12747.6 11:33:40 INFO - PROCESS | 22819 | -------- Summary: end -------- 11:33:40 INFO - PROCESS | 22819 | 11:33:40 INFO - TEST-INFO | 22819: exit 0 11:33:41 INFO - TEST-OK | dromaeo_css | took 1115765ms 11:33:41 INFO - TEST-START | kraken 11:33:41 INFO - operating with platform_type : linux_ 11:33:41 INFO - Initialising browser for kraken test... 11:33:41 INFO - TEST-INFO | started process 23127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIRrATb/profile http://localhost:53343/getInfo.html) 11:33:44 INFO - PROCESS | 23127 | __metrics Screen width/height:1600/1200 11:33:44 INFO - PROCESS | 23127 | colorDepth:24 11:33:44 INFO - PROCESS | 23127 | Browser inner width/height: 1024/697 11:33:44 INFO - PROCESS | 23127 | __metrics 11:33:45 INFO - PROCESS | 23127 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:33:45 INFO - PROCESS | 23127 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:45 INFO - PROCESS | 23127 | console.error: PushService: 11:33:45 INFO - PROCESS | 23127 | stateChangeProcessEnqueue: Error transitioning state 11:33:45 INFO - PROCESS | 23127 | UnknownError 11:33:46 INFO - TEST-INFO | 23127: exit 0 11:33:46 INFO - Browser initialized. 11:33:46 INFO - Running cycle 1/1 for kraken test... 11:33:46 INFO - TEST-INFO | started process 23208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIRrATb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:58 INFO - PROCESS | 23208 | RSS: Main: 155897856 11:33:58 INFO - PROCESS | 23208 | 11:34:00 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:01 INFO - PROCESS | 23208 | RSS: Main: 203657216 11:34:01 INFO - PROCESS | 23208 | 11:34:04 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-dft) 11:34:04 INFO - PROCESS | 23208 | RSS: Main: 191586304 11:34:04 INFO - PROCESS | 23208 | 11:34:07 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-fft) 11:34:08 INFO - PROCESS | 23208 | RSS: Main: 275898368 11:34:08 INFO - PROCESS | 23208 | 11:34:10 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53343/tests/kraken/driver.html?testName=audio-oscillator) 11:34:11 INFO - PROCESS | 23208 | RSS: Main: 185741312 11:34:11 INFO - PROCESS | 23208 | 11:34:13 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:13 INFO - PROCESS | 23208 | RSS: Main: 190889984 11:34:13 INFO - PROCESS | 23208 | 11:34:16 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:17 INFO - PROCESS | 23208 | RSS: Main: 227819520 11:34:17 INFO - PROCESS | 23208 | 11:34:20 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53343/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:21 INFO - PROCESS | 23208 | RSS: Main: 226594816 11:34:21 INFO - PROCESS | 23208 | 11:34:24 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53343/tests/kraken/driver.html?testName=json-parse-financial) 11:34:25 INFO - PROCESS | 23208 | RSS: Main: 225656832 11:34:25 INFO - PROCESS | 23208 | 11:34:26 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:27 INFO - PROCESS | 23208 | RSS: Main: 189046784 11:34:27 INFO - PROCESS | 23208 | 11:34:28 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:29 INFO - PROCESS | 23208 | RSS: Main: 196870144 11:34:29 INFO - PROCESS | 23208 | 11:34:31 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:32 INFO - PROCESS | 23208 | RSS: Main: 194039808 11:34:32 INFO - PROCESS | 23208 | 11:34:34 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:35 INFO - PROCESS | 23208 | RSS: Main: 188194816 11:34:35 INFO - PROCESS | 23208 | 11:34:38 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:38 INFO - PROCESS | 23208 | RSS: Main: 192225280 11:34:38 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | Cycle 1(1): loaded http://localhost:53343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53343/tests/kraken/driver.html?testName=ai-astar) 11:34:40 INFO - PROCESS | 23208 | RSS: Main: 242982912 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | __start_tp_report 11:34:40 INFO - PROCESS | 23208 | _x_x_mozilla_page_load 11:34:40 INFO - PROCESS | 23208 | _x_x_mozilla_page_load_details 11:34:40 INFO - PROCESS | 23208 | |i|pagename|runs| 11:34:40 INFO - PROCESS | 23208 | |0;ai-astar;103;112;111;109;107;111;110;109;111;110 11:34:40 INFO - PROCESS | 23208 | |1;audio-beat-detection;145;120;119;185;118;119;147;119;154;118 11:34:40 INFO - PROCESS | 23208 | |2;audio-dft;161;160;161;161;162;160;163;159;160;160 11:34:40 INFO - PROCESS | 23208 | |3;audio-fft;76;75;74;123;76;77;76;75;122;74 11:34:40 INFO - PROCESS | 23208 | |4;audio-oscillator;85;84;131;85;85;85;118;84;85;134 11:34:40 INFO - PROCESS | 23208 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 11:34:40 INFO - PROCESS | 23208 | |6;imaging-darkroom;146;146;146;146;145;146;145;145;146;146 11:34:40 INFO - PROCESS | 23208 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 11:34:40 INFO - PROCESS | 23208 | |8;json-parse-financial;53;49;52;50;50;53;51;50;52;50 11:34:40 INFO - PROCESS | 23208 | |9;json-stringify-tinderbox;62;63;62;61;62;61;61;62;62;62 11:34:40 INFO - PROCESS | 23208 | |10;stanford-crypto-aes;87;79;79;84;78;77;78;78;88;78 11:34:40 INFO - PROCESS | 23208 | |11;stanford-crypto-ccm;129;131;131;122;130;122;122;131;149;136 11:34:40 INFO - PROCESS | 23208 | |12;stanford-crypto-pbkdf2;169;164;165;166;163;168;166;165;162;161 11:34:40 INFO - PROCESS | 23208 | |13;stanford-crypto-sha256-iterative;64;64;64;66;65;64;65;64;66;62 11:34:40 INFO - PROCESS | 23208 | __end_tp_report 11:34:40 INFO - PROCESS | 23208 | __start_cc_report 11:34:40 INFO - PROCESS | 23208 | _x_x_mozilla_cycle_collect,1713 11:34:40 INFO - PROCESS | 23208 | __end_cc_report 11:34:40 INFO - PROCESS | 23208 | __startTimestamp1474396480704__endTimestamp 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | ------- Summary: start ------- 11:34:40 INFO - PROCESS | 23208 | Number of tests: 14 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.63 (2.4%) stddev-sans-first:1.50 11:34:40 INFO - PROCESS | 23208 | Values: 103.0 112.0 111.0 109.0 107.0 111.0 110.0 109.0 111.0 110.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:132.50 stddev:22.78 (17.2%) stddev-sans-first:23.84 11:34:40 INFO - PROCESS | 23208 | Values: 145.0 120.0 119.0 185.0 118.0 119.0 147.0 119.0 154.0 118.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 11:34:40 INFO - PROCESS | 23208 | Values: 161.0 160.0 161.0 161.0 162.0 160.0 163.0 159.0 160.0 160.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.50 stddev:19.89 (26.3%) stddev-sans-first:20.84 11:34:40 INFO - PROCESS | 23208 | Values: 76.0 75.0 74.0 123.0 76.0 77.0 76.0 75.0 122.0 74.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:21.14 (24.9%) stddev-sans-first:21.92 11:34:40 INFO - PROCESS | 23208 | Values: 85.0 84.0 131.0 85.0 85.0 85.0 118.0 84.0 85.0 134.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:34:40 INFO - PROCESS | 23208 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:34:40 INFO - PROCESS | 23208 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:34:40 INFO - PROCESS | 23208 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.41 (2.7%) stddev-sans-first:1.30 11:34:40 INFO - PROCESS | 23208 | Values: 53.0 49.0 52.0 50.0 50.0 53.0 51.0 50.0 52.0 50.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:34:40 INFO - PROCESS | 23208 | Values: 62.0 63.0 62.0 61.0 62.0 61.0 61.0 62.0 62.0 62.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.00 stddev:4.12 (5.2%) stddev-sans-first:3.66 11:34:40 INFO - PROCESS | 23208 | Values: 87.0 79.0 79.0 84.0 78.0 77.0 78.0 78.0 88.0 78.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.00 stddev:8.11 (6.2%) stddev-sans-first:8.59 11:34:40 INFO - PROCESS | 23208 | Values: 129.0 131.0 131.0 122.0 130.0 122.0 122.0 131.0 149.0 136.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:2.51 (1.5%) stddev-sans-first:2.19 11:34:40 INFO - PROCESS | 23208 | Values: 169.0 164.0 165.0 166.0 163.0 168.0 166.0 165.0 162.0 161.0 11:34:40 INFO - PROCESS | 23208 | 11:34:40 INFO - PROCESS | 23208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 11:34:40 INFO - PROCESS | 23208 | Values: 64.0 64.0 64.0 66.0 65.0 64.0 65.0 64.0 66.0 62.0 11:34:40 INFO - PROCESS | 23208 | -------- Summary: end -------- 11:34:40 INFO - PROCESS | 23208 | 11:34:41 INFO - TEST-INFO | 23208: exit 0 11:34:41 INFO - TEST-OK | kraken | took 60780ms 11:34:41 INFO - SUITE-END | took 1176s 11:34:41 INFO - Completed test suite (00:19:36) 11:34:41 INFO - javascript benchmark 11:34:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.8796848126076, 3017.336186039071, 3052.9389412211763, 3058.1437197584683, 3063.1116976076937, 5210.55710264627, 5225.8954820903555, 5257.369115706111, 5383.59623028273, 5393.649412788166, 5260.710660913648, 5319.760610772515, 5349.144136938091, 5368.0, 5446.101393270115, 4762.095201911626, 4826.469088400273, 4838.201696720037, 4843.951560484403, 5015.824446144386, 4927.6550641455115, 4939.703617782944, 4969.105560999019, 4983.053219888227, 5004.899902001957, 4777.450593181794, 4823.0, 4832.710037397767, 4916.532929371704, 4958.132326842806, 4844.927326090112, 4849.981503884189, 4863.683860549053, 4977.601791856643, 4980.77586508608, 4867.756612169413, 4887.7311747853855, 4919.188333924898, 4944.851654450372, 4972.254161875711, 5202.76587553561, 5338.359396872362, 5401.5948803839865, 5412.188171774226, 5458.181272809111, 5743.368229494752, 5821.0, 5823.359430462646, 5833.095870140135, 5834.941650583482, 5792.82621521355, 5797.855053623651, 5823.767049318022, 5865.85335366615, 5871.735771890275, 5141.53726164647, 5233.162693969023, 5383.703896285702, 5388.541973932221, 5395.352557693062, 5733.913991290134, 5846.970765146147, 5890.1164825276555, 5893.9999999999145, 5894.115882617642, 5650.802221922295, 5666.97166514173, 5710.685912274865, 5711.457411545896, 5712.685802280831, 5574.386817450078, 5642.04085305499, 5732.942670573324, 5774.422557744192, 5778.479936805707, 5684.602077854511, 5729.3984131665575, 5735.0250457422335, 5773.509251713567, 5773.653580785166, 5697.544196464273, 5742.0238559445, 5748.798792042258, 5759.078547432391, 5764.74058667361, 4346.304591265382, 4389.078293558388, 4405.801738921757, 4448.755318457516, 4491.618212451913, 3926.371780515104, 3967.2263908538134, 3988.7806170660892, 4006.579309172495, 4049.5140583130215, 5525.668459892339, 5526.696031718214, 5528.0, 5531.557475401958, 5585.916211256835, 5533.391326954032, 5730.713464326767, 5803.0, 5809.767609295665, 5810.070388737781, 5476.91784623231, 5522.723863806794, 5527.0, 5553.389127196006, 5553.777848885999, 4988.0, 5009.924851127236, 5013.298138260647, 5016.498350165028, 5036.420811606639, 5780.7398667060925, 6015.639061656315, 6088.11722300264, 6093.177421048191, 6098.786542471081, 5757.366689664217, 5823.679697616672, 5843.853903652443, 5858.47273745365, 5876.853078673067, 6015.518758499397, 6016.42843929826, 6021.578489505692, 6027.427394397525, 6112.358202388863, 5502.944970550243, 5656.632318899258, 5664.971675141598, 5723.971380143239, 5728.684922329312, 5704.401037890962, 5741.0527263002805, 5750.367459579526, 5798.304203495439, 5805.448482394166, 5549.112142057252, 5573.832785016456, 5600.243967064394, 5601.7759289629585, 5604.943950560442, 5449.972750136224, 5540.224368588481, 5592.3009623797025, 5600.691961942132, 5603.915941260966, 5506.03644362243, 5558.388577256579, 5560.805371811967, 5598.0, 5607.523360514402, 5633.8591535211945, 5638.60529762929, 5683.948469533149, 5688.345840228427, 5694.572907031907, 5358.142697168434, 5363.115086010765, 5494.780208791603, 5501.257330260363, 5502.889942201214], "value": 5308.192132959259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9520640745536, 587.3744462147815, 593.5459373579215, 599.4455129005669, 600.8557946092939, 32422.67577324226, 42416.575834241645, 43825.12349753003, 43866.99999999996, 47035.76482117593, 44617.330740038924, 45037.09925801482, 45053.7747311263, 45057.09885802282, 45063.32405013927, 8063.395245356593, 8893.333000025008, 9004.189622933935, 9019.774505637379, 9023.684171054014, 10516.631917882876, 10791.352518848855, 10806.891931080707, 11139.665810025672, 11155.944220278887, 10781.191410644233, 10833.458327083654, 10842.295250808673, 10855.457227138651, 10884.183686223525, 10607.257491975526, 10679.839802403008, 10687.038166565046, 10688.839667404995, 10724.0, 10585.311954722918, 10623.150147988143, 10639.148868090611, 10646.307989980627, 10655.360678359324, 42910.57089429097, 43317.0, 43396.566034339565, 43429.13141737179, 43494.34758478594, 3821.407681809324, 4101.2207680540605, 4148.191102734968, 4175.227582897173, 4205.684573656988, 32941.6705832941, 33057.6694233057, 33089.43008383743, 33420.83289583537, 33943.624802696984, 4238.21593005295, 4320.632746216544, 4338.349247612883, 4471.0610771737975, 4510.300903359985, 351950.99999999744, 352307.0, 352430.0, 353029.0, 353056.0, 58343.70828145917, 58641.706791466626, 58884.41115588875, 58986.82026359535, 59061.40938590645, 60988.39011609916, 61687.383126169065, 61749.69125154345, 61885.38114618886, 61970.0, 13928.721425571635, 13961.79057314141, 13970.0, 13970.371333289822, 13978.440862365595, 10961.287516311415, 11701.180917335874, 12033.819492707617, 12072.396380181131, 12077.577284795167, 17118.572035699206, 17193.312267509158, 17273.222704978307, 17408.912955435142, 17519.29922803099, 6574.934250657432, 6718.328167183243, 6803.353681400259, 6842.418394436529, 6933.93066069343, 923.4367036107968, 993.0516356879164, 998.3261298623545, 999.3703966501058, 1003.5433877585681, 33312.50031249533, 33531.66468335286, 33591.49612755811, 33646.663533364845, 33791.324173516885, 1111.1333160135107, 1118.5637601335486, 1140.230344517464, 1196.9281843089443, 1207.5230284037757, 17077.7438338425, 17284.22221000058, 17446.738298925527, 17485.65028699419, 17518.29926802939, 591282.0, 595474.0, 599152.0, 600138.0, 600550.0, 59174.704126479955, 59192.0, 59288.40711592915, 59301.0, 59382.70308648429, 1222.706550427891, 1323.1201251168059, 1355.1936597724339, 1374.8212732344732, 1385.9722805543834, 32846.507302390004, 34207.0, 34751.82624086965, 35149.64850351566, 35199.47200791939, 51331.84017917724, 51574.484255158466, 51878.0, 51884.22173667322, 51949.7402512985, 440772.0, 441961.0, 442238.0, 443317.0, 443957.0, 27500.862495687394, 28889.0, 28924.42151157007, 30018.69981300159, 30298.394032118795, 48453.515464846314, 48802.511974879795, 49076.50923490719, 49335.75332123316, 50614.2407863875, 39661.405078924414, 40729.0, 40895.591044089175, 42121.36817947672, 42166.51835261519, 41442.792786035876, 41627.0, 42583.787081064394, 42936.0, 43423.56576434321, 41593.0, 41909.0, 43382.34926476042, 43424.78287608542, 43512.34731478967, 35000.64999350076, 37618.43572346362, 37990.620093799815, 38050.42924356192, 38627.0, 28800.423991519634, 28825.0, 28885.0, 29067.563986539797, 29272.414551709273], "value": 20702.987489714033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.583102755941, 394.86969300130943, 410.29224587586407, 412.6884202427167, 428.31683464873515, 15738.763918541217, 19709.90145049273, 19793.802061979393, 20182.798172018276, 20380.388588342335, 19354.51613709658, 19633.11650975706, 19786.30747923823, 19877.900610496963, 20126.194952201895, 5710.086386178213, 5823.359430462646, 5954.672493012882, 5996.0, 6053.788117415891, 3995.9400608990745, 6018.42824931633, 6055.182550355712, 6058.697065146725, 6059.182010428602, 5720.8283751487525, 5929.970350148244, 5960.225170727799, 6056.545759068065, 6065.0902364645435, 5749.942500574983, 5976.581639285252, 6027.0, 6038.57729958903, 6060.727267272983, 5855.941440585582, 5857.179994800731, 5860.677662728548, 5862.618929769551, 5864.882702345972, 16053.0, 23218.18736344237, 23728.40678983022, 23832.523349532912, 23910.641340379734, 2460.274219105368, 2740.931476713078, 3004.3390454100063, 3039.1794215561895, 3108.7202151806446, 10535.578576856917, 10584.735381615445, 10734.78530429387, 10735.51690173944, 10842.566297348096, 1931.5364312565023, 1953.7264782930401, 1957.4812674641232, 1993.2226431691652, 2014.3252010576475, 57321.71339143278, 65724.3427565723, 75176.62411687906, 82804.0, 85463.57268213619, 11072.0, 11225.94387028076, 11447.25592836463, 11455.54177832894, 11642.126840486828, 16091.275892584861, 16119.032858028555, 16119.27463264156, 16138.273777680033, 16143.596410089607, 7716.958210641492, 7807.336376407955, 8098.75703728889, 8104.5137291762685, 8295.294899933573, 7519.774406767806, 7625.580593067434, 7803.960980195063, 7834.216578342121, 7838.725644602411, 4772.618190544748, 4834.226523756182, 4862.7326291942445, 4882.389701287339, 4983.127952608352, 2001.3295545991964, 2023.5548179400507, 2053.219776484926, 2072.958540829175, 2125.2136709417614, 900.5812297281665, 996.6461906023402, 1023.6417253961054, 1034.384541197986, 1082.3235477826358, 19446.319378821674, 20377.79622203759, 20511.794882051287, 20549.48626284325, 20736.688949665768, 980.8038392321564, 988.6342053440274, 993.965211217604, 1025.9894004405655, 1048.8531605575226, 10577.524011419504, 11405.0, 11497.655070347902, 11523.423828808525, 11523.76952460946, 495727.0, 500519.0, 501715.0, 502093.0, 502793.0, 91122.54438727764, 94086.52956735309, 97109.0, 97738.0, 99181.0, 948.8292107420731, 981.2934687025188, 984.5028260728286, 1006.582268358623, 1022.3405903192399, 17480.737788932922, 17697.292108315523, 18172.182251798436, 18367.54081147982, 18642.53393665115, 42617.57382426136, 42964.0, 44376.55623443853, 44941.550584495046, 45321.0, 60935.69532152311, 61192.38807612045, 61359.38640613715, 63125.684371577845, 64993.67503162454, 8377.45546539473, 8730.257928076184, 8954.149355811187, 9067.954660226656, 9211.677591284273, 12310.938445307716, 12527.401516092954, 13088.869111308764, 13510.662233443849, 13813.654658633213, 11027.283226590245, 11035.22753407286, 11532.654020379403, 11770.3526306054, 11887.167898247386, 11617.6514704559, 11638.825417618911, 11682.824757628472, 11778.882211178121, 11808.468618912342, 12022.699432513908, 12114.636560903187, 12148.0, 12204.755904881675, 12275.815862761887, 8705.129487051245, 8715.484643554526, 8942.86585701202, 9074.637014519345, 9151.496667683341, 6018.0, 10669.89330106689, 10990.230683852054, 11431.428428578703, 11594.594189203337], "value": 9407.706038622555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.3786982248514, 1423.1816705394394, 1465.3845384938327, 1519.2479722537346, 1691.9238634261465, 8406.78983025424, 8800.427972181811, 8836.513991730451, 8843.734687959364, 8846.071162527938, 8557.272631826303, 8658.783530411743, 8660.610272537735, 8668.609912553935, 8677.305815534757, 2080.7503099628066, 2347.9178228762, 2353.752855950126, 2393.186316652338, 2395.652630368604, 2426.114468219096, 2448.3511869354634, 2456.3981824453035, 2460.372604985726, 2460.729319774832, 2380.464395511005, 2381.476075263448, 2399.628057651058, 2401.2796161151673, 2421.0436877433403, 2274.65880117982, 2329.2779238436055, 2332.1720789119872, 2353.682252895854, 2391.5097405031925, 2377.346229786805, 2400.663907053014, 2401.3756423329887, 2403.71155461344, 2406.2660888429023, 8899.37704360695, 8955.686550970684, 8971.730848074569, 8973.685920992799, 9074.63701451941, 5290.365156181283, 5394.433584473652, 5420.0, 5422.6475279106735, 5425.7287135643455, 3285.983570082134, 3302.108430723691, 3452.896413107611, 3454.0, 3466.4280393735003, 1096.5010920031366, 1102.3165637304921, 1112.8608923884515, 1143.5082914346829, 1156.468024708635, 12093.57672481459, 12141.817872731828, 12164.695882602917, 12174.452149653287, 12185.207961482563, 4386.934195986999, 4518.864434066983, 4626.606738427204, 4677.906441871143, 4687.226607609774, 9640.566174522164, 9640.855387169198, 9644.95177524108, 9650.613975440903, 9738.123568878835, 5258.894822103536, 5272.551833094153, 5274.97362513185, 5279.736013199402, 5283.4452382499285, 4297.613214810682, 4785.258284965836, 4867.537583929521, 4953.0, 4953.23224900141, 3684.299983003221, 3727.161388687578, 3810.3331916914985, 3861.1505468796818, 3884.5726970033274, 1139.732162941708, 1144.4964215745047, 1146.7591805720724, 1148.9540418383338, 1149.0635132367095, 929.6374413978554, 939.6805086270564, 943.8395472769646, 959.7744530035436, 979.1285755677453, 5707.486326230659, 5762.654240745569, 5775.509081728016, 5802.33273173582, 6144.5084393248435, 489.22946359483956, 489.49581930611527, 495.27442297035014, 498.27749762843297, 499.49301459019125, 3858.266929283427, 3906.8632597858937, 3940.5468371137686, 3941.2905676977844, 4047.129867078533, 10588.682339529827, 10907.618233361794, 11018.559257629766, 11111.72220694489, 11169.38568378747, 10901.83647245292, 10991.175661825395, 11007.394593297286, 11008.284461509977, 11037.227394082498, 8201.343892488587, 8234.958825205835, 8271.296939760188, 8273.544955027532, 8280.130586288473, 5827.5337972961215, 5862.325832529314, 5862.560307977004, 5872.94127058741, 6052.122442245762, 10153.593856245667, 10199.490025498548, 10224.335418197794, 10227.539760710935, 10265.332753371305, 9762.951185244312, 10171.338862973884, 10173.135283500986, 10427.895721042692, 10432.0, 6707.865842683022, 7791.415643826849, 7944.483608565425, 8051.677932882619, 8252.793680158044, 8230.135835737161, 8637.740867773977, 8637.870431943651, 8641.870371944551, 8647.87028194565, 7488.288612581796, 7515.210902855121, 7527.134379546423, 7567.091948966159, 7657.6554055066545, 7388.963055184689, 7504.699812007459, 7550.584717840571, 7601.6579253934815, 7692.6922923084685, 6516.413522782972, 6645.734170633314, 6647.268800431852, 6647.60114393138, 6657.201135863727, 4934.259861020875, 5052.570531504716, 5076.644634875671, 5186.040582492251, 5196.792128314825, 4801.423829140525, 5032.119379108714, 5035.169197082587, 5039.168537191323, 5212.296339994053], "value": 4521.964394122783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.05625109523163, 340.3176630855135, 344.5331575714906, 350.1054804973292, 350.9350770107529, 5115.258287548303, 5211.478852114787, 5221.295125158103, 5244.816431424901, 5255.316808814859, 4900.166971614825, 4955.950440495594, 5098.439171691111, 5102.0, 5201.0, 4068.6808519144174, 4091.8772436826944, 4104.261232978063, 4119.485064366954, 4122.8969275768195, 4100.876973690779, 4108.958910410903, 4130.834766609332, 4136.937945930814, 4147.0, 3823.8661646842365, 3909.8045097745, 4073.5926407359175, 4081.3877918312196, 4083.591640835922, 4079.3473044313064, 4084.101497670508, 4099.282625540519, 4099.651529619986, 4108.658064903007, 3660.762050466711, 3670.853165873362, 3671.94492082619, 3672.981635091807, 3682.815859207056, 4897.559219670211, 4935.904997837295, 5027.572656324217, 5071.746412679351, 5074.2895994560795, 4668.0, 4675.919215948904, 4699.130660827758, 4710.152172608929, 4722.669413141081, 5355.598330125217, 5356.35723713153, 5370.0, 5370.7046112463795, 5386.1920711893135, 3783.9621603784162, 4011.277969965405, 4022.5172979242384, 4039.97980010101, 4050.797460127011, 5531.474509921551, 5565.805196818092, 5576.888462230773, 5580.581456390746, 5582.162675598652, 4133.132042271097, 4149.834006639761, 4151.6886233532005, 4154.875353739392, 4172.290710579209, 3963.742356746802, 4208.705390622627, 4241.172971270573, 4255.638120842962, 4256.808443620044, 4649.837255696102, 4668.6965347253, 4684.718916864999, 4708.741019243975, 4712.6229901607785, 5449.100898351807, 5459.863503412446, 5465.043617366945, 5517.69652669107, 5525.502704756591, 1365.9726805463836, 1467.1710483576744, 1467.7871708602192, 1468.5300703774903, 1475.9335829887682, 934.6495064350869, 960.4045491795132, 972.1153750087528, 972.2416515118219, 976.6679329028022, 4497.370368148462, 4680.906381872343, 4691.859244222679, 4698.875247960136, 4746.359241502422, 4830.903381932341, 4852.441969173519, 4866.31871537985, 4882.511748825089, 4896.36347274852, 4708.516817202571, 4716.764161791965, 4725.196716558194, 4727.338172655831, 4751.548602882721, 2490.302715239736, 2564.371728926425, 2581.3030481769815, 2596.610508423714, 2599.584066549343, 5045.468172279346, 5054.519820617035, 5063.708754267638, 5072.365954255718, 5090.032893750175, 4924.532169443897, 4954.606094825056, 4959.702417854868, 4970.378702662168, 4995.625328100335, 5056.84829455117, 5082.974585127125, 5102.8214012510125, 5403.0, 5854.795082172103, 5509.752061157177, 5537.5569954402745, 5569.164625306236, 5570.693611851387, 5585.888282234414, 5540.695261760642, 5541.251930989426, 5555.388907220122, 5568.081266590967, 5568.470995255444, 5734.19372897536, 5830.387809280134, 5869.090291004901, 5879.382664820132, 5888.440598143169, 4031.254217969568, 4034.8789536313957, 4035.5157381114454, 4053.6554392876938, 4070.470838790938, 5317.8404647860625, 5404.405515393382, 5527.695976721319, 5544.445555444423, 5591.524720398649, 5392.7573259202645, 5400.729963501888, 5400.9459905400445, 5404.297441332602, 5414.891702166014, 5241.580673546184, 5415.323084614423, 5445.428230035789, 5453.918191227214, 5465.496988328083, 5327.866803329948, 5339.893202136013, 5352.4915133062295, 5371.973140134274, 5381.919271210857, 5397.3523177218985, 5439.5920305976415, 5443.482869127427, 5450.236966824568, 5456.48163424474, 5078.415982162099, 5312.1766126250495, 5339.759710812945, 5342.1452567589, 5367.060764366299], "value": 4090.1409988065416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.8787450070738, 742.9665665045072, 760.9961950190249, 807.8263173417714, 865.9307255419567, 14241.216733079676, 15654.295556699948, 15706.37174513021, 15716.528504144866, 15810.288537015833, 14915.552533423988, 15023.399064037452, 15027.173505457196, 15065.62335941602, 15070.095794252353, 646.0922404022356, 769.7152053740124, 773.6441237030958, 787.7164220880478, 789.4868335581889, 798.0662624729081, 799.8200404908907, 802.1417083720421, 802.7832485229014, 802.863513202754, 839.0518713853337, 839.8446287436814, 840.0549381945311, 840.9747707568782, 841.0286119531951, 674.6356967237685, 685.1948959972013, 686.543448606676, 805.5609692717483, 837.6105111123327, 608.6226539545465, 610.487190759764, 614.929283132441, 615.2616859768251, 615.4614712126889, 14614.634634134125, 14636.41454341825, 14640.926795366062, 14658.41366345345, 14672.779908301383, 13219.86780132196, 13228.669283267898, 13535.18788872661, 13572.864271357259, 13679.400913826341, 12674.683132921658, 12870.742585148339, 12877.549285775047, 12909.935450322688, 12928.83640472362, 4428.977855110704, 4443.400140980959, 4508.594226519596, 4516.954830451687, 4517.299818528133, 81080.0, 82482.0, 82879.0, 83910.58044709737, 84776.0, 10993.340399576051, 11504.39397028915, 11654.53381864716, 11711.414429278502, 11796.233244839059, 21876.45308867291, 21947.122115115217, 21970.231041913456, 21976.230831920806, 21989.560208795734, 8347.916520834835, 8530.74407767768, 8567.228949394585, 8908.821823563492, 8939.463632182089, 4645.419322584677, 4755.548222918817, 4796.5203479651755, 4925.975370123198, 5044.066847633199, 3223.129754966146, 3252.3820474109843, 3268.9836550817568, 3295.0938491914917, 3319.203391186098, 585.1690599348934, 610.9786157484467, 616.5160349125914, 627.1627377451063, 654.1790053482848, 618.5670030978333, 639.5267502048544, 674.2684187656448, 709.1773542690454, 718.4467959671024, 9730.318877678636, 9936.304458687822, 9972.578655305224, 10032.598696052077, 10240.436775977243, 628.230417738267, 630.7634637011121, 655.672163918041, 672.2974491656231, 673.9123913891162, 4946.830562062653, 4961.578265847371, 4961.8776501502825, 4988.488104374532, 4998.100341938486, 91025.54487227522, 96804.0, 98044.50977745066, 113183.43408282906, 117285.41357293329, 95492.0, 97876.51061744646, 98246.0, 98271.50864245633, 100674.49662751786, 82229.0, 88524.55737721141, 88811.23425869, 90570.54714726385, 91646.54176729074, 9462.526873656152, 9767.120959113714, 9867.753306167404, 10033.548490317808, 10145.9492702536, 48875.755621221666, 48904.51095489142, 49534.50465495299, 50818.0, 52311.47688523066, 62321.37678623156, 63846.36153638404, 65719.34280657132, 71441.64279178779, 71796.0, 13503.797443038166, 13581.660458488617, 13742.381592828147, 14250.786238206643, 14278.785818212527, 15608.375664973273, 15659.765103523685, 15935.442259520862, 16006.199690015686, 16613.50159495217, 12057.095717821374, 12711.36443177819, 12793.80661638551, 13063.216207027608, 14867.776983345475, 13828.723425531634, 13942.58172254834, 14147.787783183467, 14626.780598291247, 15129.47046853355, 13940.442382304595, 14137.646558836112, 14409.13545187292, 14441.214454178671, 15109.773353399489, 11747.236429632047, 12076.637700868989, 12109.455074521491, 12125.757484850077, 12325.137240393087, 10842.837357439486, 11338.355938389052, 12540.24758514492, 12707.491700332253, 12747.61757147287], "value": 7584.716119538324, "unit": "score"}], "name": "dromaeo_css", "value": 7248.5784996883385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 109.0, 107.0, 111.0, 110.0, 109.0, 111.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 119.0, 185.0, 118.0, 119.0, 147.0, 119.0, 154.0, 118.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 163.0, 159.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 123.0, 76.0, 77.0, 76.0, 75.0, 122.0, 74.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 131.0, 85.0, 85.0, 85.0, 118.0, 84.0, 85.0, 134.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 52.0, 50.0, 50.0, 53.0, 51.0, 50.0, 52.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 79.0, 84.0, 78.0, 77.0, 78.0, 78.0, 88.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 131.0, 122.0, 130.0, 122.0, 122.0, 131.0, 149.0, 136.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 165.0, 166.0, 163.0, 168.0, 166.0, 165.0, 162.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 66.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1497.8, "alertThreshold": 2.0}]} 11:34:41 INFO - Return code: 0 11:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:34:42 INFO - # TBPL SUCCESS # 11:34:42 INFO - Running post-action listener: _resource_record_post_action 11:34:42 INFO - [mozharness: 2016-09-20 18:34:42.007469Z] Finished run-tests step (success) 11:34:42 INFO - Running post-run listener: _resource_record_post_run 11:34:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417218560; Read time: 16; Write time: 382812 11:34:42 INFO - TinderboxPrint: CPU usage
13.0% 11:34:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:34:42 INFO - TinderboxPrint: I/O write bytes / time
417,218,560 / 382,812 11:34:42 INFO - TinderboxPrint: CPU idle
8,286.3 (86.9%) 11:34:42 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 11:34:42 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 125063168; Read time: 0; Write time: 133316 11:34:42 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 291672064; Read time: 0; Write time: 249492 11:34:42 INFO - Running post-run listener: _upload_blobber_files 11:34:42 INFO - Blob upload gear active. 11:34:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:42 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 11:34:42 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:34:42 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:43 INFO - (blobuploader) - INFO - Done attempting. 11:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:44 INFO - (blobuploader) - INFO - Done attempting. 11:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:48 INFO - (blobuploader) - INFO - Done attempting. 11:34:48 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:48 INFO - Return code: 0 11:34:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf734d0cd39e7eea3a3f5fb05523abdbe0fc6349fd3896b4d1d0b1a33deff059a31f7f9c8e18d6203ea07ee2ce69668efe86d68f8311456c13d75a1071e96e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/516f638c0abe9f6ac936b48ef5a6d5a0e2a97e976f35eded37384d16630f575b245225c8ff9cd2aeb39b08826edca23edb1d0e6692dc31793a85bdc9fa70b7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d1071e5461312edd79e9a55e0a4ab6f3d9d8becfbd61560e68994b34effe8110602c81bad401524e6b5010344cd005cd298a7c2c559cc9263979744ded0c5efa"} 11:34:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:48 INFO - Contents: 11:34:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf734d0cd39e7eea3a3f5fb05523abdbe0fc6349fd3896b4d1d0b1a33deff059a31f7f9c8e18d6203ea07ee2ce69668efe86d68f8311456c13d75a1071e96e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/516f638c0abe9f6ac936b48ef5a6d5a0e2a97e976f35eded37384d16630f575b245225c8ff9cd2aeb39b08826edca23edb1d0e6692dc31793a85bdc9fa70b7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d1071e5461312edd79e9a55e0a4ab6f3d9d8becfbd61560e68994b34effe8110602c81bad401524e6b5010344cd005cd298a7c2c559cc9263979744ded0c5efa"} 11:34:48 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:48 INFO - Copying logs to upload dir... 11:34:48 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.489843 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-20 11:34:48.760831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 11:34:48.764383) ========= 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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf734d0cd39e7eea3a3f5fb05523abdbe0fc6349fd3896b4d1d0b1a33deff059a31f7f9c8e18d6203ea07ee2ce69668efe86d68f8311456c13d75a1071e96e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/516f638c0abe9f6ac936b48ef5a6d5a0e2a97e976f35eded37384d16630f575b245225c8ff9cd2aeb39b08826edca23edb1d0e6692dc31793a85bdc9fa70b7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d1071e5461312edd79e9a55e0a4ab6f3d9d8becfbd61560e68994b34effe8110602c81bad401524e6b5010344cd005cd298a7c2c559cc9263979744ded0c5efa"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474384529/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cf734d0cd39e7eea3a3f5fb05523abdbe0fc6349fd3896b4d1d0b1a33deff059a31f7f9c8e18d6203ea07ee2ce69668efe86d68f8311456c13d75a1071e96e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/516f638c0abe9f6ac936b48ef5a6d5a0e2a97e976f35eded37384d16630f575b245225c8ff9cd2aeb39b08826edca23edb1d0e6692dc31793a85bdc9fa70b7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d1071e5461312edd79e9a55e0a4ab6f3d9d8becfbd61560e68994b34effe8110602c81bad401524e6b5010344cd005cd298a7c2c559cc9263979744ded0c5efa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 11:34:48.792418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:34:48.793175) ========= 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-1474395252.820367-854620852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 11:34:48.877937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 11:34:48.878644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 11:34:48.879423) ========= ========= Total master_lag: 0.18 =========