builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1469060663.69 results: success (0) buildid: 20160720143019 builduid: 9235ecacf04e43b9b37557d2db6f7534 revision: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.686312) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.686767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.687038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.701367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.701688) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 17:24:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-07-20 17:24:23 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.811100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.811424) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:23.861040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 17:24:23.861392) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f4846ed9f65d7622fdbd8993289daeb6b29b692 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5f4846ed9f65d7622fdbd8993289daeb6b29b692 --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=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 17:24:23,996 truncating revision to first 12 chars 2016-07-20 17:24:23,996 Setting DEBUG logging. 2016-07-20 17:24:23,997 attempt 1/10 2016-07-20 17:24:23,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f4846ed9f65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 17:24:24,808 unpacking tar archive at: fx-team-5f4846ed9f65/testing/mozharness/ program finished with exit code 0 elapsedTime=1.142063 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 17:24:25.016705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:25.017028) ========= script_repo_revision: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:25.017437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:25.017705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 17:24:25.027849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-20 17:24:25.028121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:25 INFO - MultiFileLogger online at 20160720 17:24:25 in /builds/slave/test 17:24:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:24:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:25 INFO - {'append_to_log': False, 17:24:25 INFO - 'base_work_dir': '/builds/slave/test', 17:24:25 INFO - 'blob_upload_branch': 'Fx-Team', 17:24:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:25 INFO - 'branch': 'Fx-Team', 17:24:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:25 INFO - 'config_files': ('talos/linux_config.py',), 17:24:25 INFO - 'default_actions': ('clobber', 17:24:25 INFO - 'read-buildbot-config', 17:24:25 INFO - 'download-and-extract', 17:24:25 INFO - 'populate-webroot', 17:24:25 INFO - 'create-virtualenv', 17:24:25 INFO - 'install', 17:24:25 INFO - 'run-tests'), 17:24:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:25 INFO - 'download_minidump_stackwalk': True, 17:24:25 INFO - 'download_symbols': 'ondemand', 17:24:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:25 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:25 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:25 INFO - 'installer_path': 'installer.exe', 17:24:25 INFO - 'log_level': 'info', 17:24:25 INFO - 'log_name': 'talos', 17:24:25 INFO - 'log_to_console': True, 17:24:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:25 INFO - 'opt_config_files': (), 17:24:25 INFO - 'pip_index': False, 17:24:25 INFO - 'sps_profile': False, 17:24:25 INFO - 'sps_profile_interval': 0, 17:24:25 INFO - 'suite': 'dromaeojs', 17:24:25 INFO - 'system_bits': '32', 17:24:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:25 INFO - 'title': 'talos-linux64-ix-062', 17:24:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:25 INFO - 'use_talos_json': True, 17:24:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:25 INFO - 'work_dir': 'build'} 17:24:25 INFO - [mozharness: 2016-07-21 00:24:25.258237Z] Running clobber step. 17:24:25 INFO - Running pre-action listener: _resource_record_pre_action 17:24:25 INFO - Running main action method: clobber 17:24:25 INFO - rmtree: /builds/slave/test/build 17:24:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:25 INFO - Running post-action listener: _resource_record_post_action 17:24:25 INFO - [mozharness: 2016-07-21 00:24:25.752689Z] Finished clobber step (success) 17:24:25 INFO - [mozharness: 2016-07-21 00:24:25.752791Z] Running read-buildbot-config step. 17:24:25 INFO - Running pre-action listener: _resource_record_pre_action 17:24:25 INFO - Running main action method: read_buildbot_config 17:24:25 INFO - Using buildbot properties: 17:24:25 INFO - { 17:24:25 INFO - "project": "", 17:24:25 INFO - "product": "firefox", 17:24:25 INFO - "script_repo_revision": "production", 17:24:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:24:25 INFO - "repository": "", 17:24:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:24:25 INFO - "buildid": "20160720143019", 17:24:25 INFO - "pgo_build": "True", 17:24:25 INFO - "basedir": "/builds/slave/test", 17:24:25 INFO - "buildnumber": 1340, 17:24:25 INFO - "slavename": "talos-linux64-ix-062", 17:24:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:24:25 INFO - "platform": "ubuntu64_hw", 17:24:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:24:25 INFO - "branch": "fx-team", 17:24:25 INFO - "repo_path": "integration/fx-team", 17:24:25 INFO - "revision": "5f4846ed9f65d7622fdbd8993289daeb6b29b692", 17:24:25 INFO - "stage_platform": "linux64-pgo", 17:24:25 INFO - "builduid": "9235ecacf04e43b9b37557d2db6f7534", 17:24:25 INFO - "slavebuilddir": "test" 17:24:25 INFO - } 17:24:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:24:25 INFO - Running post-action listener: _resource_record_post_action 17:24:25 INFO - [mozharness: 2016-07-21 00:24:25.755685Z] Finished read-buildbot-config step (success) 17:24:25 INFO - [mozharness: 2016-07-21 00:24:25.755775Z] Running download-and-extract step. 17:24:25 INFO - Running pre-action listener: _resource_record_pre_action 17:24:25 INFO - Running main action method: download_and_extract 17:24:25 INFO - mkdir: /builds/slave/test/build/tests 17:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:25 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:24:26 INFO - Downloaded 1361 bytes. 17:24:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:24:26 INFO - Using the following test package requirements: 17:24:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:24:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:24:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'jsshell-linux-x86_64.zip'], 17:24:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:24:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:24:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:24:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:24:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:24:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:26 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:24:27 INFO - Downloaded 24343493 bytes. 17:24:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:24:28 INFO - Return code: 0 17:24:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:28 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:24:29 INFO - Downloaded 24343493 bytes. 17:24:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:24:31 INFO - Return code: 0 17:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:31 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:24:32 INFO - Downloaded 14403317 bytes. 17:24:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:24:32 INFO - Return code: 0 17:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:32 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:24:33 INFO - Downloaded 60882358 bytes. 17:24:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:24:33 INFO - mkdir: /builds/slave/test/properties 17:24:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:33 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:33 INFO - Contents: 17:24:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:24:34 INFO - Running post-action listener: _resource_record_post_action 17:24:34 INFO - Running post-action listener: set_extra_try_arguments 17:24:34 INFO - [mozharness: 2016-07-21 00:24:34.509602Z] Finished download-and-extract step (success) 17:24:34 INFO - [mozharness: 2016-07-21 00:24:34.509836Z] Running populate-webroot step. 17:24:34 INFO - Running pre-action listener: _resource_record_pre_action 17:24:34 INFO - Running main action method: populate_webroot 17:24:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:34 INFO - '--tppagecycles', 17:24:34 INFO - '7'], 17:24:34 INFO - 'tests': ['tsvgm']}}, 17:24:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['damp', 'tps']}, 17:24:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'tests': ['damp', 'tps']}, 17:24:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['dromaeo_dom']}, 17:24:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['basic_compositor_video']}, 17:24:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:24:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['a11yr', 17:24:34 INFO - 'ts_paint', 17:24:34 INFO - 'tpaint', 17:24:34 INFO - 'sessionrestore', 17:24:34 INFO - 'sessionrestore_no_auto_restore', 17:24:34 INFO - 'tabpaint']}, 17:24:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['tsvgx', 17:24:34 INFO - 'tsvgr_opacity', 17:24:34 INFO - 'tart', 17:24:34 INFO - 'tscrollx', 17:24:34 INFO - 'cart']}, 17:24:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:34 INFO - 'tsvgr_opacity', 17:24:34 INFO - 'tart', 17:24:34 INFO - 'tscrollx', 17:24:34 INFO - 'cart']}, 17:24:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'talos_options': ['--disable-e10s'], 17:24:34 INFO - 'tests': ['tp5o']}, 17:24:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'tests': ['tp5o']}, 17:24:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'talos_options': ['--disable-e10s', 17:24:34 INFO - '--xperf_path', 17:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:34 INFO - 'tests': ['tp5n']}, 17:24:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:34 INFO - 'talos_options': ['--xperf_path', 17:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:34 INFO - 'tests': ['tp5n']}}, 17:24:34 INFO - 'talos.zip': {'path': '', 17:24:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:34 INFO - Running post-action listener: _resource_record_post_action 17:24:34 INFO - [mozharness: 2016-07-21 00:24:34.530775Z] Finished populate-webroot step (success) 17:24:34 INFO - [mozharness: 2016-07-21 00:24:34.530865Z] Running create-virtualenv step. 17:24:34 INFO - Running pre-action listener: _resource_record_pre_action 17:24:34 INFO - Running main action method: create_virtualenv 17:24:34 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:34 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 17:24:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:34 INFO - Using real prefix '/usr' 17:24:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:35 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:37 INFO - Installing pip.................done. 17:24:37 INFO - Return code: 0 17:24:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:37 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 17:24:37 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 17:24:37 INFO - Using env: {'DISPLAY': ':0', 17:24:37 INFO - 'HOME': '/home/cltbld', 17:24:37 INFO - 'LANG': 'en_US.UTF-8', 17:24:37 INFO - 'LANGUAGE': 'en_US:en', 17:24:37 INFO - 'LOGNAME': 'cltbld', 17:24:37 INFO - 'MAIL': '/var/mail/cltbld', 17:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:37 INFO - 'MOZ_NO_REMOTE': '1', 17:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:37 INFO - 'NO_EM_RESTART': '1', 17:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:37 INFO - 'PWD': '/builds/slave/test', 17:24:37 INFO - 'SHELL': '/bin/bash', 17:24:37 INFO - 'SHLVL': '1', 17:24:37 INFO - 'TERM': 'linux', 17:24:37 INFO - 'TMOUT': '86400', 17:24:37 INFO - 'USER': 'cltbld', 17:24:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:37 INFO - '_': '/tools/buildbot/bin/python'} 17:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:37 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 17:24:37 INFO - Cleaning up... 17:24:37 INFO - Return code: 0 17:24:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:37 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 17:24:37 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 17:24:37 INFO - Using env: {'DISPLAY': ':0', 17:24:37 INFO - 'HOME': '/home/cltbld', 17:24:37 INFO - 'LANG': 'en_US.UTF-8', 17:24:37 INFO - 'LANGUAGE': 'en_US:en', 17:24:37 INFO - 'LOGNAME': 'cltbld', 17:24:37 INFO - 'MAIL': '/var/mail/cltbld', 17:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:37 INFO - 'MOZ_NO_REMOTE': '1', 17:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:37 INFO - 'NO_EM_RESTART': '1', 17:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:37 INFO - 'PWD': '/builds/slave/test', 17:24:37 INFO - 'SHELL': '/bin/bash', 17:24:37 INFO - 'SHLVL': '1', 17:24:37 INFO - 'TERM': 'linux', 17:24:37 INFO - 'TMOUT': '86400', 17:24:37 INFO - 'USER': 'cltbld', 17:24:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:37 INFO - '_': '/tools/buildbot/bin/python'} 17:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:37 INFO - Downloading/unpacking psutil>=3.1.1 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:39 INFO - Installing collected packages: psutil 17:24:39 INFO - Running setup.py install for psutil 17:24:39 INFO - building 'psutil._psutil_linux' extension 17:24:39 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 17:24:39 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 17:24:39 INFO - building 'psutil._psutil_posix' extension 17:24:39 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 17:24:40 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 17:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:40 INFO - Successfully installed psutil 17:24:40 INFO - Cleaning up... 17:24:40 INFO - Return code: 0 17:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:40 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:40 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 17:24:40 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 17:24:40 INFO - Using env: {'DISPLAY': ':0', 17:24:40 INFO - 'HOME': '/home/cltbld', 17:24:40 INFO - 'LANG': 'en_US.UTF-8', 17:24:40 INFO - 'LANGUAGE': 'en_US:en', 17:24:40 INFO - 'LOGNAME': 'cltbld', 17:24:40 INFO - 'MAIL': '/var/mail/cltbld', 17:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:40 INFO - 'MOZ_NO_REMOTE': '1', 17:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:40 INFO - 'NO_EM_RESTART': '1', 17:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:40 INFO - 'PWD': '/builds/slave/test', 17:24:40 INFO - 'SHELL': '/bin/bash', 17:24:40 INFO - 'SHLVL': '1', 17:24:40 INFO - 'TERM': 'linux', 17:24:40 INFO - 'TMOUT': '86400', 17:24:40 INFO - 'USER': 'cltbld', 17:24:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:40 INFO - '_': '/tools/buildbot/bin/python'} 17:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:40 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 17:24:40 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 17:24:40 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 17:24:40 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 17:24:40 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 17:24:40 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 17:24:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:42 INFO - Installing collected packages: mozsystemmonitor 17:24:42 INFO - Running setup.py install for mozsystemmonitor 17:24:42 INFO - Successfully installed mozsystemmonitor 17:24:42 INFO - Cleaning up... 17:24:42 INFO - Return code: 0 17:24:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:42 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:42 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 17:24:42 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 17:24:42 INFO - Using env: {'DISPLAY': ':0', 17:24:42 INFO - 'HOME': '/home/cltbld', 17:24:42 INFO - 'LANG': 'en_US.UTF-8', 17:24:42 INFO - 'LANGUAGE': 'en_US:en', 17:24:42 INFO - 'LOGNAME': 'cltbld', 17:24:42 INFO - 'MAIL': '/var/mail/cltbld', 17:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:42 INFO - 'MOZ_NO_REMOTE': '1', 17:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:42 INFO - 'NO_EM_RESTART': '1', 17:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:42 INFO - 'PWD': '/builds/slave/test', 17:24:42 INFO - 'SHELL': '/bin/bash', 17:24:42 INFO - 'SHLVL': '1', 17:24:42 INFO - 'TERM': 'linux', 17:24:42 INFO - 'TMOUT': '86400', 17:24:42 INFO - 'USER': 'cltbld', 17:24:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:42 INFO - '_': '/tools/buildbot/bin/python'} 17:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:42 INFO - Downloading/unpacking jsonschema==2.5.1 17:24:42 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 17:24:42 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 17:24:42 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 17:24:42 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 17:24:42 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 17:24:42 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 17:24:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:44 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:44 INFO - warning: no files found matching '*.txt' 17:24:44 INFO - no previously-included directories found matching 'build' 17:24:44 INFO - no previously-included directories found matching 'dist' 17:24:44 INFO - no previously-included directories found matching '.git*' 17:24:44 INFO - Installing collected packages: jsonschema, functools32 17:24:44 INFO - Running setup.py install for functools32 17:24:45 INFO - warning: no files found matching '*.txt' 17:24:45 INFO - no previously-included directories found matching 'build' 17:24:45 INFO - no previously-included directories found matching 'dist' 17:24:45 INFO - no previously-included directories found matching '.git*' 17:24:45 INFO - Successfully installed jsonschema functools32 17:24:45 INFO - Cleaning up... 17:24:45 INFO - Return code: 0 17:24:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24: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 blobuploader==1.2.4 17:24:45 INFO - Using env: {'DISPLAY': ':0', 17:24:45 INFO - 'HOME': '/home/cltbld', 17:24:45 INFO - 'LANG': 'en_US.UTF-8', 17:24:45 INFO - 'LANGUAGE': 'en_US:en', 17:24:45 INFO - 'LOGNAME': 'cltbld', 17:24:45 INFO - 'MAIL': '/var/mail/cltbld', 17:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:45 INFO - 'MOZ_NO_REMOTE': '1', 17:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:45 INFO - 'NO_EM_RESTART': '1', 17:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:45 INFO - 'PWD': '/builds/slave/test', 17:24:45 INFO - 'SHELL': '/bin/bash', 17:24:45 INFO - 'SHLVL': '1', 17:24:45 INFO - 'TERM': 'linux', 17:24:45 INFO - 'TMOUT': '86400', 17:24:45 INFO - 'USER': 'cltbld', 17:24:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:45 INFO - '_': '/tools/buildbot/bin/python'} 17:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 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 17:24:47 INFO - Downloading docopt-0.6.1.tar.gz 17:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:47 INFO - Running setup.py install for blobuploader 17:24:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:48 INFO - Running setup.py install for requests 17:24:48 INFO - Running setup.py install for docopt 17:24:48 INFO - Successfully installed blobuploader requests docopt 17:24:48 INFO - Cleaning up... 17:24:48 INFO - Return code: 0 17:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:48 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:48 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 17:24:48 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 17:24:48 INFO - Using env: {'DISPLAY': ':0', 17:24:48 INFO - 'HOME': '/home/cltbld', 17:24:48 INFO - 'LANG': 'en_US.UTF-8', 17:24:48 INFO - 'LANGUAGE': 'en_US:en', 17:24:48 INFO - 'LOGNAME': 'cltbld', 17:24:48 INFO - 'MAIL': '/var/mail/cltbld', 17:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:48 INFO - 'MOZ_NO_REMOTE': '1', 17:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:48 INFO - 'NO_EM_RESTART': '1', 17:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:48 INFO - 'PWD': '/builds/slave/test', 17:24:48 INFO - 'SHELL': '/bin/bash', 17:24:48 INFO - 'SHLVL': '1', 17:24:48 INFO - 'TERM': 'linux', 17:24:48 INFO - 'TMOUT': '86400', 17:24:48 INFO - 'USER': 'cltbld', 17:24:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:48 INFO - '_': '/tools/buildbot/bin/python'} 17:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:48 INFO - Running setup.py (path:/tmp/pip-vaRbdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:48 INFO - Running setup.py (path:/tmp/pip-B_g3Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:48 INFO - Running setup.py (path:/tmp/pip-x6L6R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:49 INFO - Running setup.py (path:/tmp/pip-mhl4T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:49 INFO - Running setup.py (path:/tmp/pip-wPTSNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:49 INFO - Running setup.py (path:/tmp/pip-uw8wBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:49 INFO - Running setup.py (path:/tmp/pip-lcVSZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:49 INFO - Running setup.py (path:/tmp/pip-aXKB44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:49 INFO - Running setup.py (path:/tmp/pip-zFxXjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:49 INFO - Running setup.py (path:/tmp/pip-KStQa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:49 INFO - Running setup.py (path:/tmp/pip-AXZsvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:49 INFO - Running setup.py (path:/tmp/pip-jwMXTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:49 INFO - Running setup.py (path:/tmp/pip-Yj78vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:49 INFO - Running setup.py (path:/tmp/pip-4Bt1BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:49 INFO - Running setup.py (path:/tmp/pip-t_JNr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:49 INFO - Running setup.py (path:/tmp/pip-5KJtY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:49 INFO - Running setup.py (path:/tmp/pip-nKNxVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:50 INFO - Running setup.py install for manifestparser 17:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Running setup.py install for mozcrash 17:24:50 INFO - Running setup.py install for mozdebug 17:24:50 INFO - Running setup.py install for mozdevice 17:24:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Running setup.py install for mozfile 17:24:50 INFO - Running setup.py install for mozhttpd 17:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Running setup.py install for mozinfo 17:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Running setup.py install for mozInstall 17:24:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:50 INFO - Running setup.py install for mozleak 17:24:50 INFO - Running setup.py install for mozlog 17:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Running setup.py install for moznetwork 17:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Running setup.py install for mozprocess 17:24:51 INFO - Running setup.py install for mozprofile 17:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Running setup.py install for mozrunner 17:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Running setup.py install for mozscreenshot 17:24:51 INFO - Running setup.py install for moztest 17:24:51 INFO - Running setup.py install for mozversion 17:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:51 INFO - Cleaning up... 17:24:51 INFO - Return code: 0 17:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:51 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:51 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 17:24:51 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 17:24:51 INFO - Using env: {'DISPLAY': ':0', 17:24:51 INFO - 'HOME': '/home/cltbld', 17:24:51 INFO - 'LANG': 'en_US.UTF-8', 17:24:51 INFO - 'LANGUAGE': 'en_US:en', 17:24:51 INFO - 'LOGNAME': 'cltbld', 17:24:51 INFO - 'MAIL': '/var/mail/cltbld', 17:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:51 INFO - 'MOZ_NO_REMOTE': '1', 17:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:51 INFO - 'NO_EM_RESTART': '1', 17:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:51 INFO - 'PWD': '/builds/slave/test', 17:24:51 INFO - 'SHELL': '/bin/bash', 17:24:51 INFO - 'SHLVL': '1', 17:24:51 INFO - 'TERM': 'linux', 17:24:51 INFO - 'TMOUT': '86400', 17:24:51 INFO - 'USER': 'cltbld', 17:24:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:51 INFO - '_': '/tools/buildbot/bin/python'} 17:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:52 INFO - Running setup.py (path:/tmp/pip-qpo6zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:52 INFO - Running setup.py (path:/tmp/pip-5tsJ2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:52 INFO - Running setup.py (path:/tmp/pip-1W1ZCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:52 INFO - Running setup.py (path:/tmp/pip-9hPrI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:52 INFO - Running setup.py (path:/tmp/pip-RSuWer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:52 INFO - Running setup.py (path:/tmp/pip-NKjzVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:52 INFO - Running setup.py (path:/tmp/pip-4bQEIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:52 INFO - Running setup.py (path:/tmp/pip-M2ZvBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:52 INFO - Running setup.py (path:/tmp/pip-UxzFn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:52 INFO - Running setup.py (path:/tmp/pip-W1mbw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:52 INFO - Running setup.py (path:/tmp/pip-rPkLxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:52 INFO - Running setup.py (path:/tmp/pip-LiofQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:52 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)) 17:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:52 INFO - Running setup.py (path:/tmp/pip-cQlAZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:53 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)) 17:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:53 INFO - Running setup.py (path:/tmp/pip-kxkUlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:53 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)) 17:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:53 INFO - Running setup.py (path:/tmp/pip-M0DRfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:53 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)) 17:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:53 INFO - Running setup.py (path:/tmp/pip-slLrmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:53 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)) 17:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:53 INFO - Running setup.py (path:/tmp/pip-A1brYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:53 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)) 17:24:53 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)) 17:24:53 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)) 17:24:53 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)) 17:24:53 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)) 17:24:53 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)) 17:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:53 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 17:24:53 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 17:24:53 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 17:24:53 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 17:24:53 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 17:24:53 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 17:24:55 INFO - Downloading blessings-1.6.tar.gz 17:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:55 INFO - Installing collected packages: blessings 17:24:55 INFO - Running setup.py install for blessings 17:24:55 INFO - Successfully installed blessings 17:24:55 INFO - Cleaning up... 17:24:55 INFO - Return code: 0 17:24:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:55 INFO - Reading from file tmpfile_stdout 17:24:55 INFO - Current package versions: 17:24:55 INFO - argparse == 1.2.1 17:24:55 INFO - blessings == 1.6 17:24:55 INFO - blobuploader == 1.2.4 17:24:55 INFO - docopt == 0.6.1 17:24:55 INFO - functools32 == 3.2.3-2 17:24:55 INFO - jsonschema == 2.5.1 17:24:55 INFO - manifestparser == 1.1 17:24:55 INFO - mozInstall == 1.12 17:24:55 INFO - mozcrash == 0.17 17:24:55 INFO - mozdebug == 0.1 17:24:55 INFO - mozdevice == 0.48 17:24:55 INFO - mozfile == 1.2 17:24:55 INFO - mozhttpd == 0.7 17:24:55 INFO - mozinfo == 0.9 17:24:55 INFO - mozleak == 0.1 17:24:55 INFO - mozlog == 3.3 17:24:55 INFO - moznetwork == 0.27 17:24:55 INFO - mozprocess == 0.23 17:24:55 INFO - mozprofile == 0.28 17:24:55 INFO - mozrunner == 6.12 17:24:55 INFO - mozscreenshot == 0.1 17:24:55 INFO - mozsystemmonitor == 0.3 17:24:55 INFO - moztest == 0.7 17:24:55 INFO - mozversion == 1.4 17:24:55 INFO - psutil == 3.1.1 17:24:55 INFO - requests == 1.2.3 17:24:55 INFO - wsgiref == 0.1.2 17:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 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 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:55 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 17:24:55 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 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 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)) 17:24:55 INFO - Cleaning up... 17:24:55 INFO - Return code: 0 17:24:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', '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 17:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:24:56 INFO - Cleaning up... 17:24:56 INFO - Return code: 0 17:24:56 INFO - Running post-action listener: _resource_record_post_action 17:24:56 INFO - Running post-action listener: _start_resource_monitoring 17:24:56 INFO - Starting resource monitoring. 17:24:56 INFO - [mozharness: 2016-07-21 00:24:56.195174Z] Finished create-virtualenv step (success) 17:24:56 INFO - [mozharness: 2016-07-21 00:24:56.195606Z] Running install step. 17:24:56 INFO - Running pre-action listener: _resource_record_pre_action 17:24:56 INFO - Running main action method: install 17:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:56 INFO - Reading from file tmpfile_stdout 17:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:56 INFO - Reading from file tmpfile_stdout 17:24:56 INFO - Output received: 17:24:56 INFO - Usage: mozinstall [options] installer 17:24:56 INFO - Options: 17:24:56 INFO - -h, --help show this help message and exit 17:24:56 INFO - -d DEST, --destination=DEST 17:24:56 INFO - Directory to install application into. [default: 17:24:56 INFO - "/builds/slave/test"] 17:24:56 INFO - --app=APP Application being installed. [default: firefox] 17:24:56 INFO - mkdir: /builds/slave/test/build/application 17:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:25:13 INFO - Reading from file tmpfile_stdout 17:25:13 INFO - Output received: 17:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:13 INFO - Running post-action listener: _resource_record_post_action 17:25:13 INFO - [mozharness: 2016-07-21 00:25:13.840979Z] Finished install step (success) 17:25:13 INFO - [mozharness: 2016-07-21 00:25:13.841086Z] Running run-tests step. 17:25:13 INFO - Running pre-action listener: _resource_record_pre_action 17:25:13 INFO - Running main action method: run_tests 17:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:13 INFO - Python 2.7.3 17:25:13 INFO - Return code: 0 17:25:13 INFO - grabbing minidump binary from tooltool 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 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 0x177a3b0>, '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 0x177b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:13 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 17:25:13 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 17:25:13 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 17:25:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:13 INFO - Return code: 0 17:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 17:25:13 INFO - Using env: {'DISPLAY': ':0', 17:25:13 INFO - 'HOME': '/home/cltbld', 17:25:13 INFO - 'LANG': 'en_US.UTF-8', 17:25:13 INFO - 'LANGUAGE': 'en_US:en', 17:25:13 INFO - 'LOGNAME': 'cltbld', 17:25:13 INFO - 'MAIL': '/var/mail/cltbld', 17:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:13 INFO - 'MOZ_NO_REMOTE': '1', 17:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:13 INFO - 'NO_EM_RESTART': '1', 17:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:13 INFO - 'PWD': '/builds/slave/test', 17:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:13 INFO - 'SHELL': '/bin/bash', 17:25:13 INFO - 'SHLVL': '1', 17:25:13 INFO - 'TERM': 'linux', 17:25:13 INFO - 'TMOUT': '86400', 17:25:13 INFO - 'USER': 'cltbld', 17:25:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571', 17:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:13 INFO - '_': '/tools/buildbot/bin/python'} 17:25:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:25:14 INFO - mozversion application_buildid: 20160720143019 17:25:14 INFO - mozversion application_changeset: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 17:25:14 INFO - mozversion application_display_name: Nightly 17:25:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:14 INFO - mozversion application_name: Firefox 17:25:14 INFO - mozversion application_remotingname: firefox 17:25:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:25:14 INFO - mozversion application_vendor: Mozilla 17:25:14 INFO - mozversion application_version: 50.0a1 17:25:14 INFO - mozversion platform_buildid: 20160720143019 17:25:14 INFO - mozversion platform_changeset: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 17:25:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:25:14 INFO - mozversion platform_version: 50.0a1 17:25:14 INFO - using testdate: 1469060714 17:25:14 INFO - actual date: 1469060714 17:25:14 INFO - starting webserver on 'localhost:50512' 17:25:14 INFO - SUITE-START | Running 2 tests 17:25:14 INFO - TEST-START | dromaeo_css 17:25:14 INFO - operating with platform_type : linux_ 17:25:14 INFO - Initialising browser for dromaeo_css test... 17:25:14 INFO - TEST-INFO | started process 24798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWnr_Kj/profile http://localhost:50512/getInfo.html) 17:25:17 INFO - PROCESS | 24798 | __metrics Screen width/height:1600/1200 17:25:17 INFO - PROCESS | 24798 | colorDepth:24 17:25:17 INFO - PROCESS | 24798 | Browser inner width/height: 1024/697 17:25:17 INFO - PROCESS | 24798 | __metrics 17:25:18 INFO - PROCESS | 24798 | 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" 17:25:18 INFO - PROCESS | 24798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:25:19 INFO - TEST-INFO | 24798: exit 0 17:25:19 INFO - Browser initialized. 17:25:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:19 INFO - TEST-INFO | started process 24881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWnr_Kj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:31 INFO - PROCESS | 24881 | RSS: Main: 157487104 17:25:31 INFO - PROCESS | 24881 | 17:26:22 INFO - PROCESS | 24881 | 1469060782874 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] 17:28:30 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50512/tests/dromaeo/cssquery-ext.html) 17:28:31 INFO - PROCESS | 24881 | RSS: Main: 275050496 17:28:31 INFO - PROCESS | 24881 | 17:31:34 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-ext.html (next: http://localhost:50512/tests/dromaeo/cssquery-jquery.html) 17:31:34 INFO - PROCESS | 24881 | RSS: Main: 242520064 17:31:34 INFO - PROCESS | 24881 | 17:34:36 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50512/tests/dromaeo/cssquery-mootools.html) 17:34:37 INFO - PROCESS | 24881 | RSS: Main: 186257408 17:34:37 INFO - PROCESS | 24881 | 17:37:39 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50512/tests/dromaeo/cssquery-prototype.html) 17:37:40 INFO - PROCESS | 24881 | RSS: Main: 210157568 17:37:40 INFO - PROCESS | 24881 | 17:40:42 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50512/tests/dromaeo/cssquery-yui.html) 17:40:43 INFO - PROCESS | 24881 | RSS: Main: 188641280 17:40:43 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-yui.html (next: http://localhost:50512/tests/dromaeo/cssquery-dojo.html) 17:43:46 INFO - PROCESS | 24881 | RSS: Main: 275771392 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | __start_tp_report 17:43:46 INFO - PROCESS | 24881 | _x_x_mozilla_page_load 17:43:46 INFO - PROCESS | 24881 | _x_x_mozilla_page_load_details 17:43:46 INFO - PROCESS | 24881 | |i|pagename|runs| 17:43:46 INFO - PROCESS | 24881 | |0;dojo.html;3086.1513083901923;3096.9380612387768;3117.485614873546;3121.188490992342;3134.639516455607;5423.186522021689;5428.782848686053;5458.263134476844;5525.364583072947;5566.471185237401;5397.595180361469;5459.071957767179;5474.288342515468;5524;5529.861753456155;4838.709677419357;4893.657443978923;4938.925916111261;4957.479464656213;5068.695878247317;5054.949450505503;5093.236014597803;5108.2848401223855;5122.6158038147105;5133.845984620468;4895.388076490439;4927.926081108786;4971.875703107415;4979.576735977446;5028.170351891933;4932.80268789248;4942.209246520575;4945.035718034985;4953.182724850395;5006.299118123466;4955.900881982377;4984.451710311862;4994.425641051289;5001.924971125436;5015.3480047593575;5423.755930983115;5444.346678398578;5490.231367608538;5495.450454954513;5543.944560554423;5865.824025279248;5874.676892770896;5916.881662366772;5930.110483427477;5937.970310148422;5871.3541510433815;5917.52659787216;5958.136070269787;5973.850653733648;5976.9402305977255;5374.7850085996515;5375.623706340558;5400.567954563626;5423.322084739408;5488.56091512686;5930.318013428425;5989.071693887455;5992.910106348409;6001.849953751103;6002.459778619946;5732.398098199629;5774.94225057744;5781.017227071408;5786.900488907094;5787.826365209051;5642.238297829823;5672.404397538199;5693.601447898607;5725.713714314267;5782.161586570008;5678.744456499468;5687.800926967537;5689.573282003867;5697.886042279131;5710.229119068873;5670.801521946794;5672.914906276409;5696.11710184922;5727.284089488814;5727.5131613812455;4342.109867477223;4362.062156636339;4380.912381752347;4404.405405270248;4440.489343725513;3922.3528117860806;3925.487687879759;3929.6070392960473;3954.723169378116;3962.7226094173707;5435.374931882884;5442.210879422461;5447.291852059207;5449.782008719607;5450.4549545045975;5675.290588676416;5767.740451679684;5857.121431785181;5889.499392551681;5898.3050847457625;5464.726763661881;5466.753996070186;5467.152591348347;5469.945300547023;5483.561315094783;5084.059449001947;5086.54221120101;5092.770825312869;5100.6429549931145;5140.920406714557;5871.324797648325;6016.639001659914;6083.422074902877;6084.5436592255755;6126.5098792097415;5875.118732190205;5875.383084776208;5877.382874798084;5879.735411906389;5942.257217847769;5947.613405128653;5995.640261584319;6003.759849605967;6013.3685962975005;6018.428249316308;5644.153376993484;5702.914456283076;5762.2221000164445;5780.306363236438;5878.500327472213;5829.242198514166;5857.58996870232;5860.2967643883;5862.765489380377;5873.647581145145;5756.913646295393;5758.568107391879;5762.971185144047;5764.769409223752;5784.363719990713;5604.383517812956;5607.775688972395;5668.376478587435;5672.4894759471845;5769.105788602773;5699.971500142473;5713.143028545752;5719.342275638355;5729.598928074995;5749.8562535936935;5723.742431590672;5740.913886291793;5756.625819321898;5783.103618939072;5808.564357673107;5496.1755736639825;5525.778968841362;5536.972315138399;5596.356419011866;5632.436756324335 17:43:46 INFO - PROCESS | 24881 | |1;ext.html;583.1282233061571;615.9999999999999;636.5862189576775;637.3435361577575;651.1404945471972;31176.84411577942;31811.522827157612;44303.999999999956;45153;45175.77412112935;43125.56874431255;46016.30975535361;46050.30924536135;46588.53411465884;46611.53388466123;8943.597538110784;9250.306227032966;9254.07459254076;9261.6295348186;9271.536423178848;9239;9299.209567186763;9313.627454901796;9314.580843862042;9329.020452852454;9336.953315233448;9363.157315841572;9376.5311734413;9379.577918993627;9384.39001464906;9255.213306868924;9301.767455813591;9308.488033158173;9310.162085412345;9318.487483188423;9205.631774729003;9267;9269.90730092704;9277.536123193813;9286.21067209288;43330.13339733219;43529.564704352866;43885.78057109726;43909.341359879625;43927.560724392984;3548.361294966905;3613.8193090345376;3622.166901612644;3639.1266096137;3653.2328211075705;31916.521252181235;31982.360352793046;32073.839630801696;32232.838835805906;32730.41852695224;4435.556444355571;4460.286354183315;4492.618127459137;4562.5665561771575;4601.654875884322;388365;389743;390128;391524.99999999715;392389;58942.70528647329;59218;59533.70233148893;59642.403575964556;59695.701521492985;53376;62436.37563624306;62540.68729656323;62549.37450625526;64322.67838660777;15353.07881527112;15356.692866142615;15376.15431151275;15412.845871541142;15471.845281547041;12415.75168496625;12495.062870284764;12510.74978500425;12514.624561263177;12519.874801251872;14417.927910360591;15962;16654.916725416537;16777;16781.91609041947;5801.1878337032;5940.287165540077;5995.961373133156;6016.458518733335;6059.969700151471;1008.9848652270222;1035.9533820978074;1056.0231785598291;1095.8465814785936;1104.9447527623586;32315.51526727101;33118.66881331156;33420.49869251963;33468.66531334655;33850.322993539994;1021.8313978193663;1143.651186388143;1155.422288855572;1159.750653609461;1201.5133870782347;17304.65390692179;17448.738268925976;17532.912335438243;17544.56138596545;17553.82446175522;541225;545839;546594;546777;547283;59657.403425966055;59745;59906;60082.69958650179;60173.699131504065;1291.251074376878;1317.5454468208452;1351.2635613590617;1362.8023936529148;1376.5732622886937;31669;32528;32779.18052048718;33053;33469.83265083659;53029.204561932376;53388.73305633447;53427.465725343805;53514;53531.19703204533;368162;370081;370764;372009;372537;31636.03867397989;36550.4517432244;36603.81698091599;39169;43003;43220.78389608158;47837.76081119572;48214.517854821;48854.26718599295;49648.751756240985;39583.2083358337;40519.392209117475;41421;42066.57933420749;44271;41143.7942810284;41931.7903410481;42803.357949631405;42942.57057429511;44039;42278.154436911704;42661;43852;44030.339544907496;44049.55950440583;34946.427410767086;38010.809945950095;38138.23723525569;38437.80781096189;39347.409788853765;28704.569431458127;29241.7075829239;29361.265968350108;29499;29576.704232958255 17:43:46 INFO - PROCESS | 24881 | |2;jquery.html;382.7206139518153;390.42217518073267;396.2530629762898;403.93133167361543;412.40201707524096;13060.130591560272;18784;20404.387868363934;20441.488962775937;20446.386608401735;19406.805931940675;19474.805251947477;20095.79904200961;20408.591828163466;20425.489362765937;5753.223314852494;5911.556633252501;5919;5920.289565252176;5945.85135371617;5726.856828579277;5818.359980402152;5822.737976791033;5837.824865254028;5878.617889837168;4289.656827453812;4719.315699223611;6541.31316211798;6561.507886908477;6567.6059436433725;5922.97038514809;6186.041163619646;6624.73501059957;6641.169853768279;6650.5344625876205;5564.4713752193475;5641.153826925953;5658.151277308396;5659.858503537444;5661.631993920423;14502.202378869159;14703.794430835353;21799.346019619436;23295.883520582458;24166.879165604234;2271.772822717715;2375.7149142102885;2387.3196139100446;2406.446517301031;2868.870900809448;10107.79784404315;10611.310264832839;10644.893551064468;10860.185486088574;10880.238383313172;1847.575057736728;1954.5895361974003;1986.7417235759258;2074.222166687492;2080.729505164334;86525.13474865233;87530;90426.5478672609;90457;90871.54564227136;11268;11328.660140195807;11336.773264534662;11454.770904582028;11468.827967580493;15143.167125808186;15427.460038898585;15531.223438828014;15610.687786244438;15707.136107514196;6455.7740479083;6544.181977252843;7513.699452021858;8114;8296;7670.846583068307;7747.225277472207;7780.299773020455;7962;7989.680412783539;4740.1230772307235;4773.355596994431;4826.782794774173;4856.980034192859;4920.778564964514;1915.7030660247683;1994.1026538057931;2007.5407625658743;2023.8785672859676;2038.4598081508411;836.93304535637;925.847235206197;946.1201082992883;952.3714348530076;978.8384916488842;19628;20494.795052049587;20528.726476152486;20588.691169632468;20758.169673213204;990.7225976726528;992.1170158558888;1027.41950797799;1036.8703912011;1092.2790957967702;10599.894001060045;11264.324140551593;11326.490307936163;11350.432478376048;11357.943210283896;388881;394697;395261;490923;497162;95339;103886;108117;108413.45793270983;109616.4519177399;944.3672739264572;977.6333874796951;1003.4130033930232;1005.5173516712019;1026.743314171457;17564;18317.90841045786;18883.433496995112;19085.141168647166;19165.137568809158;45127;45153;46772.29841552312;46833.765831170625;46881;63902.680486597266;64252.35747642464;64574.35425645871;66065.66967165134;66091.66954165198;8176.141505141874;8325.583720814057;8555.31557475413;8566.78583035429;8648.308135349283;11643.767124657628;12665.81001285;12925.676858078246;13184.406701698255;13239.20564766117;11314.773704526027;11649.708757281136;11686;11791.35147566892;11963.700907477383;10594.20543459259;11019.393933333744;11284.09727221804;11343.886561134614;11698.2981021139;11491.540338386705;11609.30344179352;11617.535298587962;11728.824067639163;11963.461644225858;8121.269085782308;8283;8429.747107586782;8458.873116903374;8603;11054.447277636247;11491.8276225855;11515.654530364103;11742;11852.76294474123 17:43:46 INFO - PROCESS | 24881 | |3;mootools.html;1352.1819299323902;1434.3832152174564;1493.2160615676771;1611.6051567365996;1784.5984653452967;8575.871361929569;9039.954800225998;9041.050689677579;9231.676891308805;9238.030006849285;9050.959139698936;9053.637854485813;9106.86339704905;9144.771380715485;9145.17693407595;2092.696558998944;2279.737830149529;2307.665388518668;2329.895154718033;2332.5568142052957;2341.8594884306995;2346;2356.387339291788;2357.6227803551437;2361.586722323595;2282.429392651837;2309.8036666883336;2323.1520495019367;2330.7669233076726;2331.8834058297102;1991.8605697601174;2050.8256798172174;2269.024319542596;2270.818334533233;2274.9090036398525;2099.0554250587297;2165.8267338612873;2211.513467037249;2228.1533017453426;2235.0724449353497;8675;8688.956555217184;8706.1729135732;8725.476471411735;8726.38915275931;5043.293938848564;5168.53483186515;5170.302009228743;5230.581553475713;5246.632735708502;3470.2538954124734;3477.9652203477895;3492.0746002309406;3552.0942159749357;3603.8017909014993;1152.3661985907802;1154.786364522566;1160.5183848702777;1163.7672465506932;1188.465190664196;12433.254004759743;12572.119951603392;12623.179493332904;12651.3041782701;12668.176568523017;4208.957910420918;4454.799534020977;4474.239379305526;4598.31025346194;4602.240630296031;9633.710988670351;9639.807203855884;9640.373375730554;9642.566084526214;9651.276154288456;5148.124818780816;5171.7155556444;5176.767045482962;5196.272521846944;5196.714180720021;4200.5169405518145;4824.34871292378;4860.36815214027;4872.366592342973;4989.476105008995;3678.6321367863534;3763.7365384423374;3855.2289542091694;3868.5551161616213;3893.260280546687;1062.5431064642278;1125.144889883678;1132.6205721083365;1133.54091592905;1136.7158210447387;971.820213260549;988.6687959533493;1006.2603986070233;1010.8534262531891;1016.8525563793208;6231.688415579203;6262.342454042351;6331.176946996861;6382.648954307465;6676.799696009128;950.8811398575178;960.5917485068818;1000.884898236712;1013.9847902281472;1041.4324193314662;4095.447114639545;4237.936430953539;4373.562643735601;4455.910881782346;4460.375547423363;10640.946795266129;11072.446377681084;11094.1124710023;11095.944520277508;11107;10471.633492827714;10918.290311129751;10966.287191332538;11026.503807328689;11041.779164416826;8341.124181960928;8517.574121294034;8525.95737021311;8532.914670853212;8536.658533658709;5997.670128142994;6107;6244.781432649836;6390.233172019387;6523.7716679915975;10258.17934565248;10410.115140212863;10411.427371494641;10419.426931518536;10492.317999330018;9514.33399662017;9851.16265117473;9858.753531161778;10095.040971107734;10440.37357758537;7272.636368181676;7806.843863122819;8110.675572977015;8242.629081691219;8252.00975882898;8300.335973122257;8418.494890306356;8572;8592.183742544448;8602.354823388147;7653.693852245848;7655.540667559964;7722.845543088994;7757.806054848674;7825.569593672175;7433.888491672521;7571.053618297713;7606.011218541555;7622.656980435783;7789.1821358756515;6705.8994115087335;6807.9319206807295;6814.2163651180745;6865.107536020286;6865.107536020485;5302.522772950453;5340.706261155674;5368.792021795065;5378.946210538001;5635.380108188014;5368.1679339702405;5403.405625381126;5428.59285553593;5469.206964990134;5493.258410114583 17:43:46 INFO - PROCESS | 24881 | |4;prototype.html;327.9278753290226;338.29803158446225;344.0641455241745;346.44049859476934;347.3608560249142;5237.711925844077;5327.147656374981;5362.862725305696;5416.458354164582;5435.809746658868;5228.712420816853;5245.344331958505;5249.947500524993;5252.921206181911;5268.841934741954;4175.060611362442;4181.351890456984;4191.790410479463;4201.1807697499;4223.535411104792;4038.495188101487;4195.832166713343;4215.59951804578;4230.504002638443;4233.936490952638;4147.688923330762;4176.415301857743;4179.540250572434;4181.58184181581;4181.790910454481;4155.958440415588;4163.354680024601;4174.415581818548;4177.16456708658;4180.268453020709;3694.6305369463107;3701.241245544684;3702.4816525686424;3711.5546134463766;3719.256148770257;5045;5172.715500647463;5191.454897235773;5216.217567364888;5233.031889100528;4727.598154156901;4737.360456338385;4742.644301677388;4748.216544270192;4763.499832517605;5416.756245968941;5493.725313734298;5496.725163741837;5506.80726174586;5532.419095994903;3960.782156981365;3981.9248802823367;3992.161646054332;3997.4603428537357;4001.1991605876005;5655.462731040545;5683;5693.715314234271;5696.6866822324755;5701.230333904911;4090.938635920404;4125.793710314472;4127.195196936628;4137.2552940471005;4149.356849688304;3974.582668819732;4120.835166593362;4160.690816596757;4161.791910404468;4180.289350810309;4653.208954477747;4708.8351907683755;4710.882227944328;4731.33761273422;4733;5537.833864984057;5550.16747487872;5565.332160140809;5626.493615574618;5637.267155269788;1305;1361.0812701426498;1419.5457453614745;1424.48006477637;1424.8218972628422;951.2117219627057;972.7762614598682;989.9406035637885;991.2862738828032;992.4392718114242;5244.895102098013;5249.160134378481;5274.841754747364;5275.235090911796;5282.418933917266;5631;5647.802326918538;5650.5479561634975;5652.576056795757;5653.491185793298;5088.592912566985;5238.476152384807;5245.344331958505;5256.789728410898;5332.146856502941;2999.2202027473013;3018.879244830226;3028.3943211357378;3029.1972627253795;3030.6060212172715;5830.941690583039;5851.239338886003;5855.560832937546;5884.146493854422;5884.146798714162;5585.463997400748;5777.7977770777825;5801.419858014165;5808.854778630568;5825.2135961644635;5808.157817116495;5840.729191652688;5855.414458554111;5858.179854820414;5876.382979787147;5406.648567843077;5669.34802497718;5675.644607487846;5676.893005863982;5702.34423041339;5647.29408823897;5675.404082571271;5678.5457163426;5698.544116470755;5703.686297253691;5856.297244330707;5890.646561206341;5910.143029260819;5928.34788173292;5941.613795103304;4022.1151346703678;4093.959060409477;4104.322786740155;4124.628783409507;4142.239548192067;5692;5726.513246374105;5737.971310143423;5748.45389687979;5754.223179870663;5503.3395992481155;5625.268715067015;5629.634073785191;5645.379008309164;5683.8863222736145;5558.44415558441;5561.833145005657;5568.972155139199;5574.049082821142;5586.888262234814;5546.8383021677255;5559.52744016747;5570.415106413769;5584.464272325143;5652.886942261214;5332.786688532416;5560.304961879765;5624.734434752311;5649.638465113251;5708.80019199326;5436.852443284802;5463.399026107205;5464.453554644504;5464.9453505464435;5475 17:43:46 INFO - PROCESS | 24881 | |5;yui.html;735.819724167579;763.805229666435;802.4904185841989;832.6752566499065;846.3144852669338;15965.920170399146;16870.57823554412;16882.66234675306;16889.155542222885;16938.999999999985;15252.923735381308;15254.618634534114;15396.307166177521;15426.228688565556;15427.69144617107;664.2726214794816;791.6002418778537;813.6663967773214;818.1613845808035;820.7004443378154;810.3436216664492;812.155358427238;814.2549567146054;814.6578437056421;815.8857759913617;863.9006514250848;865.1132589096195;865.1996902864856;865.6407590849822;865.7272959017921;701.8982247574098;715.5885365914568;716.183550752143;837.4347315562032;857.7298151082421;634.7112064010864;634.8285962790067;635.6249812610582;635.8887194740902;637.3690046853628;15776.76334854978;15822.604434889105;15827;15839;15853;14409.279536023261;14627.707445851023;14630.853691463162;14645.707085858223;14695.559133226021;13391.263480508567;13477;13641.727165456636;13719.862801371959;14313.212773297568;4382.386465894777;4385.386045953569;4407.603315701603;4412.933805992912;4612.976935115303;76865.61567192184;77238.61380693117;77285.61357193178;81686.59156704239;83644.58177709133;10757.677269681923;11209.09445394285;11265;11333.773324533464;11504.482298296429;20689.482762931046;20912.37262882116;20924.686129708065;21017.159313627282;21210.681839772416;8810.691625793066;8829.69096081634;8853.867191992125;9054.728358149267;9070.229030532479;4765.618750499952;4783.904321913542;4789.521047895182;4926.6551341406475;4928.852134435972;3621.6559426854406;3749.6625303722794;3752.836620647608;3764.607095374729;3770.321342158438;668.2749217099501;680.6664734280167;692.4425837201102;700.8177873752759;704.1866644026157;637.5568979559255;680.3808534233922;705.2594775485719;718.6370882704306;719.2627556754264;9511.57197926095;9554.808903821884;9648.517574121266;10169.694909152737;10239.539220735085;612.4579746923915;638.9009703495966;674.9628770417675;698.5215127637584;727.7489266203152;4855.150348689036;4866.245731911559;4885.780139893643;4920.778564964585;4953.18272485036;102036;123081;125251.37374313253;126107.36946315393;126544;58870.70564647235;91426.54286728657;108222;110794;112622;95757;97447;97713;97778.511107444;98021.50989245008;9245.491497967676;9331.626734930527;9339.67311144134;9550.474723890253;9552.765497201557;55672.72163639156;55732.44267557435;56433.71783141058;57307.853842923745;58181.70909145597;45558.54441455675;49975.500244997085;63517.36482635114;76499.23500764921;76549.61725191338;11452.94273528627;11513.712157195801;11838.230515016496;11875.287482751062;12043.458044387848;12829.23024618526;12893.355332233163;12933.224006559636;13176.934115329363;13241.3379331035;12095.274283542663;12369.567065152676;12682.365881706062;12796.360181990676;12800.74398512043;12267;12690.619281421572;12701.491940322283;12735.363231838557;13205.537806176737;12114.75770484603;12335.50657973707;12485.250884946932;12629;12807.871921280668;10078.596856125672;10199.439030853375;10358.326708763907;10527.368357898551;10539.894601053891;9214.880577467355;9631.903680963382;10112.646057387956;10418.218633602359;10423.807572774762 17:43:46 INFO - PROCESS | 24881 | __end_tp_report 17:43:46 INFO - PROCESS | 24881 | __start_cc_report 17:43:46 INFO - PROCESS | 24881 | _x_x_mozilla_cycle_collect,1137 17:43:46 INFO - PROCESS | 24881 | __end_cc_report 17:43:46 INFO - PROCESS | 24881 | __startTimestamp1469061826345__endTimestamp 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | ------- Summary: start ------- 17:43:46 INFO - PROCESS | 24881 | Number of tests: 6 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#0] dojo.html Cycles:165 Average:5417.25 Median:5642.24 stddev:621.94 (11.0%) stddev-sans-first:596.36 17:43:46 INFO - PROCESS | 24881 | Values: 3086.2 3096.9 3117.5 3121.2 3134.6 5423.2 5428.8 5458.3 5525.4 5566.5 5397.6 5459.1 5474.3 5524.0 5529.9 4838.7 4893.7 4938.9 4957.5 5068.7 5054.9 5093.2 5108.3 5122.6 5133.8 4895.4 4927.9 4971.9 4979.6 5028.2 4932.8 4942.2 4945.0 4953.2 5006.3 4955.9 4984.5 4994.4 5001.9 5015.3 5423.8 5444.3 5490.2 5495.5 5543.9 5865.8 5874.7 5916.9 5930.1 5938.0 5871.4 5917.5 5958.1 5973.9 5976.9 5374.8 5375.6 5400.6 5423.3 5488.6 5930.3 5989.1 5992.9 6001.8 6002.5 5732.4 5774.9 5781.0 5786.9 5787.8 5642.2 5672.4 5693.6 5725.7 5782.2 5678.7 5687.8 5689.6 5697.9 5710.2 5670.8 5672.9 5696.1 5727.3 5727.5 4342.1 4362.1 4380.9 4404.4 4440.5 3922.4 3925.5 3929.6 3954.7 3962.7 5435.4 5442.2 5447.3 5449.8 5450.5 5675.3 5767.7 5857.1 5889.5 5898.3 5464.7 5466.8 5467.2 5469.9 5483.6 5084.1 5086.5 5092.8 5100.6 5140.9 5871.3 6016.6 6083.4 6084.5 6126.5 5875.1 5875.4 5877.4 5879.7 5942.3 5947.6 5995.6 6003.8 6013.4 6018.4 5644.2 5702.9 5762.2 5780.3 5878.5 5829.2 5857.6 5860.3 5862.8 5873.6 5756.9 5758.6 5763.0 5764.8 5784.4 5604.4 5607.8 5668.4 5672.5 5769.1 5700.0 5713.1 5719.3 5729.6 5749.9 5723.7 5740.9 5756.6 5783.1 5808.6 5496.2 5525.8 5537.0 5596.4 5632.4 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#1] ext.html Cycles:180 Average:60365.04 Median:42972.79 stddev:117193.32 (272.7%) stddev-sans-first:117436.13 17:43:46 INFO - PROCESS | 24881 | Values: 583.1 616.0 636.6 637.3 651.1 31176.8 31811.5 44304.0 45153.0 45175.8 43125.6 46016.3 46050.3 46588.5 46611.5 8943.6 9250.3 9254.1 9261.6 9271.5 9239.0 9299.2 9313.6 9314.6 9329.0 9337.0 9363.2 9376.5 9379.6 9384.4 9255.2 9301.8 9308.5 9310.2 9318.5 9205.6 9267.0 9269.9 9277.5 9286.2 43330.1 43529.6 43885.8 43909.3 43927.6 3548.4 3613.8 3622.2 3639.1 3653.2 31916.5 31982.4 32073.8 32232.8 32730.4 4435.6 4460.3 4492.6 4562.6 4601.7 388365.0 389743.0 390128.0 391525.0 392389.0 58942.7 59218.0 59533.7 59642.4 59695.7 53376.0 62436.4 62540.7 62549.4 64322.7 15353.1 15356.7 15376.2 15412.8 15471.8 12415.8 12495.1 12510.7 12514.6 12519.9 14417.9 15962.0 16654.9 16777.0 16781.9 5801.2 5940.3 5996.0 6016.5 6060.0 1009.0 1036.0 1056.0 1095.8 1104.9 32315.5 33118.7 33420.5 33468.7 33850.3 1021.8 1143.7 1155.4 1159.8 1201.5 17304.7 17448.7 17532.9 17544.6 17553.8 541225.0 545839.0 546594.0 546777.0 547283.0 59657.4 59745.0 59906.0 60082.7 60173.7 1291.3 1317.5 1351.3 1362.8 1376.6 31669.0 32528.0 32779.2 33053.0 33469.8 53029.2 53388.7 53427.5 53514.0 53531.2 368162.0 370081.0 370764.0 372009.0 372537.0 31636.0 36550.5 36603.8 39169.0 43003.0 43220.8 47837.8 48214.5 48854.3 49648.8 39583.2 40519.4 41421.0 42066.6 44271.0 41143.8 41931.8 42803.4 42942.6 44039.0 42278.2 42661.0 43852.0 44030.3 44049.6 34946.4 38010.8 38138.2 38437.8 39347.4 28704.6 29241.7 29361.3 29499.0 29576.7 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#2] jquery.html Cycles:180 Average:28323.79 Median:2381.52 stddev:72942.06 (3062.8%) stddev-sans-first:73116.52 17:43:46 INFO - PROCESS | 24881 | Values: 382.7 390.4 396.3 403.9 412.4 13060.1 18784.0 20404.4 20441.5 20446.4 19406.8 19474.8 20095.8 20408.6 20425.5 5753.2 5911.6 5919.0 5920.3 5945.9 5726.9 5818.4 5822.7 5837.8 5878.6 4289.7 4719.3 6541.3 6561.5 6567.6 5923.0 6186.0 6624.7 6641.2 6650.5 5564.5 5641.2 5658.2 5659.9 5661.6 14502.2 14703.8 21799.3 23295.9 24166.9 2271.8 2375.7 2387.3 2406.4 2868.9 10107.8 10611.3 10644.9 10860.2 10880.2 1847.6 1954.6 1986.7 2074.2 2080.7 86525.1 87530.0 90426.5 90457.0 90871.5 11268.0 11328.7 11336.8 11454.8 11468.8 15143.2 15427.5 15531.2 15610.7 15707.1 6455.8 6544.2 7513.7 8114.0 8296.0 7670.8 7747.2 7780.3 7962.0 7989.7 4740.1 4773.4 4826.8 4857.0 4920.8 1915.7 1994.1 2007.5 2023.9 2038.5 836.9 925.8 946.1 952.4 978.8 19628.0 20494.8 20528.7 20588.7 20758.2 990.7 992.1 1027.4 1036.9 1092.3 10599.9 11264.3 11326.5 11350.4 11357.9 388881.0 394697.0 395261.0 490923.0 497162.0 95339.0 103886.0 108117.0 108413.5 109616.5 944.4 977.6 1003.4 1005.5 1026.7 17564.0 18317.9 18883.4 19085.1 19165.1 45127.0 45153.0 46772.3 46833.8 46881.0 63902.7 64252.4 64574.4 66065.7 66091.7 8176.1 8325.6 8555.3 8566.8 8648.3 11643.8 12665.8 12925.7 13184.4 13239.2 11314.8 11649.7 11686.0 11791.4 11963.7 10594.2 11019.4 11284.1 11343.9 11698.3 11491.5 11609.3 11617.5 11728.8 11963.5 8121.3 8283.0 8429.7 8458.9 8603.0 11054.4 11491.8 11515.7 11742.0 11852.8 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#3] mootools.html Cycles:180 Average:5837.74 Median:4866.37 stddev:3325.29 (68.3%) stddev-sans-first:3317.53 17:43:46 INFO - PROCESS | 24881 | Values: 1352.2 1434.4 1493.2 1611.6 1784.6 8575.9 9040.0 9041.1 9231.7 9238.0 9051.0 9053.6 9106.9 9144.8 9145.2 2092.7 2279.7 2307.7 2329.9 2332.6 2341.9 2346.0 2356.4 2357.6 2361.6 2282.4 2309.8 2323.2 2330.8 2331.9 1991.9 2050.8 2269.0 2270.8 2274.9 2099.1 2165.8 2211.5 2228.2 2235.1 8675.0 8689.0 8706.2 8725.5 8726.4 5043.3 5168.5 5170.3 5230.6 5246.6 3470.3 3478.0 3492.1 3552.1 3603.8 1152.4 1154.8 1160.5 1163.8 1188.5 12433.3 12572.1 12623.2 12651.3 12668.2 4209.0 4454.8 4474.2 4598.3 4602.2 9633.7 9639.8 9640.4 9642.6 9651.3 5148.1 5171.7 5176.8 5196.3 5196.7 4200.5 4824.3 4860.4 4872.4 4989.5 3678.6 3763.7 3855.2 3868.6 3893.3 1062.5 1125.1 1132.6 1133.5 1136.7 971.8 988.7 1006.3 1010.9 1016.9 6231.7 6262.3 6331.2 6382.6 6676.8 950.9 960.6 1000.9 1014.0 1041.4 4095.4 4237.9 4373.6 4455.9 4460.4 10640.9 11072.4 11094.1 11095.9 11107.0 10471.6 10918.3 10966.3 11026.5 11041.8 8341.1 8517.6 8526.0 8532.9 8536.7 5997.7 6107.0 6244.8 6390.2 6523.8 10258.2 10410.1 10411.4 10419.4 10492.3 9514.3 9851.2 9858.8 10095.0 10440.4 7272.6 7806.8 8110.7 8242.6 8252.0 8300.3 8418.5 8572.0 8592.2 8602.4 7653.7 7655.5 7722.8 7757.8 7825.6 7433.9 7571.1 7606.0 7622.7 7789.2 6705.9 6807.9 6814.2 6865.1 6865.1 5302.5 5340.7 5368.8 5378.9 5635.4 5368.2 5403.4 5428.6 5469.2 5493.3 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#4] prototype.html Cycles:180 Average:4689.90 Median:5329.65 stddev:1368.09 (25.7%) stddev-sans-first:1332.17 17:43:46 INFO - PROCESS | 24881 | Values: 327.9 338.3 344.1 346.4 347.4 5237.7 5327.1 5362.9 5416.5 5435.8 5228.7 5245.3 5249.9 5252.9 5268.8 4175.1 4181.4 4191.8 4201.2 4223.5 4038.5 4195.8 4215.6 4230.5 4233.9 4147.7 4176.4 4179.5 4181.6 4181.8 4156.0 4163.4 4174.4 4177.2 4180.3 3694.6 3701.2 3702.5 3711.6 3719.3 5045.0 5172.7 5191.5 5216.2 5233.0 4727.6 4737.4 4742.6 4748.2 4763.5 5416.8 5493.7 5496.7 5506.8 5532.4 3960.8 3981.9 3992.2 3997.5 4001.2 5655.5 5683.0 5693.7 5696.7 5701.2 4090.9 4125.8 4127.2 4137.3 4149.4 3974.6 4120.8 4160.7 4161.8 4180.3 4653.2 4708.8 4710.9 4731.3 4733.0 5537.8 5550.2 5565.3 5626.5 5637.3 1305.0 1361.1 1419.5 1424.5 1424.8 951.2 972.8 989.9 991.3 992.4 5244.9 5249.2 5274.8 5275.2 5282.4 5631.0 5647.8 5650.5 5652.6 5653.5 5088.6 5238.5 5245.3 5256.8 5332.1 2999.2 3018.9 3028.4 3029.2 3030.6 5830.9 5851.2 5855.6 5884.1 5884.1 5585.5 5777.8 5801.4 5808.9 5825.2 5808.2 5840.7 5855.4 5858.2 5876.4 5406.6 5669.3 5675.6 5676.9 5702.3 5647.3 5675.4 5678.5 5698.5 5703.7 5856.3 5890.6 5910.1 5928.3 5941.6 4022.1 4094.0 4104.3 4124.6 4142.2 5692.0 5726.5 5738.0 5748.5 5754.2 5503.3 5625.3 5629.6 5645.4 5683.9 5558.4 5561.8 5569.0 5574.0 5586.9 5546.8 5559.5 5570.4 5584.5 5652.9 5332.8 5560.3 5624.7 5649.6 5708.8 5436.9 5463.4 5464.5 5464.9 5475.0 17:43:46 INFO - PROCESS | 24881 | 17:43:46 INFO - PROCESS | 24881 | [#5] yui.html Cycles:180 Average:21019.39 Median:4786.71 stddev:31067.33 (649.0%) stddev-sans-first:31117.15 17:43:46 INFO - PROCESS | 24881 | Values: 735.8 763.8 802.5 832.7 846.3 15965.9 16870.6 16882.7 16889.2 16939.0 15252.9 15254.6 15396.3 15426.2 15427.7 664.3 791.6 813.7 818.2 820.7 810.3 812.2 814.3 814.7 815.9 863.9 865.1 865.2 865.6 865.7 701.9 715.6 716.2 837.4 857.7 634.7 634.8 635.6 635.9 637.4 15776.8 15822.6 15827.0 15839.0 15853.0 14409.3 14627.7 14630.9 14645.7 14695.6 13391.3 13477.0 13641.7 13719.9 14313.2 4382.4 4385.4 4407.6 4412.9 4613.0 76865.6 77238.6 77285.6 81686.6 83644.6 10757.7 11209.1 11265.0 11333.8 11504.5 20689.5 20912.4 20924.7 21017.2 21210.7 8810.7 8829.7 8853.9 9054.7 9070.2 4765.6 4783.9 4789.5 4926.7 4928.9 3621.7 3749.7 3752.8 3764.6 3770.3 668.3 680.7 692.4 700.8 704.2 637.6 680.4 705.3 718.6 719.3 9511.6 9554.8 9648.5 10169.7 10239.5 612.5 638.9 675.0 698.5 727.7 4855.2 4866.2 4885.8 4920.8 4953.2 102036.0 123081.0 125251.4 126107.4 126544.0 58870.7 91426.5 108222.0 110794.0 112622.0 95757.0 97447.0 97713.0 97778.5 98021.5 9245.5 9331.6 9339.7 9550.5 9552.8 55672.7 55732.4 56433.7 57307.9 58181.7 45558.5 49975.5 63517.4 76499.2 76549.6 11452.9 11513.7 11838.2 11875.3 12043.5 12829.2 12893.4 12933.2 13176.9 13241.3 12095.3 12369.6 12682.4 12796.4 12800.7 12267.0 12690.6 12701.5 12735.4 13205.5 12114.8 12335.5 12485.3 12629.0 12807.9 10078.6 10199.4 10358.3 10527.4 10539.9 9214.9 9631.9 10112.6 10418.2 10423.8 17:43:46 INFO - PROCESS | 24881 | -------- Summary: end -------- 17:43:46 INFO - PROCESS | 24881 | 17:43:47 INFO - TEST-INFO | 24881: exit 0 17:43:47 INFO - TEST-OK | dromaeo_css | took 1112965ms 17:43:47 INFO - TEST-START | kraken 17:43:47 INFO - operating with platform_type : linux_ 17:43:47 INFO - Initialising browser for kraken test... 17:43:47 INFO - TEST-INFO | started process 25068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RtK28/profile http://localhost:50512/getInfo.html) 17:43:50 INFO - PROCESS | 25068 | __metrics Screen width/height:1600/1200 17:43:50 INFO - PROCESS | 25068 | colorDepth:24 17:43:50 INFO - PROCESS | 25068 | Browser inner width/height: 1024/697 17:43:50 INFO - PROCESS | 25068 | __metrics 17:43:51 INFO - PROCESS | 25068 | 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" 17:43:51 INFO - PROCESS | 25068 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:52 INFO - TEST-INFO | 25068: exit 0 17:43:52 INFO - Browser initialized. 17:43:52 INFO - Running cycle 1/1 for kraken test... 17:43:52 INFO - TEST-INFO | started process 25152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RtK28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:03 INFO - PROCESS | 25152 | RSS: Main: 156917760 17:44:03 INFO - PROCESS | 25152 | 17:44:06 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:07 INFO - PROCESS | 25152 | RSS: Main: 213794816 17:44:07 INFO - PROCESS | 25152 | 17:44:09 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-dft) 17:44:10 INFO - PROCESS | 25152 | RSS: Main: 192159744 17:44:10 INFO - PROCESS | 25152 | 17:44:13 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-fft) 17:44:14 INFO - PROCESS | 25152 | RSS: Main: 270487552 17:44:14 INFO - PROCESS | 25152 | 17:44:16 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-oscillator) 17:44:16 INFO - PROCESS | 25152 | RSS: Main: 180285440 17:44:16 INFO - PROCESS | 25152 | 17:44:19 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:19 INFO - PROCESS | 25152 | RSS: Main: 184606720 17:44:19 INFO - PROCESS | 25152 | 17:44:22 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:23 INFO - PROCESS | 25152 | RSS: Main: 219713536 17:44:23 INFO - PROCESS | 25152 | 17:44:26 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:27 INFO - PROCESS | 25152 | RSS: Main: 220098560 17:44:27 INFO - PROCESS | 25152 | 17:44:30 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50512/tests/kraken/driver.html?testName=json-parse-financial) 17:44:30 INFO - PROCESS | 25152 | RSS: Main: 220307456 17:44:30 INFO - PROCESS | 25152 | 17:44:32 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:32 INFO - PROCESS | 25152 | RSS: Main: 184516608 17:44:32 INFO - PROCESS | 25152 | 17:44:34 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:35 INFO - PROCESS | 25152 | RSS: Main: 190472192 17:44:35 INFO - PROCESS | 25152 | 17:44:37 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:37 INFO - PROCESS | 25152 | RSS: Main: 194809856 17:44:37 INFO - PROCESS | 25152 | 17:44:40 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:40 INFO - PROCESS | 25152 | RSS: Main: 189673472 17:44:40 INFO - PROCESS | 25152 | 17:44:43 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:44 INFO - PROCESS | 25152 | RSS: Main: 193527808 17:44:44 INFO - PROCESS | 25152 | 17:44:45 INFO - PROCESS | 25152 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50512/tests/kraken/driver.html?testName=ai-astar) 17:44:46 INFO - PROCESS | 25152 | RSS: Main: 244318208 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | __start_tp_report 17:44:46 INFO - PROCESS | 25152 | _x_x_mozilla_page_load 17:44:46 INFO - PROCESS | 25152 | _x_x_mozilla_page_load_details 17:44:46 INFO - PROCESS | 25152 | |i|pagename|runs| 17:44:46 INFO - PROCESS | 25152 | |0;ai-astar;103;111;111;110;111;109;110;111;110;110 17:44:46 INFO - PROCESS | 25152 | |1;audio-beat-detection;154;116;117;181;123;123;141;118;147;121 17:44:46 INFO - PROCESS | 25152 | |2;audio-dft;162;162;161;162;161;161;161;161;162;161 17:44:46 INFO - PROCESS | 25152 | |3;audio-fft;75;75;75;121;76;77;76;76;105;74 17:44:46 INFO - PROCESS | 25152 | |4;audio-oscillator;84;85;126;84;84;84;117;84;84;136 17:44:46 INFO - PROCESS | 25152 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 17:44:46 INFO - PROCESS | 25152 | |6;imaging-darkroom;146;146;148;147;147;147;147;146;146;146 17:44:46 INFO - PROCESS | 25152 | |7;imaging-desaturate;96;95;95;95;94;96;94;95;95;95 17:44:46 INFO - PROCESS | 25152 | |8;json-parse-financial;52;51;50;51;49;52;50;50;52;51 17:44:46 INFO - PROCESS | 25152 | |9;json-stringify-tinderbox;61;61;62;61;61;62;62;63;64;61 17:44:46 INFO - PROCESS | 25152 | |10;stanford-crypto-aes;75;76;86;75;76;86;79;76;76;76 17:44:46 INFO - PROCESS | 25152 | |11;stanford-crypto-ccm;128;126;122;123;120;132;121;136;164;119 17:44:46 INFO - PROCESS | 25152 | |12;stanford-crypto-pbkdf2;157;161;160;157;153;158;157;155;153;154 17:44:46 INFO - PROCESS | 25152 | |13;stanford-crypto-sha256-iterative;63;65;64;63;63;62;63;63;64;66 17:44:46 INFO - PROCESS | 25152 | __end_tp_report 17:44:46 INFO - PROCESS | 25152 | __start_cc_report 17:44:46 INFO - PROCESS | 25152 | _x_x_mozilla_cycle_collect,1692 17:44:46 INFO - PROCESS | 25152 | __end_cc_report 17:44:46 INFO - PROCESS | 25152 | __startTimestamp1469061886184__endTimestamp 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | ------- Summary: start ------- 17:44:46 INFO - PROCESS | 25152 | Number of tests: 14 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:0.71 17:44:46 INFO - PROCESS | 25152 | Values: 103.0 111.0 111.0 110.0 111.0 109.0 110.0 111.0 110.0 110.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:132.00 stddev:21.36 (16.2%) stddev-sans-first:21.41 17:44:46 INFO - PROCESS | 25152 | Values: 154.0 116.0 117.0 181.0 123.0 123.0 141.0 118.0 147.0 121.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 17:44:46 INFO - PROCESS | 25152 | Values: 162.0 162.0 161.0 162.0 161.0 161.0 161.0 161.0 162.0 161.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:16.28 (21.6%) stddev-sans-first:17.00 17:44:46 INFO - PROCESS | 25152 | Values: 75.0 75.0 75.0 121.0 76.0 77.0 76.0 76.0 105.0 74.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.87 (24.8%) stddev-sans-first:21.61 17:44:46 INFO - PROCESS | 25152 | Values: 84.0 85.0 126.0 84.0 84.0 84.0 117.0 84.0 84.0 136.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:44:46 INFO - PROCESS | 25152 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 17:44:46 INFO - PROCESS | 25152 | Values: 146.0 146.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:44:46 INFO - PROCESS | 25152 | Values: 96.0 95.0 95.0 95.0 94.0 96.0 94.0 95.0 95.0 95.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:1.03 (2.0%) stddev-sans-first:1.00 17:44:46 INFO - PROCESS | 25152 | Values: 52.0 51.0 50.0 51.0 49.0 52.0 50.0 50.0 52.0 51.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 17:44:46 INFO - PROCESS | 25152 | Values: 61.0 61.0 62.0 61.0 61.0 62.0 62.0 63.0 64.0 61.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:76.00 stddev:4.31 (5.7%) stddev-sans-first:4.42 17:44:46 INFO - PROCESS | 25152 | Values: 75.0 76.0 86.0 75.0 76.0 86.0 79.0 76.0 76.0 76.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:127.00 stddev:13.43 (10.6%) stddev-sans-first:14.24 17:44:46 INFO - PROCESS | 25152 | Values: 128.0 126.0 122.0 123.0 120.0 132.0 121.0 136.0 164.0 119.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.00 stddev:2.76 (1.8%) stddev-sans-first:2.92 17:44:46 INFO - PROCESS | 25152 | Values: 157.0 161.0 160.0 157.0 153.0 158.0 157.0 155.0 153.0 154.0 17:44:46 INFO - PROCESS | 25152 | 17:44:46 INFO - PROCESS | 25152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 17:44:46 INFO - PROCESS | 25152 | Values: 63.0 65.0 64.0 63.0 63.0 62.0 63.0 63.0 64.0 66.0 17:44:46 INFO - PROCESS | 25152 | -------- Summary: end -------- 17:44:46 INFO - PROCESS | 25152 | 17:44:47 INFO - TEST-INFO | 25152: exit 0 17:44:47 INFO - TEST-OK | kraken | took 60058ms 17:44:47 INFO - SUITE-END | took 1173s 17:44:47 INFO - Completed test suite (00:19:33) 17:44:47 INFO - javascript benchmark 17:44:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.1513083901923, 3096.9380612387768, 3117.485614873546, 3121.188490992342, 3134.639516455607, 5423.186522021689, 5428.782848686053, 5458.263134476844, 5525.364583072947, 5566.471185237401, 5397.595180361469, 5459.071957767179, 5474.288342515468, 5524.0, 5529.861753456155, 4838.709677419357, 4893.657443978923, 4938.925916111261, 4957.479464656213, 5068.695878247317, 5054.949450505503, 5093.236014597803, 5108.2848401223855, 5122.6158038147105, 5133.845984620468, 4895.388076490439, 4927.926081108786, 4971.875703107415, 4979.576735977446, 5028.170351891933, 4932.80268789248, 4942.209246520575, 4945.035718034985, 4953.182724850395, 5006.299118123466, 4955.900881982377, 4984.451710311862, 4994.425641051289, 5001.924971125436, 5015.3480047593575, 5423.755930983115, 5444.346678398578, 5490.231367608538, 5495.450454954513, 5543.944560554423, 5865.824025279248, 5874.676892770896, 5916.881662366772, 5930.110483427477, 5937.970310148422, 5871.3541510433815, 5917.52659787216, 5958.136070269787, 5973.850653733648, 5976.9402305977255, 5374.7850085996515, 5375.623706340558, 5400.567954563626, 5423.322084739408, 5488.56091512686, 5930.318013428425, 5989.071693887455, 5992.910106348409, 6001.849953751103, 6002.459778619946, 5732.398098199629, 5774.94225057744, 5781.017227071408, 5786.900488907094, 5787.826365209051, 5642.238297829823, 5672.404397538199, 5693.601447898607, 5725.713714314267, 5782.161586570008, 5678.744456499468, 5687.800926967537, 5689.573282003867, 5697.886042279131, 5710.229119068873, 5670.801521946794, 5672.914906276409, 5696.11710184922, 5727.284089488814, 5727.5131613812455, 4342.109867477223, 4362.062156636339, 4380.912381752347, 4404.405405270248, 4440.489343725513, 3922.3528117860806, 3925.487687879759, 3929.6070392960473, 3954.723169378116, 3962.7226094173707, 5435.374931882884, 5442.210879422461, 5447.291852059207, 5449.782008719607, 5450.4549545045975, 5675.290588676416, 5767.740451679684, 5857.121431785181, 5889.499392551681, 5898.3050847457625, 5464.726763661881, 5466.753996070186, 5467.152591348347, 5469.945300547023, 5483.561315094783, 5084.059449001947, 5086.54221120101, 5092.770825312869, 5100.6429549931145, 5140.920406714557, 5871.324797648325, 6016.639001659914, 6083.422074902877, 6084.5436592255755, 6126.5098792097415, 5875.118732190205, 5875.383084776208, 5877.382874798084, 5879.735411906389, 5942.257217847769, 5947.613405128653, 5995.640261584319, 6003.759849605967, 6013.3685962975005, 6018.428249316308, 5644.153376993484, 5702.914456283076, 5762.2221000164445, 5780.306363236438, 5878.500327472213, 5829.242198514166, 5857.58996870232, 5860.2967643883, 5862.765489380377, 5873.647581145145, 5756.913646295393, 5758.568107391879, 5762.971185144047, 5764.769409223752, 5784.363719990713, 5604.383517812956, 5607.775688972395, 5668.376478587435, 5672.4894759471845, 5769.105788602773, 5699.971500142473, 5713.143028545752, 5719.342275638355, 5729.598928074995, 5749.8562535936935, 5723.742431590672, 5740.913886291793, 5756.625819321898, 5783.103618939072, 5808.564357673107, 5496.1755736639825, 5525.778968841362, 5536.972315138399, 5596.356419011866, 5632.436756324335], "value": 5374.272866330099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.1282233061571, 615.9999999999999, 636.5862189576775, 637.3435361577575, 651.1404945471972, 31176.84411577942, 31811.522827157612, 44303.999999999956, 45153.0, 45175.77412112935, 43125.56874431255, 46016.30975535361, 46050.30924536135, 46588.53411465884, 46611.53388466123, 8943.597538110784, 9250.306227032966, 9254.07459254076, 9261.6295348186, 9271.536423178848, 9239.0, 9299.209567186763, 9313.627454901796, 9314.580843862042, 9329.020452852454, 9336.953315233448, 9363.157315841572, 9376.5311734413, 9379.577918993627, 9384.39001464906, 9255.213306868924, 9301.767455813591, 9308.488033158173, 9310.162085412345, 9318.487483188423, 9205.631774729003, 9267.0, 9269.90730092704, 9277.536123193813, 9286.21067209288, 43330.13339733219, 43529.564704352866, 43885.78057109726, 43909.341359879625, 43927.560724392984, 3548.361294966905, 3613.8193090345376, 3622.166901612644, 3639.1266096137, 3653.2328211075705, 31916.521252181235, 31982.360352793046, 32073.839630801696, 32232.838835805906, 32730.41852695224, 4435.556444355571, 4460.286354183315, 4492.618127459137, 4562.5665561771575, 4601.654875884322, 388365.0, 389743.0, 390128.0, 391524.99999999715, 392389.0, 58942.70528647329, 59218.0, 59533.70233148893, 59642.403575964556, 59695.701521492985, 53376.0, 62436.37563624306, 62540.68729656323, 62549.37450625526, 64322.67838660777, 15353.07881527112, 15356.692866142615, 15376.15431151275, 15412.845871541142, 15471.845281547041, 12415.75168496625, 12495.062870284764, 12510.74978500425, 12514.624561263177, 12519.874801251872, 14417.927910360591, 15962.0, 16654.916725416537, 16777.0, 16781.91609041947, 5801.1878337032, 5940.287165540077, 5995.961373133156, 6016.458518733335, 6059.969700151471, 1008.9848652270222, 1035.9533820978074, 1056.0231785598291, 1095.8465814785936, 1104.9447527623586, 32315.51526727101, 33118.66881331156, 33420.49869251963, 33468.66531334655, 33850.322993539994, 1021.8313978193663, 1143.651186388143, 1155.422288855572, 1159.750653609461, 1201.5133870782347, 17304.65390692179, 17448.738268925976, 17532.912335438243, 17544.56138596545, 17553.82446175522, 541225.0, 545839.0, 546594.0, 546777.0, 547283.0, 59657.403425966055, 59745.0, 59906.0, 60082.69958650179, 60173.699131504065, 1291.251074376878, 1317.5454468208452, 1351.2635613590617, 1362.8023936529148, 1376.5732622886937, 31669.0, 32528.0, 32779.18052048718, 33053.0, 33469.83265083659, 53029.204561932376, 53388.73305633447, 53427.465725343805, 53514.0, 53531.19703204533, 368162.0, 370081.0, 370764.0, 372009.0, 372537.0, 31636.03867397989, 36550.4517432244, 36603.81698091599, 39169.0, 43003.0, 43220.78389608158, 47837.76081119572, 48214.517854821, 48854.26718599295, 49648.751756240985, 39583.2083358337, 40519.392209117475, 41421.0, 42066.57933420749, 44271.0, 41143.7942810284, 41931.7903410481, 42803.357949631405, 42942.57057429511, 44039.0, 42278.154436911704, 42661.0, 43852.0, 44030.339544907496, 44049.55950440583, 34946.427410767086, 38010.809945950095, 38138.23723525569, 38437.80781096189, 39347.409788853765, 28704.569431458127, 29241.7075829239, 29361.265968350108, 29499.0, 29576.704232958255], "value": 20401.418349725867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7206139518153, 390.42217518073267, 396.2530629762898, 403.93133167361543, 412.40201707524096, 13060.130591560272, 18784.0, 20404.387868363934, 20441.488962775937, 20446.386608401735, 19406.805931940675, 19474.805251947477, 20095.79904200961, 20408.591828163466, 20425.489362765937, 5753.223314852494, 5911.556633252501, 5919.0, 5920.289565252176, 5945.85135371617, 5726.856828579277, 5818.359980402152, 5822.737976791033, 5837.824865254028, 5878.617889837168, 4289.656827453812, 4719.315699223611, 6541.31316211798, 6561.507886908477, 6567.6059436433725, 5922.97038514809, 6186.041163619646, 6624.73501059957, 6641.169853768279, 6650.5344625876205, 5564.4713752193475, 5641.153826925953, 5658.151277308396, 5659.858503537444, 5661.631993920423, 14502.202378869159, 14703.794430835353, 21799.346019619436, 23295.883520582458, 24166.879165604234, 2271.772822717715, 2375.7149142102885, 2387.3196139100446, 2406.446517301031, 2868.870900809448, 10107.79784404315, 10611.310264832839, 10644.893551064468, 10860.185486088574, 10880.238383313172, 1847.575057736728, 1954.5895361974003, 1986.7417235759258, 2074.222166687492, 2080.729505164334, 86525.13474865233, 87530.0, 90426.5478672609, 90457.0, 90871.54564227136, 11268.0, 11328.660140195807, 11336.773264534662, 11454.770904582028, 11468.827967580493, 15143.167125808186, 15427.460038898585, 15531.223438828014, 15610.687786244438, 15707.136107514196, 6455.7740479083, 6544.181977252843, 7513.699452021858, 8114.0, 8296.0, 7670.846583068307, 7747.225277472207, 7780.299773020455, 7962.0, 7989.680412783539, 4740.1230772307235, 4773.355596994431, 4826.782794774173, 4856.980034192859, 4920.778564964514, 1915.7030660247683, 1994.1026538057931, 2007.5407625658743, 2023.8785672859676, 2038.4598081508411, 836.93304535637, 925.847235206197, 946.1201082992883, 952.3714348530076, 978.8384916488842, 19628.0, 20494.795052049587, 20528.726476152486, 20588.691169632468, 20758.169673213204, 990.7225976726528, 992.1170158558888, 1027.41950797799, 1036.8703912011, 1092.2790957967702, 10599.894001060045, 11264.324140551593, 11326.490307936163, 11350.432478376048, 11357.943210283896, 388881.0, 394697.0, 395261.0, 490923.0, 497162.0, 95339.0, 103886.0, 108117.0, 108413.45793270983, 109616.4519177399, 944.3672739264572, 977.6333874796951, 1003.4130033930232, 1005.5173516712019, 1026.743314171457, 17564.0, 18317.90841045786, 18883.433496995112, 19085.141168647166, 19165.137568809158, 45127.0, 45153.0, 46772.29841552312, 46833.765831170625, 46881.0, 63902.680486597266, 64252.35747642464, 64574.35425645871, 66065.66967165134, 66091.66954165198, 8176.141505141874, 8325.583720814057, 8555.31557475413, 8566.78583035429, 8648.308135349283, 11643.767124657628, 12665.81001285, 12925.676858078246, 13184.406701698255, 13239.20564766117, 11314.773704526027, 11649.708757281136, 11686.0, 11791.35147566892, 11963.700907477383, 10594.20543459259, 11019.393933333744, 11284.09727221804, 11343.886561134614, 11698.2981021139, 11491.540338386705, 11609.30344179352, 11617.535298587962, 11728.824067639163, 11963.461644225858, 8121.269085782308, 8283.0, 8429.747107586782, 8458.873116903374, 8603.0, 11054.447277636247, 11491.8276225855, 11515.654530364103, 11742.0, 11852.76294474123], "value": 9329.110986392863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.1819299323902, 1434.3832152174564, 1493.2160615676771, 1611.6051567365996, 1784.5984653452967, 8575.871361929569, 9039.954800225998, 9041.050689677579, 9231.676891308805, 9238.030006849285, 9050.959139698936, 9053.637854485813, 9106.86339704905, 9144.771380715485, 9145.17693407595, 2092.696558998944, 2279.737830149529, 2307.665388518668, 2329.895154718033, 2332.5568142052957, 2341.8594884306995, 2346.0, 2356.387339291788, 2357.6227803551437, 2361.586722323595, 2282.429392651837, 2309.8036666883336, 2323.1520495019367, 2330.7669233076726, 2331.8834058297102, 1991.8605697601174, 2050.8256798172174, 2269.024319542596, 2270.818334533233, 2274.9090036398525, 2099.0554250587297, 2165.8267338612873, 2211.513467037249, 2228.1533017453426, 2235.0724449353497, 8675.0, 8688.956555217184, 8706.1729135732, 8725.476471411735, 8726.38915275931, 5043.293938848564, 5168.53483186515, 5170.302009228743, 5230.581553475713, 5246.632735708502, 3470.2538954124734, 3477.9652203477895, 3492.0746002309406, 3552.0942159749357, 3603.8017909014993, 1152.3661985907802, 1154.786364522566, 1160.5183848702777, 1163.7672465506932, 1188.465190664196, 12433.254004759743, 12572.119951603392, 12623.179493332904, 12651.3041782701, 12668.176568523017, 4208.957910420918, 4454.799534020977, 4474.239379305526, 4598.31025346194, 4602.240630296031, 9633.710988670351, 9639.807203855884, 9640.373375730554, 9642.566084526214, 9651.276154288456, 5148.124818780816, 5171.7155556444, 5176.767045482962, 5196.272521846944, 5196.714180720021, 4200.5169405518145, 4824.34871292378, 4860.36815214027, 4872.366592342973, 4989.476105008995, 3678.6321367863534, 3763.7365384423374, 3855.2289542091694, 3868.5551161616213, 3893.260280546687, 1062.5431064642278, 1125.144889883678, 1132.6205721083365, 1133.54091592905, 1136.7158210447387, 971.820213260549, 988.6687959533493, 1006.2603986070233, 1010.8534262531891, 1016.8525563793208, 6231.688415579203, 6262.342454042351, 6331.176946996861, 6382.648954307465, 6676.799696009128, 950.8811398575178, 960.5917485068818, 1000.884898236712, 1013.9847902281472, 1041.4324193314662, 4095.447114639545, 4237.936430953539, 4373.562643735601, 4455.910881782346, 4460.375547423363, 10640.946795266129, 11072.446377681084, 11094.1124710023, 11095.944520277508, 11107.0, 10471.633492827714, 10918.290311129751, 10966.287191332538, 11026.503807328689, 11041.779164416826, 8341.124181960928, 8517.574121294034, 8525.95737021311, 8532.914670853212, 8536.658533658709, 5997.670128142994, 6107.0, 6244.781432649836, 6390.233172019387, 6523.7716679915975, 10258.17934565248, 10410.115140212863, 10411.427371494641, 10419.426931518536, 10492.317999330018, 9514.33399662017, 9851.16265117473, 9858.753531161778, 10095.040971107734, 10440.37357758537, 7272.636368181676, 7806.843863122819, 8110.675572977015, 8242.629081691219, 8252.00975882898, 8300.335973122257, 8418.494890306356, 8572.0, 8592.183742544448, 8602.354823388147, 7653.693852245848, 7655.540667559964, 7722.845543088994, 7757.806054848674, 7825.569593672175, 7433.888491672521, 7571.053618297713, 7606.011218541555, 7622.656980435783, 7789.1821358756515, 6705.8994115087335, 6807.9319206807295, 6814.2163651180745, 6865.107536020286, 6865.107536020485, 5302.522772950453, 5340.706261155674, 5368.792021795065, 5378.946210538001, 5635.380108188014, 5368.1679339702405, 5403.405625381126, 5428.59285553593, 5469.206964990134, 5493.258410114583], "value": 4655.099165736687, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9278753290226, 338.29803158446225, 344.0641455241745, 346.44049859476934, 347.3608560249142, 5237.711925844077, 5327.147656374981, 5362.862725305696, 5416.458354164582, 5435.809746658868, 5228.712420816853, 5245.344331958505, 5249.947500524993, 5252.921206181911, 5268.841934741954, 4175.060611362442, 4181.351890456984, 4191.790410479463, 4201.1807697499, 4223.535411104792, 4038.495188101487, 4195.832166713343, 4215.59951804578, 4230.504002638443, 4233.936490952638, 4147.688923330762, 4176.415301857743, 4179.540250572434, 4181.58184181581, 4181.790910454481, 4155.958440415588, 4163.354680024601, 4174.415581818548, 4177.16456708658, 4180.268453020709, 3694.6305369463107, 3701.241245544684, 3702.4816525686424, 3711.5546134463766, 3719.256148770257, 5045.0, 5172.715500647463, 5191.454897235773, 5216.217567364888, 5233.031889100528, 4727.598154156901, 4737.360456338385, 4742.644301677388, 4748.216544270192, 4763.499832517605, 5416.756245968941, 5493.725313734298, 5496.725163741837, 5506.80726174586, 5532.419095994903, 3960.782156981365, 3981.9248802823367, 3992.161646054332, 3997.4603428537357, 4001.1991605876005, 5655.462731040545, 5683.0, 5693.715314234271, 5696.6866822324755, 5701.230333904911, 4090.938635920404, 4125.793710314472, 4127.195196936628, 4137.2552940471005, 4149.356849688304, 3974.582668819732, 4120.835166593362, 4160.690816596757, 4161.791910404468, 4180.289350810309, 4653.208954477747, 4708.8351907683755, 4710.882227944328, 4731.33761273422, 4733.0, 5537.833864984057, 5550.16747487872, 5565.332160140809, 5626.493615574618, 5637.267155269788, 1305.0, 1361.0812701426498, 1419.5457453614745, 1424.48006477637, 1424.8218972628422, 951.2117219627057, 972.7762614598682, 989.9406035637885, 991.2862738828032, 992.4392718114242, 5244.895102098013, 5249.160134378481, 5274.841754747364, 5275.235090911796, 5282.418933917266, 5631.0, 5647.802326918538, 5650.5479561634975, 5652.576056795757, 5653.491185793298, 5088.592912566985, 5238.476152384807, 5245.344331958505, 5256.789728410898, 5332.146856502941, 2999.2202027473013, 3018.879244830226, 3028.3943211357378, 3029.1972627253795, 3030.6060212172715, 5830.941690583039, 5851.239338886003, 5855.560832937546, 5884.146493854422, 5884.146798714162, 5585.463997400748, 5777.7977770777825, 5801.419858014165, 5808.854778630568, 5825.2135961644635, 5808.157817116495, 5840.729191652688, 5855.414458554111, 5858.179854820414, 5876.382979787147, 5406.648567843077, 5669.34802497718, 5675.644607487846, 5676.893005863982, 5702.34423041339, 5647.29408823897, 5675.404082571271, 5678.5457163426, 5698.544116470755, 5703.686297253691, 5856.297244330707, 5890.646561206341, 5910.143029260819, 5928.34788173292, 5941.613795103304, 4022.1151346703678, 4093.959060409477, 4104.322786740155, 4124.628783409507, 4142.239548192067, 5692.0, 5726.513246374105, 5737.971310143423, 5748.45389687979, 5754.223179870663, 5503.3395992481155, 5625.268715067015, 5629.634073785191, 5645.379008309164, 5683.8863222736145, 5558.44415558441, 5561.833145005657, 5568.972155139199, 5574.049082821142, 5586.888262234814, 5546.8383021677255, 5559.52744016747, 5570.415106413769, 5584.464272325143, 5652.886942261214, 5332.786688532416, 5560.304961879765, 5624.734434752311, 5649.638465113251, 5708.80019199326, 5436.852443284802, 5463.399026107205, 5464.453554644504, 5464.9453505464435, 5475.0], "value": 4256.060168890144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.819724167579, 763.805229666435, 802.4904185841989, 832.6752566499065, 846.3144852669338, 15965.920170399146, 16870.57823554412, 16882.66234675306, 16889.155542222885, 16938.999999999985, 15252.923735381308, 15254.618634534114, 15396.307166177521, 15426.228688565556, 15427.69144617107, 664.2726214794816, 791.6002418778537, 813.6663967773214, 818.1613845808035, 820.7004443378154, 810.3436216664492, 812.155358427238, 814.2549567146054, 814.6578437056421, 815.8857759913617, 863.9006514250848, 865.1132589096195, 865.1996902864856, 865.6407590849822, 865.7272959017921, 701.8982247574098, 715.5885365914568, 716.183550752143, 837.4347315562032, 857.7298151082421, 634.7112064010864, 634.8285962790067, 635.6249812610582, 635.8887194740902, 637.3690046853628, 15776.76334854978, 15822.604434889105, 15827.0, 15839.0, 15853.0, 14409.279536023261, 14627.707445851023, 14630.853691463162, 14645.707085858223, 14695.559133226021, 13391.263480508567, 13477.0, 13641.727165456636, 13719.862801371959, 14313.212773297568, 4382.386465894777, 4385.386045953569, 4407.603315701603, 4412.933805992912, 4612.976935115303, 76865.61567192184, 77238.61380693117, 77285.61357193178, 81686.59156704239, 83644.58177709133, 10757.677269681923, 11209.09445394285, 11265.0, 11333.773324533464, 11504.482298296429, 20689.482762931046, 20912.37262882116, 20924.686129708065, 21017.159313627282, 21210.681839772416, 8810.691625793066, 8829.69096081634, 8853.867191992125, 9054.728358149267, 9070.229030532479, 4765.618750499952, 4783.904321913542, 4789.521047895182, 4926.6551341406475, 4928.852134435972, 3621.6559426854406, 3749.6625303722794, 3752.836620647608, 3764.607095374729, 3770.321342158438, 668.2749217099501, 680.6664734280167, 692.4425837201102, 700.8177873752759, 704.1866644026157, 637.5568979559255, 680.3808534233922, 705.2594775485719, 718.6370882704306, 719.2627556754264, 9511.57197926095, 9554.808903821884, 9648.517574121266, 10169.694909152737, 10239.539220735085, 612.4579746923915, 638.9009703495966, 674.9628770417675, 698.5215127637584, 727.7489266203152, 4855.150348689036, 4866.245731911559, 4885.780139893643, 4920.778564964585, 4953.18272485036, 102036.0, 123081.0, 125251.37374313253, 126107.36946315393, 126544.0, 58870.70564647235, 91426.54286728657, 108222.0, 110794.0, 112622.0, 95757.0, 97447.0, 97713.0, 97778.511107444, 98021.50989245008, 9245.491497967676, 9331.626734930527, 9339.67311144134, 9550.474723890253, 9552.765497201557, 55672.72163639156, 55732.44267557435, 56433.71783141058, 57307.853842923745, 58181.70909145597, 45558.54441455675, 49975.500244997085, 63517.36482635114, 76499.23500764921, 76549.61725191338, 11452.94273528627, 11513.712157195801, 11838.230515016496, 11875.287482751062, 12043.458044387848, 12829.23024618526, 12893.355332233163, 12933.224006559636, 13176.934115329363, 13241.3379331035, 12095.274283542663, 12369.567065152676, 12682.365881706062, 12796.360181990676, 12800.74398512043, 12267.0, 12690.619281421572, 12701.491940322283, 12735.363231838557, 13205.537806176737, 12114.75770484603, 12335.50657973707, 12485.250884946932, 12629.0, 12807.871921280668, 10078.596856125672, 10199.439030853375, 10358.326708763907, 10527.368357898551, 10539.894601053891, 9214.880577467355, 9631.903680963382, 10112.646057387956, 10418.218633602359, 10423.807572774762], "value": 7560.145030628202, "unit": "score"}], "name": "dromaeo_css", "value": 7315.130193689865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 111.0, 109.0, 110.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 117.0, 181.0, 123.0, 123.0, 141.0, 118.0, 147.0, 121.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 76.0, 77.0, 76.0, 76.0, 105.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 126.0, 84.0, 84.0, 84.0, 117.0, 84.0, 84.0, 136.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 49.0, 52.0, 50.0, 50.0, 52.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 63.0, 64.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 86.0, 75.0, 76.0, 86.0, 79.0, 76.0, 76.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 122.0, 123.0, 120.0, 132.0, 121.0, 136.0, 164.0, 119.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 160.0, 157.0, 153.0, 158.0, 157.0, 155.0, 153.0, 154.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0, 66.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1483.4999999999998, "alertThreshold": 2.0}]} 17:44:47 INFO - Return code: 0 17:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:44:47 INFO - # TBPL SUCCESS # 17:44:47 INFO - Running post-action listener: _resource_record_post_action 17:44:47 INFO - [mozharness: 2016-07-21 00:44:47.482153Z] Finished run-tests step (success) 17:44:47 INFO - Running post-run listener: _resource_record_post_run 17:44:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561975296; Read time: 12; Write time: 468668 17:44:47 INFO - TinderboxPrint: CPU usage
13.0% 17:44:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:44:47 INFO - TinderboxPrint: I/O write bytes / time
561,975,296 / 468,668 17:44:47 INFO - TinderboxPrint: CPU idle
8,265.5 (87.0%) 17:44:47 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 17:44:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:44:47 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257687552; Read time: 0; Write time: 273832 17:44:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 300331008; Read time: 0; Write time: 194168 17:44:48 INFO - Running post-run listener: _upload_blobber_files 17:44:48 INFO - Blob upload gear active. 17:44:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:48 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 17:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:44:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:56 INFO - (blobuploader) - INFO - Done attempting. 17:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:57 INFO - (blobuploader) - INFO - Done attempting. 17:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:58 INFO - (blobuploader) - INFO - Done attempting. 17:44:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:58 INFO - Return code: 0 17:44:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73384ab5000b4421ddfcddeac859cea1a8e11b35dc713c5272c5fd04466218095df2793554d162dffe1765e45245fa08985748a98c6a2bb5627295cc3b717ff8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8fd18bb637f364a564b81f6df7bd46570997fb4b2648b08813b179bd32eb2e643cc806fe0b0dd83c0a4415488f2040bf08debfa673f05e47d497ed0159598e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86720f3a8583e5f2d70c1b0070adf298f5605f9c8cdc69a50a13cd39b752eac39538e4bd3aeba9dc31216e7994cb043f6742bd908934f90bb27c8a1a41dbc5fb"} 17:44:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:58 INFO - Contents: 17:44:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73384ab5000b4421ddfcddeac859cea1a8e11b35dc713c5272c5fd04466218095df2793554d162dffe1765e45245fa08985748a98c6a2bb5627295cc3b717ff8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8fd18bb637f364a564b81f6df7bd46570997fb4b2648b08813b179bd32eb2e643cc806fe0b0dd83c0a4415488f2040bf08debfa673f05e47d497ed0159598e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86720f3a8583e5f2d70c1b0070adf298f5605f9c8cdc69a50a13cd39b752eac39538e4bd3aeba9dc31216e7994cb043f6742bd908934f90bb27c8a1a41dbc5fb"} 17:44:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:58 INFO - Copying logs to upload dir... 17:44:58 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.544774 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-20 17:44:58.615679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 17:44:58.622809) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73384ab5000b4421ddfcddeac859cea1a8e11b35dc713c5272c5fd04466218095df2793554d162dffe1765e45245fa08985748a98c6a2bb5627295cc3b717ff8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8fd18bb637f364a564b81f6df7bd46570997fb4b2648b08813b179bd32eb2e643cc806fe0b0dd83c0a4415488f2040bf08debfa673f05e47d497ed0159598e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86720f3a8583e5f2d70c1b0070adf298f5605f9c8cdc69a50a13cd39b752eac39538e4bd3aeba9dc31216e7994cb043f6742bd908934f90bb27c8a1a41dbc5fb"} build_url:https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73384ab5000b4421ddfcddeac859cea1a8e11b35dc713c5272c5fd04466218095df2793554d162dffe1765e45245fa08985748a98c6a2bb5627295cc3b717ff8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8fd18bb637f364a564b81f6df7bd46570997fb4b2648b08813b179bd32eb2e643cc806fe0b0dd83c0a4415488f2040bf08debfa673f05e47d497ed0159598e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86720f3a8583e5f2d70c1b0070adf298f5605f9c8cdc69a50a13cd39b752eac39538e4bd3aeba9dc31216e7994cb043f6742bd908934f90bb27c8a1a41dbc5fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 17:44:58.647293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:44:58.647606) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469060663.46645-1100862571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:44:58.701634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 17:44:58.701944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 17:44:58.702232) ========= ========= Total master_lag: 0.16 =========