builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1471918678.55 results: success (0) buildid: 20160822191704 builduid: f6bf3f3df3b44ed3a84dcfe38b3fe188 revision: 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.550991) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.551503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.551822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.564233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.564549) ========= 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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 19:17:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-08-22 19:17:59 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.708615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.709099) ========= 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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019204 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.759133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:58.759543) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 --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 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 --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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 19:17:59,161 truncating revision to first 12 chars 2016-08-22 19:17:59,161 Setting DEBUG logging. 2016-08-22 19:17:59,161 attempt 1/10 2016-08-22 19:17:59,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7fab74549bba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 19:17:59,467 unpacking tar archive at: mozilla-inbound-7fab74549bba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:59.348350) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:59.348718) ========= script_repo_revision: 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:59.349180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:59.349519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 19:17:59.360303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-22 19:17:59.360667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:59 INFO - MultiFileLogger online at 20160822 19:17:59 in /builds/slave/test 19:17:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:59 INFO - {'append_to_log': False, 19:17:59 INFO - 'base_work_dir': '/builds/slave/test', 19:17:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:59 INFO - 'branch': 'Mozilla-Inbound', 19:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:59 INFO - 'config_files': ('talos/linux_config.py',), 19:17:59 INFO - 'default_actions': ('clobber', 19:17:59 INFO - 'read-buildbot-config', 19:17:59 INFO - 'download-and-extract', 19:17:59 INFO - 'populate-webroot', 19:17:59 INFO - 'create-virtualenv', 19:17:59 INFO - 'install', 19:17:59 INFO - 'run-tests'), 19:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:59 INFO - 'download_minidump_stackwalk': True, 19:17:59 INFO - 'download_symbols': 'ondemand', 19:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:59 INFO - 'installer_path': 'installer.exe', 19:17:59 INFO - 'log_level': 'info', 19:17:59 INFO - 'log_name': 'talos', 19:17:59 INFO - 'log_to_console': True, 19:17:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:59 INFO - 'opt_config_files': (), 19:17:59 INFO - 'pip_index': False, 19:17:59 INFO - 'sps_profile': False, 19:17:59 INFO - 'sps_profile_interval': 0, 19:17:59 INFO - 'suite': 'dromaeojs', 19:17:59 INFO - 'system_bits': '32', 19:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:59 INFO - 'title': 'talos-linux64-ix-003', 19:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:59 INFO - 'use_talos_json': True, 19:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:59 INFO - 'work_dir': 'build'} 19:17:59 INFO - [mozharness: 2016-08-23 02:17:59.858932Z] Running clobber step. 19:17:59 INFO - Running pre-action listener: _resource_record_pre_action 19:17:59 INFO - Running main action method: clobber 19:17:59 INFO - rmtree: /builds/slave/test/build 19:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:00 INFO - Running post-action listener: _resource_record_post_action 19:18:00 INFO - [mozharness: 2016-08-23 02:18:00.838107Z] Finished clobber step (success) 19:18:00 INFO - [mozharness: 2016-08-23 02:18:00.838206Z] Running read-buildbot-config step. 19:18:00 INFO - Running pre-action listener: _resource_record_pre_action 19:18:00 INFO - Running main action method: read_buildbot_config 19:18:00 INFO - Using buildbot properties: 19:18:00 INFO - { 19:18:00 INFO - "project": "", 19:18:00 INFO - "product": "firefox", 19:18:00 INFO - "script_repo_revision": "production", 19:18:00 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:18:00 INFO - "repository": "", 19:18:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:18:00 INFO - "buildid": "20160822191704", 19:18:00 INFO - "stage_platform": "linux64-pgo", 19:18:00 INFO - "basedir": "/builds/slave/test", 19:18:00 INFO - "buildnumber": 1442, 19:18:00 INFO - "platform": "ubuntu64_hw", 19:18:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:18:00 INFO - "slavebuilddir": "test", 19:18:00 INFO - "branch": "mozilla-inbound", 19:18:00 INFO - "revision": "7fab74549bbabc0ab0e64a19fd83f4c5660716b4", 19:18:00 INFO - "slavename": "talos-linux64-ix-003", 19:18:00 INFO - "builduid": "f6bf3f3df3b44ed3a84dcfe38b3fe188", 19:18:00 INFO - "repo_path": "integration/mozilla-inbound" 19:18:00 INFO - } 19:18:00 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:18:00 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 19:18:00 INFO - Running post-action listener: _resource_record_post_action 19:18:00 INFO - [mozharness: 2016-08-23 02:18:00.840530Z] Finished read-buildbot-config step (success) 19:18:00 INFO - [mozharness: 2016-08-23 02:18:00.840618Z] Running download-and-extract step. 19:18:00 INFO - Running pre-action listener: _resource_record_pre_action 19:18:00 INFO - Running main action method: download_and_extract 19:18:00 INFO - mkdir: /builds/slave/test/build/tests 19:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:18:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:01 INFO - Downloaded 1361 bytes. 19:18:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:18:01 INFO - Using the following test package requirements: 19:18:01 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:18:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:18:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'jsshell-linux-x86_64.zip'], 19:18:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:18:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:18:01 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:18:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:18:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:01 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:18:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:18: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')]} 19:18:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:04 INFO - Downloaded 21914480 bytes. 19:18:04 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 19:18:09 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 19:18:09 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')]} 19:18:09 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:09 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:09 INFO - Downloaded 21914480 bytes. 19:18:09 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 19:18:14 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')]} 19:18:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:18 INFO - Downloaded 14413981 bytes. 19:18:18 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 19:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:19 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:19 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/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 19:18:23 INFO - Downloaded 59767404 bytes. 19:18:23 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:23 INFO - mkdir: /builds/slave/test/properties 19:18:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:23 INFO - Contents: 19:18:23 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:24 INFO - Running post-action listener: _resource_record_post_action 19:18:24 INFO - Running post-action listener: set_extra_try_arguments 19:18:24 INFO - [mozharness: 2016-08-23 02:18:24.225532Z] Finished download-and-extract step (success) 19:18:24 INFO - [mozharness: 2016-08-23 02:18:24.225757Z] Running populate-webroot step. 19:18:24 INFO - Running pre-action listener: _resource_record_pre_action 19:18:24 INFO - Running main action method: populate_webroot 19:18:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:24 INFO - '--tppagecycles', 19:18:24 INFO - '7'], 19:18:24 INFO - 'tests': ['tsvgm']}}, 19:18:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['damp', 'tps']}, 19:18:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'tests': ['damp', 'tps']}, 19:18:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['dromaeo_dom']}, 19:18:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['basic_compositor_video']}, 19:18:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:18:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['a11yr', 19:18:24 INFO - 'ts_paint', 19:18:24 INFO - 'tpaint', 19:18:24 INFO - 'sessionrestore', 19:18:24 INFO - 'sessionrestore_no_auto_restore', 19:18:24 INFO - 'tabpaint']}, 19:18:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['tsvgx', 19:18:24 INFO - 'tsvgr_opacity', 19:18:24 INFO - 'tart', 19:18:24 INFO - 'tscrollx', 19:18:24 INFO - 'cart']}, 19:18:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:24 INFO - 'tsvgr_opacity', 19:18:24 INFO - 'tart', 19:18:24 INFO - 'tscrollx', 19:18:24 INFO - 'cart']}, 19:18:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'talos_options': ['--disable-e10s'], 19:18:24 INFO - 'tests': ['tp5o']}, 19:18:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'tests': ['tp5o']}, 19:18:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'talos_options': ['--disable-e10s', 19:18:24 INFO - '--xperf_path', 19:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:24 INFO - 'tests': ['tp5n']}, 19:18:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:24 INFO - 'talos_options': ['--xperf_path', 19:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:24 INFO - 'tests': ['tp5n']}}, 19:18:24 INFO - 'talos.zip': {'path': '', 19:18:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:24 INFO - Running post-action listener: _resource_record_post_action 19:18:24 INFO - [mozharness: 2016-08-23 02:18:24.241170Z] Finished populate-webroot step (success) 19:18:24 INFO - [mozharness: 2016-08-23 02:18:24.241258Z] Running create-virtualenv step. 19:18:24 INFO - Running pre-action listener: _resource_record_pre_action 19:18:24 INFO - Running main action method: create_virtualenv 19:18:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:18:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:24 INFO - Using real prefix '/usr' 19:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:26 INFO - Installing pip.................done. 19:18:26 INFO - Return code: 0 19:18:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18:26 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')]} 19:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 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')]} 19:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:18:26 INFO - Using env: {'DISPLAY': ':0', 19:18:26 INFO - 'HOME': '/home/cltbld', 19:18:26 INFO - 'LANG': 'en_US.UTF-8', 19:18:26 INFO - 'LANGUAGE': 'en_US:en', 19:18:26 INFO - 'LOGNAME': 'cltbld', 19:18:26 INFO - 'MAIL': '/var/mail/cltbld', 19:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:26 INFO - 'MOZ_NO_REMOTE': '1', 19:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:26 INFO - 'NO_EM_RESTART': '1', 19:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:26 INFO - 'PWD': '/builds/slave/test', 19:18:26 INFO - 'SHELL': '/bin/bash', 19:18:26 INFO - 'SHLVL': '1', 19:18:26 INFO - 'TERM': 'linux', 19:18:26 INFO - 'TMOUT': '86400', 19:18:26 INFO - 'USER': 'cltbld', 19:18:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:26 INFO - '_': '/tools/buildbot/bin/python'} 19:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:18:27 INFO - Cleaning up... 19:18:27 INFO - Return code: 0 19:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18:27 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')]} 19:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:27 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')]} 19:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:27 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:18:27 INFO - Using env: {'DISPLAY': ':0', 19:18:27 INFO - 'HOME': '/home/cltbld', 19:18:27 INFO - 'LANG': 'en_US.UTF-8', 19:18:27 INFO - 'LANGUAGE': 'en_US:en', 19:18:27 INFO - 'LOGNAME': 'cltbld', 19:18:27 INFO - 'MAIL': '/var/mail/cltbld', 19:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:27 INFO - 'MOZ_NO_REMOTE': '1', 19:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:27 INFO - 'NO_EM_RESTART': '1', 19:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:27 INFO - 'PWD': '/builds/slave/test', 19:18:27 INFO - 'SHELL': '/bin/bash', 19:18:27 INFO - 'SHLVL': '1', 19:18:27 INFO - 'TERM': 'linux', 19:18:27 INFO - 'TMOUT': '86400', 19:18:27 INFO - 'USER': 'cltbld', 19:18:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:27 INFO - '_': '/tools/buildbot/bin/python'} 19:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:27 INFO - Downloading/unpacking psutil>=3.1.1 19:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:29 INFO - Installing collected packages: psutil 19:18:29 INFO - Running setup.py install for psutil 19:18:29 INFO - building 'psutil._psutil_linux' extension 19:18:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:18:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:18:29 INFO - building 'psutil._psutil_posix' extension 19:18:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:18:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:29 INFO - Successfully installed psutil 19:18:29 INFO - Cleaning up... 19:18:29 INFO - Return code: 0 19:18:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:29 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:18:29 INFO - Using env: {'DISPLAY': ':0', 19:18:29 INFO - 'HOME': '/home/cltbld', 19:18:29 INFO - 'LANG': 'en_US.UTF-8', 19:18:29 INFO - 'LANGUAGE': 'en_US:en', 19:18:29 INFO - 'LOGNAME': 'cltbld', 19:18:29 INFO - 'MAIL': '/var/mail/cltbld', 19:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:29 INFO - 'MOZ_NO_REMOTE': '1', 19:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:29 INFO - 'NO_EM_RESTART': '1', 19:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:29 INFO - 'PWD': '/builds/slave/test', 19:18:29 INFO - 'SHELL': '/bin/bash', 19:18:29 INFO - 'SHLVL': '1', 19:18:29 INFO - 'TERM': 'linux', 19:18:29 INFO - 'TMOUT': '86400', 19:18:29 INFO - 'USER': 'cltbld', 19:18:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:29 INFO - '_': '/tools/buildbot/bin/python'} 19:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:31 INFO - Installing collected packages: mozsystemmonitor 19:18:31 INFO - Running setup.py install for mozsystemmonitor 19:18:32 INFO - Successfully installed mozsystemmonitor 19:18:32 INFO - Cleaning up... 19:18:32 INFO - Return code: 0 19:18:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:32 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:18:32 INFO - Using env: {'DISPLAY': ':0', 19:18:32 INFO - 'HOME': '/home/cltbld', 19:18:32 INFO - 'LANG': 'en_US.UTF-8', 19:18:32 INFO - 'LANGUAGE': 'en_US:en', 19:18:32 INFO - 'LOGNAME': 'cltbld', 19:18:32 INFO - 'MAIL': '/var/mail/cltbld', 19:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:32 INFO - 'MOZ_NO_REMOTE': '1', 19:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:32 INFO - 'NO_EM_RESTART': '1', 19:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:32 INFO - 'PWD': '/builds/slave/test', 19:18:32 INFO - 'SHELL': '/bin/bash', 19:18:32 INFO - 'SHLVL': '1', 19:18:32 INFO - 'TERM': 'linux', 19:18:32 INFO - 'TMOUT': '86400', 19:18:32 INFO - 'USER': 'cltbld', 19:18:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:32 INFO - '_': '/tools/buildbot/bin/python'} 19:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:34 INFO - warning: no files found matching '*.txt' 19:18:34 INFO - no previously-included directories found matching 'build' 19:18:34 INFO - no previously-included directories found matching 'dist' 19:18:34 INFO - no previously-included directories found matching '.git*' 19:18:34 INFO - Installing collected packages: jsonschema, functools32 19:18:34 INFO - Running setup.py install for functools32 19:18:34 INFO - warning: no files found matching '*.txt' 19:18:34 INFO - no previously-included directories found matching 'build' 19:18:34 INFO - no previously-included directories found matching 'dist' 19:18:34 INFO - no previously-included directories found matching '.git*' 19:18:34 INFO - Successfully installed jsonschema functools32 19:18:34 INFO - Cleaning up... 19:18:34 INFO - Return code: 0 19:18:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:18:34 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')]} 19:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:34 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')]} 19:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:18:34 INFO - Using env: {'DISPLAY': ':0', 19:18:34 INFO - 'HOME': '/home/cltbld', 19:18:34 INFO - 'LANG': 'en_US.UTF-8', 19:18:34 INFO - 'LANGUAGE': 'en_US:en', 19:18:34 INFO - 'LOGNAME': 'cltbld', 19:18:34 INFO - 'MAIL': '/var/mail/cltbld', 19:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:34 INFO - 'MOZ_NO_REMOTE': '1', 19:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:34 INFO - 'NO_EM_RESTART': '1', 19:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:34 INFO - 'PWD': '/builds/slave/test', 19:18:34 INFO - 'SHELL': '/bin/bash', 19:18:34 INFO - 'SHLVL': '1', 19:18:34 INFO - 'TERM': 'linux', 19:18:34 INFO - 'TMOUT': '86400', 19:18:34 INFO - 'USER': 'cltbld', 19:18:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:34 INFO - '_': '/tools/buildbot/bin/python'} 19:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:18:34 INFO - Cleaning up... 19:18:34 INFO - Return code: 0 19:18:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18:34 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')]} 19:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:34 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')]} 19:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:18:34 INFO - Using env: {'DISPLAY': ':0', 19:18:34 INFO - 'HOME': '/home/cltbld', 19:18:34 INFO - 'LANG': 'en_US.UTF-8', 19:18:34 INFO - 'LANGUAGE': 'en_US:en', 19:18:34 INFO - 'LOGNAME': 'cltbld', 19:18:34 INFO - 'MAIL': '/var/mail/cltbld', 19:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:34 INFO - 'MOZ_NO_REMOTE': '1', 19:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:34 INFO - 'NO_EM_RESTART': '1', 19:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:34 INFO - 'PWD': '/builds/slave/test', 19:18:34 INFO - 'SHELL': '/bin/bash', 19:18:34 INFO - 'SHLVL': '1', 19:18:34 INFO - 'TERM': 'linux', 19:18:34 INFO - 'TMOUT': '86400', 19:18:34 INFO - 'USER': 'cltbld', 19:18:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:34 INFO - '_': '/tools/buildbot/bin/python'} 19:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:37 INFO - Downloading docopt-0.6.1.tar.gz 19:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:37 INFO - Running setup.py install for blobuploader 19:18:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:37 INFO - Running setup.py install for requests 19:18:38 INFO - Running setup.py install for docopt 19:18:38 INFO - Successfully installed blobuploader requests docopt 19:18:38 INFO - Cleaning up... 19:18:38 INFO - Return code: 0 19:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:38 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')]} 19:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:38 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')]} 19:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:38 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:38 INFO - Using env: {'DISPLAY': ':0', 19:18:38 INFO - 'HOME': '/home/cltbld', 19:18:38 INFO - 'LANG': 'en_US.UTF-8', 19:18:38 INFO - 'LANGUAGE': 'en_US:en', 19:18:38 INFO - 'LOGNAME': 'cltbld', 19:18:38 INFO - 'MAIL': '/var/mail/cltbld', 19:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:38 INFO - 'MOZ_NO_REMOTE': '1', 19:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:38 INFO - 'NO_EM_RESTART': '1', 19:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:38 INFO - 'PWD': '/builds/slave/test', 19:18:38 INFO - 'SHELL': '/bin/bash', 19:18:38 INFO - 'SHLVL': '1', 19:18:38 INFO - 'TERM': 'linux', 19:18:38 INFO - 'TMOUT': '86400', 19:18:38 INFO - 'USER': 'cltbld', 19:18:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:38 INFO - '_': '/tools/buildbot/bin/python'} 19:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:38 INFO - Running setup.py (path:/tmp/pip-bogmfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:38 INFO - Running setup.py (path:/tmp/pip-2ZTWCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:38 INFO - Running setup.py (path:/tmp/pip-RbqLWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:38 INFO - Running setup.py (path:/tmp/pip-_9eEgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:38 INFO - Running setup.py (path:/tmp/pip-FffzVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:38 INFO - Running setup.py (path:/tmp/pip-I1io24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:39 INFO - Running setup.py (path:/tmp/pip-bwBukN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:39 INFO - Running setup.py (path:/tmp/pip-YxTsXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:39 INFO - Running setup.py (path:/tmp/pip-ZX3cIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:39 INFO - Running setup.py (path:/tmp/pip-4ZBNjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:39 INFO - Running setup.py (path:/tmp/pip-BeAEW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:39 INFO - Running setup.py (path:/tmp/pip-BwI6ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:39 INFO - Running setup.py (path:/tmp/pip-oDvv2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:39 INFO - Running setup.py (path:/tmp/pip-STa8CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:39 INFO - Running setup.py (path:/tmp/pip-XCrpDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:39 INFO - Running setup.py (path:/tmp/pip-kcyOCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:39 INFO - Running setup.py (path:/tmp/pip-acONeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:39 INFO - Running setup.py install for manifestparser 19:18:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:39 INFO - Running setup.py install for mozcrash 19:18:39 INFO - Running setup.py install for mozdebug 19:18:40 INFO - Running setup.py install for mozdevice 19:18:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for mozfile 19:18:40 INFO - Running setup.py install for mozhttpd 19:18:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for mozinfo 19:18:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for mozInstall 19:18:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for mozleak 19:18:40 INFO - Running setup.py install for mozlog 19:18:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for moznetwork 19:18:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:40 INFO - Running setup.py install for mozprocess 19:18:41 INFO - Running setup.py install for mozprofile 19:18:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:41 INFO - Running setup.py install for mozrunner 19:18:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:41 INFO - Running setup.py install for mozscreenshot 19:18:41 INFO - Running setup.py install for moztest 19:18:41 INFO - Running setup.py install for mozversion 19:18:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:41 INFO - Cleaning up... 19:18:41 INFO - Return code: 0 19:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:41 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:41 INFO - Using env: {'DISPLAY': ':0', 19:18:41 INFO - 'HOME': '/home/cltbld', 19:18:41 INFO - 'LANG': 'en_US.UTF-8', 19:18:41 INFO - 'LANGUAGE': 'en_US:en', 19:18:41 INFO - 'LOGNAME': 'cltbld', 19:18:41 INFO - 'MAIL': '/var/mail/cltbld', 19:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:41 INFO - 'MOZ_NO_REMOTE': '1', 19:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:41 INFO - 'NO_EM_RESTART': '1', 19:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:41 INFO - 'PWD': '/builds/slave/test', 19:18:41 INFO - 'SHELL': '/bin/bash', 19:18:41 INFO - 'SHLVL': '1', 19:18:41 INFO - 'TERM': 'linux', 19:18:41 INFO - 'TMOUT': '86400', 19:18:41 INFO - 'USER': 'cltbld', 19:18:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:41 INFO - '_': '/tools/buildbot/bin/python'} 19:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:41 INFO - Running setup.py (path:/tmp/pip-XgvB25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:41 INFO - Running setup.py (path:/tmp/pip-sxqhmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:41 INFO - Running setup.py (path:/tmp/pip-vMRDTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:42 INFO - Running setup.py (path:/tmp/pip-U9xq0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:42 INFO - Running setup.py (path:/tmp/pip-NzF_if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:42 INFO - Running setup.py (path:/tmp/pip-JzznTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:42 INFO - Running setup.py (path:/tmp/pip-anaD73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:42 INFO - Running setup.py (path:/tmp/pip-yH42M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:42 INFO - Running setup.py (path:/tmp/pip-iKulRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:42 INFO - Running setup.py (path:/tmp/pip-J9ZXMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:42 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)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:42 INFO - Running setup.py (path:/tmp/pip-ncfQnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:42 INFO - Running setup.py (path:/tmp/pip-u6jgUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:42 INFO - Running setup.py (path:/tmp/pip-N76EE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:42 INFO - Running setup.py (path:/tmp/pip-dRZ8MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:42 INFO - Running setup.py (path:/tmp/pip-ZoUrM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:42 INFO - Running setup.py (path:/tmp/pip-1cLfs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:42 INFO - Running setup.py (path:/tmp/pip-rhvLmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:44 INFO - Downloading blessings-1.6.tar.gz 19:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:45 INFO - Installing collected packages: blessings 19:18:45 INFO - Running setup.py install for blessings 19:18:45 INFO - Successfully installed blessings 19:18:45 INFO - Cleaning up... 19:18:45 INFO - Return code: 0 19:18:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:45 INFO - Reading from file tmpfile_stdout 19:18:45 INFO - Current package versions: 19:18:45 INFO - argparse == 1.2.1 19:18:45 INFO - blessings == 1.6 19:18:45 INFO - blobuploader == 1.2.4 19:18:45 INFO - docopt == 0.6.1 19:18:45 INFO - functools32 == 3.2.3-2 19:18:45 INFO - jsonschema == 2.5.1 19:18:45 INFO - manifestparser == 1.1 19:18:45 INFO - mozInstall == 1.12 19:18:45 INFO - mozcrash == 0.17 19:18:45 INFO - mozdebug == 0.1 19:18:45 INFO - mozdevice == 0.48 19:18:45 INFO - mozfile == 1.2 19:18:45 INFO - mozhttpd == 0.7 19:18:45 INFO - mozinfo == 0.9 19:18:45 INFO - mozleak == 0.1 19:18:45 INFO - mozlog == 3.3 19:18:45 INFO - moznetwork == 0.27 19:18:45 INFO - mozprocess == 0.23 19:18:45 INFO - mozprofile == 0.28 19:18:45 INFO - mozrunner == 6.12 19:18:45 INFO - mozscreenshot == 0.1 19:18:45 INFO - mozsystemmonitor == 0.3 19:18:45 INFO - moztest == 0.7 19:18:45 INFO - mozversion == 1.4 19:18:45 INFO - psutil == 3.1.1 19:18:45 INFO - requests == 1.2.3 19:18:45 INFO - wsgiref == 0.1.2 19:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:45 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')]} 19:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:45 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')]} 19:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:45 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:45 INFO - Using env: {'DISPLAY': ':0', 19:18:45 INFO - 'HOME': '/home/cltbld', 19:18:45 INFO - 'LANG': 'en_US.UTF-8', 19:18:45 INFO - 'LANGUAGE': 'en_US:en', 19:18:45 INFO - 'LOGNAME': 'cltbld', 19:18:45 INFO - 'MAIL': '/var/mail/cltbld', 19:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:45 INFO - 'MOZ_NO_REMOTE': '1', 19:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:45 INFO - 'NO_EM_RESTART': '1', 19:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:45 INFO - 'PWD': '/builds/slave/test', 19:18:45 INFO - 'SHELL': '/bin/bash', 19:18:45 INFO - 'SHLVL': '1', 19:18:45 INFO - 'TERM': 'linux', 19:18:45 INFO - 'TMOUT': '86400', 19:18:45 INFO - 'USER': 'cltbld', 19:18:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:45 INFO - '_': '/tools/buildbot/bin/python'} 19:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:45 INFO - Cleaning up... 19:18:45 INFO - Return code: 0 19:18:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:45 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')]} 19:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:45 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')]} 19:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:45 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 0x7f18c8acff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2866230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, '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': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:18:45 INFO - Using env: {'DISPLAY': ':0', 19:18:45 INFO - 'HOME': '/home/cltbld', 19:18:45 INFO - 'LANG': 'en_US.UTF-8', 19:18:45 INFO - 'LANGUAGE': 'en_US:en', 19:18:45 INFO - 'LOGNAME': 'cltbld', 19:18:45 INFO - 'MAIL': '/var/mail/cltbld', 19:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:45 INFO - 'MOZ_NO_REMOTE': '1', 19:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:45 INFO - 'NO_EM_RESTART': '1', 19:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:45 INFO - 'PWD': '/builds/slave/test', 19:18:45 INFO - 'SHELL': '/bin/bash', 19:18:45 INFO - 'SHLVL': '1', 19:18:45 INFO - 'TERM': 'linux', 19:18:45 INFO - 'TMOUT': '86400', 19:18:45 INFO - 'USER': 'cltbld', 19:18:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:45 INFO - '_': '/tools/buildbot/bin/python'} 19:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:45 INFO - Cleaning up... 19:18:45 INFO - Return code: 0 19:18:45 INFO - Running post-action listener: _resource_record_post_action 19:18:45 INFO - Running post-action listener: _start_resource_monitoring 19:18:45 INFO - Starting resource monitoring. 19:18:45 INFO - [mozharness: 2016-08-23 02:18:45.905145Z] Finished create-virtualenv step (success) 19:18:45 INFO - [mozharness: 2016-08-23 02:18:45.905602Z] Running install step. 19:18:45 INFO - Running pre-action listener: _resource_record_pre_action 19:18:45 INFO - Running main action method: install 19:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:46 INFO - Reading from file tmpfile_stdout 19:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:46 INFO - Reading from file tmpfile_stdout 19:18:46 INFO - Output received: 19:18:46 INFO - Usage: mozinstall [options] installer 19:18:46 INFO - Options: 19:18:46 INFO - -h, --help show this help message and exit 19:18:46 INFO - -d DEST, --destination=DEST 19:18:46 INFO - Directory to install application into. [default: 19:18:46 INFO - "/builds/slave/test"] 19:18:46 INFO - --app=APP Application being installed. [default: firefox] 19:18:46 INFO - mkdir: /builds/slave/test/build/application 19:18:46 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'] 19:18:46 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 19:19:03 INFO - Reading from file tmpfile_stdout 19:19:03 INFO - Output received: 19:19:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - [mozharness: 2016-08-23 02:19:03.198722Z] Finished install step (success) 19:19:03 INFO - [mozharness: 2016-08-23 02:19:03.198996Z] Running run-tests step. 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: run_tests 19:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:03 INFO - Python 2.7.3 19:19:03 INFO - Return code: 0 19:19:03 INFO - grabbing minidump binary from tooltool 19:19: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')]} 19:19:03 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 0x2860090>, '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 0x28639b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2863e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:19:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:19:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:19:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:03 INFO - Return code: 0 19:19:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:03 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:19:03 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:19:03 INFO - Using env: {'DISPLAY': ':0', 19:19:03 INFO - 'HOME': '/home/cltbld', 19:19:03 INFO - 'LANG': 'en_US.UTF-8', 19:19:03 INFO - 'LANGUAGE': 'en_US:en', 19:19:03 INFO - 'LOGNAME': 'cltbld', 19:19:03 INFO - 'MAIL': '/var/mail/cltbld', 19:19:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:03 INFO - 'MOZ_NO_REMOTE': '1', 19:19:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:03 INFO - 'NO_EM_RESTART': '1', 19:19:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:03 INFO - 'PWD': '/builds/slave/test', 19:19:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:03 INFO - 'SHELL': '/bin/bash', 19:19:03 INFO - 'SHLVL': '1', 19:19:03 INFO - 'TERM': 'linux', 19:19:03 INFO - 'TMOUT': '86400', 19:19:03 INFO - 'USER': 'cltbld', 19:19:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471918677.584565-859886591', 19:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:03 INFO - '_': '/tools/buildbot/bin/python'} 19:19:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:19:03 INFO - mozversion application_buildid: 20160822163003 19:19:03 INFO - mozversion application_changeset: 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 19:19:03 INFO - mozversion application_display_name: Nightly 19:19:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:03 INFO - mozversion application_name: Firefox 19:19:03 INFO - mozversion application_remotingname: firefox 19:19:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:19:03 INFO - mozversion application_vendor: Mozilla 19:19:03 INFO - mozversion application_version: 51.0a1 19:19:03 INFO - mozversion platform_buildid: 20160822163003 19:19:03 INFO - mozversion platform_changeset: 7fab74549bbabc0ab0e64a19fd83f4c5660716b4 19:19:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:19:03 INFO - mozversion platform_version: 51.0a1 19:19:03 INFO - using testdate: 1471918743 19:19:03 INFO - actual date: 1471918743 19:19:03 INFO - starting webserver on 'localhost:55938' 19:19:03 INFO - SUITE-START | Running 2 tests 19:19:03 INFO - TEST-START | dromaeo_css 19:19:03 INFO - operating with platform_type : linux_ 19:19:03 INFO - Initialising browser for dromaeo_css test... 19:19:03 INFO - TEST-INFO | started process 11144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9iyLBA/profile http://localhost:55938/getInfo.html) 19:19:08 INFO - PROCESS | 11144 | __metrics Screen width/height:1600/1200 19:19:08 INFO - PROCESS | 11144 | colorDepth:24 19:19:08 INFO - PROCESS | 11144 | Browser inner width/height: 1024/697 19:19:08 INFO - PROCESS | 11144 | __metrics 19:19:08 INFO - PROCESS | 11144 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:08 INFO - PROCESS | 11144 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:09 INFO - PROCESS | 11144 | console.error: PushService: 19:19:09 INFO - PROCESS | 11144 | stateChangeProcessEnqueue: Error transitioning state 19:19:09 INFO - PROCESS | 11144 | UnknownError 19:19:09 INFO - TEST-INFO | 11144: exit 0 19:19:09 INFO - Browser initialized. 19:19:09 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:09 INFO - TEST-INFO | started process 11223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9iyLBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:21 INFO - PROCESS | 11223 | RSS: Main: 181448704 19:19:21 INFO - PROCESS | 11223 | 19:20:13 INFO - PROCESS | 11223 | 1471918813556 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:22:23 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55938/tests/dromaeo/cssquery-ext.html) 19:22:24 INFO - PROCESS | 11223 | RSS: Main: 272003072 19:22:24 INFO - PROCESS | 11223 | 19:25:26 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-ext.html (next: http://localhost:55938/tests/dromaeo/cssquery-jquery.html) 19:25:27 INFO - PROCESS | 11223 | RSS: Main: 282968064 19:25:27 INFO - PROCESS | 11223 | 19:28:29 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55938/tests/dromaeo/cssquery-mootools.html) 19:28:30 INFO - PROCESS | 11223 | RSS: Main: 263041024 19:28:30 INFO - PROCESS | 11223 | 19:31:32 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55938/tests/dromaeo/cssquery-prototype.html) 19:31:32 INFO - PROCESS | 11223 | RSS: Main: 218415104 19:31:32 INFO - PROCESS | 11223 | 19:34:35 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55938/tests/dromaeo/cssquery-yui.html) 19:34:36 INFO - PROCESS | 11223 | RSS: Main: 220930048 19:34:36 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:55938/tests/dromaeo/cssquery-yui.html (next: http://localhost:55938/tests/dromaeo/cssquery-dojo.html) 19:37:39 INFO - PROCESS | 11223 | RSS: Main: 310792192 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | __start_tp_report 19:37:39 INFO - PROCESS | 11223 | _x_x_mozilla_page_load 19:37:39 INFO - PROCESS | 11223 | _x_x_mozilla_page_load_details 19:37:39 INFO - PROCESS | 11223 | |i|pagename|runs| 19:37:39 INFO - PROCESS | 11223 | |0;dojo.html;3036.3623639035795;3037.2255074955883;3054.60290162279;3088.922776930578;3110.3779244151174;5208.687478751278;5361.839144825656;5364.383095943967;5448.3734370547445;5451.5911306652015;5369.9463005369935;5395.433479484656;5398.4601539846;5408.756605952732;5427;4864.829730959426;4944.060628480595;4961.355023846895;4962.454130045692;5015.247712843085;4897.534734200245;4943.604511639061;4987.077390682717;4999.100161970844;5006.524380183877;4909.361782968209;5080.618953578478;5082.822101226458;5084.923726144111;5093.159628661267;4934.013197360542;4972.428170760372;4973.254011898226;4987.600991920674;5001.074801161797;4790.568848803624;4835.758212089381;4856.587190088847;4887.8778030549165;4892.021595680878;5238.633295669305;5256.474352564751;5298.258243845865;5324.840254792323;5338.97330513345;5698.43015698431;5735.369109398004;5737.053386191274;5742.167385729046;5755.0504166812425;5685;5691.943080569225;5698.886022279573;5768.221290125821;5768.567357448166;5320.281761962163;5342.958123165945;5371.57027437804;5399.811006614789;5416.783328666888;5875.41245875409;5880.852978675482;5886.411358864165;5886.793962211302;5892.292924849045;5521.917171242435;5611.158326251095;5669.688167150764;5671.716414179275;5744.368119506851;5745.913811292834;5760.251167348218;5760.251167348301;5761;5764.250647415893;5720.942790572124;5728.598998070095;5729;5730.7421166047625;5734.082546792493;5592.133219350926;5609.49514543693;5656.236408084856;5739;5754.683492407958;4436.179306828247;4439.1121775645;4451.554844515587;4454.997625534294;4459.241928872099;3869.903252418656;3909.3158697227873;3985.362342025262;4005.319095753729;4024.63778259958;5485.670859748428;5542.8337149884765;5547.11246200606;5547.11246200606;5560.165975103767;5767.740451679684;5776.826695199151;5777.220075289866;5778.8266352009505;5778.942210577925;5290.074237008508;5466.426025267369;5482.451754824486;5483.506484416342;5486.039943009957;4998.700077995332;5040.949590504121;5042.596592272609;5066.721330326794;5123.8462846113935;6024.819255422344;6036.939630603638;6038.396160383926;6043.214382130295;6044.516438684895;5679.801206957736;5796.59423840344;5811.360750317546;5816.127580862904;5821.79623713168;5964.194833697396;6004.489618382312;6029.427204415573;6059.424354686298;6126.08108783686;5736.885262294814;5742.540596752333;5745.080787074048;5751.252337196138;5759.51044161251;5640.041192997118;5850.12248162779;5856.326522449973;5859.94140058594;5862.3844496328975;5576.302962129734;5609.887802244014;5626.127950167731;5635.182898479616;5694.4590263924865;5572.498475137257;5595.692236927008;5612.466815652507;5621.213030175861;5621.578381621313;5401.081816091352;5546.500814926676;5556.972215138899;5562.721863906708;5563.471470210324;5639.492445679908;5678.3186017678145;5689.943100568941;5714.05718056516;5778.739956702043;5579.19101730255;5597.748101335531;5598.272224610774;5598.972005139948;5601.663900166003 19:37:39 INFO - PROCESS | 11223 | |1;ext.html;575.5453191978335;576.7289373994223;579.5450571301529;582.7872826418359;583.4544700704841;29153.999999999975;36085.81957090214;37320;37455.62544374559;39983.60016399835;38673.80663096688;39033.804830975874;39035.21929561407;39039;39055.414168787494;8576.228139467446;8726.301895848348;8735.95632021839;8737.60680769367;8738.606762695663;8576.485410875337;8672.826543469128;8676.566171691422;8678.132186781335;8681.956590217073;8737.650493980233;8787.47275163489;8794.736157915273;8795.076516965722;8796;8692.174243446863;8721.084286149926;8731.738047858575;8732.738017859474;8734.257588104987;8547.401681882271;8613.655453781841;8614.655413783441;8617.913820861773;8623.525706086162;37018.8149059253;37278.44082338767;37332.066698332485;37354.626453735385;37368.43947340792;3212.405704944569;3307.7353811695007;3374.9831250843836;3535.5934067582302;3601.549806274216;29866.850665746748;30054.54918176229;30250.84874575635;31382.52926206109;31389.686103139135;4335.349697545362;4390.319500477399;4481.977590112028;4486.955130448687;4536.54634536547;250369;250459;250792;251426;251513.99999999817;46558.76720616375;46666.533334666216;46951.29573056407;46999.360076791;47001.294980575316;50746.49253507492;50819.74590127026;50839.49160508347;50841.49158508368;50858.491415086115;13511.25688087145;14146.151230925972;14162.504312349018;14377.56867293983;14393.64015899611;10816.188785841094;10826.458677066274;10828.78342433147;10832.133429325635;10848.294860834021;15936.840631593768;15961;15996.76004859928;16005.759913601305;16030.198490075449;5810.903313164209;5828.504577110908;5940.584159108907;5983.19226904371;6000.189974353494;830;918.5728636184207;955.5508910811907;994.955227014786;1010.2776514791813;28398.85800570984;29358.853205733834;29584;29623.666934987978;29776.85111574428;989.4360214677708;1035.7928414317166;1075.5160177919968;1093.2893619147617;1115.7099154219961;14334.713305733827;15100.169490678118;15220.619484512976;15431.15128667934;15611.297491612677;521535;527543;527988;528049;528262;49508.50491495039;49704.50295497071;50264.24603630949;50373.49626503761;50405;1069.1286601419818;1155.8728539860608;1178.3872386359046;1181.3620644851683;1211.158245019703;28325.71674283231;29532.409351813272;29718.702812971595;30218.84890575533;30260.84869575638;42683.786581066895;43018;43049.354259686756;43064.78467607642;43133.56866431295;405393;407414;408048;408353;408443;25382.746172538038;26105.347366315993;26415.867920660272;26422.603660945486;26453.867730661223;40523.18953620852;41206.793966029974;41435.23494798137;41745.791271043454;42119.36820947749;35897.61535769551;35963.28073438569;36045.27909441744;36650;36865.26269474542;36130.4580431299;36224.45663315105;36228.27543449169;37542.2491550162;37848.62151378561;35561.64438355687;36130.63869361273;36444;36772.44841327329;36779.26441471209;30304.84847575748;32743.345133097682;32930.5060424089;32978;33053.504197436574;24642.876785615957;25163.986881049837;25201.74798251994;25302.873485632455;25882.61176082398 19:37:39 INFO - PROCESS | 11223 | |2;jquery.html;349.35892637011085;357.35319072478813;374.32808109443545;377.6016302800546;395.76452011053414;14094.929525352372;17593.296268149275;18520.99999999998;19521.316753913616;19549;16548;17286.481405557854;17733.64532709345;17822.732659010093;17943.10284485777;5981.342052374246;6295.685215739218;6302.432781049704;6410;6411.93588064118;6148.723307451153;6354.459870910978;6369.8089057328125;6409.935900641004;6442.452391546724;6402.935970640304;6405.935940640604;6406.711697973602;6407.070974708665;6407.231132264112;6192.752289908398;6398.520110991671;6424.903626445607;6426.1003459515705;6434.034894765776;6001.489873360726;6203.689815509207;6226.533010024221;6233.283172435183;6235.501159907242;25040.373990650198;25080.372990675198;25085.874570627213;25136;25197.62203566948;2361.9645705314433;2402.4954759500524;2466.149178533421;2590.896364145432;2995.445842519141;14931.70136597262;14939.25303734809;15005.774913376308;15873.682526349408;16251.349946002145;2065.0810389376734;2090.5191805884733;2158.9028493717665;2168.447046003259;2224.6106931287122;73255.63372183159;75226;75304;93479.53260233655;97769;16555.337786488646;16638.417655382003;16850.747238791428;17090.658186836194;17246.65506689859;27800.443991120064;27815;27852.30369240785;27932.301692457444;28676.569851452245;8334.999400215918;8633.223009929137;8783.25342345895;8942.68700595476;9034.096590340914;7301.342879140797;7386.298301661333;7407.592582407911;7572;7597;7940.483868548526;7969.72105976288;7979.16218797018;8145.633446494803;8182.140875208136;3079.979633197918;3098.870141157447;3108.4044822573405;3220.533022711694;3242.908633445468;782.8042989252687;851.3699862102;884.0408157149436;904.2675432899373;906.3881879731155;17628.383006594708;17761.378351757627;18230.908845455688;18410.987395693097;18463.007824741628;848.6223630484375;863;883.430187529053;931;948.7153853843819;9431.339806213637;10234.385936843813;10314.896851031544;10325.380477171393;10353.844692329621;413920.51278205117;438429.8078509587;443044;443919;451654;63118.68440657859;65732;84931.57534212289;85738;94648.52675736714;997.586001809241;998.2313618513849;1046.2571574182416;1047.471027131309;1047.9056884880245;17446.302147914448;17813.821861781737;18134.45596632103;18427.26290948347;18550;33992.66007339895;42602.36096458617;44383;45572.54427455683;47091;56520.71739641276;62615;63008.68495657492;63703.770368036894;64707.67646161739;8123.147069557612;8258.752237432887;8466.782622603372;8605.827883442422;8651.394402391772;13051.804222936473;13070.80393794075;13529.59411217665;13690.38393272325;13691.383887724876;11547.538098475967;11609.477573509044;11757;11847.289162650268;12053.939730301292;10779.407132607781;11474.196806223817;11590.826137608112;11894.226875253082;12286.078544109407;11933.224340418192;12051.939740301594;12129.393530323625;12165.878341216474;12588.559400420942;8411.3270938326;8530.872036919576;8604.397692161489;8656;8978.55107244622;9944.751381215527;11972.461239244429;11974.461149248478;11994.520219191483;12051.57819476314 19:37:39 INFO - PROCESS | 11223 | |3;mootools.html;1135.279097772914;1212.1090998116383;1222.8471441069867;1237.2390979547579;1421.5522110535187;7941.920580794191;8159.265666090051;8313.5011899286;8638.740837774862;8642.870356944635;8437.367197460184;8535.274501667365;8546.65813367466;8547.615357308921;8572.357073219518;2064.277502873997;2260.1863329201556;2361.386039629696;2392.1149174805346;2395.6765836612008;2395.3532546212514;2416.4804567018086;2421.1646981791255;2422.0190822716827;2423.127674037345;2331.4171457135717;2343.800776933963;2349.4948586053997;2360.091364824538;2409.6867407237037;2300.976990230093;2333.346662934381;2339.6724458575727;2341.683872677184;2369.3721163891582;2354.2348736660656;2372.833901626887;2373.9169129080574;2383.547126046046;2384.5946189147885;8556.657733690645;8629.95685021577;8641.351898607629;8650.697225597074;8655.740327790176;4971;5067.113255180366;5085.847424577269;5091.261767043795;5094.7197904115255;3261.4129456697783;3339.7996120232865;3486.755927085105;3499.6500349965054;3564.322778672044;1140.8916152965455;1188.8454500914825;1196.8623608284984;1216.878312168785;1221.2123180548497;12093.45579448927;12161.756764864742;12223.449944752507;12263.69340766488;12284.078694097978;4225.619694227535;4364.432623758891;4535.750533720677;4556.954430455719;4561.794719237576;9301.813963720688;9306.90693093074;9311.48786816718;9312.301577381588;9325.207357374564;5065.189569668835;5065.746712664352;5069.670471419419;5073.543381095719;5083.262926875583;4053.8783836484954;4577.382053422812;4681.368015317888;4733.83431579893;4746.050789841976;3671.81640917953;3736.8505259789304;3755.5681096673684;3794.354959656865;3819.7708137511836;1132.5243397772956;1137.4312843578211;1169.789437901186;1170.1457935706812;1182.8462299900957;819.5574389829426;832.696065935929;844.8310337932438;863.1411745313453;875.6584931876573;5470.64440811354;5660.575456840754;5679.375268720438;5697.4587414195585;5939.277609493285;436.49802726863726;456.0286589564273;458.08840407588656;460.9421377937641;461.78526984952157;3981.6416522513114;4107.445494858216;4127.545969943304;4153.127843152912;4206.749389076829;10327.380357178594;10844.295120817122;10983.505742241618;11098.334099954029;11098.722531936766;10880.401577913291;10884.292520986111;10995.450227488594;11036.061934735477;11044.116470682326;7755.612219389008;7895.407844411692;7915.16890726477;7917.722879699183;7926.24700653437;5722.942770572241;5787.102999035156;5792.333881603669;5829.504492118217;6003.969980150071;10024.599016039569;10093.394396336244;10115.241356898116;10146.847797282899;10151.390916545031;9590.184834289164;10040.196784257389;10047.397156170653;10330.018648228406;10334.948325258627;6483.2544257411;7340.192578816219;7437.590932498548;7542.849143016999;7575.204603516771;8143.75568732939;8331.54176520273;8333.499990000377;8336.833263334578;8347.165283471604;7263.164736055422;7358.264173582813;7374.225706300761;7387.335139837441;7508.324250817453;7141.64291785419;7185.173705023989;7314.890276645961;7445.441591880739;7469.88795168062;6835.58986460814;6841.247462778991;6859.965700171467;6878.58728476273;6901.516893817385;4961.330220420197;4998.900021999612;5049.141645920276;5073.213651883964;5152.355955505562;4949.653524253267;5107.8212262572115;5108.872278193075;5220.530152286313;5242 19:37:39 INFO - PROCESS | 11223 | |4;prototype.html;314.39479002919387;324.56022090067955;330.43660558747337;331.6037335384215;338.9813560254185;5069.391672999245;5188.16989281715;5253.106971814791;5285.735713214338;5317.5214230719275;5242.135047717132;5250.291210686556;5273.182656688219;5295.867603309919;5307.708076055816;4124.566920473352;4138.213739389506;4138.855140070098;4142.487991882971;4154.85458008969;3900.8829735107993;4044.5348784889675;4102.5076990761;4136.379543068534;4147.523034851;4013.4782478277784;4040.5757395473493;4042.939355909664;4048.068944142849;4056.843799517138;4042.9191416171657;4045.939310910324;4047.6964227683043;4053.27041132596;4063.4514340564238;3427.628948420627;3552.8223588820456;3557.2174121693447;3575.249197668467;3577.695895848856;5041.798328066873;5048.873778155539;5064.468230835783;5064.772085256172;5085.211792172219;4616.515265897099;4622.352870598119;4634.745089020103;4653.302004699322;4653.837115700968;5288.471152884719;5336.329029472951;5371.677699338053;5380.569554435675;5419.945800541984;3859.4789703389965;3870.3613903705855;3870.4774855394726;3872.3610604250266;3883.708721845873;5565.193047008202;5571.582131340166;5582.302212223472;5618.213450116946;5643.971780141073;3854.768713877176;3946.960530394659;3949.842006319715;3951.664108550748;3960.2277555876326;3990.521137463523;4006.4390985262085;4006.8797936061965;4009.51885773709;4036.354183330653;4581.977090114595;4585.564371384779;4594.471635761864;4620.5148459411275;4626.537346265347;5302.655327403706;5424.802954803232;5464.644798088191;5490.56075513958;5514.751836167382;1345.5895951734815;1382.2397681275258;1386;1387.2300873015372;1391.5060153645513;856.4775486952954;875.5403413207989;885.8262801787529;886.4459712679575;893.4728510179026;4637.536246375403;4675.392199014106;4743.857684269408;4745.715257084586;4750.976245118753;4959.90080198394;4964.429090654621;4972;4996.950030499721;5009;4476.836022634138;4776.546228108324;4776.570108690165;4786.731516148224;4793.520647935248;2608.8173827832247;2620.908268210642;2624.173385383598;2635.7891368690457;2640.2211347652105;5050.545450909436;5052.545270925634;5054.393472783289;5064.18972964324;5090.745462726849;4675.09786799841;4980.306695723399;5002.874928126753;5007.69953802773;5009.273655320031;5035.9424520851035;5076.974615126975;5121.900020991376;5123;5135.691858488428;4884.316195732671;4953.984433191259;4991.925121123113;4993.550580447777;5012.373453318335;4917.934467523577;4935.507568677938;4947.550962273697;5211.374635043819;5605.159226116115;5838;5869.559783016376;5879.353271140086;5880.294364676266;5880.558958078076;3924.587918268655;4007.418924255908;4039.6970227232487;4099.774512401847;4126.236646220459;5620.269364982526;5621.016322143691;5628.718564071698;5631.408702086222;5647.1529270609735;5418.9678870423595;5481.780728770805;5488.231647569263;5493.36318567098;5504.119340905436;5273.683578985273;5496.780128794803;5545.889082218414;5552.222688823649;5563.554915606823;5484.698341591251;5488.725563721718;5502.449755024466;5509.807156749494;5534.695591742332;5320.654157479751;5563.860903477445;5603.747831347518;5607.719614019365;5637.802676906289;5438.918416223681;5476;5485.61600687948;5489.149181876815;5500.642458240201 19:37:39 INFO - PROCESS | 11223 | |5;yui.html;607.9969600151999;646.666966512246;668.2215219269551;680.836599216188;688.4217257503695;13606.319684015809;14945.25273736313;16388.180590970434;16393.42623008195;16434.342626294932;13759.931200343985;14034.789478157836;14086.154830710164;14207.857921420782;14280.857191428082;582.2314544800864;597.952163826895;611.9449249567538;612.3080918562018;612.457974692396;519.8596378977674;568.6588047171705;582.4990508162998;584.8362458511624;591.2609238451935;605.8667093239502;613.7483631711;614.3764079459353;614.7110857896804;615.1756646094233;609.5915736456585;610.5451438678191;610.5695484683309;610.7495926670089;610.8595023144702;399.21554146102756;440.4934325525671;441.42614601018545;445.6746575000268;448.7823405648258;13675.247861367621;13700.520481783089;13737;13743.931280343635;13757;12620.81068783969;12945;12971.935140324238;13110.410031548603;13444.596662100055;11921.582744603897;11922.582709605209;12008.519659213709;12090.214136081127;12121.696957576043;4293.635041021517;4294.484661840599;4421.712588681726;4527.818887244539;4573.885652858705;84093;84189.99999999939;85064;85191.57404213001;85199;10457.163426925828;10632;10768.623098191525;10887.618933337295;10896.18278629106;18351.08244587765;18355.265789368543;18357.08214589265;18448.538786530444;18469.63060738778;8045.275925166763;8052.83894322122;8140.877886831702;8200.794980125425;8250.174982501701;4929.531694489017;5021.84934451967;5035.420926593415;5050.974745126251;5132.024915266087;3121.843907804601;3198.584184056058;3203.1351535085864;3213.694699003591;3215.0354893532312;561.0602241245897;581.3692144023697;581.3924448950772;583.7489879351834;584.4973322942267;451.43345101897563;475.2965610895893;503.896701176258;550.8788066625336;589.1839801874435;8440.577971101544;9117.498537580364;9223.53882305882;9296.72109836706;9304.162625363615;553.7452771725052;593.9673317967553;615.6767696959132;629.5089829932659;663.6383171171723;3644.635536446387;3933.350997085449;3947.289487892207;3976.58245884178;4057.533383660858;73670.26329736634;74481.62759186169;84533;131532.3423382896;131600.3419982894;89550;90057;92616;93867;106127.46936265424;65689.67155164194;71046.64476677583;82921.75617365744;85513;86958;9565.378250413702;10228.795424091328;10275;10298.867124616436;10363.792724145625;51986.480135198166;52951.470485296195;52962.47037529575;53168.46831531635;55202.72398637981;66921.33078669151;67200.32799671941;74718;74877;75417.24582754102;11759.88240117622;11832.34922079294;11866.490733521206;12079.75840483203;12130.090243231969;13837.238951857744;14413.207273600052;14421.134731916118;14438.021581482039;14501.20243386624;12100.818487722867;13548.458061677817;13737.587872363845;14234.14595124296;14301.92622069815;11734;11856.17006809515;13135.802962955755;13192.80210796858;13484.528041518499;13610.59168224955;13641.386137623633;13720.313984300945;14084.929575352058;14258.42966281337;11273.267237629529;11293.153013524183;11325.943370283425;11738.94130529342;11903.82144267854;9183.382735920231;10669.8933010672;11052.778944420907;11115.277506962022;11161.49773260189 19:37:39 INFO - PROCESS | 11223 | __end_tp_report 19:37:39 INFO - PROCESS | 11223 | __start_cc_report 19:37:39 INFO - PROCESS | 11223 | _x_x_mozilla_cycle_collect,1047 19:37:39 INFO - PROCESS | 11223 | __end_cc_report 19:37:39 INFO - PROCESS | 11223 | __startTimestamp1471919859755__endTimestamp 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | ------- Summary: start ------- 19:37:39 INFO - PROCESS | 11223 | Number of tests: 6 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#0] dojo.html Cycles:165 Average:5367.25 Median:5576.30 stddev:606.44 (10.9%) stddev-sans-first:580.08 19:37:39 INFO - PROCESS | 11223 | Values: 3036.4 3037.2 3054.6 3088.9 3110.4 5208.7 5361.8 5364.4 5448.4 5451.6 5369.9 5395.4 5398.5 5408.8 5427.0 4864.8 4944.1 4961.4 4962.5 5015.2 4897.5 4943.6 4987.1 4999.1 5006.5 4909.4 5080.6 5082.8 5084.9 5093.2 4934.0 4972.4 4973.3 4987.6 5001.1 4790.6 4835.8 4856.6 4887.9 4892.0 5238.6 5256.5 5298.3 5324.8 5339.0 5698.4 5735.4 5737.1 5742.2 5755.1 5685.0 5691.9 5698.9 5768.2 5768.6 5320.3 5343.0 5371.6 5399.8 5416.8 5875.4 5880.9 5886.4 5886.8 5892.3 5521.9 5611.2 5669.7 5671.7 5744.4 5745.9 5760.3 5760.3 5761.0 5764.3 5720.9 5728.6 5729.0 5730.7 5734.1 5592.1 5609.5 5656.2 5739.0 5754.7 4436.2 4439.1 4451.6 4455.0 4459.2 3869.9 3909.3 3985.4 4005.3 4024.6 5485.7 5542.8 5547.1 5547.1 5560.2 5767.7 5776.8 5777.2 5778.8 5778.9 5290.1 5466.4 5482.5 5483.5 5486.0 4998.7 5040.9 5042.6 5066.7 5123.8 6024.8 6036.9 6038.4 6043.2 6044.5 5679.8 5796.6 5811.4 5816.1 5821.8 5964.2 6004.5 6029.4 6059.4 6126.1 5736.9 5742.5 5745.1 5751.3 5759.5 5640.0 5850.1 5856.3 5859.9 5862.4 5576.3 5609.9 5626.1 5635.2 5694.5 5572.5 5595.7 5612.5 5621.2 5621.6 5401.1 5546.5 5557.0 5562.7 5563.5 5639.5 5678.3 5689.9 5714.1 5778.7 5579.2 5597.7 5598.3 5599.0 5601.7 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#1] ext.html Cycles:180 Average:53590.88 Median:37412.03 stddev:109390.36 (292.4%) stddev-sans-first:109624.81 19:37:39 INFO - PROCESS | 11223 | Values: 575.5 576.7 579.5 582.8 583.5 29154.0 36085.8 37320.0 37455.6 39983.6 38673.8 39033.8 39035.2 39039.0 39055.4 8576.2 8726.3 8736.0 8737.6 8738.6 8576.5 8672.8 8676.6 8678.1 8682.0 8737.7 8787.5 8794.7 8795.1 8796.0 8692.2 8721.1 8731.7 8732.7 8734.3 8547.4 8613.7 8614.7 8617.9 8623.5 37018.8 37278.4 37332.1 37354.6 37368.4 3212.4 3307.7 3375.0 3535.6 3601.5 29866.9 30054.5 30250.8 31382.5 31389.7 4335.3 4390.3 4482.0 4487.0 4536.5 250369.0 250459.0 250792.0 251426.0 251514.0 46558.8 46666.5 46951.3 46999.4 47001.3 50746.5 50819.7 50839.5 50841.5 50858.5 13511.3 14146.2 14162.5 14377.6 14393.6 10816.2 10826.5 10828.8 10832.1 10848.3 15936.8 15961.0 15996.8 16005.8 16030.2 5810.9 5828.5 5940.6 5983.2 6000.2 830.0 918.6 955.6 995.0 1010.3 28398.9 29358.9 29584.0 29623.7 29776.9 989.4 1035.8 1075.5 1093.3 1115.7 14334.7 15100.2 15220.6 15431.2 15611.3 521535.0 527543.0 527988.0 528049.0 528262.0 49508.5 49704.5 50264.2 50373.5 50405.0 1069.1 1155.9 1178.4 1181.4 1211.2 28325.7 29532.4 29718.7 30218.8 30260.8 42683.8 43018.0 43049.4 43064.8 43133.6 405393.0 407414.0 408048.0 408353.0 408443.0 25382.7 26105.3 26415.9 26422.6 26453.9 40523.2 41206.8 41435.2 41745.8 42119.4 35897.6 35963.3 36045.3 36650.0 36865.3 36130.5 36224.5 36228.3 37542.2 37848.6 35561.6 36130.6 36444.0 36772.4 36779.3 30304.8 32743.3 32930.5 32978.0 33053.5 24642.9 25164.0 25201.7 25302.9 25882.6 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#2] jquery.html Cycles:180 Average:28231.61 Median:386.68 stddev:72310.00 (18700.1%) stddev-sans-first:72482.54 19:37:39 INFO - PROCESS | 11223 | Values: 349.4 357.4 374.3 377.6 395.8 14094.9 17593.3 18521.0 19521.3 19549.0 16548.0 17286.5 17733.6 17822.7 17943.1 5981.3 6295.7 6302.4 6410.0 6411.9 6148.7 6354.5 6369.8 6409.9 6442.5 6402.9 6405.9 6406.7 6407.1 6407.2 6192.8 6398.5 6424.9 6426.1 6434.0 6001.5 6203.7 6226.5 6233.3 6235.5 25040.4 25080.4 25085.9 25136.0 25197.6 2362.0 2402.5 2466.1 2590.9 2995.4 14931.7 14939.3 15005.8 15873.7 16251.3 2065.1 2090.5 2158.9 2168.4 2224.6 73255.6 75226.0 75304.0 93479.5 97769.0 16555.3 16638.4 16850.7 17090.7 17246.7 27800.4 27815.0 27852.3 27932.3 28676.6 8335.0 8633.2 8783.3 8942.7 9034.1 7301.3 7386.3 7407.6 7572.0 7597.0 7940.5 7969.7 7979.2 8145.6 8182.1 3080.0 3098.9 3108.4 3220.5 3242.9 782.8 851.4 884.0 904.3 906.4 17628.4 17761.4 18230.9 18411.0 18463.0 848.6 863.0 883.4 931.0 948.7 9431.3 10234.4 10314.9 10325.4 10353.8 413920.5 438429.8 443044.0 443919.0 451654.0 63118.7 65732.0 84931.6 85738.0 94648.5 997.6 998.2 1046.3 1047.5 1047.9 17446.3 17813.8 18134.5 18427.3 18550.0 33992.7 42602.4 44383.0 45572.5 47091.0 56520.7 62615.0 63008.7 63703.8 64707.7 8123.1 8258.8 8466.8 8605.8 8651.4 13051.8 13070.8 13529.6 13690.4 13691.4 11547.5 11609.5 11757.0 11847.3 12053.9 10779.4 11474.2 11590.8 11894.2 12286.1 11933.2 12051.9 12129.4 12165.9 12588.6 8411.3 8530.9 8604.4 8656.0 8978.6 9944.8 11972.5 11974.5 11994.5 12051.6 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#3] mootools.html Cycles:180 Average:5634.57 Median:2571.58 stddev:3244.07 (126.2%) stddev-sans-first:3235.55 19:37:39 INFO - PROCESS | 11223 | Values: 1135.3 1212.1 1222.8 1237.2 1421.6 7941.9 8159.3 8313.5 8638.7 8642.9 8437.4 8535.3 8546.7 8547.6 8572.4 2064.3 2260.2 2361.4 2392.1 2395.7 2395.4 2416.5 2421.2 2422.0 2423.1 2331.4 2343.8 2349.5 2360.1 2409.7 2301.0 2333.3 2339.7 2341.7 2369.4 2354.2 2372.8 2373.9 2383.5 2384.6 8556.7 8630.0 8641.4 8650.7 8655.7 4971.0 5067.1 5085.8 5091.3 5094.7 3261.4 3339.8 3486.8 3499.7 3564.3 1140.9 1188.8 1196.9 1216.9 1221.2 12093.5 12161.8 12223.4 12263.7 12284.1 4225.6 4364.4 4535.8 4557.0 4561.8 9301.8 9306.9 9311.5 9312.3 9325.2 5065.2 5065.7 5069.7 5073.5 5083.3 4053.9 4577.4 4681.4 4733.8 4746.1 3671.8 3736.9 3755.6 3794.4 3819.8 1132.5 1137.4 1169.8 1170.1 1182.8 819.6 832.7 844.8 863.1 875.7 5470.6 5660.6 5679.4 5697.5 5939.3 436.5 456.0 458.1 460.9 461.8 3981.6 4107.4 4127.5 4153.1 4206.7 10327.4 10844.3 10983.5 11098.3 11098.7 10880.4 10884.3 10995.5 11036.1 11044.1 7755.6 7895.4 7915.2 7917.7 7926.2 5722.9 5787.1 5792.3 5829.5 6004.0 10024.6 10093.4 10115.2 10146.8 10151.4 9590.2 10040.2 10047.4 10330.0 10334.9 6483.3 7340.2 7437.6 7542.8 7575.2 8143.8 8331.5 8333.5 8336.8 8347.2 7263.2 7358.3 7374.2 7387.3 7508.3 7141.6 7185.2 7314.9 7445.4 7469.9 6835.6 6841.2 6860.0 6878.6 6901.5 4961.3 4998.9 5049.1 5073.2 5152.4 4949.7 5107.8 5108.9 5220.5 5242.0 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#4] prototype.html Cycles:180 Average:4463.43 Median:4992.74 stddev:1304.72 (26.1%) stddev-sans-first:1270.67 19:37:39 INFO - PROCESS | 11223 | Values: 314.4 324.6 330.4 331.6 339.0 5069.4 5188.2 5253.1 5285.7 5317.5 5242.1 5250.3 5273.2 5295.9 5307.7 4124.6 4138.2 4138.9 4142.5 4154.9 3900.9 4044.5 4102.5 4136.4 4147.5 4013.5 4040.6 4042.9 4048.1 4056.8 4042.9 4045.9 4047.7 4053.3 4063.5 3427.6 3552.8 3557.2 3575.2 3577.7 5041.8 5048.9 5064.5 5064.8 5085.2 4616.5 4622.4 4634.7 4653.3 4653.8 5288.5 5336.3 5371.7 5380.6 5419.9 3859.5 3870.4 3870.5 3872.4 3883.7 5565.2 5571.6 5582.3 5618.2 5644.0 3854.8 3947.0 3949.8 3951.7 3960.2 3990.5 4006.4 4006.9 4009.5 4036.4 4582.0 4585.6 4594.5 4620.5 4626.5 5302.7 5424.8 5464.6 5490.6 5514.8 1345.6 1382.2 1386.0 1387.2 1391.5 856.5 875.5 885.8 886.4 893.5 4637.5 4675.4 4743.9 4745.7 4751.0 4959.9 4964.4 4972.0 4997.0 5009.0 4476.8 4776.5 4776.6 4786.7 4793.5 2608.8 2620.9 2624.2 2635.8 2640.2 5050.5 5052.5 5054.4 5064.2 5090.7 4675.1 4980.3 5002.9 5007.7 5009.3 5035.9 5077.0 5121.9 5123.0 5135.7 4884.3 4954.0 4991.9 4993.6 5012.4 4917.9 4935.5 4947.6 5211.4 5605.2 5838.0 5869.6 5879.4 5880.3 5880.6 3924.6 4007.4 4039.7 4099.8 4126.2 5620.3 5621.0 5628.7 5631.4 5647.2 5419.0 5481.8 5488.2 5493.4 5504.1 5273.7 5496.8 5545.9 5552.2 5563.6 5484.7 5488.7 5502.4 5509.8 5534.7 5320.7 5563.9 5603.7 5607.7 5637.8 5438.9 5476.0 5485.6 5489.1 5500.6 19:37:39 INFO - PROCESS | 11223 | 19:37:39 INFO - PROCESS | 11223 | [#5] yui.html Cycles:180 Average:19916.90 Median:2431.57 stddev:28703.30 (1180.4%) stddev-sans-first:28747.20 19:37:39 INFO - PROCESS | 11223 | Values: 608.0 646.7 668.2 680.8 688.4 13606.3 14945.3 16388.2 16393.4 16434.3 13759.9 14034.8 14086.2 14207.9 14280.9 582.2 598.0 611.9 612.3 612.5 519.9 568.7 582.5 584.8 591.3 605.9 613.7 614.4 614.7 615.2 609.6 610.5 610.6 610.7 610.9 399.2 440.5 441.4 445.7 448.8 13675.2 13700.5 13737.0 13743.9 13757.0 12620.8 12945.0 12971.9 13110.4 13444.6 11921.6 11922.6 12008.5 12090.2 12121.7 4293.6 4294.5 4421.7 4527.8 4573.9 84093.0 84190.0 85064.0 85191.6 85199.0 10457.2 10632.0 10768.6 10887.6 10896.2 18351.1 18355.3 18357.1 18448.5 18469.6 8045.3 8052.8 8140.9 8200.8 8250.2 4929.5 5021.8 5035.4 5051.0 5132.0 3121.8 3198.6 3203.1 3213.7 3215.0 561.1 581.4 581.4 583.7 584.5 451.4 475.3 503.9 550.9 589.2 8440.6 9117.5 9223.5 9296.7 9304.2 553.7 594.0 615.7 629.5 663.6 3644.6 3933.4 3947.3 3976.6 4057.5 73670.3 74481.6 84533.0 131532.3 131600.3 89550.0 90057.0 92616.0 93867.0 106127.5 65689.7 71046.6 82921.8 85513.0 86958.0 9565.4 10228.8 10275.0 10298.9 10363.8 51986.5 52951.5 52962.5 53168.5 55202.7 66921.3 67200.3 74718.0 74877.0 75417.2 11759.9 11832.3 11866.5 12079.8 12130.1 13837.2 14413.2 14421.1 14438.0 14501.2 12100.8 13548.5 13737.6 14234.1 14301.9 11734.0 11856.2 13135.8 13192.8 13484.5 13610.6 13641.4 13720.3 14084.9 14258.4 11273.3 11293.2 11325.9 11738.9 11903.8 9183.4 10669.9 11052.8 11115.3 11161.5 19:37:39 INFO - PROCESS | 11223 | -------- Summary: end -------- 19:37:39 INFO - PROCESS | 11223 | 19:37:40 INFO - TEST-INFO | 11223: exit 0 19:37:40 INFO - TEST-OK | dromaeo_css | took 1117230ms 19:37:40 INFO - TEST-START | kraken 19:37:40 INFO - operating with platform_type : linux_ 19:37:40 INFO - Initialising browser for kraken test... 19:37:40 INFO - TEST-INFO | started process 11529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFAdcb/profile http://localhost:55938/getInfo.html) 19:37:44 INFO - PROCESS | 11529 | __metrics Screen width/height:1600/1200 19:37:44 INFO - PROCESS | 11529 | colorDepth:24 19:37:44 INFO - PROCESS | 11529 | Browser inner width/height: 1024/697 19:37:44 INFO - PROCESS | 11529 | __metrics 19:37:45 INFO - PROCESS | 11529 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:37:45 INFO - PROCESS | 11529 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:46 INFO - PROCESS | 11529 | console.error: PushService: 19:37:46 INFO - PROCESS | 11529 | stateChangeProcessEnqueue: Error transitioning state 19:37:46 INFO - PROCESS | 11529 | UnknownError 19:37:46 INFO - TEST-INFO | 11529: exit 0 19:37:46 INFO - Browser initialized. 19:37:46 INFO - Running cycle 1/1 for kraken test... 19:37:46 INFO - TEST-INFO | started process 11612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjFAdcb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:58 INFO - PROCESS | 11612 | RSS: Main: 181899264 19:37:58 INFO - PROCESS | 11612 | 19:38:01 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55938/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:02 INFO - PROCESS | 11612 | RSS: Main: 244170752 19:38:02 INFO - PROCESS | 11612 | 19:38:04 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55938/tests/kraken/driver.html?testName=audio-dft) 19:38:05 INFO - PROCESS | 11612 | RSS: Main: 226062336 19:38:05 INFO - PROCESS | 11612 | 19:38:08 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55938/tests/kraken/driver.html?testName=audio-fft) 19:38:09 INFO - PROCESS | 11612 | RSS: Main: 303190016 19:38:09 INFO - PROCESS | 11612 | 19:38:11 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55938/tests/kraken/driver.html?testName=audio-oscillator) 19:38:11 INFO - PROCESS | 11612 | RSS: Main: 213237760 19:38:11 INFO - PROCESS | 11612 | 19:38:14 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:14 INFO - PROCESS | 11612 | RSS: Main: 216580096 19:38:14 INFO - PROCESS | 11612 | 19:38:17 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55938/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:18 INFO - PROCESS | 11612 | RSS: Main: 255942656 19:38:18 INFO - PROCESS | 11612 | 19:38:21 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55938/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:22 INFO - PROCESS | 11612 | RSS: Main: 254840832 19:38:22 INFO - PROCESS | 11612 | 19:38:25 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55938/tests/kraken/driver.html?testName=json-parse-financial) 19:38:26 INFO - PROCESS | 11612 | RSS: Main: 254369792 19:38:26 INFO - PROCESS | 11612 | 19:38:27 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:28 INFO - PROCESS | 11612 | RSS: Main: 217366528 19:38:28 INFO - PROCESS | 11612 | 19:38:29 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:38:30 INFO - PROCESS | 11612 | RSS: Main: 225173504 19:38:30 INFO - PROCESS | 11612 | 19:38:32 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:38:33 INFO - PROCESS | 11612 | RSS: Main: 222994432 19:38:33 INFO - PROCESS | 11612 | 19:38:36 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:36 INFO - PROCESS | 11612 | RSS: Main: 218980352 19:38:36 INFO - PROCESS | 11612 | 19:38:39 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:40 INFO - PROCESS | 11612 | RSS: Main: 222011392 19:38:40 INFO - PROCESS | 11612 | 19:38:41 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55938/tests/kraken/driver.html?testName=ai-astar) 19:38:42 INFO - PROCESS | 11612 | RSS: Main: 272744448 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | __start_tp_report 19:38:42 INFO - PROCESS | 11612 | _x_x_mozilla_page_load 19:38:42 INFO - PROCESS | 11612 | _x_x_mozilla_page_load_details 19:38:42 INFO - PROCESS | 11612 | |i|pagename|runs| 19:38:42 INFO - PROCESS | 11612 | |0;ai-astar;110;113;127;111;111;111;110;111;110;110 19:38:42 INFO - PROCESS | 11612 | |1;audio-beat-detection;151;122;164;199;119;147;148;127;175;121 19:38:42 INFO - PROCESS | 11612 | |2;audio-dft;161;162;161;162;161;161;160;160;160;162 19:38:42 INFO - PROCESS | 11612 | |3;audio-fft;76;77;75;169;76;75;78;76;164;80 19:38:42 INFO - PROCESS | 11612 | |4;audio-oscillator;89;85;151;86;85;86;152;85;86;150 19:38:42 INFO - PROCESS | 11612 | |5;imaging-gaussian-blur;116;116;116;116;116;116;116;117;117;117 19:38:42 INFO - PROCESS | 11612 | |6;imaging-darkroom;147;146;146;146;146;145;145;145;146;147 19:38:42 INFO - PROCESS | 11612 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;94;95 19:38:42 INFO - PROCESS | 11612 | |8;json-parse-financial;55;52;60;53;51;55;52;53;51;50 19:38:42 INFO - PROCESS | 11612 | |9;json-stringify-tinderbox;64;62;62;62;62;62;63;63;63;62 19:38:42 INFO - PROCESS | 11612 | |10;stanford-crypto-aes;78;78;86;77;81;77;78;78;78;79 19:38:42 INFO - PROCESS | 11612 | |11;stanford-crypto-ccm;126;147;124;123;125;131;120;123;155;122 19:38:42 INFO - PROCESS | 11612 | |12;stanford-crypto-pbkdf2;163;163;163;162;161;166;165;162;161;163 19:38:42 INFO - PROCESS | 11612 | |13;stanford-crypto-sha256-iterative;64;64;65;70;64;64;64;63;64;64 19:38:42 INFO - PROCESS | 11612 | __end_tp_report 19:38:42 INFO - PROCESS | 11612 | __start_cc_report 19:38:42 INFO - PROCESS | 11612 | _x_x_mozilla_cycle_collect,1738 19:38:42 INFO - PROCESS | 11612 | __end_cc_report 19:38:42 INFO - PROCESS | 11612 | __startTimestamp1471919922161__endTimestamp 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | ------- Summary: start ------- 19:38:42 INFO - PROCESS | 11612 | Number of tests: 14 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#0] ai-astar Cycles:10 Average:112.40 Median:111.00 stddev:5.21 (4.7%) stddev-sans-first:5.45 19:38:42 INFO - PROCESS | 11612 | Values: 110.0 113.0 127.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:149.50 stddev:26.41 (17.7%) stddev-sans-first:27.98 19:38:42 INFO - PROCESS | 11612 | Values: 151.0 122.0 164.0 199.0 119.0 147.0 148.0 127.0 175.0 121.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 19:38:42 INFO - PROCESS | 11612 | Values: 161.0 162.0 161.0 162.0 161.0 161.0 160.0 160.0 160.0 162.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:37.94 (49.9%) stddev-sans-first:39.64 19:38:42 INFO - PROCESS | 11612 | Values: 76.0 77.0 75.0 169.0 76.0 75.0 78.0 76.0 164.0 80.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:85.50 stddev:31.42 (36.8%) stddev-sans-first:32.76 19:38:42 INFO - PROCESS | 11612 | Values: 89.0 85.0 151.0 86.0 85.0 86.0 152.0 85.0 86.0 150.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:38:42 INFO - PROCESS | 11612 | Values: 116.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 19:38:42 INFO - PROCESS | 11612 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 147.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:38:42 INFO - PROCESS | 11612 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:2.90 (5.5%) stddev-sans-first:3.00 19:38:42 INFO - PROCESS | 11612 | Values: 55.0 52.0 60.0 53.0 51.0 55.0 52.0 53.0 51.0 50.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 19:38:42 INFO - PROCESS | 11612 | Values: 64.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 63.0 62.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:2.71 (3.5%) stddev-sans-first:2.85 19:38:42 INFO - PROCESS | 11612 | Values: 78.0 78.0 86.0 77.0 81.0 77.0 78.0 78.0 78.0 79.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:125.50 stddev:11.80 (9.4%) stddev-sans-first:12.44 19:38:42 INFO - PROCESS | 11612 | Values: 126.0 147.0 124.0 123.0 125.0 131.0 120.0 123.0 155.0 122.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 19:38:42 INFO - PROCESS | 11612 | Values: 163.0 163.0 163.0 162.0 161.0 166.0 165.0 162.0 161.0 163.0 19:38:42 INFO - PROCESS | 11612 | 19:38:42 INFO - PROCESS | 11612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:1.96 (3.1%) stddev-sans-first:2.06 19:38:42 INFO - PROCESS | 11612 | Values: 64.0 64.0 65.0 70.0 64.0 64.0 64.0 63.0 64.0 64.0 19:38:42 INFO - PROCESS | 11612 | -------- Summary: end -------- 19:38:42 INFO - PROCESS | 11612 | 19:38:43 INFO - TEST-INFO | 11612: exit 0 19:38:43 INFO - TEST-OK | kraken | took 62654ms 19:38:43 INFO - SUITE-END | took 1179s 19:38:43 INFO - Completed test suite (00:19:40) 19:38:43 INFO - javascript benchmark 19:38:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.3623639035795, 3037.2255074955883, 3054.60290162279, 3088.922776930578, 3110.3779244151174, 5208.687478751278, 5361.839144825656, 5364.383095943967, 5448.3734370547445, 5451.5911306652015, 5369.9463005369935, 5395.433479484656, 5398.4601539846, 5408.756605952732, 5427.0, 4864.829730959426, 4944.060628480595, 4961.355023846895, 4962.454130045692, 5015.247712843085, 4897.534734200245, 4943.604511639061, 4987.077390682717, 4999.100161970844, 5006.524380183877, 4909.361782968209, 5080.618953578478, 5082.822101226458, 5084.923726144111, 5093.159628661267, 4934.013197360542, 4972.428170760372, 4973.254011898226, 4987.600991920674, 5001.074801161797, 4790.568848803624, 4835.758212089381, 4856.587190088847, 4887.8778030549165, 4892.021595680878, 5238.633295669305, 5256.474352564751, 5298.258243845865, 5324.840254792323, 5338.97330513345, 5698.43015698431, 5735.369109398004, 5737.053386191274, 5742.167385729046, 5755.0504166812425, 5685.0, 5691.943080569225, 5698.886022279573, 5768.221290125821, 5768.567357448166, 5320.281761962163, 5342.958123165945, 5371.57027437804, 5399.811006614789, 5416.783328666888, 5875.41245875409, 5880.852978675482, 5886.411358864165, 5886.793962211302, 5892.292924849045, 5521.917171242435, 5611.158326251095, 5669.688167150764, 5671.716414179275, 5744.368119506851, 5745.913811292834, 5760.251167348218, 5760.251167348301, 5761.0, 5764.250647415893, 5720.942790572124, 5728.598998070095, 5729.0, 5730.7421166047625, 5734.082546792493, 5592.133219350926, 5609.49514543693, 5656.236408084856, 5739.0, 5754.683492407958, 4436.179306828247, 4439.1121775645, 4451.554844515587, 4454.997625534294, 4459.241928872099, 3869.903252418656, 3909.3158697227873, 3985.362342025262, 4005.319095753729, 4024.63778259958, 5485.670859748428, 5542.8337149884765, 5547.11246200606, 5547.11246200606, 5560.165975103767, 5767.740451679684, 5776.826695199151, 5777.220075289866, 5778.8266352009505, 5778.942210577925, 5290.074237008508, 5466.426025267369, 5482.451754824486, 5483.506484416342, 5486.039943009957, 4998.700077995332, 5040.949590504121, 5042.596592272609, 5066.721330326794, 5123.8462846113935, 6024.819255422344, 6036.939630603638, 6038.396160383926, 6043.214382130295, 6044.516438684895, 5679.801206957736, 5796.59423840344, 5811.360750317546, 5816.127580862904, 5821.79623713168, 5964.194833697396, 6004.489618382312, 6029.427204415573, 6059.424354686298, 6126.08108783686, 5736.885262294814, 5742.540596752333, 5745.080787074048, 5751.252337196138, 5759.51044161251, 5640.041192997118, 5850.12248162779, 5856.326522449973, 5859.94140058594, 5862.3844496328975, 5576.302962129734, 5609.887802244014, 5626.127950167731, 5635.182898479616, 5694.4590263924865, 5572.498475137257, 5595.692236927008, 5612.466815652507, 5621.213030175861, 5621.578381621313, 5401.081816091352, 5546.500814926676, 5556.972215138899, 5562.721863906708, 5563.471470210324, 5639.492445679908, 5678.3186017678145, 5689.943100568941, 5714.05718056516, 5778.739956702043, 5579.19101730255, 5597.748101335531, 5598.272224610774, 5598.972005139948, 5601.663900166003], "value": 5325.923034809009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.5453191978335, 576.7289373994223, 579.5450571301529, 582.7872826418359, 583.4544700704841, 29153.999999999975, 36085.81957090214, 37320.0, 37455.62544374559, 39983.60016399835, 38673.80663096688, 39033.804830975874, 39035.21929561407, 39039.0, 39055.414168787494, 8576.228139467446, 8726.301895848348, 8735.95632021839, 8737.60680769367, 8738.606762695663, 8576.485410875337, 8672.826543469128, 8676.566171691422, 8678.132186781335, 8681.956590217073, 8737.650493980233, 8787.47275163489, 8794.736157915273, 8795.076516965722, 8796.0, 8692.174243446863, 8721.084286149926, 8731.738047858575, 8732.738017859474, 8734.257588104987, 8547.401681882271, 8613.655453781841, 8614.655413783441, 8617.913820861773, 8623.525706086162, 37018.8149059253, 37278.44082338767, 37332.066698332485, 37354.626453735385, 37368.43947340792, 3212.405704944569, 3307.7353811695007, 3374.9831250843836, 3535.5934067582302, 3601.549806274216, 29866.850665746748, 30054.54918176229, 30250.84874575635, 31382.52926206109, 31389.686103139135, 4335.349697545362, 4390.319500477399, 4481.977590112028, 4486.955130448687, 4536.54634536547, 250369.0, 250459.0, 250792.0, 251426.0, 251513.99999999817, 46558.76720616375, 46666.533334666216, 46951.29573056407, 46999.360076791, 47001.294980575316, 50746.49253507492, 50819.74590127026, 50839.49160508347, 50841.49158508368, 50858.491415086115, 13511.25688087145, 14146.151230925972, 14162.504312349018, 14377.56867293983, 14393.64015899611, 10816.188785841094, 10826.458677066274, 10828.78342433147, 10832.133429325635, 10848.294860834021, 15936.840631593768, 15961.0, 15996.76004859928, 16005.759913601305, 16030.198490075449, 5810.903313164209, 5828.504577110908, 5940.584159108907, 5983.19226904371, 6000.189974353494, 830.0, 918.5728636184207, 955.5508910811907, 994.955227014786, 1010.2776514791813, 28398.85800570984, 29358.853205733834, 29584.0, 29623.666934987978, 29776.85111574428, 989.4360214677708, 1035.7928414317166, 1075.5160177919968, 1093.2893619147617, 1115.7099154219961, 14334.713305733827, 15100.169490678118, 15220.619484512976, 15431.15128667934, 15611.297491612677, 521535.0, 527543.0, 527988.0, 528049.0, 528262.0, 49508.50491495039, 49704.50295497071, 50264.24603630949, 50373.49626503761, 50405.0, 1069.1286601419818, 1155.8728539860608, 1178.3872386359046, 1181.3620644851683, 1211.158245019703, 28325.71674283231, 29532.409351813272, 29718.702812971595, 30218.84890575533, 30260.84869575638, 42683.786581066895, 43018.0, 43049.354259686756, 43064.78467607642, 43133.56866431295, 405393.0, 407414.0, 408048.0, 408353.0, 408443.0, 25382.746172538038, 26105.347366315993, 26415.867920660272, 26422.603660945486, 26453.867730661223, 40523.18953620852, 41206.793966029974, 41435.23494798137, 41745.791271043454, 42119.36820947749, 35897.61535769551, 35963.28073438569, 36045.27909441744, 36650.0, 36865.26269474542, 36130.4580431299, 36224.45663315105, 36228.27543449169, 37542.2491550162, 37848.62151378561, 35561.64438355687, 36130.63869361273, 36444.0, 36772.44841327329, 36779.26441471209, 30304.84847575748, 32743.345133097682, 32930.5060424089, 32978.0, 33053.504197436574, 24642.876785615957, 25163.986881049837, 25201.74798251994, 25302.873485632455, 25882.61176082398], "value": 18083.822997163184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.35892637011085, 357.35319072478813, 374.32808109443545, 377.6016302800546, 395.76452011053414, 14094.929525352372, 17593.296268149275, 18520.99999999998, 19521.316753913616, 19549.0, 16548.0, 17286.481405557854, 17733.64532709345, 17822.732659010093, 17943.10284485777, 5981.342052374246, 6295.685215739218, 6302.432781049704, 6410.0, 6411.93588064118, 6148.723307451153, 6354.459870910978, 6369.8089057328125, 6409.935900641004, 6442.452391546724, 6402.935970640304, 6405.935940640604, 6406.711697973602, 6407.070974708665, 6407.231132264112, 6192.752289908398, 6398.520110991671, 6424.903626445607, 6426.1003459515705, 6434.034894765776, 6001.489873360726, 6203.689815509207, 6226.533010024221, 6233.283172435183, 6235.501159907242, 25040.373990650198, 25080.372990675198, 25085.874570627213, 25136.0, 25197.62203566948, 2361.9645705314433, 2402.4954759500524, 2466.149178533421, 2590.896364145432, 2995.445842519141, 14931.70136597262, 14939.25303734809, 15005.774913376308, 15873.682526349408, 16251.349946002145, 2065.0810389376734, 2090.5191805884733, 2158.9028493717665, 2168.447046003259, 2224.6106931287122, 73255.63372183159, 75226.0, 75304.0, 93479.53260233655, 97769.0, 16555.337786488646, 16638.417655382003, 16850.747238791428, 17090.658186836194, 17246.65506689859, 27800.443991120064, 27815.0, 27852.30369240785, 27932.301692457444, 28676.569851452245, 8334.999400215918, 8633.223009929137, 8783.25342345895, 8942.68700595476, 9034.096590340914, 7301.342879140797, 7386.298301661333, 7407.592582407911, 7572.0, 7597.0, 7940.483868548526, 7969.72105976288, 7979.16218797018, 8145.633446494803, 8182.140875208136, 3079.979633197918, 3098.870141157447, 3108.4044822573405, 3220.533022711694, 3242.908633445468, 782.8042989252687, 851.3699862102, 884.0408157149436, 904.2675432899373, 906.3881879731155, 17628.383006594708, 17761.378351757627, 18230.908845455688, 18410.987395693097, 18463.007824741628, 848.6223630484375, 863.0, 883.430187529053, 931.0, 948.7153853843819, 9431.339806213637, 10234.385936843813, 10314.896851031544, 10325.380477171393, 10353.844692329621, 413920.51278205117, 438429.8078509587, 443044.0, 443919.0, 451654.0, 63118.68440657859, 65732.0, 84931.57534212289, 85738.0, 94648.52675736714, 997.586001809241, 998.2313618513849, 1046.2571574182416, 1047.471027131309, 1047.9056884880245, 17446.302147914448, 17813.821861781737, 18134.45596632103, 18427.26290948347, 18550.0, 33992.66007339895, 42602.36096458617, 44383.0, 45572.54427455683, 47091.0, 56520.71739641276, 62615.0, 63008.68495657492, 63703.770368036894, 64707.67646161739, 8123.147069557612, 8258.752237432887, 8466.782622603372, 8605.827883442422, 8651.394402391772, 13051.804222936473, 13070.80393794075, 13529.59411217665, 13690.38393272325, 13691.383887724876, 11547.538098475967, 11609.477573509044, 11757.0, 11847.289162650268, 12053.939730301292, 10779.407132607781, 11474.196806223817, 11590.826137608112, 11894.226875253082, 12286.078544109407, 11933.224340418192, 12051.939740301594, 12129.393530323625, 12165.878341216474, 12588.559400420942, 8411.3270938326, 8530.872036919576, 8604.397692161489, 8656.0, 8978.55107244622, 9944.751381215527, 11972.461239244429, 11974.461149248478, 11994.520219191483, 12051.57819476314], "value": 9913.448409123075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1135.279097772914, 1212.1090998116383, 1222.8471441069867, 1237.2390979547579, 1421.5522110535187, 7941.920580794191, 8159.265666090051, 8313.5011899286, 8638.740837774862, 8642.870356944635, 8437.367197460184, 8535.274501667365, 8546.65813367466, 8547.615357308921, 8572.357073219518, 2064.277502873997, 2260.1863329201556, 2361.386039629696, 2392.1149174805346, 2395.6765836612008, 2395.3532546212514, 2416.4804567018086, 2421.1646981791255, 2422.0190822716827, 2423.127674037345, 2331.4171457135717, 2343.800776933963, 2349.4948586053997, 2360.091364824538, 2409.6867407237037, 2300.976990230093, 2333.346662934381, 2339.6724458575727, 2341.683872677184, 2369.3721163891582, 2354.2348736660656, 2372.833901626887, 2373.9169129080574, 2383.547126046046, 2384.5946189147885, 8556.657733690645, 8629.95685021577, 8641.351898607629, 8650.697225597074, 8655.740327790176, 4971.0, 5067.113255180366, 5085.847424577269, 5091.261767043795, 5094.7197904115255, 3261.4129456697783, 3339.7996120232865, 3486.755927085105, 3499.6500349965054, 3564.322778672044, 1140.8916152965455, 1188.8454500914825, 1196.8623608284984, 1216.878312168785, 1221.2123180548497, 12093.45579448927, 12161.756764864742, 12223.449944752507, 12263.69340766488, 12284.078694097978, 4225.619694227535, 4364.432623758891, 4535.750533720677, 4556.954430455719, 4561.794719237576, 9301.813963720688, 9306.90693093074, 9311.48786816718, 9312.301577381588, 9325.207357374564, 5065.189569668835, 5065.746712664352, 5069.670471419419, 5073.543381095719, 5083.262926875583, 4053.8783836484954, 4577.382053422812, 4681.368015317888, 4733.83431579893, 4746.050789841976, 3671.81640917953, 3736.8505259789304, 3755.5681096673684, 3794.354959656865, 3819.7708137511836, 1132.5243397772956, 1137.4312843578211, 1169.789437901186, 1170.1457935706812, 1182.8462299900957, 819.5574389829426, 832.696065935929, 844.8310337932438, 863.1411745313453, 875.6584931876573, 5470.64440811354, 5660.575456840754, 5679.375268720438, 5697.4587414195585, 5939.277609493285, 436.49802726863726, 456.0286589564273, 458.08840407588656, 460.9421377937641, 461.78526984952157, 3981.6416522513114, 4107.445494858216, 4127.545969943304, 4153.127843152912, 4206.749389076829, 10327.380357178594, 10844.295120817122, 10983.505742241618, 11098.334099954029, 11098.722531936766, 10880.401577913291, 10884.292520986111, 10995.450227488594, 11036.061934735477, 11044.116470682326, 7755.612219389008, 7895.407844411692, 7915.16890726477, 7917.722879699183, 7926.24700653437, 5722.942770572241, 5787.102999035156, 5792.333881603669, 5829.504492118217, 6003.969980150071, 10024.599016039569, 10093.394396336244, 10115.241356898116, 10146.847797282899, 10151.390916545031, 9590.184834289164, 10040.196784257389, 10047.397156170653, 10330.018648228406, 10334.948325258627, 6483.2544257411, 7340.192578816219, 7437.590932498548, 7542.849143016999, 7575.204603516771, 8143.75568732939, 8331.54176520273, 8333.499990000377, 8336.833263334578, 8347.165283471604, 7263.164736055422, 7358.264173582813, 7374.225706300761, 7387.335139837441, 7508.324250817453, 7141.64291785419, 7185.173705023989, 7314.890276645961, 7445.441591880739, 7469.88795168062, 6835.58986460814, 6841.247462778991, 6859.965700171467, 6878.58728476273, 6901.516893817385, 4961.330220420197, 4998.900021999612, 5049.141645920276, 5073.213651883964, 5152.355955505562, 4949.653524253267, 5107.8212262572115, 5108.872278193075, 5220.530152286313, 5242.0], "value": 4418.976471019036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.39479002919387, 324.56022090067955, 330.43660558747337, 331.6037335384215, 338.9813560254185, 5069.391672999245, 5188.16989281715, 5253.106971814791, 5285.735713214338, 5317.5214230719275, 5242.135047717132, 5250.291210686556, 5273.182656688219, 5295.867603309919, 5307.708076055816, 4124.566920473352, 4138.213739389506, 4138.855140070098, 4142.487991882971, 4154.85458008969, 3900.8829735107993, 4044.5348784889675, 4102.5076990761, 4136.379543068534, 4147.523034851, 4013.4782478277784, 4040.5757395473493, 4042.939355909664, 4048.068944142849, 4056.843799517138, 4042.9191416171657, 4045.939310910324, 4047.6964227683043, 4053.27041132596, 4063.4514340564238, 3427.628948420627, 3552.8223588820456, 3557.2174121693447, 3575.249197668467, 3577.695895848856, 5041.798328066873, 5048.873778155539, 5064.468230835783, 5064.772085256172, 5085.211792172219, 4616.515265897099, 4622.352870598119, 4634.745089020103, 4653.302004699322, 4653.837115700968, 5288.471152884719, 5336.329029472951, 5371.677699338053, 5380.569554435675, 5419.945800541984, 3859.4789703389965, 3870.3613903705855, 3870.4774855394726, 3872.3610604250266, 3883.708721845873, 5565.193047008202, 5571.582131340166, 5582.302212223472, 5618.213450116946, 5643.971780141073, 3854.768713877176, 3946.960530394659, 3949.842006319715, 3951.664108550748, 3960.2277555876326, 3990.521137463523, 4006.4390985262085, 4006.8797936061965, 4009.51885773709, 4036.354183330653, 4581.977090114595, 4585.564371384779, 4594.471635761864, 4620.5148459411275, 4626.537346265347, 5302.655327403706, 5424.802954803232, 5464.644798088191, 5490.56075513958, 5514.751836167382, 1345.5895951734815, 1382.2397681275258, 1386.0, 1387.2300873015372, 1391.5060153645513, 856.4775486952954, 875.5403413207989, 885.8262801787529, 886.4459712679575, 893.4728510179026, 4637.536246375403, 4675.392199014106, 4743.857684269408, 4745.715257084586, 4750.976245118753, 4959.90080198394, 4964.429090654621, 4972.0, 4996.950030499721, 5009.0, 4476.836022634138, 4776.546228108324, 4776.570108690165, 4786.731516148224, 4793.520647935248, 2608.8173827832247, 2620.908268210642, 2624.173385383598, 2635.7891368690457, 2640.2211347652105, 5050.545450909436, 5052.545270925634, 5054.393472783289, 5064.18972964324, 5090.745462726849, 4675.09786799841, 4980.306695723399, 5002.874928126753, 5007.69953802773, 5009.273655320031, 5035.9424520851035, 5076.974615126975, 5121.900020991376, 5123.0, 5135.691858488428, 4884.316195732671, 4953.984433191259, 4991.925121123113, 4993.550580447777, 5012.373453318335, 4917.934467523577, 4935.507568677938, 4947.550962273697, 5211.374635043819, 5605.159226116115, 5838.0, 5869.559783016376, 5879.353271140086, 5880.294364676266, 5880.558958078076, 3924.587918268655, 4007.418924255908, 4039.6970227232487, 4099.774512401847, 4126.236646220459, 5620.269364982526, 5621.016322143691, 5628.718564071698, 5631.408702086222, 5647.1529270609735, 5418.9678870423595, 5481.780728770805, 5488.231647569263, 5493.36318567098, 5504.119340905436, 5273.683578985273, 5496.780128794803, 5545.889082218414, 5552.222688823649, 5563.554915606823, 5484.698341591251, 5488.725563721718, 5502.449755024466, 5509.807156749494, 5534.695591742332, 5320.654157479751, 5563.860903477445, 5603.747831347518, 5607.719614019365, 5637.802676906289, 5438.918416223681, 5476.0, 5485.61600687948, 5489.149181876815, 5500.642458240201], "value": 4048.5036902424654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9969600151999, 646.666966512246, 668.2215219269551, 680.836599216188, 688.4217257503695, 13606.319684015809, 14945.25273736313, 16388.180590970434, 16393.42623008195, 16434.342626294932, 13759.931200343985, 14034.789478157836, 14086.154830710164, 14207.857921420782, 14280.857191428082, 582.2314544800864, 597.952163826895, 611.9449249567538, 612.3080918562018, 612.457974692396, 519.8596378977674, 568.6588047171705, 582.4990508162998, 584.8362458511624, 591.2609238451935, 605.8667093239502, 613.7483631711, 614.3764079459353, 614.7110857896804, 615.1756646094233, 609.5915736456585, 610.5451438678191, 610.5695484683309, 610.7495926670089, 610.8595023144702, 399.21554146102756, 440.4934325525671, 441.42614601018545, 445.6746575000268, 448.7823405648258, 13675.247861367621, 13700.520481783089, 13737.0, 13743.931280343635, 13757.0, 12620.81068783969, 12945.0, 12971.935140324238, 13110.410031548603, 13444.596662100055, 11921.582744603897, 11922.582709605209, 12008.519659213709, 12090.214136081127, 12121.696957576043, 4293.635041021517, 4294.484661840599, 4421.712588681726, 4527.818887244539, 4573.885652858705, 84093.0, 84189.99999999939, 85064.0, 85191.57404213001, 85199.0, 10457.163426925828, 10632.0, 10768.623098191525, 10887.618933337295, 10896.18278629106, 18351.08244587765, 18355.265789368543, 18357.08214589265, 18448.538786530444, 18469.63060738778, 8045.275925166763, 8052.83894322122, 8140.877886831702, 8200.794980125425, 8250.174982501701, 4929.531694489017, 5021.84934451967, 5035.420926593415, 5050.974745126251, 5132.024915266087, 3121.843907804601, 3198.584184056058, 3203.1351535085864, 3213.694699003591, 3215.0354893532312, 561.0602241245897, 581.3692144023697, 581.3924448950772, 583.7489879351834, 584.4973322942267, 451.43345101897563, 475.2965610895893, 503.896701176258, 550.8788066625336, 589.1839801874435, 8440.577971101544, 9117.498537580364, 9223.53882305882, 9296.72109836706, 9304.162625363615, 553.7452771725052, 593.9673317967553, 615.6767696959132, 629.5089829932659, 663.6383171171723, 3644.635536446387, 3933.350997085449, 3947.289487892207, 3976.58245884178, 4057.533383660858, 73670.26329736634, 74481.62759186169, 84533.0, 131532.3423382896, 131600.3419982894, 89550.0, 90057.0, 92616.0, 93867.0, 106127.46936265424, 65689.67155164194, 71046.64476677583, 82921.75617365744, 85513.0, 86958.0, 9565.378250413702, 10228.795424091328, 10275.0, 10298.867124616436, 10363.792724145625, 51986.480135198166, 52951.470485296195, 52962.47037529575, 53168.46831531635, 55202.72398637981, 66921.33078669151, 67200.32799671941, 74718.0, 74877.0, 75417.24582754102, 11759.88240117622, 11832.34922079294, 11866.490733521206, 12079.75840483203, 12130.090243231969, 13837.238951857744, 14413.207273600052, 14421.134731916118, 14438.021581482039, 14501.20243386624, 12100.818487722867, 13548.458061677817, 13737.587872363845, 14234.14595124296, 14301.92622069815, 11734.0, 11856.17006809515, 13135.802962955755, 13192.80210796858, 13484.528041518499, 13610.59168224955, 13641.386137623633, 13720.313984300945, 14084.929575352058, 14258.42966281337, 11273.267237629529, 11293.153013524183, 11325.943370283425, 11738.94130529342, 11903.82144267854, 9183.382735920231, 10669.8933010672, 11052.778944420907, 11115.277506962022, 11161.49773260189], "value": 6897.279043116338, "unit": "score"}], "name": "dromaeo_css", "value": 7001.776936325265, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 127.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 164.0, 199.0, 119.0, 147.0, 148.0, 127.0, 175.0, 121.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 169.0, 76.0, 75.0, 78.0, 76.0, 164.0, 80.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 151.0, 86.0, 85.0, 86.0, 152.0, 85.0, 86.0, 150.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 60.0, 53.0, 51.0, 55.0, 52.0, 53.0, 51.0, 50.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 86.0, 77.0, 81.0, 77.0, 78.0, 78.0, 78.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 147.0, 124.0, 123.0, 125.0, 131.0, 120.0, 123.0, 155.0, 122.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 166.0, 165.0, 162.0, 161.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 70.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1529.8, "alertThreshold": 2.0}]} 19:38:43 INFO - Return code: 0 19:38:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:38:43 INFO - # TBPL SUCCESS # 19:38:43 INFO - Running post-action listener: _resource_record_post_action 19:38:43 INFO - [mozharness: 2016-08-23 02:38:43.975600Z] Finished run-tests step (success) 19:38:43 INFO - Running post-run listener: _resource_record_post_run 19:38:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 407855104; Read time: 64; Write time: 262604 19:38:44 INFO - TinderboxPrint: CPU usage
13.3% 19:38:44 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 64 19:38:44 INFO - TinderboxPrint: I/O write bytes / time
407,855,104 / 262,604 19:38:44 INFO - TinderboxPrint: CPU idle
8,283.2 (86.7%) 19:38:44 INFO - TinderboxPrint: CPU user
1,207.5 (12.6%) 19:38:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:38:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119308288; Read time: 0; Write time: 70268 19:38:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288546816; Read time: 48; Write time: 192336 19:38:44 INFO - Running post-run listener: _upload_blobber_files 19:38:44 INFO - Blob upload gear active. 19:38:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:38:44 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'] 19:38:44 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 19:38:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:46 INFO - (blobuploader) - INFO - Done attempting. 19:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:46 INFO - (blobuploader) - INFO - Done attempting. 19:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:50 INFO - (blobuploader) - INFO - Done attempting. 19:38:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:50 INFO - Return code: 0 19:38:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a04778b29fc8031bb1977f074af1ee3f87f8f721ac9dfd28b18682ce76ce7d0bfc56d43eff5313a9504b80b3fc1a04d422f085d8f1b6b7236a201c5b1ded91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2043575d55c166398490eb65c2cef22ce5db71a923a2947f425b9868fb7b341e03ed15d64dfabb4a0a24038c97b0636fe6184a7862917759a8677c138f1a4928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f81f0b151e7a1471d578b8a563c9af06e16ceef71fdfc3d3c5034fa247eda0a7815205126b437def3e79c369fe3ace662be73f631b6b3e254fb5ba9128de386"} 19:38:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:50 INFO - Contents: 19:38:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a04778b29fc8031bb1977f074af1ee3f87f8f721ac9dfd28b18682ce76ce7d0bfc56d43eff5313a9504b80b3fc1a04d422f085d8f1b6b7236a201c5b1ded91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2043575d55c166398490eb65c2cef22ce5db71a923a2947f425b9868fb7b341e03ed15d64dfabb4a0a24038c97b0636fe6184a7862917759a8677c138f1a4928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f81f0b151e7a1471d578b8a563c9af06e16ceef71fdfc3d3c5034fa247eda0a7815205126b437def3e79c369fe3ace662be73f631b6b3e254fb5ba9128de386"} 19:38:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:50 INFO - Copying logs to upload dir... 19:38:50 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.896993 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-22 19:38:50.282091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 19:38:50.285533) ========= 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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a04778b29fc8031bb1977f074af1ee3f87f8f721ac9dfd28b18682ce76ce7d0bfc56d43eff5313a9504b80b3fc1a04d422f085d8f1b6b7236a201c5b1ded91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2043575d55c166398490eb65c2cef22ce5db71a923a2947f425b9868fb7b341e03ed15d64dfabb4a0a24038c97b0636fe6184a7862917759a8677c138f1a4928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f81f0b151e7a1471d578b8a563c9af06e16ceef71fdfc3d3c5034fa247eda0a7815205126b437def3e79c369fe3ace662be73f631b6b3e254fb5ba9128de386"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471908603/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a04778b29fc8031bb1977f074af1ee3f87f8f721ac9dfd28b18682ce76ce7d0bfc56d43eff5313a9504b80b3fc1a04d422f085d8f1b6b7236a201c5b1ded91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2043575d55c166398490eb65c2cef22ce5db71a923a2947f425b9868fb7b341e03ed15d64dfabb4a0a24038c97b0636fe6184a7862917759a8677c138f1a4928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f81f0b151e7a1471d578b8a563c9af06e16ceef71fdfc3d3c5034fa247eda0a7815205126b437def3e79c369fe3ace662be73f631b6b3e254fb5ba9128de386"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 19:38:50.313375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:38:50.314015) ========= 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=7de08804244eb36560b44971000001c3-1471918677.584565-859886591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 19:38:50.400413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 19:38:50.401203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 19:38:50.401864) ========= ========= Total master_lag: 0.18 =========