builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1472826448.66 results: success (0) buildid: 20160902072725 builduid: bebec679827441b5952d578358807849 revision: fc4928fc74e5add861fb00c40ee40ba5386c82d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.660279) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.660662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.660940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.704001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.704260) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 07:27:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-09-02 07:27:28 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.806264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.806536) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.858736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:28.859027) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc4928fc74e5add861fb00c40ee40ba5386c82d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc4928fc74e5add861fb00c40ee40ba5386c82d3 --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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 07:27:28,970 truncating revision to first 12 chars 2016-09-02 07:27:28,970 Setting DEBUG logging. 2016-09-02 07:27:28,970 attempt 1/10 2016-09-02 07:27:28,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fc4928fc74e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 07:27:29,272 unpacking tar archive at: mozilla-inbound-fc4928fc74e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634670 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:29.507481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:29.507773) ========= script_repo_revision: fc4928fc74e5add861fb00c40ee40ba5386c82d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:29.508126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:29.508382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 07:27:29.518951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-02 07:27:29.519211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:29 INFO - MultiFileLogger online at 20160902 07:27:29 in /builds/slave/test 07:27:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:27:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:29 INFO - {'append_to_log': False, 07:27:29 INFO - 'base_work_dir': '/builds/slave/test', 07:27:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:27:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:29 INFO - 'branch': 'Mozilla-Inbound', 07:27:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:29 INFO - 'config_files': ('talos/linux_config.py',), 07:27:29 INFO - 'default_actions': ('clobber', 07:27:29 INFO - 'read-buildbot-config', 07:27:29 INFO - 'download-and-extract', 07:27:29 INFO - 'populate-webroot', 07:27:29 INFO - 'create-virtualenv', 07:27:29 INFO - 'install', 07:27:29 INFO - 'run-tests'), 07:27:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:29 INFO - 'download_minidump_stackwalk': True, 07:27:29 INFO - 'download_symbols': 'ondemand', 07:27:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:29 INFO - 'installer_path': 'installer.exe', 07:27:29 INFO - 'log_level': 'info', 07:27:29 INFO - 'log_name': 'talos', 07:27:29 INFO - 'log_to_console': True, 07:27:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:29 INFO - 'opt_config_files': (), 07:27:29 INFO - 'pip_index': False, 07:27:29 INFO - 'sps_profile': False, 07:27:29 INFO - 'sps_profile_interval': 0, 07:27:29 INFO - 'suite': 'dromaeojs-e10s', 07:27:29 INFO - 'system_bits': '32', 07:27:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:29 INFO - 'title': 'talos-linux64-ix-009', 07:27:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:29 INFO - 'use_talos_json': True, 07:27:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:29 INFO - 'work_dir': 'build'} 07:27:29 INFO - [mozharness: 2016-09-02 14:27:29.727542Z] Running clobber step. 07:27:29 INFO - Running pre-action listener: _resource_record_pre_action 07:27:29 INFO - Running main action method: clobber 07:27:29 INFO - rmtree: /builds/slave/test/build 07:27:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:30 INFO - Running post-action listener: _resource_record_post_action 07:27:30 INFO - [mozharness: 2016-09-02 14:27:30.701959Z] Finished clobber step (success) 07:27:30 INFO - [mozharness: 2016-09-02 14:27:30.702059Z] Running read-buildbot-config step. 07:27:30 INFO - Running pre-action listener: _resource_record_pre_action 07:27:30 INFO - Running main action method: read_buildbot_config 07:27:30 INFO - Using buildbot properties: 07:27:30 INFO - { 07:27:30 INFO - "project": "", 07:27:30 INFO - "product": "firefox", 07:27:30 INFO - "script_repo_revision": "production", 07:27:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:27:30 INFO - "repository": "", 07:27:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:27:30 INFO - "buildid": "20160902072725", 07:27:30 INFO - "stage_platform": "linux64-pgo", 07:27:30 INFO - "basedir": "/builds/slave/test", 07:27:30 INFO - "buildnumber": 1555, 07:27:30 INFO - "platform": "ubuntu64_hw", 07:27:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:27:30 INFO - "slavebuilddir": "test", 07:27:30 INFO - "branch": "mozilla-inbound", 07:27:30 INFO - "revision": "fc4928fc74e5add861fb00c40ee40ba5386c82d3", 07:27:30 INFO - "slavename": "talos-linux64-ix-009", 07:27:30 INFO - "builduid": "bebec679827441b5952d578358807849", 07:27:30 INFO - "repo_path": "integration/mozilla-inbound" 07:27:30 INFO - } 07:27:30 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:27:30 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 07:27:30 INFO - Running post-action listener: _resource_record_post_action 07:27:30 INFO - [mozharness: 2016-09-02 14:27:30.704434Z] Finished read-buildbot-config step (success) 07:27:30 INFO - [mozharness: 2016-09-02 14:27:30.704525Z] Running download-and-extract step. 07:27:30 INFO - Running pre-action listener: _resource_record_pre_action 07:27:30 INFO - Running main action method: download_and_extract 07:27:30 INFO - mkdir: /builds/slave/test/build/tests 07:27:30 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')]} 07:27:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:27:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:30 INFO - Downloaded 1361 bytes. 07:27:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:27:30 INFO - Using the following test package requirements: 07:27:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:27:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:27:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'jsshell-linux-x86_64.zip'], 07:27:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:27:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:27:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:27:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:27:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:27:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:27:30 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')]} 07:27:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:27:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:31 INFO - Downloaded 21906572 bytes. 07:27:31 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 07:27:35 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 07:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:27:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:35 INFO - Downloaded 21906572 bytes. 07:27:35 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 07:27: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')]} 07:27:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:42 INFO - Downloaded 14413998 bytes. 07:27:42 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 07:27:42 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')]} 07:27:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:27:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/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 07:27:52 INFO - Downloaded 59755046 bytes. 07:27:52 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:27:52 INFO - mkdir: /builds/slave/test/properties 07:27:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:52 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:52 INFO - Contents: 07:27:52 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:27:53 INFO - Running post-action listener: _resource_record_post_action 07:27:53 INFO - Running post-action listener: set_extra_try_arguments 07:27:53 INFO - [mozharness: 2016-09-02 14:27:53.263156Z] Finished download-and-extract step (success) 07:27:53 INFO - [mozharness: 2016-09-02 14:27:53.263386Z] Running populate-webroot step. 07:27:53 INFO - Running pre-action listener: _resource_record_pre_action 07:27:53 INFO - Running main action method: populate_webroot 07:27:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:53 INFO - '--tppagecycles', 07:27:53 INFO - '7'], 07:27:53 INFO - 'tests': ['tsvgm']}}, 07:27:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['damp', 'tps']}, 07:27:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'tests': ['damp', 'tps']}, 07:27:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['dromaeo_dom']}, 07:27:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['basic_compositor_video']}, 07:27:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['a11yr', 07:27:53 INFO - 'ts_paint', 07:27:53 INFO - 'tpaint', 07:27:53 INFO - 'sessionrestore', 07:27:53 INFO - 'sessionrestore_no_auto_restore', 07:27:53 INFO - 'tabpaint']}, 07:27:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['tsvgx', 07:27:53 INFO - 'tsvgr_opacity', 07:27:53 INFO - 'tart', 07:27:53 INFO - 'tscrollx', 07:27:53 INFO - 'cart']}, 07:27:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:53 INFO - 'tsvgr_opacity', 07:27:53 INFO - 'tart', 07:27:53 INFO - 'tscrollx', 07:27:53 INFO - 'cart']}, 07:27:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'talos_options': ['--disable-e10s'], 07:27:53 INFO - 'tests': ['tp5o']}, 07:27:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'tests': ['tp5o']}, 07:27:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'talos_options': ['--disable-e10s', 07:27:53 INFO - '--xperf_path', 07:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:53 INFO - 'tests': ['tp5n']}, 07:27:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:53 INFO - 'talos_options': ['--xperf_path', 07:27:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:53 INFO - 'tests': ['tp5n']}}, 07:27:53 INFO - 'talos.zip': {'path': '', 07:27:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:53 INFO - Running post-action listener: _resource_record_post_action 07:27:53 INFO - [mozharness: 2016-09-02 14:27:53.280714Z] Finished populate-webroot step (success) 07:27:53 INFO - [mozharness: 2016-09-02 14:27:53.280805Z] Running create-virtualenv step. 07:27:53 INFO - Running pre-action listener: _resource_record_pre_action 07:27:53 INFO - Running main action method: create_virtualenv 07:27:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:53 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 07:27:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:53 INFO - Using real prefix '/usr' 07:27:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:55 INFO - Installing pip.................done. 07:27:55 INFO - Return code: 0 07:27:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:27:55 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 07:27:55 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 07:27:55 INFO - Using env: {'DISPLAY': ':0', 07:27:55 INFO - 'HOME': '/home/cltbld', 07:27:55 INFO - 'LANG': 'en_US.UTF-8', 07:27:55 INFO - 'LANGUAGE': 'en_US:en', 07:27:55 INFO - 'LOGNAME': 'cltbld', 07:27:55 INFO - 'MAIL': '/var/mail/cltbld', 07:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:55 INFO - 'MOZ_NO_REMOTE': '1', 07:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:55 INFO - 'NO_EM_RESTART': '1', 07:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:55 INFO - 'PWD': '/builds/slave/test', 07:27:55 INFO - 'SHELL': '/bin/bash', 07:27:55 INFO - 'SHLVL': '1', 07:27:55 INFO - 'TERM': 'linux', 07:27:55 INFO - 'TMOUT': '86400', 07:27:55 INFO - 'USER': 'cltbld', 07:27:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:55 INFO - '_': '/tools/buildbot/bin/python'} 07:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:56 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 07:27:56 INFO - Cleaning up... 07:27:56 INFO - Return code: 0 07:27:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:27:56 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 07:27:56 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 07:27:56 INFO - Using env: {'DISPLAY': ':0', 07:27:56 INFO - 'HOME': '/home/cltbld', 07:27:56 INFO - 'LANG': 'en_US.UTF-8', 07:27:56 INFO - 'LANGUAGE': 'en_US:en', 07:27:56 INFO - 'LOGNAME': 'cltbld', 07:27:56 INFO - 'MAIL': '/var/mail/cltbld', 07:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:56 INFO - 'MOZ_NO_REMOTE': '1', 07:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:56 INFO - 'NO_EM_RESTART': '1', 07:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:56 INFO - 'PWD': '/builds/slave/test', 07:27:56 INFO - 'SHELL': '/bin/bash', 07:27:56 INFO - 'SHLVL': '1', 07:27:56 INFO - 'TERM': 'linux', 07:27:56 INFO - 'TMOUT': '86400', 07:27:56 INFO - 'USER': 'cltbld', 07:27:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:56 INFO - '_': '/tools/buildbot/bin/python'} 07:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:56 INFO - Downloading/unpacking psutil>=3.1.1 07:27:56 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 07:27:56 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 07:27:56 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 07:27:56 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 07:27:56 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 07:27:56 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 07:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:58 INFO - Installing collected packages: psutil 07:27:58 INFO - Running setup.py install for psutil 07:27:58 INFO - building 'psutil._psutil_linux' extension 07:27:58 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 07:27:58 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 07:27:58 INFO - building 'psutil._psutil_posix' extension 07:27:58 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 07:27:58 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 07:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:58 INFO - Successfully installed psutil 07:27:58 INFO - Cleaning up... 07:27:58 INFO - Return code: 0 07:27:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:58 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:27:58 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 07:27:58 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 07:27:58 INFO - Using env: {'DISPLAY': ':0', 07:27:58 INFO - 'HOME': '/home/cltbld', 07:27:58 INFO - 'LANG': 'en_US.UTF-8', 07:27:58 INFO - 'LANGUAGE': 'en_US:en', 07:27:58 INFO - 'LOGNAME': 'cltbld', 07:27:58 INFO - 'MAIL': '/var/mail/cltbld', 07:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:58 INFO - 'MOZ_NO_REMOTE': '1', 07:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:58 INFO - 'NO_EM_RESTART': '1', 07:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:58 INFO - 'PWD': '/builds/slave/test', 07:27:58 INFO - 'SHELL': '/bin/bash', 07:27:58 INFO - 'SHLVL': '1', 07:27:58 INFO - 'TERM': 'linux', 07:27:58 INFO - 'TMOUT': '86400', 07:27:58 INFO - 'USER': 'cltbld', 07:27:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:58 INFO - '_': '/tools/buildbot/bin/python'} 07:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:28:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:01 INFO - Installing collected packages: mozsystemmonitor 07:28:01 INFO - Running setup.py install for mozsystemmonitor 07:28:01 INFO - Successfully installed mozsystemmonitor 07:28:01 INFO - Cleaning up... 07:28:01 INFO - Return code: 0 07:28:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:28:01 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')]} 07:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 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')]} 07:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:01 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 07:28:01 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 07:28:01 INFO - Using env: {'DISPLAY': ':0', 07:28:01 INFO - 'HOME': '/home/cltbld', 07:28:01 INFO - 'LANG': 'en_US.UTF-8', 07:28:01 INFO - 'LANGUAGE': 'en_US:en', 07:28:01 INFO - 'LOGNAME': 'cltbld', 07:28:01 INFO - 'MAIL': '/var/mail/cltbld', 07:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:01 INFO - 'MOZ_NO_REMOTE': '1', 07:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:01 INFO - 'NO_EM_RESTART': '1', 07:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:01 INFO - 'PWD': '/builds/slave/test', 07:28:01 INFO - 'SHELL': '/bin/bash', 07:28:01 INFO - 'SHLVL': '1', 07:28:01 INFO - 'TERM': 'linux', 07:28:01 INFO - 'TMOUT': '86400', 07:28:01 INFO - 'USER': 'cltbld', 07:28:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:01 INFO - '_': '/tools/buildbot/bin/python'} 07:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:01 INFO - Downloading/unpacking jsonschema==2.5.1 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:03 INFO - warning: no files found matching '*.txt' 07:28:03 INFO - no previously-included directories found matching 'build' 07:28:03 INFO - no previously-included directories found matching 'dist' 07:28:03 INFO - no previously-included directories found matching '.git*' 07:28:03 INFO - Installing collected packages: jsonschema, functools32 07:28:03 INFO - Running setup.py install for functools32 07:28:03 INFO - warning: no files found matching '*.txt' 07:28:03 INFO - no previously-included directories found matching 'build' 07:28:03 INFO - no previously-included directories found matching 'dist' 07:28:03 INFO - no previously-included directories found matching '.git*' 07:28:03 INFO - Successfully installed jsonschema functools32 07:28:03 INFO - Cleaning up... 07:28:03 INFO - Return code: 0 07:28:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:28:03 INFO - Using env: {'DISPLAY': ':0', 07:28:03 INFO - 'HOME': '/home/cltbld', 07:28:03 INFO - 'LANG': 'en_US.UTF-8', 07:28:03 INFO - 'LANGUAGE': 'en_US:en', 07:28:03 INFO - 'LOGNAME': 'cltbld', 07:28:03 INFO - 'MAIL': '/var/mail/cltbld', 07:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:03 INFO - 'MOZ_NO_REMOTE': '1', 07:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:03 INFO - 'NO_EM_RESTART': '1', 07:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:03 INFO - 'PWD': '/builds/slave/test', 07:28:03 INFO - 'SHELL': '/bin/bash', 07:28:03 INFO - 'SHLVL': '1', 07:28:03 INFO - 'TERM': 'linux', 07:28:03 INFO - 'TMOUT': '86400', 07:28:03 INFO - 'USER': 'cltbld', 07:28:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:03 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:28:04 INFO - Cleaning up... 07:28:04 INFO - Return code: 0 07:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:04 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 07:28:04 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 07:28:04 INFO - Using env: {'DISPLAY': ':0', 07:28:04 INFO - 'HOME': '/home/cltbld', 07:28:04 INFO - 'LANG': 'en_US.UTF-8', 07:28:04 INFO - 'LANGUAGE': 'en_US:en', 07:28:04 INFO - 'LOGNAME': 'cltbld', 07:28:04 INFO - 'MAIL': '/var/mail/cltbld', 07:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:04 INFO - 'MOZ_NO_REMOTE': '1', 07:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:04 INFO - 'NO_EM_RESTART': '1', 07:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:04 INFO - 'PWD': '/builds/slave/test', 07:28:04 INFO - 'SHELL': '/bin/bash', 07:28:04 INFO - 'SHLVL': '1', 07:28:04 INFO - 'TERM': 'linux', 07:28:04 INFO - 'TMOUT': '86400', 07:28:04 INFO - 'USER': 'cltbld', 07:28:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:04 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - Downloading docopt-0.6.1.tar.gz 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:06 INFO - Running setup.py install for blobuploader 07:28:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:07 INFO - Running setup.py install for requests 07:28:07 INFO - Running setup.py install for docopt 07:28:07 INFO - Successfully installed blobuploader requests docopt 07:28:07 INFO - Cleaning up... 07:28:07 INFO - Return code: 0 07:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:07 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')]} 07:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 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')]} 07:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:07 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 07:28:07 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 07:28:07 INFO - Using env: {'DISPLAY': ':0', 07:28:07 INFO - 'HOME': '/home/cltbld', 07:28:07 INFO - 'LANG': 'en_US.UTF-8', 07:28:07 INFO - 'LANGUAGE': 'en_US:en', 07:28:07 INFO - 'LOGNAME': 'cltbld', 07:28:07 INFO - 'MAIL': '/var/mail/cltbld', 07:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:07 INFO - 'MOZ_NO_REMOTE': '1', 07:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:07 INFO - 'NO_EM_RESTART': '1', 07:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:07 INFO - 'PWD': '/builds/slave/test', 07:28:07 INFO - 'SHELL': '/bin/bash', 07:28:07 INFO - 'SHLVL': '1', 07:28:07 INFO - 'TERM': 'linux', 07:28:07 INFO - 'TMOUT': '86400', 07:28:07 INFO - 'USER': 'cltbld', 07:28:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:07 INFO - '_': '/tools/buildbot/bin/python'} 07:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:07 INFO - Running setup.py (path:/tmp/pip-n6xYYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:07 INFO - Running setup.py (path:/tmp/pip-IWwCF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:07 INFO - Running setup.py (path:/tmp/pip-Ee9EAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:07 INFO - Running setup.py (path:/tmp/pip-ta86cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:08 INFO - Running setup.py (path:/tmp/pip-04IUsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:08 INFO - Running setup.py (path:/tmp/pip-Oj67qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:08 INFO - Running setup.py (path:/tmp/pip-VlKio_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:08 INFO - Running setup.py (path:/tmp/pip-w5Ae5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:08 INFO - Running setup.py (path:/tmp/pip-km57y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:08 INFO - Running setup.py (path:/tmp/pip-BgO6M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:08 INFO - Running setup.py (path:/tmp/pip-f6pY_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:08 INFO - Running setup.py (path:/tmp/pip-hgfWzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:08 INFO - Running setup.py (path:/tmp/pip-FvwU9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:08 INFO - Running setup.py (path:/tmp/pip-JU1Bui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:08 INFO - Running setup.py (path:/tmp/pip-hPNYbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:08 INFO - Running setup.py (path:/tmp/pip-uc9nyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:08 INFO - Running setup.py (path:/tmp/pip-s46SZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:08 INFO - Running setup.py install for manifestparser 07:28:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for mozcrash 07:28:09 INFO - Running setup.py install for mozdebug 07:28:09 INFO - Running setup.py install for mozdevice 07:28:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for mozfile 07:28:09 INFO - Running setup.py install for mozhttpd 07:28:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for mozinfo 07:28:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for mozInstall 07:28:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for mozleak 07:28:09 INFO - Running setup.py install for mozlog 07:28:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:09 INFO - Running setup.py install for moznetwork 07:28:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Running setup.py install for mozprocess 07:28:10 INFO - Running setup.py install for mozprofile 07:28:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Running setup.py install for mozrunner 07:28:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Running setup.py install for mozscreenshot 07:28:10 INFO - Running setup.py install for moztest 07:28:10 INFO - Running setup.py install for mozversion 07:28:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:10 INFO - Cleaning up... 07:28:10 INFO - Return code: 0 07:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:10 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')]} 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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')]} 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:10 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 07:28:10 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 07:28:10 INFO - Using env: {'DISPLAY': ':0', 07:28:10 INFO - 'HOME': '/home/cltbld', 07:28:10 INFO - 'LANG': 'en_US.UTF-8', 07:28:10 INFO - 'LANGUAGE': 'en_US:en', 07:28:10 INFO - 'LOGNAME': 'cltbld', 07:28:10 INFO - 'MAIL': '/var/mail/cltbld', 07:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:10 INFO - 'MOZ_NO_REMOTE': '1', 07:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:10 INFO - 'NO_EM_RESTART': '1', 07:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:10 INFO - 'PWD': '/builds/slave/test', 07:28:10 INFO - 'SHELL': '/bin/bash', 07:28:10 INFO - 'SHLVL': '1', 07:28:10 INFO - 'TERM': 'linux', 07:28:10 INFO - 'TMOUT': '86400', 07:28:10 INFO - 'USER': 'cltbld', 07:28:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:10 INFO - '_': '/tools/buildbot/bin/python'} 07:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:10 INFO - Running setup.py (path:/tmp/pip-Az4mu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:11 INFO - Running setup.py (path:/tmp/pip-2qfMcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:11 INFO - Running setup.py (path:/tmp/pip-VFTU5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:11 INFO - Running setup.py (path:/tmp/pip-2zDkU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:11 INFO - Running setup.py (path:/tmp/pip-BZY8ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:11 INFO - Running setup.py (path:/tmp/pip-kPX7Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:11 INFO - Running setup.py (path:/tmp/pip-AKNdig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:11 INFO - Running setup.py (path:/tmp/pip-VEd6e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:11 INFO - Running setup.py (path:/tmp/pip-QU2FtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:11 INFO - Running setup.py (path:/tmp/pip-WjmQWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:11 INFO - Running setup.py (path:/tmp/pip-fU3IW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:11 INFO - Running setup.py (path:/tmp/pip-lkNPxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:11 INFO - Running setup.py (path:/tmp/pip-J155G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:11 INFO - Running setup.py (path:/tmp/pip-uwFG1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:11 INFO - Running setup.py (path:/tmp/pip-oWKUSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:12 INFO - Running setup.py (path:/tmp/pip-oEqMhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:12 INFO - Running setup.py (path:/tmp/pip-pN0Xst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:12 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)) 07:28:12 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)) 07:28:12 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)) 07:28:12 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)) 07:28:12 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)) 07:28:12 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)) 07:28:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:12 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 07:28:12 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 07:28:12 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 07:28:12 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 07:28:12 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 07:28:12 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 07:28:14 INFO - Downloading blessings-1.6.tar.gz 07:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:14 INFO - Installing collected packages: blessings 07:28:14 INFO - Running setup.py install for blessings 07:28:14 INFO - Successfully installed blessings 07:28:14 INFO - Cleaning up... 07:28:15 INFO - Return code: 0 07:28:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:15 INFO - Reading from file tmpfile_stdout 07:28:15 INFO - Current package versions: 07:28:15 INFO - argparse == 1.2.1 07:28:15 INFO - blessings == 1.6 07:28:15 INFO - blobuploader == 1.2.4 07:28:15 INFO - docopt == 0.6.1 07:28:15 INFO - functools32 == 3.2.3-2 07:28:15 INFO - jsonschema == 2.5.1 07:28:15 INFO - manifestparser == 1.1 07:28:15 INFO - mozInstall == 1.12 07:28:15 INFO - mozcrash == 0.17 07:28:15 INFO - mozdebug == 0.1 07:28:15 INFO - mozdevice == 0.48 07:28:15 INFO - mozfile == 1.2 07:28:15 INFO - mozhttpd == 0.7 07:28:15 INFO - mozinfo == 0.9 07:28:15 INFO - mozleak == 0.1 07:28:15 INFO - mozlog == 3.3 07:28:15 INFO - moznetwork == 0.27 07:28:15 INFO - mozprocess == 0.23 07:28:15 INFO - mozprofile == 0.28 07:28:15 INFO - mozrunner == 6.12 07:28:15 INFO - mozscreenshot == 0.1 07:28:15 INFO - mozsystemmonitor == 0.3 07:28:15 INFO - moztest == 0.7 07:28:15 INFO - mozversion == 1.4 07:28:15 INFO - psutil == 3.1.1 07:28:15 INFO - requests == 1.2.3 07:28:15 INFO - wsgiref == 0.1.2 07:28:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:15 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:15 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 07:28:15 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 07:28:15 INFO - Using env: {'DISPLAY': ':0', 07:28:15 INFO - 'HOME': '/home/cltbld', 07:28:15 INFO - 'LANG': 'en_US.UTF-8', 07:28:15 INFO - 'LANGUAGE': 'en_US:en', 07:28:15 INFO - 'LOGNAME': 'cltbld', 07:28:15 INFO - 'MAIL': '/var/mail/cltbld', 07:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:15 INFO - 'MOZ_NO_REMOTE': '1', 07:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:15 INFO - 'NO_EM_RESTART': '1', 07:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:15 INFO - 'PWD': '/builds/slave/test', 07:28:15 INFO - 'SHELL': '/bin/bash', 07:28:15 INFO - 'SHLVL': '1', 07:28:15 INFO - 'TERM': 'linux', 07:28:15 INFO - 'TMOUT': '86400', 07:28:15 INFO - 'USER': 'cltbld', 07:28:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:15 INFO - '_': '/tools/buildbot/bin/python'} 07:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 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)) 07:28:15 INFO - Cleaning up... 07:28:15 INFO - Return code: 0 07:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:15 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 0x7f4468896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2589230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, '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': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', '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 07:28:15 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 07:28:15 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 07:28:15 INFO - Using env: {'DISPLAY': ':0', 07:28:15 INFO - 'HOME': '/home/cltbld', 07:28:15 INFO - 'LANG': 'en_US.UTF-8', 07:28:15 INFO - 'LANGUAGE': 'en_US:en', 07:28:15 INFO - 'LOGNAME': 'cltbld', 07:28:15 INFO - 'MAIL': '/var/mail/cltbld', 07:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:15 INFO - 'MOZ_NO_REMOTE': '1', 07:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:15 INFO - 'NO_EM_RESTART': '1', 07:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:15 INFO - 'PWD': '/builds/slave/test', 07:28:15 INFO - 'SHELL': '/bin/bash', 07:28:15 INFO - 'SHLVL': '1', 07:28:15 INFO - 'TERM': 'linux', 07:28:15 INFO - 'TMOUT': '86400', 07:28:15 INFO - 'USER': 'cltbld', 07:28:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:15 INFO - '_': '/tools/buildbot/bin/python'} 07:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:15 INFO - Cleaning up... 07:28:15 INFO - Return code: 0 07:28:15 INFO - Running post-action listener: _resource_record_post_action 07:28:15 INFO - Running post-action listener: _start_resource_monitoring 07:28:15 INFO - Starting resource monitoring. 07:28:15 INFO - [mozharness: 2016-09-02 14:28:15.822945Z] Finished create-virtualenv step (success) 07:28:15 INFO - [mozharness: 2016-09-02 14:28:15.823441Z] Running install step. 07:28:15 INFO - Running pre-action listener: _resource_record_pre_action 07:28:15 INFO - Running main action method: install 07:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:16 INFO - Reading from file tmpfile_stdout 07:28:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:16 INFO - Reading from file tmpfile_stdout 07:28:16 INFO - Output received: 07:28:16 INFO - Usage: mozinstall [options] installer 07:28:16 INFO - Options: 07:28:16 INFO - -h, --help show this help message and exit 07:28:16 INFO - -d DEST, --destination=DEST 07:28:16 INFO - Directory to install application into. [default: 07:28:16 INFO - "/builds/slave/test"] 07:28:16 INFO - --app=APP Application being installed. [default: firefox] 07:28:16 INFO - mkdir: /builds/slave/test/build/application 07:28:16 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'] 07:28:16 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 07:28:33 INFO - Reading from file tmpfile_stdout 07:28:33 INFO - Output received: 07:28:33 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:33 INFO - Running post-action listener: _resource_record_post_action 07:28:33 INFO - [mozharness: 2016-09-02 14:28:33.163374Z] Finished install step (success) 07:28:33 INFO - [mozharness: 2016-09-02 14:28:33.163628Z] Running run-tests step. 07:28:33 INFO - Running pre-action listener: _resource_record_pre_action 07:28:33 INFO - Running main action method: run_tests 07:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:33 INFO - Python 2.7.3 07:28:33 INFO - Return code: 0 07:28:33 INFO - grabbing minidump binary from tooltool 07:28: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')]} 07:28:33 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 0x2583090>, '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 0x25869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2586e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:33 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 07:28:33 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 07:28:33 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 07:28:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:33 INFO - Return code: 0 07:28:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:28:33 INFO - Using env: {'DISPLAY': ':0', 07:28:33 INFO - 'HOME': '/home/cltbld', 07:28:33 INFO - 'LANG': 'en_US.UTF-8', 07:28:33 INFO - 'LANGUAGE': 'en_US:en', 07:28:33 INFO - 'LOGNAME': 'cltbld', 07:28:33 INFO - 'MAIL': '/var/mail/cltbld', 07:28:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:33 INFO - 'MOZ_NO_REMOTE': '1', 07:28:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:33 INFO - 'NO_EM_RESTART': '1', 07:28:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:33 INFO - 'PWD': '/builds/slave/test', 07:28:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:33 INFO - 'SHELL': '/bin/bash', 07:28:33 INFO - 'SHLVL': '1', 07:28:33 INFO - 'TERM': 'linux', 07:28:33 INFO - 'TMOUT': '86400', 07:28:33 INFO - 'USER': 'cltbld', 07:28:33 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433', 07:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:33 INFO - '_': '/tools/buildbot/bin/python'} 07:28:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:28:33 INFO - mozversion application_buildid: 20160902043001 07:28:33 INFO - mozversion application_changeset: fc4928fc74e5add861fb00c40ee40ba5386c82d3 07:28:33 INFO - mozversion application_display_name: Nightly 07:28:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:33 INFO - mozversion application_name: Firefox 07:28:33 INFO - mozversion application_remotingname: firefox 07:28:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:33 INFO - mozversion application_vendor: Mozilla 07:28:33 INFO - mozversion application_version: 51.0a1 07:28:33 INFO - mozversion platform_buildid: 20160902043001 07:28:33 INFO - mozversion platform_changeset: fc4928fc74e5add861fb00c40ee40ba5386c82d3 07:28:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:33 INFO - mozversion platform_version: 51.0a1 07:28:33 INFO - using testdate: 1472826513 07:28:33 INFO - actual date: 1472826513 07:28:33 INFO - starting webserver on 'localhost:44846' 07:28:33 INFO - SUITE-START | Running 2 tests 07:28:33 INFO - TEST-START | dromaeo_css 07:28:33 INFO - operating with platform_type : linux_ 07:28:33 INFO - Initialising browser for dromaeo_css test... 07:28:33 INFO - TEST-INFO | started process 12433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgbZiIB/profile http://localhost:44846/getInfo.html) 07:28:38 INFO - PROCESS | 12433 | __metrics Screen width/height:1600/1200 07:28:38 INFO - PROCESS | 12433 | colorDepth:24 07:28:38 INFO - PROCESS | 12433 | Browser inner width/height: 1024/697 07:28:38 INFO - PROCESS | 12433 | __metrics 07:28:38 ERROR - PROCESS | 12433 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 07:28:39 INFO - TEST-INFO | 12433: exit 0 07:28:39 INFO - Browser initialized. 07:28:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:39 INFO - TEST-INFO | started process 12554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgbZiIB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:51 INFO - PROCESS | 12554 | RSS: Main: 191123456 07:28:51 INFO - PROCESS | 12554 | 07:29:41 INFO - PROCESS | 12554 | 1472826581270 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] 07:31:51 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44846/tests/dromaeo/cssquery-ext.html) 07:31:52 INFO - PROCESS | 12554 | RSS: Main: 206098432 07:31:52 INFO - PROCESS | 12554 | 07:34:54 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-ext.html (next: http://localhost:44846/tests/dromaeo/cssquery-jquery.html) 07:34:55 INFO - PROCESS | 12554 | RSS: Main: 200871936 07:34:55 INFO - PROCESS | 12554 | 07:37:57 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44846/tests/dromaeo/cssquery-mootools.html) 07:37:57 INFO - PROCESS | 12554 | RSS: Main: 198660096 07:37:57 INFO - PROCESS | 12554 | 07:40:59 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44846/tests/dromaeo/cssquery-prototype.html) 07:41:00 INFO - PROCESS | 12554 | RSS: Main: 193122304 07:41:00 INFO - PROCESS | 12554 | 07:44:02 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44846/tests/dromaeo/cssquery-yui.html) 07:44:03 INFO - PROCESS | 12554 | RSS: Main: 196939776 07:44:03 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | Cycle 1(1): loaded http://localhost:44846/tests/dromaeo/cssquery-yui.html (next: http://localhost:44846/tests/dromaeo/cssquery-dojo.html) 07:47:06 INFO - PROCESS | 12554 | RSS: Main: 197128192 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | __start_tp_report 07:47:06 INFO - PROCESS | 12554 | _x_x_mozilla_page_load 07:47:06 INFO - PROCESS | 12554 | _x_x_mozilla_page_load_details 07:47:06 INFO - PROCESS | 12554 | |i|pagename|runs| 07:47:06 INFO - PROCESS | 12554 | |0;dojo.html;3114.517249826277;3124.6562878083405;3127.82796946168;3138.8744450221993;3158.0367987763725;5296.629235953485;5424.0779067558515;5452.236686863837;5497.862553436166;5528.226048353234;5412.972935135329;5497.615166938316;5509.118541033436;5520.1167813149905;5558.194061861028;4969.776360063796;5030.974845125769;5044.697318160922;5097.05704444677;5117.948820511784;5111.667741596784;5121.56466700329;5124.718140502271;5185.507376799198;5188.6367954243215;4854.12625727369;4913.606911447111;4936.33359496467;5043.848684539451;5053.873653158664;4914.21372580389;4920.335754673145;4945.208766597363;5004.574611158056;5034.647574669774;4912.5578697917;4935.975320123376;4969.627277954131;4985.152524070917;4997.625178111656;5388.91916621251;5441.102218134043;5450.945490545084;5460.426655201187;5468.699221542814;5767;5768.538516918637;5773.595848290622;5784.219130417424;5786.884262314772;5863.58954873159;5872.207252020965;5873.500752436005;5876.970615146897;5879.059350503899;5400.432954539795;5410.296661433988;5418.620696551282;5464.153056276284;5507.366652834975;5962.433568810956;5964.284285885721;5973.402659733992;5978.641281523035;5979.521638268928;5674.687892165888;5684.37471878093;5693.373728889902;5726.284214473191;5728.05487094633;5658.971705141448;5792.044312688444;5827.708614569255;5850.795222167204;5945.019071853096;5693.743781529841;5825.650460972271;5844.386339434383;5864.618799778001;5879.588428810028;5696.401877802771;5849.385814489502;5874.265716785402;5885.058390657474;5885.264341957255;4402.141582391467;4458.643308535309;4478.037221997286;4503.369528266046;4547.567981041796;3986.342253528135;3991.3214753491975;4025.456563363967;4043.757374557536;4047.615476529725;5532.6680399175375;5569.805056822992;5574.581906356958;5581.134924086773;5600.355959064678;5688.203651488795;5780.855478613068;5814.622049566765;5920.585559010828;5958.731857066442;5536.335639723259;5538.501534861801;5542.778288868481;5572.414896435897;5578.9163162552595;5042.823501177441;5043.218301163325;5043.52086551777;5047.772850221749;5104.617153713486;5938.257717785277;5990.041593345044;6019.067044608093;6040.09398590215;6084.695765211633;5938.792142275172;5951.851203719942;5955.642661440327;5985.042393217064;6006.669633170218;6126.663033533198;6151.907721384272;6156.661383623765;6159.784407545893;6168.1056246844855;5634.267545219095;5736.541076713769;5748.310202775694;5813.709314534341;5861.677607731615;5852.648841069549;5897.351291357862;5904.557158213065;5935.970320148372;5955.225820643289;5766.221560089334;5767.077267637158;5773.1051686988585;5775.364709881994;5777;5613.494785469327;5677.77288908439;5708.143778433102;5730.369659337386;5758.510526605285;5683.090705487102;5698.2592263005545;5711.714414279187;5716.42835716425;5740.540756739534;5766.971165144148;5827.79602713903;5835.066389377679;5836.737346819318;5845.327787304344;5471.06991811401;5526.613137080366;5552.805651802168;5579.163125531203;5686.943130568641 07:47:06 INFO - PROCESS | 12554 | |1;ext.html;550.2076210809463;579.7246308003697;584.4155844155841;602.9668368239746;633.8637193003503;42714.572854271486;43681;43829.34255986159;43884.12231755363;44004.339934901;44282.114357712824;44605.10789784211;44671.77664111683;44697.106057878824;44753.552464475346;8923.687670931518;9108.316876234276;9129.269658427309;9137.862932055992;9152.130547597968;8896.37725359225;8984;8984.146506081912;8993.505357205351;9007.594658240396;9005.639774409015;9042.186203241707;9042.86435703465;9067.501287429188;9070.637174513045;8955.552222388887;8991.64033438665;9006.459612423276;9019.143181397822;9062.27501799861;8894.42186257891;8941.329400295004;8957;8977.281817454588;8984;41393;41488;41514.584854151675;41515.377269340985;41619;3429.8285085745615;3536.7524273300623;3560.9109772255642;4146.744805327803;4226.640735537483;32249.838750806095;33457.49813752795;33602.83198584016;33718.32563348744;33779.83110084458;4335.241332766753;4359.891002724926;4406.735595864258;4491.416115904912;4607.516210797851;343918;351102;351351;351430;351462;58236.41763582395;58783.412165878646;58870;58931.70534147302;58974.41025589775;61956.38043619596;62233.37766622366;62370.688146558976;62466.375336246965;62686;16977.575560610836;17162.742558861628;17208.569785755455;17235.74146387805;17257.137143142794;13708.45166193361;13728.65678358029;13773.931130344285;13811.654708632364;13885.514007009706;16509.44103663934;17659.470215893543;17669.7349539757;17739.11304434773;17751.822481775016;5731.942680573225;6028.125921741323;6036.486898613667;6056.939430605726;6091.725872335755;903.629511900131;975.6487664440796;1047.528612124547;1056.144522936424;1158.3802665573878;32004;32539;32782;32964.17589560232;33118.50322245168;1015.243643485608;1039.812833689943;1040.4953597505205;1062.8830828608848;1073.1682945717132;15997.28012239452;16662.91691040103;16686.83313166853;16692.58268543296;17094.743578846326;531765;539385;543746;552611;861729;57897;58012.70993645089;58190.12714809281;58276;58422;1317.22942078883;1333.2800287844454;1354.5056054540023;1358.8980826438058;1363.5363976248123;31106.844465777525;32683.34633307368;32833.34333313368;32937.83531082329;33284.833575831966;50296.497035029184;50467;50564.24153637625;50679;50810.23784643159;495830;498090;498306;498803;501105;27923.44153116967;28012.71987280101;28105.859470702515;28155.71844281531;28175.914492398897;46101.76949115233;46754.53245467638;46808.76595617;48067.75966120287;48095.27857082077;39321.88815454087;40702.79648601738;40790.79604601958;41634.375484367156;42416.36375454309;39745.2050958985;40217.79891100526;40796.59203407928;41361.37957930694;41479.58520414878;39644.603553964094;39655.60344396519;39895.80052099721;40018.199636007696;40347.59652403439;33862;36568;36665.633343666224;37190.25619487649;37299.440508391854;27863.721362786113;28096.43807123805;28098.578521322605;28177.718222817508;28282.2929426766 07:47:06 INFO - PROCESS | 12554 | |2;jquery.html;388.9222155568887;405.75249098050165;415.81496234175785;418.4664552695313;431.9092990472001;18583.442496725103;20392.184312627476;20492.59014819703;20521.48696282592;20926.581468370663;19428.51428714283;19713.211471541155;19765.703514447294;19813.405597832087;19901.50246243841;5462.9726851365685;5807.506361959238;5860.765569377219;5878.764849406019;5887.558433117512;5547.472990065938;5715.571332150084;5845.298564172305;5846.619969701956;5860.73626686798;5720.856978575548;5733.512651424634;5743.368229494752;5777.768889244425;5780.0751879699255;5585.357683866367;5757.827265182052;5759.712014399284;5768.221290125843;5772.740226689809;5230.293910322096;5232.398274198478;5237.73811309433;5241.475852414728;5243.842684719464;19641.901790491098;23391.181308654286;23580;23793.16723914672;23822.404439889142;2280.0423821994636;2291.2209848651537;2369.4668699542635;2439.7163120567375;2979.0467050543834;14720.190389528572;14889.776653350209;15050.32273547682;15157.393704251817;15527.301271442699;1827.9817201827946;1912.6079153773444;1914.8468122550162;1942.0678074524167;1959.7844237133904;71034.64482677553;72118.63940680315;72340.63829680817;73775.26224737738;74006.62996685036;10713.78572428547;10808.351498910091;10929.344239345506;11200.663980080612;11247.943760281147;15373.692526149414;15477.5356739298;15483.612909677124;15497.070175789264;15530;8495.447795893248;8697.565121743888;8761.518116503654;8775.91224087751;8924.241439477588;8352.290055345364;8497.320214382835;8559.40084194113;8768.298536117096;8869.467831930106;6610.8016759497295;6674.16572928384;6675.833104172338;6696.43080338167;6826.146731658543;1964.5481539246055;2017.2636987499457;2037.1647624473894;2039.1129858511595;2064.5045189154794;972.7130496503548;984.227381505529;998.3560603410905;1064.2656566968922;1082.3451811653993;18904.48764098869;20456.590868182553;20513.58972820565;20709.792902071087;20963.580728385346;990.9900900991042;1034.1519953637944;1079.2930630437077;1081.8269076947809;1109.8612673415823;10699.572017119228;11533.76932461346;11606.70983225426;11688.766224675628;11761.353125578175;470075;470983;472083;472394;475179;49645.75177124164;70744;81038.18961810424;81636;82245.17754822376;1010.368519675203;1018.4042335233823;1032.3547782635853;1034.01251804528;1067.3809190669392;18126.909365453615;18185;18846.905765471085;18871.528211794266;19119.330823421114;44394.77802610966;44522.77738611286;44625.776871115435;44703.329450058925;46084.30873536832;55234.723826380614;55617;56032.71983640219;63294;63325.36674633194;7581.166071731995;7609.505382150142;7848.60756962161;8105.27052565272;8178.5092894426525;11944.820827687417;12970.351482425653;13152;13545.255010974492;13759.587212383645;11821.468033938665;11836.289822610672;11900.166988310735;12065.577704780291;12283.324417157142;11320.377379243891;11427.485763140845;11711.941440292743;12039.819402709141;12231.143819932875;11803.822942655695;12016.75966480683;12038.578649747216;12105.394730263628;12145.089118316338;7960.442769006114;7977.282044616012;8071.798205044921;8341.374396920133;8347.833043338978;10917.508712108132;12091.274523528617;12335.444904979477;12339.383030848601;12627.052971027393 07:47:06 INFO - PROCESS | 12554 | |3;mootools.html;1503.4737841755386;1519.6124988128026;1657.2632249904138;1729.1786401459317;1803.873728838981;7831.530108193512;8332.333413326935;8728.781780455492;8952;8961.148690874374;8904.688335908244;8967.596458159382;9002.459852408843;9078.182963533282;9095.590698418571;2436.2082323244927;2449.9142530011454;2461.950760984779;2462.1382516119306;2467.284487498623;2399.904003839853;2404.3748625357357;2473.418746594549;2476.7399423060588;2476.8018558515278;2408.7832095111435;2433.051110067075;2433.245693834908;2435.1111844176926;2457.3979375053136;2391.497785465054;2394.6288325309606;2406.0736616402723;2417.673614062114;2453.9509209815706;2273.4089136824377;2343.0627748900406;2345.6012477878803;2354.799842013431;2356.905723771047;8969.416987895765;8972.10278972104;9036.186743193144;9065.68270110543;9133.36066475347;5114.462981386975;5266.552343050846;5268.315119034501;5272.630915835893;5283.709395983219;3150.9054728358187;3345.866165353383;3381.4082535556427;3389.8305084745666;3438.0889064397957;1003.3578509753763;1068.1881769854888;1108.8613923259593;1119.1270808769173;1134.0190735014237;12596.307203103917;12609.18040327385;12677.049221308347;12719.364031798374;12752.10735248533;4414.139242847614;4606.262997920317;4698.201305778026;4718.339432479455;4774.212254977959;10183.643572474928;10185.287029907835;10186.337888037255;10201.13290370312;10209.591616335263;5355.491228333302;5357.785688572491;5361.812336568201;5368.167933970163;5368.275282836845;4424.11517696462;4857.514248575114;4924.3352147460355;4938.604911607134;4979.576735977483;4012.1373904610064;4043.6765058795227;4061.679954014957;4077.6941729370415;4141.171765646883;1352.1751731443812;1369.8630136986221;1370.3353873371407;1381.2679279981626;1381.5648070857649;862.4566523090413;864.049545499945;886.1847100667402;887.0464250930276;902.9187373136449;6163.9383606164265;6223.626582405071;6226.5641405101205;6331.96834015827;6511.674416279167;960.7838236396755;976.6239997600833;990.1732053735068;999.835027220515;1036.2797855490512;4118.258713431551;4363.869083927424;4444.82220711168;4450.35469856869;4537.410136682276;10977.890221097847;11300.94349528247;11328.94335528317;11404.771904562029;11429.771404572028;10983.121350291958;11009.61466348674;11364.659060228207;11383.43082845871;11401.543938242543;8329.541875196923;8365.414420990593;8414.410991230678;8436.957815210884;8442.451240669337;6120.60216085953;6220.595661282002;6226.221722284715;6227.719752611234;6232.8130156095385;10001.499925003865;10138.18894488454;10143.54354054084;10145.695629131138;10314.587416503557;10232.488375581042;10459.477026148814;10471.68584942453;10553.366797992145;10621.681349559525;7424.554526728413;7442.888356674546;7495.475316727777;7495.850082998419;7513.060867391576;8790.824183516166;8799.91200087991;8802.163794439519;8833.24917382004;8839.204471597586;7746.767596972099;7815.843683126419;7844.372450204084;8005.879911801211;8095.5142691438705;7422.703091876265;7586.24137586237;7749.186335434698;7837.804054898673;7958.045034595885;6784.118064651761;7107.395871350786;7212.4230061596;7212.639368031472;7213.422926165789;5310.442403547727;5334.866628334323;5347.759350829144;5382.757775900016;5589.189567512769;5457.61796674229;5473.808416705396;5496.80761173357;5541.556675465872;5594.552435805044 07:47:06 INFO - PROCESS | 12554 | |4;prototype.html;322.4453939224533;324.90090522390676;325.941330560499;339.8623557459229;349.2996541933423;5553.305836770403;5554.472325129112;5576.219329293902;5585.385607583167;5605.915911261324;5485.561155107592;5497.367802702691;5497.5601951843855;5522.254495643087;5557.360903496089;4033.9225298970982;4117.3206420940505;4186.518550366701;4243.363495475673;4268.509121451027;4243.469566304212;4246;4246.341817018351;4258;4271.231178387889;4246.723962942398;4249.46881639795;4251.82992680294;4255.489341279051;4261.4673165854265;3985.6412922837085;4204.201201771653;4227.943014246438;4232.32282834748;4252.638525725317;3718.7025037996896;3722.3671975764187;3723.6276372362818;3726.6273372662786;3751.1747415568802;5367.973160134214;5377.623566350357;5390.865228369283;5395.460453954613;5395.595330350239;4633.2818413146015;4835.226363781778;4888.511148885119;4926.531979461945;4932.778024988884;5722.256106706143;5722.570807189478;5730;5730.914036289459;5732.22614946981;4032.9395059074136;4045.676345892351;4054.878353649395;4056.5599212279512;4062.5124985001694;5819.854503637401;5904.409559044061;5961.463468287875;5966.3138739045135;6013.218281623361;4077.6330130287824;4095.8976025599004;4107.650849677811;4109.3425051991535;4113.444684967491;4154.605312495308;4156.750594964251;4165.812538435777;4167.541570427311;4170.436991006175;4717.976410117927;4803.231482962709;4831.806727730922;4839.903201936012;4883.877903052452;5799.652020878761;5805.912911306334;5828.737706803204;5833.949889019932;5853.9414605854245;1474.8525147485166;1486.8215814102161;1504.5561559340022;1505.1796770759963;1505.4505105636583;895.9239893750698;937.4890684576922;953.3374304858057;1002.6991902429243;1031.5409642709074;5569.944300557024;5587.357453892854;5601.047821870292;5601.5238704710555;5605.32736071674;5934.468990950378;5938.910916336258;5964.628135528853;5967.224260846149;5974.1934838796205;5264.052300648785;5544.750486228129;5571.9442805572235;5584.441555844464;5625.212470254168;3131.4676504994204;3147.2918593316776;3149.5590617313137;3150.779445438843;3160.920976975594;5844.240248767633;5949.679624946274;6005.639661620229;6043.486303664238;6064.848378790477;5870.26621672291;5938.2280303560265;5950.899083669448;5982;5985.491233245136;6013.496625843539;6075.635461872302;6089.269287685506;6092.238470191226;6099.420555047263;5749.367569567428;5833.79581714638;5847.7368518417625;5859.179714839841;5868.618539794899;5720.170575266647;5742.052561327334;5770.711464426846;5805.82582522525;5830.941690583039;5845.2920911095225;5948.672822994604;5985.221921150222;6000.87998240024;6021.638701677914;4234.2801723706425;4251.277282861983;4257.808398622007;4258.765767882796;4259.935016245939;5835.241418615723;5913.438223368773;5915.40845915405;5944.3164036136395;5950.940490595039;5653.689047102449;5729.598928074995;5742.684152371659;5773.538116950718;5809.215755873072;5641.407652196624;5761;5761.859786416497;5806.912896306474;5812.593118481665;5422.972885135707;5622.269105016322;5622.313306008263;5728.0786798732115;5729.570282228933;5762.30852297727;5801;5829.213056237354;5844.736986835517;5856;5710.543156547549;5737.885242295214;5741.684207368635;5754.223179870832;5780.21967034445 07:47:06 INFO - PROCESS | 12554 | |5;yui.html;682.7780971184364;744.4528271720288;746.1493896957469;799.6406109613655;812.4759530103082;14904.925475372622;15945.282462289197;16268.430604928815;16290;16692.248848801803;14546.854531454683;14903.403863845433;14916.850831491682;14954.40182392703;15003.474878379258;779.7699678594814;785.4462603864262;817.9018517777845;824.9010118785754;825.3768404854327;819.1767273889733;824.4805772363433;827.5283088639478;827.6399766101765;828.1345993436873;870.9912900871005;876.3383645347753;877.934154938379;878.9384743067988;879.4064006795387;862.9482231066124;866.3069544364483;869.7216890595012;874.8381549413347;875.1729615513342;633.2464367402775;634.0964126120306;634.3973225435855;635.7615894039735;641.2913730327967;15865.682686346325;16035.438759643474;16037.518874433787;16068.919655401649;16098.517044488684;14887.330070146869;15015.174165420898;15110;15153.924230378887;15222.391104355813;10980.505877235544;11006.889931100746;11166.720831979184;11289.604863829809;11971.880281197251;3773.924521509582;3774.8678796242275;3895.474110995036;3991.0621004064024;3996.1208534122447;86427;87363;88637.11362886353;89301.55349223278;90036.09963900343;10805.621803236849;10932.398718070423;11471.780339945304;11572.537098515964;11688.590899318484;21553.461163470725;21701.34895953124;21709.240176593743;21714;21714.89142554277;8613.526256055851;8669.783255418664;8693.826123477622;8697.91302086971;8793.736187914374;4856.150173719585;4912.214045752662;4916.385451818523;5044.041632089891;5173.146430838945;3411.8635254590035;3525.2420729543273;3535.6287589803214;3537.3809583322814;3542.132177616449;609.7896225802091;627.7865525721277;640.0750914927885;640.3884290502559;652.1815122021832;682.6313790553145;712.3268511256916;762.0854974031184;768;776.1384862802284;9270.212031977357;9795.657151999645;9885.15976142036;10048.648297309559;10469.895301046892;706.4030893894651;716.4197000429668;734.8683028136717;772.764306886405;783.7452827830978;4761.142994260997;4920.6309526785635;4950.6782059166035;4969.229769385679;4973.602111831045;77658.6117069411;124206;126977;129048;134118;111310;114631;116104;116244;118164.40917795528;77747.22252777513;78240.60879695565;79014.604926975;84422.99999999878;101145.98854011513;9497.43015419077;9918.355306905316;10240.795184096425;10376.481175941324;10561.577536898438;49924;50509.40321338934;50877.49122508727;51420.48579514307;52584.73707631438;74631.25368746243;75206;75308.62345688237;76390.61804690941;79390;12324.753504929671;12626.116171868249;12693.873061269269;12716.554920577735;12910.483580656668;13668.453261869414;13679.452821887411;13875.861241387456;14468.493602723855;14588.416463341347;13120.671983200114;13182.934085329513;13321.13412628176;13472.797908031584;13474.383074031179;13374.866251337362;13474.26406614322;13754.120593563286;13901.30493475302;14031.649208769453;11468.483918223867;12926.806097908351;12967.286799226133;12994.155379900276;13658.726825463236;11028.22802403824;11185.272957258077;11265.704443989047;11485.712857178638;11973.221740586834;11337.886621133683;11511.827322590336;11934.28394296345;12101.878981210075;12183.269003859443 07:47:06 INFO - PROCESS | 12554 | __end_tp_report 07:47:06 INFO - PROCESS | 12554 | __start_cc_report 07:47:06 INFO - PROCESS | 12554 | _x_x_mozilla_cycle_collect,315 07:47:06 INFO - PROCESS | 12554 | __end_cc_report 07:47:06 INFO - PROCESS | 12554 | __startTimestamp1472827626801__endTimestamp 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | ------- Summary: start ------- 07:47:06 INFO - PROCESS | 12554 | Number of tests: 6 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#0] dojo.html Cycles:165 Average:5445.85 Median:5674.69 stddev:618.49 (10.9%) stddev-sans-first:592.73 07:47:06 INFO - PROCESS | 12554 | Values: 3114.5 3124.7 3127.8 3138.9 3158.0 5296.6 5424.1 5452.2 5497.9 5528.2 5413.0 5497.6 5509.1 5520.1 5558.2 4969.8 5031.0 5044.7 5097.1 5117.9 5111.7 5121.6 5124.7 5185.5 5188.6 4854.1 4913.6 4936.3 5043.8 5053.9 4914.2 4920.3 4945.2 5004.6 5034.6 4912.6 4936.0 4969.6 4985.2 4997.6 5388.9 5441.1 5450.9 5460.4 5468.7 5767.0 5768.5 5773.6 5784.2 5786.9 5863.6 5872.2 5873.5 5877.0 5879.1 5400.4 5410.3 5418.6 5464.2 5507.4 5962.4 5964.3 5973.4 5978.6 5979.5 5674.7 5684.4 5693.4 5726.3 5728.1 5659.0 5792.0 5827.7 5850.8 5945.0 5693.7 5825.7 5844.4 5864.6 5879.6 5696.4 5849.4 5874.3 5885.1 5885.3 4402.1 4458.6 4478.0 4503.4 4547.6 3986.3 3991.3 4025.5 4043.8 4047.6 5532.7 5569.8 5574.6 5581.1 5600.4 5688.2 5780.9 5814.6 5920.6 5958.7 5536.3 5538.5 5542.8 5572.4 5578.9 5042.8 5043.2 5043.5 5047.8 5104.6 5938.3 5990.0 6019.1 6040.1 6084.7 5938.8 5951.9 5955.6 5985.0 6006.7 6126.7 6151.9 6156.7 6159.8 6168.1 5634.3 5736.5 5748.3 5813.7 5861.7 5852.6 5897.4 5904.6 5936.0 5955.2 5766.2 5767.1 5773.1 5775.4 5777.0 5613.5 5677.8 5708.1 5730.4 5758.5 5683.1 5698.3 5711.7 5716.4 5740.5 5767.0 5827.8 5835.1 5836.7 5845.3 5471.1 5526.6 5552.8 5579.2 5686.9 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#1] ext.html Cycles:180 Average:63941.41 Median:22930.51 stddev:133794.64 (583.5%) stddev-sans-first:134085.31 07:47:06 INFO - PROCESS | 12554 | Values: 550.2 579.7 584.4 603.0 633.9 42714.6 43681.0 43829.3 43884.1 44004.3 44282.1 44605.1 44671.8 44697.1 44753.6 8923.7 9108.3 9129.3 9137.9 9152.1 8896.4 8984.0 8984.1 8993.5 9007.6 9005.6 9042.2 9042.9 9067.5 9070.6 8955.6 8991.6 9006.5 9019.1 9062.3 8894.4 8941.3 8957.0 8977.3 8984.0 41393.0 41488.0 41514.6 41515.4 41619.0 3429.8 3536.8 3560.9 4146.7 4226.6 32249.8 33457.5 33602.8 33718.3 33779.8 4335.2 4359.9 4406.7 4491.4 4607.5 343918.0 351102.0 351351.0 351430.0 351462.0 58236.4 58783.4 58870.0 58931.7 58974.4 61956.4 62233.4 62370.7 62466.4 62686.0 16977.6 17162.7 17208.6 17235.7 17257.1 13708.5 13728.7 13773.9 13811.7 13885.5 16509.4 17659.5 17669.7 17739.1 17751.8 5731.9 6028.1 6036.5 6056.9 6091.7 903.6 975.6 1047.5 1056.1 1158.4 32004.0 32539.0 32782.0 32964.2 33118.5 1015.2 1039.8 1040.5 1062.9 1073.2 15997.3 16662.9 16686.8 16692.6 17094.7 531765.0 539385.0 543746.0 552611.0 861729.0 57897.0 58012.7 58190.1 58276.0 58422.0 1317.2 1333.3 1354.5 1358.9 1363.5 31106.8 32683.3 32833.3 32937.8 33284.8 50296.5 50467.0 50564.2 50679.0 50810.2 495830.0 498090.0 498306.0 498803.0 501105.0 27923.4 28012.7 28105.9 28155.7 28175.9 46101.8 46754.5 46808.8 48067.8 48095.3 39321.9 40702.8 40790.8 41634.4 42416.4 39745.2 40217.8 40796.6 41361.4 41479.6 39644.6 39655.6 39895.8 40018.2 40347.6 33862.0 36568.0 36665.6 37190.3 37299.4 27863.7 28096.4 28098.6 28177.7 28282.3 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#2] jquery.html Cycles:180 Average:28200.51 Median:12974.73 stddev:77420.56 (596.7%) stddev-sans-first:77609.59 07:47:06 INFO - PROCESS | 12554 | Values: 388.9 405.8 415.8 418.5 431.9 18583.4 20392.2 20492.6 20521.5 20926.6 19428.5 19713.2 19765.7 19813.4 19901.5 5463.0 5807.5 5860.8 5878.8 5887.6 5547.5 5715.6 5845.3 5846.6 5860.7 5720.9 5733.5 5743.4 5777.8 5780.1 5585.4 5757.8 5759.7 5768.2 5772.7 5230.3 5232.4 5237.7 5241.5 5243.8 19641.9 23391.2 23580.0 23793.2 23822.4 2280.0 2291.2 2369.5 2439.7 2979.0 14720.2 14889.8 15050.3 15157.4 15527.3 1828.0 1912.6 1914.8 1942.1 1959.8 71034.6 72118.6 72340.6 73775.3 74006.6 10713.8 10808.4 10929.3 11200.7 11247.9 15373.7 15477.5 15483.6 15497.1 15530.0 8495.4 8697.6 8761.5 8775.9 8924.2 8352.3 8497.3 8559.4 8768.3 8869.5 6610.8 6674.2 6675.8 6696.4 6826.1 1964.5 2017.3 2037.2 2039.1 2064.5 972.7 984.2 998.4 1064.3 1082.3 18904.5 20456.6 20513.6 20709.8 20963.6 991.0 1034.2 1079.3 1081.8 1109.9 10699.6 11533.8 11606.7 11688.8 11761.4 470075.0 470983.0 472083.0 472394.0 475179.0 49645.8 70744.0 81038.2 81636.0 82245.2 1010.4 1018.4 1032.4 1034.0 1067.4 18126.9 18185.0 18846.9 18871.5 19119.3 44394.8 44522.8 44625.8 44703.3 46084.3 55234.7 55617.0 56032.7 63294.0 63325.4 7581.2 7609.5 7848.6 8105.3 8178.5 11944.8 12970.4 13152.0 13545.3 13759.6 11821.5 11836.3 11900.2 12065.6 12283.3 11320.4 11427.5 11711.9 12039.8 12231.1 11803.8 12016.8 12038.6 12105.4 12145.1 7960.4 7977.3 8071.8 8341.4 8347.8 10917.5 12091.3 12335.4 12339.4 12627.1 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#3] mootools.html Cycles:180 Average:5925.80 Median:4746.28 stddev:3349.81 (70.6%) stddev-sans-first:3342.72 07:47:06 INFO - PROCESS | 12554 | Values: 1503.5 1519.6 1657.3 1729.2 1803.9 7831.5 8332.3 8728.8 8952.0 8961.1 8904.7 8967.6 9002.5 9078.2 9095.6 2436.2 2449.9 2462.0 2462.1 2467.3 2399.9 2404.4 2473.4 2476.7 2476.8 2408.8 2433.1 2433.2 2435.1 2457.4 2391.5 2394.6 2406.1 2417.7 2454.0 2273.4 2343.1 2345.6 2354.8 2356.9 8969.4 8972.1 9036.2 9065.7 9133.4 5114.5 5266.6 5268.3 5272.6 5283.7 3150.9 3345.9 3381.4 3389.8 3438.1 1003.4 1068.2 1108.9 1119.1 1134.0 12596.3 12609.2 12677.0 12719.4 12752.1 4414.1 4606.3 4698.2 4718.3 4774.2 10183.6 10185.3 10186.3 10201.1 10209.6 5355.5 5357.8 5361.8 5368.2 5368.3 4424.1 4857.5 4924.3 4938.6 4979.6 4012.1 4043.7 4061.7 4077.7 4141.2 1352.2 1369.9 1370.3 1381.3 1381.6 862.5 864.0 886.2 887.0 902.9 6163.9 6223.6 6226.6 6332.0 6511.7 960.8 976.6 990.2 999.8 1036.3 4118.3 4363.9 4444.8 4450.4 4537.4 10977.9 11300.9 11328.9 11404.8 11429.8 10983.1 11009.6 11364.7 11383.4 11401.5 8329.5 8365.4 8414.4 8437.0 8442.5 6120.6 6220.6 6226.2 6227.7 6232.8 10001.5 10138.2 10143.5 10145.7 10314.6 10232.5 10459.5 10471.7 10553.4 10621.7 7424.6 7442.9 7495.5 7495.9 7513.1 8790.8 8799.9 8802.2 8833.2 8839.2 7746.8 7815.8 7844.4 8005.9 8095.5 7422.7 7586.2 7749.2 7837.8 7958.0 6784.1 7107.4 7212.4 7212.6 7213.4 5310.4 5334.9 5347.8 5382.8 5589.2 5457.6 5473.8 5496.8 5541.6 5594.6 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#4] prototype.html Cycles:180 Average:4831.70 Median:5584.91 stddev:1429.28 (25.6%) stddev-sans-first:1392.64 07:47:06 INFO - PROCESS | 12554 | Values: 322.4 324.9 325.9 339.9 349.3 5553.3 5554.5 5576.2 5585.4 5605.9 5485.6 5497.4 5497.6 5522.3 5557.4 4033.9 4117.3 4186.5 4243.4 4268.5 4243.5 4246.0 4246.3 4258.0 4271.2 4246.7 4249.5 4251.8 4255.5 4261.5 3985.6 4204.2 4227.9 4232.3 4252.6 3718.7 3722.4 3723.6 3726.6 3751.2 5368.0 5377.6 5390.9 5395.5 5395.6 4633.3 4835.2 4888.5 4926.5 4932.8 5722.3 5722.6 5730.0 5730.9 5732.2 4032.9 4045.7 4054.9 4056.6 4062.5 5819.9 5904.4 5961.5 5966.3 6013.2 4077.6 4095.9 4107.7 4109.3 4113.4 4154.6 4156.8 4165.8 4167.5 4170.4 4718.0 4803.2 4831.8 4839.9 4883.9 5799.7 5805.9 5828.7 5833.9 5853.9 1474.9 1486.8 1504.6 1505.2 1505.5 895.9 937.5 953.3 1002.7 1031.5 5569.9 5587.4 5601.0 5601.5 5605.3 5934.5 5938.9 5964.6 5967.2 5974.2 5264.1 5544.8 5571.9 5584.4 5625.2 3131.5 3147.3 3149.6 3150.8 3160.9 5844.2 5949.7 6005.6 6043.5 6064.8 5870.3 5938.2 5950.9 5982.0 5985.5 6013.5 6075.6 6089.3 6092.2 6099.4 5749.4 5833.8 5847.7 5859.2 5868.6 5720.2 5742.1 5770.7 5805.8 5830.9 5845.3 5948.7 5985.2 6000.9 6021.6 4234.3 4251.3 4257.8 4258.8 4259.9 5835.2 5913.4 5915.4 5944.3 5950.9 5653.7 5729.6 5742.7 5773.5 5809.2 5641.4 5761.0 5761.9 5806.9 5812.6 5423.0 5622.3 5622.3 5728.1 5729.6 5762.3 5801.0 5829.2 5844.7 5856.0 5710.5 5737.9 5741.7 5754.2 5780.2 07:47:06 INFO - PROCESS | 12554 | 07:47:06 INFO - PROCESS | 12554 | [#5] yui.html Cycles:180 Average:21729.78 Median:3774.40 stddev:32287.93 (855.4%) stddev-sans-first:32339.83 07:47:06 INFO - PROCESS | 12554 | Values: 682.8 744.5 746.1 799.6 812.5 14904.9 15945.3 16268.4 16290.0 16692.2 14546.9 14903.4 14916.9 14954.4 15003.5 779.8 785.4 817.9 824.9 825.4 819.2 824.5 827.5 827.6 828.1 871.0 876.3 877.9 878.9 879.4 862.9 866.3 869.7 874.8 875.2 633.2 634.1 634.4 635.8 641.3 15865.7 16035.4 16037.5 16068.9 16098.5 14887.3 15015.2 15110.0 15153.9 15222.4 10980.5 11006.9 11166.7 11289.6 11971.9 3773.9 3774.9 3895.5 3991.1 3996.1 86427.0 87363.0 88637.1 89301.6 90036.1 10805.6 10932.4 11471.8 11572.5 11688.6 21553.5 21701.3 21709.2 21714.0 21714.9 8613.5 8669.8 8693.8 8697.9 8793.7 4856.2 4912.2 4916.4 5044.0 5173.1 3411.9 3525.2 3535.6 3537.4 3542.1 609.8 627.8 640.1 640.4 652.2 682.6 712.3 762.1 768.0 776.1 9270.2 9795.7 9885.2 10048.6 10469.9 706.4 716.4 734.9 772.8 783.7 4761.1 4920.6 4950.7 4969.2 4973.6 77658.6 124206.0 126977.0 129048.0 134118.0 111310.0 114631.0 116104.0 116244.0 118164.4 77747.2 78240.6 79014.6 84423.0 101146.0 9497.4 9918.4 10240.8 10376.5 10561.6 49924.0 50509.4 50877.5 51420.5 52584.7 74631.3 75206.0 75308.6 76390.6 79390.0 12324.8 12626.1 12693.9 12716.6 12910.5 13668.5 13679.5 13875.9 14468.5 14588.4 13120.7 13182.9 13321.1 13472.8 13474.4 13374.9 13474.3 13754.1 13901.3 14031.6 11468.5 12926.8 12967.3 12994.2 13658.7 11028.2 11185.3 11265.7 11485.7 11973.2 11337.9 11511.8 11934.3 12101.9 12183.3 07:47:06 INFO - PROCESS | 12554 | -------- Summary: end -------- 07:47:06 INFO - PROCESS | 12554 | 07:47:07 INFO - TEST-INFO | 12554: exit 0 07:47:07 INFO - TEST-OK | dromaeo_css | took 1114374ms 07:47:07 INFO - TEST-START | kraken 07:47:07 INFO - operating with platform_type : linux_ 07:47:07 INFO - Initialising browser for kraken test... 07:47:07 INFO - TEST-INFO | started process 12910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBz8sH/profile http://localhost:44846/getInfo.html) 07:47:12 INFO - PROCESS | 12910 | __metrics Screen width/height:1600/1200 07:47:12 INFO - PROCESS | 12910 | colorDepth:24 07:47:12 INFO - PROCESS | 12910 | Browser inner width/height: 1024/697 07:47:12 INFO - PROCESS | 12910 | __metrics 07:47:12 ERROR - PROCESS | 12910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 07:47:13 INFO - TEST-INFO | 12910: exit 0 07:47:13 INFO - Browser initialized. 07:47:13 INFO - Running cycle 1/1 for kraken test... 07:47:13 INFO - TEST-INFO | started process 13031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBz8sH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:25 INFO - PROCESS | 13031 | RSS: Main: 191791104 07:47:25 INFO - PROCESS | 13031 | 07:47:28 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44846/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:29 INFO - PROCESS | 13031 | RSS: Main: 205021184 07:47:29 INFO - PROCESS | 13031 | 07:47:32 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44846/tests/kraken/driver.html?testName=audio-dft) 07:47:32 INFO - PROCESS | 13031 | RSS: Main: 204152832 07:47:32 INFO - PROCESS | 13031 | 07:47:35 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44846/tests/kraken/driver.html?testName=audio-fft) 07:47:36 INFO - PROCESS | 13031 | RSS: Main: 194768896 07:47:36 INFO - PROCESS | 13031 | 07:47:38 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44846/tests/kraken/driver.html?testName=audio-oscillator) 07:47:39 INFO - PROCESS | 13031 | RSS: Main: 195579904 07:47:39 INFO - PROCESS | 13031 | 07:47:41 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:41 INFO - PROCESS | 13031 | RSS: Main: 195670016 07:47:41 INFO - PROCESS | 13031 | 07:47:45 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44846/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:45 INFO - PROCESS | 13031 | RSS: Main: 196124672 07:47:45 INFO - PROCESS | 13031 | 07:47:49 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44846/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:49 INFO - PROCESS | 13031 | RSS: Main: 193499136 07:47:49 INFO - PROCESS | 13031 | 07:47:52 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44846/tests/kraken/driver.html?testName=json-parse-financial) 07:47:53 INFO - PROCESS | 13031 | RSS: Main: 195383296 07:47:53 INFO - PROCESS | 13031 | 07:47:54 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:55 INFO - PROCESS | 13031 | RSS: Main: 195399680 07:47:55 INFO - PROCESS | 13031 | 07:47:57 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:57 INFO - PROCESS | 13031 | RSS: Main: 195293184 07:47:57 INFO - PROCESS | 13031 | 07:47:59 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:00 INFO - PROCESS | 13031 | RSS: Main: 195997696 07:48:00 INFO - PROCESS | 13031 | 07:48:03 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:03 INFO - PROCESS | 13031 | RSS: Main: 196063232 07:48:03 INFO - PROCESS | 13031 | 07:48:06 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:07 INFO - PROCESS | 13031 | RSS: Main: 195919872 07:48:07 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:44846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44846/tests/kraken/driver.html?testName=ai-astar) 07:48:09 INFO - PROCESS | 13031 | RSS: Main: 197689344 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | __start_tp_report 07:48:09 INFO - PROCESS | 13031 | _x_x_mozilla_page_load 07:48:09 INFO - PROCESS | 13031 | _x_x_mozilla_page_load_details 07:48:09 INFO - PROCESS | 13031 | |i|pagename|runs| 07:48:09 INFO - PROCESS | 13031 | |0;ai-astar;110;113;113;113;113;111;114;114;114;130 07:48:09 INFO - PROCESS | 13031 | |1;audio-beat-detection;154;121;144;181;123;161;156;126;185;119 07:48:09 INFO - PROCESS | 13031 | |2;audio-dft;162;163;165;172;162;163;163;163;166;164 07:48:09 INFO - PROCESS | 13031 | |3;audio-fft;74;76;75;181;77;75;77;76;159;77 07:48:09 INFO - PROCESS | 13031 | |4;audio-oscillator;84;83;148;87;84;83;145;82;83;140 07:48:09 INFO - PROCESS | 13031 | |5;imaging-gaussian-blur;119;118;117;117;118;117;117;117;118;118 07:48:09 INFO - PROCESS | 13031 | |6;imaging-darkroom;146;149;148;147;146;147;149;148;148;149 07:48:09 INFO - PROCESS | 13031 | |7;imaging-desaturate;96;97;95;96;97;95;95;96;96;96 07:48:09 INFO - PROCESS | 13031 | |8;json-parse-financial;52;53;54;58;54;54;59;53;52;59 07:48:09 INFO - PROCESS | 13031 | |9;json-stringify-tinderbox;62;65;63;63;63;61;63;65;64;63 07:48:09 INFO - PROCESS | 13031 | |10;stanford-crypto-aes;80;78;80;84;82;82;80;79;80;78 07:48:09 INFO - PROCESS | 13031 | |11;stanford-crypto-ccm;135;128;135;134;138;130;131;134;161;127 07:48:09 INFO - PROCESS | 13031 | |12;stanford-crypto-pbkdf2;166;170;165;167;163;168;169;166;166;165 07:48:09 INFO - PROCESS | 13031 | |13;stanford-crypto-sha256-iterative;67;68;71;64;68;66;67;66;67;65 07:48:09 INFO - PROCESS | 13031 | __end_tp_report 07:48:09 INFO - PROCESS | 13031 | __start_cc_report 07:48:09 INFO - PROCESS | 13031 | _x_x_mozilla_cycle_collect,805 07:48:09 INFO - PROCESS | 13031 | __end_cc_report 07:48:09 INFO - PROCESS | 13031 | __startTimestamp1472827689409__endTimestamp 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | ------- Summary: start ------- 07:48:09 INFO - PROCESS | 13031 | Number of tests: 14 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.50 stddev:5.60 (4.9%) stddev-sans-first:5.70 07:48:09 INFO - PROCESS | 13031 | Values: 110.0 113.0 113.0 113.0 113.0 111.0 114.0 114.0 114.0 130.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.00 stddev:24.52 (15.8%) stddev-sans-first:25.88 07:48:09 INFO - PROCESS | 13031 | Values: 154.0 121.0 144.0 181.0 123.0 161.0 156.0 126.0 185.0 119.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:2.98 (1.8%) stddev-sans-first:3.05 07:48:09 INFO - PROCESS | 13031 | Values: 162.0 163.0 165.0 172.0 162.0 163.0 163.0 163.0 166.0 164.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.04 (52.7%) stddev-sans-first:41.76 07:48:09 INFO - PROCESS | 13031 | Values: 74.0 76.0 75.0 181.0 77.0 75.0 77.0 76.0 159.0 77.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:83.00 stddev:29.37 (35.4%) stddev-sans-first:30.43 07:48:09 INFO - PROCESS | 13031 | Values: 84.0 83.0 148.0 87.0 84.0 83.0 145.0 82.0 83.0 140.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 07:48:09 INFO - PROCESS | 13031 | Values: 119.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.05 07:48:09 INFO - PROCESS | 13031 | Values: 146.0 149.0 148.0 147.0 146.0 147.0 149.0 148.0 148.0 149.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 07:48:09 INFO - PROCESS | 13031 | Values: 96.0 97.0 95.0 96.0 97.0 95.0 95.0 96.0 96.0 96.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:2.78 (5.1%) stddev-sans-first:2.76 07:48:09 INFO - PROCESS | 13031 | Values: 52.0 53.0 54.0 58.0 54.0 54.0 59.0 53.0 52.0 59.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 07:48:09 INFO - PROCESS | 13031 | Values: 62.0 65.0 63.0 63.0 63.0 61.0 63.0 65.0 64.0 63.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.89 (2.4%) stddev-sans-first:2.00 07:48:09 INFO - PROCESS | 13031 | Values: 80.0 78.0 80.0 84.0 82.0 82.0 80.0 79.0 80.0 78.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.50 stddev:9.66 (7.2%) stddev-sans-first:10.25 07:48:09 INFO - PROCESS | 13031 | Values: 135.0 128.0 135.0 134.0 138.0 130.0 131.0 134.0 161.0 127.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:2.07 (1.2%) stddev-sans-first:2.19 07:48:09 INFO - PROCESS | 13031 | Values: 166.0 170.0 165.0 167.0 163.0 168.0 169.0 166.0 166.0 165.0 07:48:09 INFO - PROCESS | 13031 | 07:48:09 INFO - PROCESS | 13031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.91 (2.9%) stddev-sans-first:2.03 07:48:09 INFO - PROCESS | 13031 | Values: 67.0 68.0 71.0 64.0 68.0 66.0 67.0 66.0 67.0 65.0 07:48:09 INFO - PROCESS | 13031 | -------- Summary: end -------- 07:48:09 INFO - PROCESS | 13031 | 07:48:10 INFO - TEST-INFO | 13031: exit 0 07:48:10 INFO - TEST-OK | kraken | took 62745ms 07:48:10 INFO - SUITE-END | took 1177s 07:48:10 INFO - Completed test suite (00:19:37) 07:48:10 INFO - javascript benchmark 07:48:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.881668026596, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.517249826277, 3124.6562878083405, 3127.82796946168, 3138.8744450221993, 3158.0367987763725, 5296.629235953485, 5424.0779067558515, 5452.236686863837, 5497.862553436166, 5528.226048353234, 5412.972935135329, 5497.615166938316, 5509.118541033436, 5520.1167813149905, 5558.194061861028, 4969.776360063796, 5030.974845125769, 5044.697318160922, 5097.05704444677, 5117.948820511784, 5111.667741596784, 5121.56466700329, 5124.718140502271, 5185.507376799198, 5188.6367954243215, 4854.12625727369, 4913.606911447111, 4936.33359496467, 5043.848684539451, 5053.873653158664, 4914.21372580389, 4920.335754673145, 4945.208766597363, 5004.574611158056, 5034.647574669774, 4912.5578697917, 4935.975320123376, 4969.627277954131, 4985.152524070917, 4997.625178111656, 5388.91916621251, 5441.102218134043, 5450.945490545084, 5460.426655201187, 5468.699221542814, 5767.0, 5768.538516918637, 5773.595848290622, 5784.219130417424, 5786.884262314772, 5863.58954873159, 5872.207252020965, 5873.500752436005, 5876.970615146897, 5879.059350503899, 5400.432954539795, 5410.296661433988, 5418.620696551282, 5464.153056276284, 5507.366652834975, 5962.433568810956, 5964.284285885721, 5973.402659733992, 5978.641281523035, 5979.521638268928, 5674.687892165888, 5684.37471878093, 5693.373728889902, 5726.284214473191, 5728.05487094633, 5658.971705141448, 5792.044312688444, 5827.708614569255, 5850.795222167204, 5945.019071853096, 5693.743781529841, 5825.650460972271, 5844.386339434383, 5864.618799778001, 5879.588428810028, 5696.401877802771, 5849.385814489502, 5874.265716785402, 5885.058390657474, 5885.264341957255, 4402.141582391467, 4458.643308535309, 4478.037221997286, 4503.369528266046, 4547.567981041796, 3986.342253528135, 3991.3214753491975, 4025.456563363967, 4043.757374557536, 4047.615476529725, 5532.6680399175375, 5569.805056822992, 5574.581906356958, 5581.134924086773, 5600.355959064678, 5688.203651488795, 5780.855478613068, 5814.622049566765, 5920.585559010828, 5958.731857066442, 5536.335639723259, 5538.501534861801, 5542.778288868481, 5572.414896435897, 5578.9163162552595, 5042.823501177441, 5043.218301163325, 5043.52086551777, 5047.772850221749, 5104.617153713486, 5938.257717785277, 5990.041593345044, 6019.067044608093, 6040.09398590215, 6084.695765211633, 5938.792142275172, 5951.851203719942, 5955.642661440327, 5985.042393217064, 6006.669633170218, 6126.663033533198, 6151.907721384272, 6156.661383623765, 6159.784407545893, 6168.1056246844855, 5634.267545219095, 5736.541076713769, 5748.310202775694, 5813.709314534341, 5861.677607731615, 5852.648841069549, 5897.351291357862, 5904.557158213065, 5935.970320148372, 5955.225820643289, 5766.221560089334, 5767.077267637158, 5773.1051686988585, 5775.364709881994, 5777.0, 5613.494785469327, 5677.77288908439, 5708.143778433102, 5730.369659337386, 5758.510526605285, 5683.090705487102, 5698.2592263005545, 5711.714414279187, 5716.42835716425, 5740.540756739534, 5766.971165144148, 5827.79602713903, 5835.066389377679, 5836.737346819318, 5845.327787304344, 5471.06991811401, 5526.613137080366, 5552.805651802168, 5579.163125531203, 5686.943130568641], "value": 5403.744996636463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2076210809463, 579.7246308003697, 584.4155844155841, 602.9668368239746, 633.8637193003503, 42714.572854271486, 43681.0, 43829.34255986159, 43884.12231755363, 44004.339934901, 44282.114357712824, 44605.10789784211, 44671.77664111683, 44697.106057878824, 44753.552464475346, 8923.687670931518, 9108.316876234276, 9129.269658427309, 9137.862932055992, 9152.130547597968, 8896.37725359225, 8984.0, 8984.146506081912, 8993.505357205351, 9007.594658240396, 9005.639774409015, 9042.186203241707, 9042.86435703465, 9067.501287429188, 9070.637174513045, 8955.552222388887, 8991.64033438665, 9006.459612423276, 9019.143181397822, 9062.27501799861, 8894.42186257891, 8941.329400295004, 8957.0, 8977.281817454588, 8984.0, 41393.0, 41488.0, 41514.584854151675, 41515.377269340985, 41619.0, 3429.8285085745615, 3536.7524273300623, 3560.9109772255642, 4146.744805327803, 4226.640735537483, 32249.838750806095, 33457.49813752795, 33602.83198584016, 33718.32563348744, 33779.83110084458, 4335.241332766753, 4359.891002724926, 4406.735595864258, 4491.416115904912, 4607.516210797851, 343918.0, 351102.0, 351351.0, 351430.0, 351462.0, 58236.41763582395, 58783.412165878646, 58870.0, 58931.70534147302, 58974.41025589775, 61956.38043619596, 62233.37766622366, 62370.688146558976, 62466.375336246965, 62686.0, 16977.575560610836, 17162.742558861628, 17208.569785755455, 17235.74146387805, 17257.137143142794, 13708.45166193361, 13728.65678358029, 13773.931130344285, 13811.654708632364, 13885.514007009706, 16509.44103663934, 17659.470215893543, 17669.7349539757, 17739.11304434773, 17751.822481775016, 5731.942680573225, 6028.125921741323, 6036.486898613667, 6056.939430605726, 6091.725872335755, 903.629511900131, 975.6487664440796, 1047.528612124547, 1056.144522936424, 1158.3802665573878, 32004.0, 32539.0, 32782.0, 32964.17589560232, 33118.50322245168, 1015.243643485608, 1039.812833689943, 1040.4953597505205, 1062.8830828608848, 1073.1682945717132, 15997.28012239452, 16662.91691040103, 16686.83313166853, 16692.58268543296, 17094.743578846326, 531765.0, 539385.0, 543746.0, 552611.0, 861729.0, 57897.0, 58012.70993645089, 58190.12714809281, 58276.0, 58422.0, 1317.22942078883, 1333.2800287844454, 1354.5056054540023, 1358.8980826438058, 1363.5363976248123, 31106.844465777525, 32683.34633307368, 32833.34333313368, 32937.83531082329, 33284.833575831966, 50296.497035029184, 50467.0, 50564.24153637625, 50679.0, 50810.23784643159, 495830.0, 498090.0, 498306.0, 498803.0, 501105.0, 27923.44153116967, 28012.71987280101, 28105.859470702515, 28155.71844281531, 28175.914492398897, 46101.76949115233, 46754.53245467638, 46808.76595617, 48067.75966120287, 48095.27857082077, 39321.88815454087, 40702.79648601738, 40790.79604601958, 41634.375484367156, 42416.36375454309, 39745.2050958985, 40217.79891100526, 40796.59203407928, 41361.37957930694, 41479.58520414878, 39644.603553964094, 39655.60344396519, 39895.80052099721, 40018.199636007696, 40347.59652403439, 33862.0, 36568.0, 36665.633343666224, 37190.25619487649, 37299.440508391854, 27863.721362786113, 28096.43807123805, 28098.578521322605, 28177.718222817508, 28282.2929426766], "value": 20229.236981874878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.9222155568887, 405.75249098050165, 415.81496234175785, 418.4664552695313, 431.9092990472001, 18583.442496725103, 20392.184312627476, 20492.59014819703, 20521.48696282592, 20926.581468370663, 19428.51428714283, 19713.211471541155, 19765.703514447294, 19813.405597832087, 19901.50246243841, 5462.9726851365685, 5807.506361959238, 5860.765569377219, 5878.764849406019, 5887.558433117512, 5547.472990065938, 5715.571332150084, 5845.298564172305, 5846.619969701956, 5860.73626686798, 5720.856978575548, 5733.512651424634, 5743.368229494752, 5777.768889244425, 5780.0751879699255, 5585.357683866367, 5757.827265182052, 5759.712014399284, 5768.221290125843, 5772.740226689809, 5230.293910322096, 5232.398274198478, 5237.73811309433, 5241.475852414728, 5243.842684719464, 19641.901790491098, 23391.181308654286, 23580.0, 23793.16723914672, 23822.404439889142, 2280.0423821994636, 2291.2209848651537, 2369.4668699542635, 2439.7163120567375, 2979.0467050543834, 14720.190389528572, 14889.776653350209, 15050.32273547682, 15157.393704251817, 15527.301271442699, 1827.9817201827946, 1912.6079153773444, 1914.8468122550162, 1942.0678074524167, 1959.7844237133904, 71034.64482677553, 72118.63940680315, 72340.63829680817, 73775.26224737738, 74006.62996685036, 10713.78572428547, 10808.351498910091, 10929.344239345506, 11200.663980080612, 11247.943760281147, 15373.692526149414, 15477.5356739298, 15483.612909677124, 15497.070175789264, 15530.0, 8495.447795893248, 8697.565121743888, 8761.518116503654, 8775.91224087751, 8924.241439477588, 8352.290055345364, 8497.320214382835, 8559.40084194113, 8768.298536117096, 8869.467831930106, 6610.8016759497295, 6674.16572928384, 6675.833104172338, 6696.43080338167, 6826.146731658543, 1964.5481539246055, 2017.2636987499457, 2037.1647624473894, 2039.1129858511595, 2064.5045189154794, 972.7130496503548, 984.227381505529, 998.3560603410905, 1064.2656566968922, 1082.3451811653993, 18904.48764098869, 20456.590868182553, 20513.58972820565, 20709.792902071087, 20963.580728385346, 990.9900900991042, 1034.1519953637944, 1079.2930630437077, 1081.8269076947809, 1109.8612673415823, 10699.572017119228, 11533.76932461346, 11606.70983225426, 11688.766224675628, 11761.353125578175, 470075.0, 470983.0, 472083.0, 472394.0, 475179.0, 49645.75177124164, 70744.0, 81038.18961810424, 81636.0, 82245.17754822376, 1010.368519675203, 1018.4042335233823, 1032.3547782635853, 1034.01251804528, 1067.3809190669392, 18126.909365453615, 18185.0, 18846.905765471085, 18871.528211794266, 19119.330823421114, 44394.77802610966, 44522.77738611286, 44625.776871115435, 44703.329450058925, 46084.30873536832, 55234.723826380614, 55617.0, 56032.71983640219, 63294.0, 63325.36674633194, 7581.166071731995, 7609.505382150142, 7848.60756962161, 8105.27052565272, 8178.5092894426525, 11944.820827687417, 12970.351482425653, 13152.0, 13545.255010974492, 13759.587212383645, 11821.468033938665, 11836.289822610672, 11900.166988310735, 12065.577704780291, 12283.324417157142, 11320.377379243891, 11427.485763140845, 11711.941440292743, 12039.819402709141, 12231.143819932875, 11803.822942655695, 12016.75966480683, 12038.578649747216, 12105.394730263628, 12145.089118316338, 7960.442769006114, 7977.282044616012, 8071.798205044921, 8341.374396920133, 8347.833043338978, 10917.508712108132, 12091.274523528617, 12335.444904979477, 12339.383030848601, 12627.052971027393], "value": 9478.93660542757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.4737841755386, 1519.6124988128026, 1657.2632249904138, 1729.1786401459317, 1803.873728838981, 7831.530108193512, 8332.333413326935, 8728.781780455492, 8952.0, 8961.148690874374, 8904.688335908244, 8967.596458159382, 9002.459852408843, 9078.182963533282, 9095.590698418571, 2436.2082323244927, 2449.9142530011454, 2461.950760984779, 2462.1382516119306, 2467.284487498623, 2399.904003839853, 2404.3748625357357, 2473.418746594549, 2476.7399423060588, 2476.8018558515278, 2408.7832095111435, 2433.051110067075, 2433.245693834908, 2435.1111844176926, 2457.3979375053136, 2391.497785465054, 2394.6288325309606, 2406.0736616402723, 2417.673614062114, 2453.9509209815706, 2273.4089136824377, 2343.0627748900406, 2345.6012477878803, 2354.799842013431, 2356.905723771047, 8969.416987895765, 8972.10278972104, 9036.186743193144, 9065.68270110543, 9133.36066475347, 5114.462981386975, 5266.552343050846, 5268.315119034501, 5272.630915835893, 5283.709395983219, 3150.9054728358187, 3345.866165353383, 3381.4082535556427, 3389.8305084745666, 3438.0889064397957, 1003.3578509753763, 1068.1881769854888, 1108.8613923259593, 1119.1270808769173, 1134.0190735014237, 12596.307203103917, 12609.18040327385, 12677.049221308347, 12719.364031798374, 12752.10735248533, 4414.139242847614, 4606.262997920317, 4698.201305778026, 4718.339432479455, 4774.212254977959, 10183.643572474928, 10185.287029907835, 10186.337888037255, 10201.13290370312, 10209.591616335263, 5355.491228333302, 5357.785688572491, 5361.812336568201, 5368.167933970163, 5368.275282836845, 4424.11517696462, 4857.514248575114, 4924.3352147460355, 4938.604911607134, 4979.576735977483, 4012.1373904610064, 4043.6765058795227, 4061.679954014957, 4077.6941729370415, 4141.171765646883, 1352.1751731443812, 1369.8630136986221, 1370.3353873371407, 1381.2679279981626, 1381.5648070857649, 862.4566523090413, 864.049545499945, 886.1847100667402, 887.0464250930276, 902.9187373136449, 6163.9383606164265, 6223.626582405071, 6226.5641405101205, 6331.96834015827, 6511.674416279167, 960.7838236396755, 976.6239997600833, 990.1732053735068, 999.835027220515, 1036.2797855490512, 4118.258713431551, 4363.869083927424, 4444.82220711168, 4450.35469856869, 4537.410136682276, 10977.890221097847, 11300.94349528247, 11328.94335528317, 11404.771904562029, 11429.771404572028, 10983.121350291958, 11009.61466348674, 11364.659060228207, 11383.43082845871, 11401.543938242543, 8329.541875196923, 8365.414420990593, 8414.410991230678, 8436.957815210884, 8442.451240669337, 6120.60216085953, 6220.595661282002, 6226.221722284715, 6227.719752611234, 6232.8130156095385, 10001.499925003865, 10138.18894488454, 10143.54354054084, 10145.695629131138, 10314.587416503557, 10232.488375581042, 10459.477026148814, 10471.68584942453, 10553.366797992145, 10621.681349559525, 7424.554526728413, 7442.888356674546, 7495.475316727777, 7495.850082998419, 7513.060867391576, 8790.824183516166, 8799.91200087991, 8802.163794439519, 8833.24917382004, 8839.204471597586, 7746.767596972099, 7815.843683126419, 7844.372450204084, 8005.879911801211, 8095.5142691438705, 7422.703091876265, 7586.24137586237, 7749.186335434698, 7837.804054898673, 7958.045034595885, 6784.118064651761, 7107.395871350786, 7212.4230061596, 7212.639368031472, 7213.422926165789, 5310.442403547727, 5334.866628334323, 5347.759350829144, 5382.757775900016, 5589.189567512769, 5457.61796674229, 5473.808416705396, 5496.80761173357, 5541.556675465872, 5594.552435805044], "value": 4746.268129830566, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.4453939224533, 324.90090522390676, 325.941330560499, 339.8623557459229, 349.2996541933423, 5553.305836770403, 5554.472325129112, 5576.219329293902, 5585.385607583167, 5605.915911261324, 5485.561155107592, 5497.367802702691, 5497.5601951843855, 5522.254495643087, 5557.360903496089, 4033.9225298970982, 4117.3206420940505, 4186.518550366701, 4243.363495475673, 4268.509121451027, 4243.469566304212, 4246.0, 4246.341817018351, 4258.0, 4271.231178387889, 4246.723962942398, 4249.46881639795, 4251.82992680294, 4255.489341279051, 4261.4673165854265, 3985.6412922837085, 4204.201201771653, 4227.943014246438, 4232.32282834748, 4252.638525725317, 3718.7025037996896, 3722.3671975764187, 3723.6276372362818, 3726.6273372662786, 3751.1747415568802, 5367.973160134214, 5377.623566350357, 5390.865228369283, 5395.460453954613, 5395.595330350239, 4633.2818413146015, 4835.226363781778, 4888.511148885119, 4926.531979461945, 4932.778024988884, 5722.256106706143, 5722.570807189478, 5730.0, 5730.914036289459, 5732.22614946981, 4032.9395059074136, 4045.676345892351, 4054.878353649395, 4056.5599212279512, 4062.5124985001694, 5819.854503637401, 5904.409559044061, 5961.463468287875, 5966.3138739045135, 6013.218281623361, 4077.6330130287824, 4095.8976025599004, 4107.650849677811, 4109.3425051991535, 4113.444684967491, 4154.605312495308, 4156.750594964251, 4165.812538435777, 4167.541570427311, 4170.436991006175, 4717.976410117927, 4803.231482962709, 4831.806727730922, 4839.903201936012, 4883.877903052452, 5799.652020878761, 5805.912911306334, 5828.737706803204, 5833.949889019932, 5853.9414605854245, 1474.8525147485166, 1486.8215814102161, 1504.5561559340022, 1505.1796770759963, 1505.4505105636583, 895.9239893750698, 937.4890684576922, 953.3374304858057, 1002.6991902429243, 1031.5409642709074, 5569.944300557024, 5587.357453892854, 5601.047821870292, 5601.5238704710555, 5605.32736071674, 5934.468990950378, 5938.910916336258, 5964.628135528853, 5967.224260846149, 5974.1934838796205, 5264.052300648785, 5544.750486228129, 5571.9442805572235, 5584.441555844464, 5625.212470254168, 3131.4676504994204, 3147.2918593316776, 3149.5590617313137, 3150.779445438843, 3160.920976975594, 5844.240248767633, 5949.679624946274, 6005.639661620229, 6043.486303664238, 6064.848378790477, 5870.26621672291, 5938.2280303560265, 5950.899083669448, 5982.0, 5985.491233245136, 6013.496625843539, 6075.635461872302, 6089.269287685506, 6092.238470191226, 6099.420555047263, 5749.367569567428, 5833.79581714638, 5847.7368518417625, 5859.179714839841, 5868.618539794899, 5720.170575266647, 5742.052561327334, 5770.711464426846, 5805.82582522525, 5830.941690583039, 5845.2920911095225, 5948.672822994604, 5985.221921150222, 6000.87998240024, 6021.638701677914, 4234.2801723706425, 4251.277282861983, 4257.808398622007, 4258.765767882796, 4259.935016245939, 5835.241418615723, 5913.438223368773, 5915.40845915405, 5944.3164036136395, 5950.940490595039, 5653.689047102449, 5729.598928074995, 5742.684152371659, 5773.538116950718, 5809.215755873072, 5641.407652196624, 5761.0, 5761.859786416497, 5806.912896306474, 5812.593118481665, 5422.972885135707, 5622.269105016322, 5622.313306008263, 5728.0786798732115, 5729.570282228933, 5762.30852297727, 5801.0, 5829.213056237354, 5844.736986835517, 5856.0, 5710.543156547549, 5737.885242295214, 5741.684207368635, 5754.223179870832, 5780.21967034445], "value": 4373.091316457858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.7780971184364, 744.4528271720288, 746.1493896957469, 799.6406109613655, 812.4759530103082, 14904.925475372622, 15945.282462289197, 16268.430604928815, 16290.0, 16692.248848801803, 14546.854531454683, 14903.403863845433, 14916.850831491682, 14954.40182392703, 15003.474878379258, 779.7699678594814, 785.4462603864262, 817.9018517777845, 824.9010118785754, 825.3768404854327, 819.1767273889733, 824.4805772363433, 827.5283088639478, 827.6399766101765, 828.1345993436873, 870.9912900871005, 876.3383645347753, 877.934154938379, 878.9384743067988, 879.4064006795387, 862.9482231066124, 866.3069544364483, 869.7216890595012, 874.8381549413347, 875.1729615513342, 633.2464367402775, 634.0964126120306, 634.3973225435855, 635.7615894039735, 641.2913730327967, 15865.682686346325, 16035.438759643474, 16037.518874433787, 16068.919655401649, 16098.517044488684, 14887.330070146869, 15015.174165420898, 15110.0, 15153.924230378887, 15222.391104355813, 10980.505877235544, 11006.889931100746, 11166.720831979184, 11289.604863829809, 11971.880281197251, 3773.924521509582, 3774.8678796242275, 3895.474110995036, 3991.0621004064024, 3996.1208534122447, 86427.0, 87363.0, 88637.11362886353, 89301.55349223278, 90036.09963900343, 10805.621803236849, 10932.398718070423, 11471.780339945304, 11572.537098515964, 11688.590899318484, 21553.461163470725, 21701.34895953124, 21709.240176593743, 21714.0, 21714.89142554277, 8613.526256055851, 8669.783255418664, 8693.826123477622, 8697.91302086971, 8793.736187914374, 4856.150173719585, 4912.214045752662, 4916.385451818523, 5044.041632089891, 5173.146430838945, 3411.8635254590035, 3525.2420729543273, 3535.6287589803214, 3537.3809583322814, 3542.132177616449, 609.7896225802091, 627.7865525721277, 640.0750914927885, 640.3884290502559, 652.1815122021832, 682.6313790553145, 712.3268511256916, 762.0854974031184, 768.0, 776.1384862802284, 9270.212031977357, 9795.657151999645, 9885.15976142036, 10048.648297309559, 10469.895301046892, 706.4030893894651, 716.4197000429668, 734.8683028136717, 772.764306886405, 783.7452827830978, 4761.142994260997, 4920.6309526785635, 4950.6782059166035, 4969.229769385679, 4973.602111831045, 77658.6117069411, 124206.0, 126977.0, 129048.0, 134118.0, 111310.0, 114631.0, 116104.0, 116244.0, 118164.40917795528, 77747.22252777513, 78240.60879695565, 79014.604926975, 84422.99999999878, 101145.98854011513, 9497.43015419077, 9918.355306905316, 10240.795184096425, 10376.481175941324, 10561.577536898438, 49924.0, 50509.40321338934, 50877.49122508727, 51420.48579514307, 52584.73707631438, 74631.25368746243, 75206.0, 75308.62345688237, 76390.61804690941, 79390.0, 12324.753504929671, 12626.116171868249, 12693.873061269269, 12716.554920577735, 12910.483580656668, 13668.453261869414, 13679.452821887411, 13875.861241387456, 14468.493602723855, 14588.416463341347, 13120.671983200114, 13182.934085329513, 13321.13412628176, 13472.797908031584, 13474.383074031179, 13374.866251337362, 13474.26406614322, 13754.120593563286, 13901.30493475302, 14031.649208769453, 11468.483918223867, 12926.806097908351, 12967.286799226133, 12994.155379900276, 13658.726825463236, 11028.22802403824, 11185.272957258077, 11265.704443989047, 11485.712857178638, 11973.221740586834, 11337.886621133683, 11511.827322590336, 11934.28394296345, 12101.878981210075, 12183.269003859443], "value": 7714.4397026266315, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 113.0, 113.0, 111.0, 114.0, 114.0, 114.0, 130.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 144.0, 181.0, 123.0, 161.0, 156.0, 126.0, 185.0, 119.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 172.0, 162.0, 163.0, 163.0, 163.0, 166.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 181.0, 77.0, 75.0, 77.0, 76.0, 159.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 148.0, 87.0, 84.0, 83.0, 145.0, 82.0, 83.0, 140.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 148.0, 147.0, 146.0, 147.0, 149.0, 148.0, 148.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 58.0, 54.0, 54.0, 59.0, 53.0, 52.0, 59.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 63.0, 61.0, 63.0, 65.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 84.0, 82.0, 82.0, 80.0, 79.0, 80.0, 78.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 135.0, 134.0, 138.0, 130.0, 131.0, 134.0, 161.0, 127.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 165.0, 167.0, 163.0, 168.0, 169.0, 166.0, 166.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 64.0, 68.0, 66.0, 67.0, 66.0, 67.0, 65.0], "value": 66.9, "unit": "score"}]}]} 07:48:10 INFO - Return code: 0 07:48:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:48:10 ERROR - # TBPL SUCCESS # 07:48:10 INFO - Running post-action listener: _resource_record_post_action 07:48:10 INFO - [mozharness: 2016-09-02 14:48:10.707082Z] Finished run-tests step (success) 07:48:10 INFO - Running post-run listener: _resource_record_post_run 07:48:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 304705536; Read time: 312; Write time: 265492 07:48:10 INFO - TinderboxPrint: CPU usage
13.4% 07:48:10 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 312 07:48:10 INFO - TinderboxPrint: I/O write bytes / time
304,705,536 / 265,492 07:48:10 INFO - TinderboxPrint: CPU idle
8,245.2 (86.6%) 07:48:10 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 07:48:10 INFO - TinderboxPrint: Swap in / out
0 / 0 07:48:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13729792; Read time: 0; Write time: 5108 07:48:10 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290975744; Read time: 300; Write time: 260384 07:48:11 INFO - Running post-run listener: _upload_blobber_files 07:48:11 INFO - Blob upload gear active. 07:48:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:11 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 07:48:11 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:48:11 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:48:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:15 INFO - (blobuploader) - INFO - Done attempting. 07:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:16 INFO - (blobuploader) - INFO - Done attempting. 07:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:17 INFO - (blobuploader) - INFO - Done attempting. 07:48:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:17 INFO - Return code: 0 07:48:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/009394c5ac793ccb3900c08d2856e95bc3c58266644cdde97907a1ec463d9e3967f51ebe646cc400ba95bdd91b81666f9880be6cec9e21048bd7f89c43175031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73949387f1dab1a1b9a780db8212b55cfd47debd95d08fdf18e97f1a271e1c043d2730b1942f52fee4b160f4c83edcfbdfa1eaf55602cc6b8f1475e7904ccee8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c26406fc02bc0f6335c67a402e4faef2e8fb08d770c76f68c27ae119bbe936a178d769dd0187cbeb1c1eddc80546508fafd84185d340f7660e158a2fb47e5007"} 07:48:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:17 INFO - Contents: 07:48:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/009394c5ac793ccb3900c08d2856e95bc3c58266644cdde97907a1ec463d9e3967f51ebe646cc400ba95bdd91b81666f9880be6cec9e21048bd7f89c43175031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73949387f1dab1a1b9a780db8212b55cfd47debd95d08fdf18e97f1a271e1c043d2730b1942f52fee4b160f4c83edcfbdfa1eaf55602cc6b8f1475e7904ccee8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c26406fc02bc0f6335c67a402e4faef2e8fb08d770c76f68c27ae119bbe936a178d769dd0187cbeb1c1eddc80546508fafd84185d340f7660e158a2fb47e5007"} 07:48:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:17 INFO - Copying logs to upload dir... 07:48:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.135870 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-02 07:48:17.677518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 07:48:17.681072) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/009394c5ac793ccb3900c08d2856e95bc3c58266644cdde97907a1ec463d9e3967f51ebe646cc400ba95bdd91b81666f9880be6cec9e21048bd7f89c43175031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73949387f1dab1a1b9a780db8212b55cfd47debd95d08fdf18e97f1a271e1c043d2730b1942f52fee4b160f4c83edcfbdfa1eaf55602cc6b8f1475e7904ccee8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c26406fc02bc0f6335c67a402e4faef2e8fb08d770c76f68c27ae119bbe936a178d769dd0187cbeb1c1eddc80546508fafd84185d340f7660e158a2fb47e5007"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1472815801/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/009394c5ac793ccb3900c08d2856e95bc3c58266644cdde97907a1ec463d9e3967f51ebe646cc400ba95bdd91b81666f9880be6cec9e21048bd7f89c43175031", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73949387f1dab1a1b9a780db8212b55cfd47debd95d08fdf18e97f1a271e1c043d2730b1942f52fee4b160f4c83edcfbdfa1eaf55602cc6b8f1475e7904ccee8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c26406fc02bc0f6335c67a402e4faef2e8fb08d770c76f68c27ae119bbe936a178d769dd0187cbeb1c1eddc80546508fafd84185d340f7660e158a2fb47e5007"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 07:48:17.707835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:48:17.708156) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472822226.60410-1977727433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 07:48:17.793565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 07:48:17.793892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 07:48:17.794201) ========= ========= Total master_lag: 0.18 =========