builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1470745348.22 results: success (0) buildid: 20160809023001 builduid: 7ad9101e5ff64756950b2ecf6a3853b1 revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.220634) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.221086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.221416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.254440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.254796) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 05:22:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-08-09 05:22:28 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.394220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.394578) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.444459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:28.444824) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 05:22:28,925 truncating revision to first 12 chars 2016-08-09 05:22:28,925 Setting DEBUG logging. 2016-08-09 05:22:28,925 attempt 1/10 2016-08-09 05:22:28,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2edc35144ebf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 05:22:29,244 unpacking tar archive at: fx-team-2edc35144ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:29.097511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:29.098225) ========= script_repo_revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:29.099193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:29.099665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:22:29.110976) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-09 05:22:29.111533) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:22:29 INFO - MultiFileLogger online at 20160809 05:22:29 in /builds/slave/test 05:22:29 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 05:22:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:29 INFO - {'append_to_log': False, 05:22:29 INFO - 'base_work_dir': '/builds/slave/test', 05:22:29 INFO - 'blob_upload_branch': 'Fx-Team', 05:22:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:29 INFO - 'branch': 'Fx-Team', 05:22:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:29 INFO - 'config_files': ('talos/linux_config.py',), 05:22:29 INFO - 'default_actions': ('clobber', 05:22:29 INFO - 'read-buildbot-config', 05:22:29 INFO - 'download-and-extract', 05:22:29 INFO - 'populate-webroot', 05:22:29 INFO - 'create-virtualenv', 05:22:29 INFO - 'install', 05:22:29 INFO - 'run-tests'), 05:22:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:29 INFO - 'download_minidump_stackwalk': True, 05:22:29 INFO - 'download_symbols': 'ondemand', 05:22:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:29 INFO - 'installer_path': 'installer.exe', 05:22:29 INFO - 'log_level': 'info', 05:22:29 INFO - 'log_name': 'talos', 05:22:29 INFO - 'log_to_console': True, 05:22:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:22:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:22:29 INFO - 'opt_config_files': (), 05:22:29 INFO - 'pip_index': False, 05:22:29 INFO - 'sps_profile': False, 05:22:29 INFO - 'sps_profile_interval': 0, 05:22:29 INFO - 'suite': 'dromaeojs', 05:22:29 INFO - 'system_bits': '32', 05:22:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:29 INFO - 'title': 'talos-linux64-ix-019', 05:22:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:29 INFO - 'use_talos_json': True, 05:22:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:29 INFO - 'work_dir': 'build'} 05:22:29 INFO - [mozharness: 2016-08-09 12:22:29.684734Z] Running clobber step. 05:22:29 INFO - Running pre-action listener: _resource_record_pre_action 05:22:29 INFO - Running main action method: clobber 05:22:29 INFO - rmtree: /builds/slave/test/build 05:22:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:30 INFO - Running post-action listener: _resource_record_post_action 05:22:30 INFO - [mozharness: 2016-08-09 12:22:30.651074Z] Finished clobber step (success) 05:22:30 INFO - [mozharness: 2016-08-09 12:22:30.651175Z] Running read-buildbot-config step. 05:22:30 INFO - Running pre-action listener: _resource_record_pre_action 05:22:30 INFO - Running main action method: read_buildbot_config 05:22:30 INFO - Using buildbot properties: 05:22:30 INFO - { 05:22:30 INFO - "project": "", 05:22:30 INFO - "product": "firefox", 05:22:30 INFO - "script_repo_revision": "production", 05:22:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:22:30 INFO - "repository": "", 05:22:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:22:30 INFO - "buildid": "20160809023001", 05:22:30 INFO - "pgo_build": "True", 05:22:30 INFO - "basedir": "/builds/slave/test", 05:22:30 INFO - "buildnumber": 1444, 05:22:30 INFO - "slavename": "talos-linux64-ix-019", 05:22:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:22:30 INFO - "platform": "ubuntu64_hw", 05:22:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:22:30 INFO - "branch": "fx-team", 05:22:30 INFO - "repo_path": "integration/fx-team", 05:22:30 INFO - "revision": "2edc35144ebf50ca6339e686e766e200cc4b04b8", 05:22:30 INFO - "stage_platform": "linux64-pgo", 05:22:30 INFO - "builduid": "7ad9101e5ff64756950b2ecf6a3853b1", 05:22:30 INFO - "slavebuilddir": "test" 05:22:30 INFO - } 05:22:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:22:30 INFO - Running post-action listener: _resource_record_post_action 05:22:30 INFO - [mozharness: 2016-08-09 12:22:30.653610Z] Finished read-buildbot-config step (success) 05:22:30 INFO - [mozharness: 2016-08-09 12:22:30.653699Z] Running download-and-extract step. 05:22:30 INFO - Running pre-action listener: _resource_record_pre_action 05:22:30 INFO - Running main action method: download_and_extract 05:22:30 INFO - mkdir: /builds/slave/test/build/tests 05:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:30 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:22:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:22:31 INFO - Downloaded 1361 bytes. 05:22:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:22:31 INFO - Using the following test package requirements: 05:22:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:22:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:22:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'jsshell-linux-x86_64.zip'], 05:22:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:22:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:22:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:22:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:22:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:22:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:31 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:32 INFO - Downloaded 21828529 bytes. 05:22:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:33 INFO - Return code: 0 05:22:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:33 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:22:35 INFO - Downloaded 21828529 bytes. 05:22:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:22:36 INFO - Return code: 0 05:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:36 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:22:47 INFO - Downloaded 14413723 bytes. 05:22:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:22:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:22:47 INFO - Return code: 0 05:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:47 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:22:50 INFO - Downloaded 59972166 bytes. 05:22:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:22:50 INFO - mkdir: /builds/slave/test/properties 05:22:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:50 INFO - Contents: 05:22:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:22:50 INFO - Running post-action listener: _resource_record_post_action 05:22:50 INFO - Running post-action listener: set_extra_try_arguments 05:22:50 INFO - [mozharness: 2016-08-09 12:22:50.713216Z] Finished download-and-extract step (success) 05:22:50 INFO - [mozharness: 2016-08-09 12:22:50.713458Z] Running populate-webroot step. 05:22:50 INFO - Running pre-action listener: _resource_record_pre_action 05:22:50 INFO - Running main action method: populate_webroot 05:22:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:50 INFO - '--tppagecycles', 05:22:50 INFO - '7'], 05:22:50 INFO - 'tests': ['tsvgm']}}, 05:22:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['damp', 'tps']}, 05:22:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'tests': ['damp', 'tps']}, 05:22:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['dromaeo_dom']}, 05:22:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['basic_compositor_video']}, 05:22:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:22:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['a11yr', 05:22:50 INFO - 'ts_paint', 05:22:50 INFO - 'tpaint', 05:22:50 INFO - 'sessionrestore', 05:22:50 INFO - 'sessionrestore_no_auto_restore', 05:22:50 INFO - 'tabpaint']}, 05:22:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['tsvgx', 05:22:50 INFO - 'tsvgr_opacity', 05:22:50 INFO - 'tart', 05:22:50 INFO - 'tscrollx', 05:22:50 INFO - 'cart']}, 05:22:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:50 INFO - 'tsvgr_opacity', 05:22:50 INFO - 'tart', 05:22:50 INFO - 'tscrollx', 05:22:50 INFO - 'cart']}, 05:22:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'talos_options': ['--disable-e10s'], 05:22:50 INFO - 'tests': ['tp5o']}, 05:22:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'tests': ['tp5o']}, 05:22:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'talos_options': ['--disable-e10s', 05:22:50 INFO - '--xperf_path', 05:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:50 INFO - 'tests': ['tp5n']}, 05:22:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:50 INFO - 'talos_options': ['--xperf_path', 05:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:50 INFO - 'tests': ['tp5n']}}, 05:22:50 INFO - 'talos.zip': {'path': '', 05:22:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:50 INFO - Running post-action listener: _resource_record_post_action 05:22:50 INFO - [mozharness: 2016-08-09 12:22:50.736236Z] Finished populate-webroot step (success) 05:22:50 INFO - [mozharness: 2016-08-09 12:22:50.736324Z] Running create-virtualenv step. 05:22:50 INFO - Running pre-action listener: _resource_record_pre_action 05:22:50 INFO - Running main action method: create_virtualenv 05:22:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:50 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 05:22:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:50 INFO - Using real prefix '/usr' 05:22:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:53 INFO - Installing pip.................done. 05:22:53 INFO - Return code: 0 05:22:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:53 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:22:53 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 05:22:53 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 05:22:53 INFO - Using env: {'DISPLAY': ':0', 05:22:53 INFO - 'HOME': '/home/cltbld', 05:22:53 INFO - 'LANG': 'en_US.UTF-8', 05:22:53 INFO - 'LANGUAGE': 'en_US:en', 05:22:53 INFO - 'LOGNAME': 'cltbld', 05:22:53 INFO - 'MAIL': '/var/mail/cltbld', 05:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:53 INFO - 'MOZ_NO_REMOTE': '1', 05:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:53 INFO - 'NO_EM_RESTART': '1', 05:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:53 INFO - 'PWD': '/builds/slave/test', 05:22:53 INFO - 'SHELL': '/bin/bash', 05:22:53 INFO - 'SHLVL': '1', 05:22:53 INFO - 'TERM': 'linux', 05:22:53 INFO - 'TMOUT': '86400', 05:22:53 INFO - 'USER': 'cltbld', 05:22:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:53 INFO - '_': '/tools/buildbot/bin/python'} 05:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:53 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 05:22:53 INFO - Cleaning up... 05:22:53 INFO - Return code: 0 05:22:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:53 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:22:53 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 05:22:53 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 05:22:53 INFO - Using env: {'DISPLAY': ':0', 05:22:53 INFO - 'HOME': '/home/cltbld', 05:22:53 INFO - 'LANG': 'en_US.UTF-8', 05:22:53 INFO - 'LANGUAGE': 'en_US:en', 05:22:53 INFO - 'LOGNAME': 'cltbld', 05:22:53 INFO - 'MAIL': '/var/mail/cltbld', 05:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:53 INFO - 'MOZ_NO_REMOTE': '1', 05:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:53 INFO - 'NO_EM_RESTART': '1', 05:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:53 INFO - 'PWD': '/builds/slave/test', 05:22:53 INFO - 'SHELL': '/bin/bash', 05:22:53 INFO - 'SHLVL': '1', 05:22:53 INFO - 'TERM': 'linux', 05:22:53 INFO - 'TMOUT': '86400', 05:22:53 INFO - 'USER': 'cltbld', 05:22:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:53 INFO - '_': '/tools/buildbot/bin/python'} 05:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:53 INFO - Downloading/unpacking psutil>=3.1.1 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:55 INFO - Installing collected packages: psutil 05:22:55 INFO - Running setup.py install for psutil 05:22:55 INFO - building 'psutil._psutil_linux' extension 05:22:55 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 05:22:55 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 05:22:56 INFO - building 'psutil._psutil_posix' extension 05:22:56 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 05:22:56 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 05:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:56 INFO - Successfully installed psutil 05:22:56 INFO - Cleaning up... 05:22:56 INFO - Return code: 0 05:22:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:22:56 INFO - Using env: {'DISPLAY': ':0', 05:22:56 INFO - 'HOME': '/home/cltbld', 05:22:56 INFO - 'LANG': 'en_US.UTF-8', 05:22:56 INFO - 'LANGUAGE': 'en_US:en', 05:22:56 INFO - 'LOGNAME': 'cltbld', 05:22:56 INFO - 'MAIL': '/var/mail/cltbld', 05:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:56 INFO - 'MOZ_NO_REMOTE': '1', 05:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:56 INFO - 'NO_EM_RESTART': '1', 05:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:56 INFO - 'PWD': '/builds/slave/test', 05:22:56 INFO - 'SHELL': '/bin/bash', 05:22:56 INFO - 'SHLVL': '1', 05:22:56 INFO - 'TERM': 'linux', 05:22:56 INFO - 'TMOUT': '86400', 05:22:56 INFO - 'USER': 'cltbld', 05:22:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:56 INFO - '_': '/tools/buildbot/bin/python'} 05:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:22:58 INFO - Installing collected packages: mozsystemmonitor 05:22:58 INFO - Running setup.py install for mozsystemmonitor 05:22:58 INFO - Successfully installed mozsystemmonitor 05:22:58 INFO - Cleaning up... 05:22:58 INFO - Return code: 0 05:22:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:22:58 INFO - Using env: {'DISPLAY': ':0', 05:22:58 INFO - 'HOME': '/home/cltbld', 05:22:58 INFO - 'LANG': 'en_US.UTF-8', 05:22:58 INFO - 'LANGUAGE': 'en_US:en', 05:22:58 INFO - 'LOGNAME': 'cltbld', 05:22:58 INFO - 'MAIL': '/var/mail/cltbld', 05:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:58 INFO - 'MOZ_NO_REMOTE': '1', 05:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:58 INFO - 'NO_EM_RESTART': '1', 05:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:58 INFO - 'PWD': '/builds/slave/test', 05:22:58 INFO - 'SHELL': '/bin/bash', 05:22:58 INFO - 'SHLVL': '1', 05:22:58 INFO - 'TERM': 'linux', 05:22:58 INFO - 'TMOUT': '86400', 05:22:58 INFO - 'USER': 'cltbld', 05:22:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:58 INFO - '_': '/tools/buildbot/bin/python'} 05:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:58 INFO - Downloading/unpacking jsonschema==2.5.1 05:22:58 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 05:22:58 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 05:22:58 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 05:22:58 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 05:22:58 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 05:22:58 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 05:23:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:23:00 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 05:23:00 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 05:23:00 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 05:23:00 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 05:23:00 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 05:23:00 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 05:23:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:00 INFO - warning: no files found matching '*.txt' 05:23:00 INFO - no previously-included directories found matching 'build' 05:23:00 INFO - no previously-included directories found matching 'dist' 05:23:00 INFO - no previously-included directories found matching '.git*' 05:23:00 INFO - Installing collected packages: jsonschema, functools32 05:23:01 INFO - Running setup.py install for functools32 05:23:01 INFO - warning: no files found matching '*.txt' 05:23:01 INFO - no previously-included directories found matching 'build' 05:23:01 INFO - no previously-included directories found matching 'dist' 05:23:01 INFO - no previously-included directories found matching '.git*' 05:23:01 INFO - Successfully installed jsonschema functools32 05:23:01 INFO - Cleaning up... 05:23:01 INFO - Return code: 0 05:23:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:23:01 INFO - Using env: {'DISPLAY': ':0', 05:23:01 INFO - 'HOME': '/home/cltbld', 05:23:01 INFO - 'LANG': 'en_US.UTF-8', 05:23:01 INFO - 'LANGUAGE': 'en_US:en', 05:23:01 INFO - 'LOGNAME': 'cltbld', 05:23:01 INFO - 'MAIL': '/var/mail/cltbld', 05:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:01 INFO - 'MOZ_NO_REMOTE': '1', 05:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:01 INFO - 'NO_EM_RESTART': '1', 05:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:01 INFO - 'PWD': '/builds/slave/test', 05:23:01 INFO - 'SHELL': '/bin/bash', 05:23:01 INFO - 'SHLVL': '1', 05:23:01 INFO - 'TERM': 'linux', 05:23:01 INFO - 'TMOUT': '86400', 05:23:01 INFO - 'USER': 'cltbld', 05:23:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:01 INFO - '_': '/tools/buildbot/bin/python'} 05:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:23:01 INFO - Cleaning up... 05:23:01 INFO - Return code: 0 05:23:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:23:01 INFO - Using env: {'DISPLAY': ':0', 05:23:01 INFO - 'HOME': '/home/cltbld', 05:23:01 INFO - 'LANG': 'en_US.UTF-8', 05:23:01 INFO - 'LANGUAGE': 'en_US:en', 05:23:01 INFO - 'LOGNAME': 'cltbld', 05:23:01 INFO - 'MAIL': '/var/mail/cltbld', 05:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:01 INFO - 'MOZ_NO_REMOTE': '1', 05:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:01 INFO - 'NO_EM_RESTART': '1', 05:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:01 INFO - 'PWD': '/builds/slave/test', 05:23:01 INFO - 'SHELL': '/bin/bash', 05:23:01 INFO - 'SHLVL': '1', 05:23:01 INFO - 'TERM': 'linux', 05:23:01 INFO - 'TMOUT': '86400', 05:23:01 INFO - 'USER': 'cltbld', 05:23:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:01 INFO - '_': '/tools/buildbot/bin/python'} 05:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:04 INFO - Downloading docopt-0.6.1.tar.gz 05:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:04 INFO - Running setup.py install for blobuploader 05:23:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:04 INFO - Running setup.py install for requests 05:23:04 INFO - Running setup.py install for docopt 05:23:04 INFO - Successfully installed blobuploader requests docopt 05:23:04 INFO - Cleaning up... 05:23:04 INFO - Return code: 0 05:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:04 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:04 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 05:23:04 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 05:23:04 INFO - Using env: {'DISPLAY': ':0', 05:23:04 INFO - 'HOME': '/home/cltbld', 05:23:04 INFO - 'LANG': 'en_US.UTF-8', 05:23:04 INFO - 'LANGUAGE': 'en_US:en', 05:23:04 INFO - 'LOGNAME': 'cltbld', 05:23:04 INFO - 'MAIL': '/var/mail/cltbld', 05:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:04 INFO - 'MOZ_NO_REMOTE': '1', 05:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:04 INFO - 'NO_EM_RESTART': '1', 05:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:04 INFO - 'PWD': '/builds/slave/test', 05:23:04 INFO - 'SHELL': '/bin/bash', 05:23:04 INFO - 'SHLVL': '1', 05:23:04 INFO - 'TERM': 'linux', 05:23:04 INFO - 'TMOUT': '86400', 05:23:04 INFO - 'USER': 'cltbld', 05:23:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:04 INFO - '_': '/tools/buildbot/bin/python'} 05:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:05 INFO - Running setup.py (path:/tmp/pip-Bq2e_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:05 INFO - Running setup.py (path:/tmp/pip-lR5Xl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:05 INFO - Running setup.py (path:/tmp/pip-RGjt9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:05 INFO - Running setup.py (path:/tmp/pip-2HfVMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:05 INFO - Running setup.py (path:/tmp/pip-FHYKEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:05 INFO - Running setup.py (path:/tmp/pip-rVPBUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:05 INFO - Running setup.py (path:/tmp/pip-q3D3De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:05 INFO - Running setup.py (path:/tmp/pip-wwqarU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:05 INFO - Running setup.py (path:/tmp/pip-l1f0KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:05 INFO - Running setup.py (path:/tmp/pip-HPuQ0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:05 INFO - Running setup.py (path:/tmp/pip-TmJOuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:05 INFO - Running setup.py (path:/tmp/pip-PlMGZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:05 INFO - Running setup.py (path:/tmp/pip-c9j668-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:06 INFO - Running setup.py (path:/tmp/pip-VAGHbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:06 INFO - Running setup.py (path:/tmp/pip-GdG18_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:06 INFO - Running setup.py (path:/tmp/pip-KU2TS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:06 INFO - Running setup.py (path:/tmp/pip-U302yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:06 INFO - Running setup.py install for manifestparser 05:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozcrash 05:23:06 INFO - Running setup.py install for mozdebug 05:23:06 INFO - Running setup.py install for mozdevice 05:23:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozfile 05:23:06 INFO - Running setup.py install for mozhttpd 05:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozinfo 05:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozInstall 05:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozleak 05:23:07 INFO - Running setup.py install for mozlog 05:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for moznetwork 05:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozprocess 05:23:07 INFO - Running setup.py install for mozprofile 05:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozrunner 05:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozscreenshot 05:23:07 INFO - Running setup.py install for moztest 05:23:07 INFO - Running setup.py install for mozversion 05:23:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:08 INFO - Cleaning up... 05:23:08 INFO - Return code: 0 05:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:08 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 05:23:08 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 05:23:08 INFO - Using env: {'DISPLAY': ':0', 05:23:08 INFO - 'HOME': '/home/cltbld', 05:23:08 INFO - 'LANG': 'en_US.UTF-8', 05:23:08 INFO - 'LANGUAGE': 'en_US:en', 05:23:08 INFO - 'LOGNAME': 'cltbld', 05:23:08 INFO - 'MAIL': '/var/mail/cltbld', 05:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:08 INFO - 'MOZ_NO_REMOTE': '1', 05:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:08 INFO - 'NO_EM_RESTART': '1', 05:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:08 INFO - 'PWD': '/builds/slave/test', 05:23:08 INFO - 'SHELL': '/bin/bash', 05:23:08 INFO - 'SHLVL': '1', 05:23:08 INFO - 'TERM': 'linux', 05:23:08 INFO - 'TMOUT': '86400', 05:23:08 INFO - 'USER': 'cltbld', 05:23:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:08 INFO - '_': '/tools/buildbot/bin/python'} 05:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:08 INFO - Running setup.py (path:/tmp/pip-vLGJLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:08 INFO - Running setup.py (path:/tmp/pip-JAC5SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:08 INFO - Running setup.py (path:/tmp/pip-U0q2wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:08 INFO - Running setup.py (path:/tmp/pip-7Ok_3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:08 INFO - Running setup.py (path:/tmp/pip-BRJKv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:08 INFO - Running setup.py (path:/tmp/pip-xYTBBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:08 INFO - Running setup.py (path:/tmp/pip-BMDbQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:08 INFO - Running setup.py (path:/tmp/pip-R4FplH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:08 INFO - Running setup.py (path:/tmp/pip-Q6vusV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:08 INFO - Running setup.py (path:/tmp/pip-D7HUN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:09 INFO - Running setup.py (path:/tmp/pip-_gR28k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:09 INFO - Running setup.py (path:/tmp/pip-3vX60d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:09 INFO - Running setup.py (path:/tmp/pip-1gSCbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:09 INFO - Running setup.py (path:/tmp/pip-pc8QRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:09 INFO - Running setup.py (path:/tmp/pip-RgceL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:09 INFO - Running setup.py (path:/tmp/pip-ZDSM5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:09 INFO - Running setup.py (path:/tmp/pip-rHsQYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:09 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)) 05:23:09 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)) 05:23:09 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)) 05:23:09 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)) 05:23:09 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)) 05:23:09 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)) 05:23:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:09 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 05:23:09 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 05:23:09 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 05:23:09 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 05:23:09 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 05:23:09 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 05:23:11 INFO - Downloading blessings-1.6.tar.gz 05:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:11 INFO - Installing collected packages: blessings 05:23:11 INFO - Running setup.py install for blessings 05:23:11 INFO - Successfully installed blessings 05:23:11 INFO - Cleaning up... 05:23:11 INFO - Return code: 0 05:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:11 INFO - Reading from file tmpfile_stdout 05:23:11 INFO - Current package versions: 05:23:11 INFO - argparse == 1.2.1 05:23:11 INFO - blessings == 1.6 05:23:11 INFO - blobuploader == 1.2.4 05:23:11 INFO - docopt == 0.6.1 05:23:11 INFO - functools32 == 3.2.3-2 05:23:11 INFO - jsonschema == 2.5.1 05:23:11 INFO - manifestparser == 1.1 05:23:11 INFO - mozInstall == 1.12 05:23:11 INFO - mozcrash == 0.17 05:23:11 INFO - mozdebug == 0.1 05:23:11 INFO - mozdevice == 0.48 05:23:11 INFO - mozfile == 1.2 05:23:11 INFO - mozhttpd == 0.7 05:23:11 INFO - mozinfo == 0.9 05:23:11 INFO - mozleak == 0.1 05:23:11 INFO - mozlog == 3.3 05:23:11 INFO - moznetwork == 0.27 05:23:11 INFO - mozprocess == 0.23 05:23:11 INFO - mozprofile == 0.28 05:23:11 INFO - mozrunner == 6.12 05:23:11 INFO - mozscreenshot == 0.1 05:23:11 INFO - mozsystemmonitor == 0.3 05:23:11 INFO - moztest == 0.7 05:23:11 INFO - mozversion == 1.4 05:23:11 INFO - psutil == 3.1.1 05:23:11 INFO - requests == 1.2.3 05:23:11 INFO - wsgiref == 0.1.2 05:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:11 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:11 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 05:23:11 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 05:23:11 INFO - Using env: {'DISPLAY': ':0', 05:23:11 INFO - 'HOME': '/home/cltbld', 05:23:11 INFO - 'LANG': 'en_US.UTF-8', 05:23:11 INFO - 'LANGUAGE': 'en_US:en', 05:23:11 INFO - 'LOGNAME': 'cltbld', 05:23:11 INFO - 'MAIL': '/var/mail/cltbld', 05:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:11 INFO - 'MOZ_NO_REMOTE': '1', 05:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:11 INFO - 'NO_EM_RESTART': '1', 05:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:11 INFO - 'PWD': '/builds/slave/test', 05:23:11 INFO - 'SHELL': '/bin/bash', 05:23:11 INFO - 'SHLVL': '1', 05:23:11 INFO - 'TERM': 'linux', 05:23:11 INFO - 'TMOUT': '86400', 05:23:11 INFO - 'USER': 'cltbld', 05:23:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:11 INFO - '_': '/tools/buildbot/bin/python'} 05:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 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)) 05:23:12 INFO - Cleaning up... 05:23:12 INFO - Return code: 0 05:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:12 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 0x1a9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', '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 05:23:12 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 05:23:12 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 05:23:12 INFO - Using env: {'DISPLAY': ':0', 05:23:12 INFO - 'HOME': '/home/cltbld', 05:23:12 INFO - 'LANG': 'en_US.UTF-8', 05:23:12 INFO - 'LANGUAGE': 'en_US:en', 05:23:12 INFO - 'LOGNAME': 'cltbld', 05:23:12 INFO - 'MAIL': '/var/mail/cltbld', 05:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:12 INFO - 'MOZ_NO_REMOTE': '1', 05:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:12 INFO - 'NO_EM_RESTART': '1', 05:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:12 INFO - 'PWD': '/builds/slave/test', 05:23:12 INFO - 'SHELL': '/bin/bash', 05:23:12 INFO - 'SHLVL': '1', 05:23:12 INFO - 'TERM': 'linux', 05:23:12 INFO - 'TMOUT': '86400', 05:23:12 INFO - 'USER': 'cltbld', 05:23:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:12 INFO - '_': '/tools/buildbot/bin/python'} 05:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:23:12 INFO - Cleaning up... 05:23:12 INFO - Return code: 0 05:23:12 INFO - Running post-action listener: _resource_record_post_action 05:23:12 INFO - Running post-action listener: _start_resource_monitoring 05:23:12 INFO - Starting resource monitoring. 05:23:12 INFO - [mozharness: 2016-08-09 12:23:12.442796Z] Finished create-virtualenv step (success) 05:23:12 INFO - [mozharness: 2016-08-09 12:23:12.443281Z] Running install step. 05:23:12 INFO - Running pre-action listener: _resource_record_pre_action 05:23:12 INFO - Running main action method: install 05:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:12 INFO - Reading from file tmpfile_stdout 05:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:12 INFO - Reading from file tmpfile_stdout 05:23:12 INFO - Output received: 05:23:12 INFO - Usage: mozinstall [options] installer 05:23:12 INFO - Options: 05:23:12 INFO - -h, --help show this help message and exit 05:23:12 INFO - -d DEST, --destination=DEST 05:23:12 INFO - Directory to install application into. [default: 05:23:12 INFO - "/builds/slave/test"] 05:23:12 INFO - --app=APP Application being installed. [default: firefox] 05:23:12 INFO - mkdir: /builds/slave/test/build/application 05:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:23:29 INFO - Reading from file tmpfile_stdout 05:23:29 INFO - Output received: 05:23:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:23:29 INFO - Running post-action listener: _resource_record_post_action 05:23:29 INFO - [mozharness: 2016-08-09 12:23:29.776853Z] Finished install step (success) 05:23:29 INFO - [mozharness: 2016-08-09 12:23:29.777096Z] Running run-tests step. 05:23:29 INFO - Running pre-action listener: _resource_record_pre_action 05:23:29 INFO - Running main action method: run_tests 05:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:29 INFO - Python 2.7.3 05:23:29 INFO - Return code: 0 05:23:29 INFO - grabbing minidump binary from tooltool 05:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:29 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 0x1d5c3b0>, '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 0x1d5d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:29 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 05:23:29 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 05:23:29 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 05:23:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:29 INFO - Return code: 0 05:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:29 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 05:23:29 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 05:23:29 INFO - Using env: {'DISPLAY': ':0', 05:23:29 INFO - 'HOME': '/home/cltbld', 05:23:29 INFO - 'LANG': 'en_US.UTF-8', 05:23:29 INFO - 'LANGUAGE': 'en_US:en', 05:23:29 INFO - 'LOGNAME': 'cltbld', 05:23:29 INFO - 'MAIL': '/var/mail/cltbld', 05:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:29 INFO - 'MOZ_NO_REMOTE': '1', 05:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:29 INFO - 'NO_EM_RESTART': '1', 05:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:29 INFO - 'PWD': '/builds/slave/test', 05:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:29 INFO - 'SHELL': '/bin/bash', 05:23:29 INFO - 'SHLVL': '1', 05:23:29 INFO - 'TERM': 'linux', 05:23:29 INFO - 'TMOUT': '86400', 05:23:29 INFO - 'USER': 'cltbld', 05:23:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468', 05:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:29 INFO - '_': '/tools/buildbot/bin/python'} 05:23:29 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 05:23:30 INFO - mozversion application_buildid: 20160809023001 05:23:30 INFO - mozversion application_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:23:30 INFO - mozversion application_display_name: Nightly 05:23:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:30 INFO - mozversion application_name: Firefox 05:23:30 INFO - mozversion application_remotingname: firefox 05:23:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:23:30 INFO - mozversion application_vendor: Mozilla 05:23:30 INFO - mozversion application_version: 51.0a1 05:23:30 INFO - mozversion platform_buildid: 20160809023001 05:23:30 INFO - mozversion platform_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:23:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:23:30 INFO - mozversion platform_version: 51.0a1 05:23:30 INFO - using testdate: 1470745410 05:23:30 INFO - actual date: 1470745410 05:23:30 INFO - starting webserver on 'localhost:44173' 05:23:30 INFO - SUITE-START | Running 2 tests 05:23:30 INFO - TEST-START | dromaeo_css 05:23:30 INFO - operating with platform_type : linux_ 05:23:30 INFO - Initialising browser for dromaeo_css test... 05:23:30 INFO - TEST-INFO | started process 3421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hS8K6/profile http://localhost:44173/getInfo.html) 05:23:34 INFO - PROCESS | 3421 | __metrics Screen width/height:1600/1200 05:23:34 INFO - PROCESS | 3421 | colorDepth:24 05:23:34 INFO - PROCESS | 3421 | Browser inner width/height: 1024/697 05:23:34 INFO - PROCESS | 3421 | __metrics 05:23:35 INFO - PROCESS | 3421 | 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" 05:23:35 INFO - PROCESS | 3421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:35 INFO - PROCESS | 3421 | console.error: PushService: 05:23:35 INFO - PROCESS | 3421 | stateChangeProcessEnqueue: Error transitioning state 05:23:35 INFO - PROCESS | 3421 | UnknownError 05:23:36 INFO - TEST-INFO | 3421: exit 0 05:23:36 INFO - Browser initialized. 05:23:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:36 INFO - TEST-INFO | started process 3500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hS8K6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:48 INFO - PROCESS | 3500 | RSS: Main: 156577792 05:23:48 INFO - PROCESS | 3500 | 05:24:39 INFO - PROCESS | 3500 | 1470745479644 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] 05:26:48 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44173/tests/dromaeo/cssquery-ext.html) 05:26:49 INFO - PROCESS | 3500 | RSS: Main: 250667008 05:26:49 INFO - PROCESS | 3500 | 05:29:52 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-ext.html (next: http://localhost:44173/tests/dromaeo/cssquery-jquery.html) 05:29:52 INFO - PROCESS | 3500 | RSS: Main: 236175360 05:29:52 INFO - PROCESS | 3500 | 05:32:54 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44173/tests/dromaeo/cssquery-mootools.html) 05:32:55 INFO - PROCESS | 3500 | RSS: Main: 186347520 05:32:55 INFO - PROCESS | 3500 | 05:35:57 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44173/tests/dromaeo/cssquery-prototype.html) 05:35:57 INFO - PROCESS | 3500 | RSS: Main: 184475648 05:35:58 INFO - PROCESS | 3500 | 05:39:00 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44173/tests/dromaeo/cssquery-yui.html) 05:39:01 INFO - PROCESS | 3500 | RSS: Main: 185815040 05:39:01 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:44173/tests/dromaeo/cssquery-yui.html (next: http://localhost:44173/tests/dromaeo/cssquery-dojo.html) 05:42:04 INFO - PROCESS | 3500 | RSS: Main: 278974464 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | __start_tp_report 05:42:04 INFO - PROCESS | 3500 | _x_x_mozilla_page_load 05:42:04 INFO - PROCESS | 3500 | _x_x_mozilla_page_load_details 05:42:04 INFO - PROCESS | 3500 | |i|pagename|runs| 05:42:04 INFO - PROCESS | 3500 | |0;dojo.html;3043.3913217356526;3045.939081218377;3051.725344718975;3077.5383692446144;3093.6906309369065;5137.434882162959;5249.422563518019;5356.410794812572;5432.212329212267;5450.0189965806185;5305.734713264341;5338.519533242007;5380.112281473552;5407.053765591016;5412.404635490093;4791.041791641668;4791.616670666347;4866.07544566533;4867.123917694814;4961.8511444656715;4896.951030489703;4926;4957.25641153828;4963.106640804654;4964;4703.623710103184;4743.905121897543;4793.784279707422;4855.028994201174;4896.951030489685;4770.522947705236;4785.976070119662;4796.760161991921;4856.17445034345;4910.508949105097;4779.091972525209;4800.735959522225;4810.35060266863;4831.154547954129;4872.9512704873205;5150.793968241266;5276.393214780311;5329.920051199235;5333.173358129496;5336.252924590561;5731;5771.249737534135;5775.018246898037;5777.855553611152;5781.364049954502;5775.306963164405;5816.040353341694;5816.912746308809;5823.737931793079;5825.504832089277;5105.693658380472;5204.661696989683;5257.921131183035;5265.578753699695;5357.330333708286;5823.184754134425;5828.6211396259105;5829.213056237354;5834.0373838317055;5834.766609335664;5552.278203833556;5556.111022236423;5576.609637325349;5593.328800543879;5610.13042978339;5386.676799392049;5575.916361254584;5628.409017053151;5641.915371269434;5644.85887852807;5623.297087864017;5629.943700563023;5633.380328163898;5639.689817060101;5659.5755318351285;5603.047481928082;5639.859003524863;5646.802361917313;5648.802291919763;5657.57568182388;4199.160167966419;4209.536950935395;4237.258479766028;4299.634531064895;4318.913621727548;3736.290104880064;3767.05823544114;3773.0755964788805;3850.7689538627774;3853.9807300963316;5251.579873610102;5267.473252674778;5283.471652834686;5285.920711189336;5332.813351532678;5593.692346920877;5602.915956260659;5604.775808967677;5611.6352437091455;5629.605927585029;5188.662736922088;5350.27771250884;5413.323334583177;5420.430854760272;5488.533474654699;4912.6561140719805;4914.459409464956;4918.409790825052;4919.950800491949;4924;5989.460948514655;5997.310309314397;5998.280206375263;6001.819945401645;6005.309389420273;5440.891182176413;5651.152327150796;5730.856728581819;5736.082226843685;5809.012467880555;5927.199828023162;5931.733072011683;5957.314908785545;5958.19564358806;5996.760129594942;5547.583931205257;5569.415211402745;5571.470710282517;5571.582131340085;5575.804846830504;5429.755660995185;5649.943500564942;5689.288838895138;5689.800856969986;5703.08750599902;5577.860553486033;5617.269754931833;5628.831135065954;5631.63394379364;5637.689927054052;5576.386597474356;5604.075327570905;5614.270144881302;5615.831525054255;5623.859403514781;5383.838484845461;5405.459454054563;5434.3750468695025;5450.700211488406;5460.508554229979;5546.916796247979;5553.555715542828;5589.664620122806;5594.580406469612;5601.971990140023;5397.379301380234;5419.458054194549;5425.267588875451;5427.213054107054;5429 05:42:04 INFO - PROCESS | 3500 | |1;ext.html;580.147183640049;591.1133300049925;596.9553281756926;602.1209034809178;617.0497433951713;32053.83973080134;43480.34779478306;44249.11501769962;44287.77856110723;44314.999999999956;44124;44438.77780611093;44486.555134448645;44527.33209001867;44553.554464455345;8828.690995815165;8961.103889611051;8967.192952634294;8975.057618950013;8979.865302020475;8785.165409286108;8886.911130888673;8893.73318800437;8893.911060889373;8897.199252067312;8936.731898043068;8999.190072893438;9002.234810041122;9007.324450666194;9010.729678109667;8924.509151996637;8967.955160224223;8973.910260897406;8974.371793974424;8975.820483590292;8840.602172902234;8893.066228046091;8893.155150260714;8895.066018068075;8897.777555561162;42174.57825421737;42461;42539.361909571075;42579.57420425787;42590.787046064885;3729.272791805599;3737.626237376268;3974.225026119908;4104.445899803518;4209.158168366339;32732.672673273202;32837.17907052319;33526.32947341064;33910.32179356399;34219.82890085533;4019.2363450944517;4119.752814831119;4146.295129827937;4204.957950420488;4255.659547236213;326550;334732;334835;335230;335839;59145;59357;59437.702811485666;59536;59634;61763.38236617576;61780;62150;62226.37773622206;62235.688821556505;15138.545843624708;15311.15788631636;15314.234288285541;15314.463993760164;15320.540383788504;12398.75202495945;12427.627171184879;12450.066245031478;12455.128141030222;12456;14932.925335373471;17268.654626907643;17294.221760020577;17315.91342043307;17538.473845784647;6019.337872833985;6049.727762250709;6069;6077.17958075663;6229.906551401733;948.6964171465065;1088.2654208409292;1107.3521989636154;1147.5581900968186;1210.2435977514053;32136.35727285488;32552;32694;32877.671223287936;33519.49720754142;1123.545232638497;1133.6032388663903;1156.1791128298835;1170.0581032268935;1244.3715923458597;17251.3962011329;17263;17353.65292694139;17429.564260893327;17600.735988960176;519697;520751;521931;522393;523127;58849.11726324109;58962.41037589655;58966.70516647475;59026.704866476255;59052.40947590555;1257.057207094679;1294.5533790842144;1363.8090667306585;1399.0486469201041;1411.5412490940485;31879.362412752078;33170;33968.66031339655;34221.31557368889;34474;44795;55452.16821747758;57125.71437142788;57209;60758.69620651868;459116;463325;464249;464757;466056;25728.742712572635;28293.858530707214;28525.572116418687;28622;29076.418471630874;47782;47782.76108619435;47978;48280.51719482901;48485.272720908506;38752;40181.79909100553;40683.59316406798;41089.38365924573;41767.373489397076;39617.60382396254;39815.80092099521;40965.38551921664;41006.384904225866;41246.793766030976;40301.19397611973;40678.1864362717;40929.59070409377;41049;41652.16695666009;34930;37777.433338500494;44016;44424.77787611041;45748.771256143504;32106.67893321037;35219.23903804748;35264.82367588145;35265.47101793526;35312.82343588266 05:42:04 INFO - PROCESS | 3500 | |2;jquery.html;383.9596842331555;387.5543125405783;389.6629415555544;390.6136695447029;412.90090378309196;14467.131972081655;17480.562985925357;18715.3449629263;20240;20255.088521016572;19248;19764.20943162272;19911.402657920287;20466.386008419733;20488.69266960993;5827.213326200951;6007.429294217064;6022.066579680157;6024.487918526908;6045.063015232624;4281.464816897887;5900;5976.581639285252;6430.292667806538;6733.09103271057;6678;6761.729530818761;6768.7630932917355;6781.389674929255;6783.864322713543;6477.222733272014;6587.473002159816;6655.301193374675;6663.16710411201;6665.833354166136;5645.209670646072;5848.5321174305955;5853.5317174625925;5857.736401861926;5902.08517679756;24023.519529609486;24104.517909641883;24174.516509669884;24194.758052419602;24246.15138470163;2179.6294629912954;2331.3122628824367;2351.247600767755;2422.527607116613;3128.1553980425383;10406;10425;10703.946480267627;10944.890551094546;10962.506687199095;1975.3580086471811;2014.3956812956055;2020.7676117246558;2024.7469066366705;2030.9390718278476;79575.60212198959;81757;82372;83597;85863.57068214682;11375.03312218454;11375.715607109889;11434;11449.198556100993;11600.709982250512;15972.68054638924;15990.520284391487;16001.599960001093;16005.919970400073;16021.919890400706;8106.4325497215805;8325.250727434439;8336.708215212439;8413.663453461793;8453.239208471266;7914;7961.203879612109;8118.715844945516;8163.877541836877;8174.427790054639;4604.953950460453;4665.86002419928;4666.393368862026;4671.131547381075;4841.661083724105;1987.4335814293147;2049.7950204979384;2069.1619893942975;2070.1408915300285;2076.7404074490687;982.3467394182788;989.564591579717;1017.9949100254452;1055.6199768083484;1082.220801023262;19034.33379831699;19891.502712432306;20122;20233.559673950276;20272.898635506728;979.9657012004545;1000.1898462245605;1000.8048430555972;1010.2978429991233;1015.97460063499;10455;11068.501917413736;11182.608608698656;11289.887101129048;11300.434978251054;456686;456778;459259;467508;474726;58827.70586147042;87933;88428;92600.53699731592;93579.53210234041;994.6170724271063;1021.0861279155263;1038.0449986013036;1041.141058626636;1044;17451.214695338487;17893.821061789215;18277.26890924348;18441;18657.253709851455;43662.34506482469;43905.34141987937;44334.33498497461;44348.11303773971;45838.541614583424;64289;64727.352726472134;65255;65329.34670653233;65499;8456.746297611082;8539.188777066169;8613.612387442705;8689.522076285612;8832.38173327861;11130.332180069221;12934.611961641165;13186.736265274832;13205.669858253235;13224;11658.76682466363;11665.618856589768;11670.474828632561;11735.471903764523;11843.46704398287;10930.180236482454;11083.944580277048;11164.832527511931;11411.258268212872;11540.826887596524;7099.538529995534;11471;11553.595624153115;11798.233114847508;12242.204256723284;8082.595870206584;8563.529005904735;8639.222469977733;8739.257163141205;8858.911410886067;11108.333499990027;11510.654680359603;11529.942350288195;11585.6524304271;11638 05:42:04 INFO - PROCESS | 3500 | |3;mootools.html;1364.0042768778796;1472.3080152328405;1514.7046325966435;1637.5005623284894;1794.6051868588913;8609.956950215248;9003.099690031002;9042.140996605329;9240.768980775483;9260.351775375726;9043.231325337354;9182.86225706615;9185.035571265005;9187.632494700221;9189.954050229757;2405.9157929472426;2441.3042282949273;2441.4750828571855;2441.706995160583;2445.7798798108165;2316.5714342846545;2374.2283757778705;2393.7965272951733;2395.508920671267;2429.8056155507516;2383.4041489627593;2393.4854006388623;2403.639454081884;2432.2338463384067;2437.049550675238;2219.7891200336103;2261.027758064032;2262.1177740681064;2265.988670056656;2267.365137761421;2296.1733775840685;2315.560043591729;2318.7681231876845;2323.4307594639254;2325;9041.954790226073;9113.81772364549;9131.589078491485;9207.539623018822;9224.07759224079;5394.109971854639;5526.590719366536;5539.086050801613;5545.00189965806;5549.250851135085;3383.407903616882;3416.26550291686;3436.60479044908;3451.5685539307588;3464.0820182651364;1137.203957229934;1143.2168964259508;1151.5106079916086;1181.3325471108797;1196.114874992508;12642.431090600852;12645.683857903534;12699.936500317532;12720.87279127206;12734.554290599785;4335.674824388184;4391.231534481453;4534.115847409789;4558.703684260512;4646.442426908792;9982.900170998197;9989.250806189564;9989.450580218012;9990.950045249727;9994.650187243411;5292.814751483679;5300.31095957523;5302.416734159239;5312.043832110257;5316.601254905898;4056.8377264909072;4411.426514553087;4559.954400456019;4866.416030076413;4949.133901567283;3849.364854798927;3851.8459261629782;3956.050547868491;3957.92084158321;3978.3236849735613;1178.7642471505733;1186.839776630144;1190.6487586162102;1197.6167626359481;1203.061611942686;862.6204470033165;954.3367359684952;960.6349587156975;986.4180133721139;1010.8534262531891;5969.940300597025;6165.290991535941;6181.8454538636;6203.069539569011;6371.681415929185;466.59406316504857;467.38072054527885;478.37810845900884;478.80129746155654;481.194000049915;4213.620774130343;4272.295071313199;4282.186384586918;4355.825766969349;4408.096340250241;10290.485475726184;10704.571817127384;10709.46452677363;10720.731981700364;10748.301360411548;10641.840372394421;10670.839937400946;11082.279651822606;11130.666080017612;11325.433728313552;8345.374096942754;8545.829083418297;8551.74344769658;8551.931008624046;8565.229129378386;6199.582162956541;6347.143135676809;6399.104125422352;6449.7097630605795;6526.869462610816;10187.337823041478;10391.896081039395;10470.528826202992;10595.258331916692;10621.681349559525;9396.95301523488;10714.785704286027;10806.891931080903;10936.289141205796;10939.781204376028;7706.152323244327;7892.447528672938;7996.3602911768085;8170.101288858102;8187.099419064018;8442.66229350819;8746.081661425713;8804.911950880409;8826.91173088261;8839.602217900081;7729.690812367442;7854.960725196337;7886.369090472863;8122.228388303101;8148.022237331558;7775.572343520935;7869.544134335167;7900.960495197487;7908.84182316362;7976.760697179094;6955.513114081966;6980.581165130108;7031.578105313698;7033.120859892513;7034.859302813813;5028.64799464034;5191.273221748883;5211.895762084813;5319.175527793198;5327.3074500314715;5093.490650934877;5106.208537676666;5188.610854186027;5288.735563221747;5291.550218231493 05:42:04 INFO - PROCESS | 3500 | |4;prototype.html;325.7426632959962;332.8735080669347;335.7649645248326;336.63979541890154;339.97667022263;5214.452482489341;5270.890174796869;5271.235670827732;5281.313429254192;5286.2070689396605;5156.767945442455;5198.45416231296;5236.460316746375;5236.476352364771;5249.002689488994;3902.6487616114546;3930.449737036817;4076.694247931417;4089.5705950875176;4118.732282401635;4096.119334343116;4096.651784598313;4110.938335924949;4124.505059392877;4125.64931980782;4060.7563546187175;4062.6749860011128;4065.2072845795083;4075.9592404075875;4077.979610101945;3908.6482216600502;3968.9801550992206;4049.2104039712267;4074.6740260779065;4087;3624.238909828939;3635.2366003139373;3636.5999740028574;3636.61815509373;3639.508666330038;5073.695578265316;5082.872928176788;5096.464871188509;5146.562542183919;5171.870703232412;4637.489876113625;4667.183242932473;4679.15775160471;4692.8683494528395;4717.33470589116;5385.515303622654;5393.78424863005;5396.136618141118;5396.163594642837;5414.35027796667;3981.422693709425;4003.339448990913;4016.3172260715746;4022.959770402317;4038.0308725905866;5424;5567.025770490148;5584.888302233973;5620.66276023444;5713.257456475773;4090.795460226977;4092.5702801205443;4092.856750013735;4093.1199792044854;4096.242195193899;4137.834486620562;4142.420061191436;4178.540360560336;4196.979015104966;4209.34755112958;4604.631629469634;4711.481737008926;4745.454272758608;4756.191447453941;4760.357351757538;5370;5428.75570599324;5442.482964118402;5443.577607964417;5519.751611177507;1401.6425811418023;1417.9432822687183;1419.0917812599944;1431.439730693549;1433.72042451723;878.5299864572551;937.1097457415483;942.853857652065;945.5366870233536;956.3783540698463;5087.440381558025;5169.397486779036;5207.270982062514;5267.473252674778;5273.446288139767;5528.9723551381985;5533.6956467393875;5539.446055394428;5582.97208513963;5616.69108199053;4973.651844370932;5240.4497527759795;5250.291210686509;5263.763130659129;5264.631475796734;2922.824630522133;2938.6032885560176;2951.1294168220425;2974.598429212072;2987.208389776711;5807.157962095473;5842.678652674059;5860.648361098348;5869.6771677558145;5873.970630146908;5566.803137325494;5610.401035704886;5652.795409790185;5672.546196304285;5712.457636438138;5793;5795.623284486495;5799.797007104816;5857.20927674767;5891.351951285441;5414.35027796667;5578.135389014709;5674.404187560412;5681.2330335404195;5690.914636280542;5450.863728406822;5546.805861794818;5547.44525547442;5558.388577256418;5563.638363506359;5762.7237241290295;5794.0439827428;5819.94180058194;5867.413258674099;5875.3243377010485;3587.833953965024;3668.63313668631;3700.5744339401313;3715.7027437804372;3726.515552978204;4902.607791376753;4956.653034287565;4977.726225057657;4986.952739924512;5004.374453193351;4832.081904438145;4869.151546345428;4875.19559272716;4877.853664390074;4926.802927882844;4727.837326450499;4824.975875120602;4873.293372461044;4896.853094407174;4921.744955036586;4747.907981164282;4808.687435316833;4824.758762061953;4829.782659780248;4838.919264716065;5225.667454799154;5320.627556071193;5434.891302174014;5462.371827239918;5462.808801691922;5324.600654950972;5325.866853328698;5330.866728331823;5359.544438722753;5385.626665200349 05:42:04 INFO - PROCESS | 3500 | |5;yui.html;734.6914295995682;765.7128576783705;799.4044436894515;846.2637505370325;867.9652813887445;15449.922750386246;15940.282687279101;16492.917535412307;16506.27646438336;16526.83473165268;15095.698086038301;15120.243987800593;15150.696986060273;15189.240537973112;15237.84762152378;821.6302663801298;842.0779246724826;843.569779412501;844.0630899701326;845.1421806866036;676.5703778100892;807.4630370803409;842.8567143585575;843.8987321521427;849.8045449546609;882.8984666763308;887.4497811356968;888.0409158109259;888.4580405952364;888.7955770172832;884.1997991817448;884.44280103535;885.5306687455627;886.4326830828275;889.6574818694785;518.3701802310173;623.5043140703152;635.6249812610536;636.2651137935692;636.3318515558645;14838.406463741438;14861.331240094114;14865.777013344808;14970.62573435662;15020.474283400028;14265.57203283903;14383.568492945229;14574.344154512966;14691.926540367229;14859.851401485956;13146.802797958038;13246.271455069967;13422.463101476027;13507.86492135076;13931.373088211054;4383.3424986252;4429.800658970354;4437.800298986521;4487.955120448786;4510.594046535794;82908.58545707233;83750.58124709337;84988.15011849864;90161;91174.08825911723;10490.108340790966;10697.304675196086;10856.891431085745;10953;11220.551177952953;18013.369532066314;18030.819691802913;18042.368517101837;18171.364002259856;19974.60050799005;8866.024737278894;8886.777830554287;8967.730968070968;9068.54657267134;9220.769480763034;4860.076585448754;4977.751112444364;4989.326440930428;5068.239764035424;5202.4277329493725;3459.3427248822645;3546.929061418757;3550.840212190458;3554.253606742613;3554.7689400189424;620.5407998081387;625.8185126313409;637.5887552528593;646.0148273882273;647.0294558162756;683.7777722240291;705;717.8241330873865;742.9219931907072;750.152327869504;9162.770930726652;9514.809703805886;9698.127168554864;9726.319157658896;9844.704658860246;652.3574279334852;700.7897630710767;711.7437722419925;720.7585458871232;738.3723834740535;4225.704200705983;4667.6265898728025;4710.6702530823195;4791.65011519819;4851.636127290467;128554;131158.34420827834;133305.33347333202;133515.3324233392;136574;109734.12392884519;110727.44636276927;112239;113930.43034784938;115690;79040.60479697565;80481.19518804736;80583;81597.9999999988;90567.54716226508;9626.32615716893;9717.757056073655;9817.26370522228;9884.061014203638;10198.43908585035;51287.97424051573;52292;52987.73506132445;53017.20474192813;54763;72404;77415.61292193728;77827.61086194533;78052;78728.60635696785;11852.58024305086;12203.75592488163;12369.752604947671;12509.186902851285;12780.424880880197;14573;14609.853901460849;14803.333849976992;14867;14953.626159346104;12796.61610151697;13011.21932684042;13236.669083272995;13377.53178638743;13808.654783630489;13822.585322440344;14116.223607701675;14222.288885555474;14350.354234059701;14380.856191437952;12348.753024939631;12438.689032774253;13112.672183195496;13127.949764019046;13170.670733231746;10691.946540267249;11054.392008439612;11125.44372781374;11528.59649912249;11570.826437603275;9327.347085704207;10472.895271047497;11264.605738799102;11486.138539609396;11918 05:42:04 INFO - PROCESS | 3500 | __end_tp_report 05:42:04 INFO - PROCESS | 3500 | __start_cc_report 05:42:04 INFO - PROCESS | 3500 | _x_x_mozilla_cycle_collect,951 05:42:04 INFO - PROCESS | 3500 | __end_cc_report 05:42:04 INFO - PROCESS | 3500 | __startTimestamp1470746524440__endTimestamp 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | ------- Summary: start ------- 05:42:04 INFO - PROCESS | 3500 | Number of tests: 6 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#0] dojo.html Cycles:165 Average:5274.67 Median:5434.38 stddev:615.24 (11.3%) stddev-sans-first:591.70 05:42:04 INFO - PROCESS | 3500 | Values: 3043.4 3045.9 3051.7 3077.5 3093.7 5137.4 5249.4 5356.4 5432.2 5450.0 5305.7 5338.5 5380.1 5407.1 5412.4 4791.0 4791.6 4866.1 4867.1 4961.9 4897.0 4926.0 4957.3 4963.1 4964.0 4703.6 4743.9 4793.8 4855.0 4897.0 4770.5 4786.0 4796.8 4856.2 4910.5 4779.1 4800.7 4810.4 4831.2 4873.0 5150.8 5276.4 5329.9 5333.2 5336.3 5731.0 5771.2 5775.0 5777.9 5781.4 5775.3 5816.0 5816.9 5823.7 5825.5 5105.7 5204.7 5257.9 5265.6 5357.3 5823.2 5828.6 5829.2 5834.0 5834.8 5552.3 5556.1 5576.6 5593.3 5610.1 5386.7 5575.9 5628.4 5641.9 5644.9 5623.3 5629.9 5633.4 5639.7 5659.6 5603.0 5639.9 5646.8 5648.8 5657.6 4199.2 4209.5 4237.3 4299.6 4318.9 3736.3 3767.1 3773.1 3850.8 3854.0 5251.6 5267.5 5283.5 5285.9 5332.8 5593.7 5602.9 5604.8 5611.6 5629.6 5188.7 5350.3 5413.3 5420.4 5488.5 4912.7 4914.5 4918.4 4920.0 4924.0 5989.5 5997.3 5998.3 6001.8 6005.3 5440.9 5651.2 5730.9 5736.1 5809.0 5927.2 5931.7 5957.3 5958.2 5996.8 5547.6 5569.4 5571.5 5571.6 5575.8 5429.8 5649.9 5689.3 5689.8 5703.1 5577.9 5617.3 5628.8 5631.6 5637.7 5576.4 5604.1 5614.3 5615.8 5623.9 5383.8 5405.5 5434.4 5450.7 5460.5 5546.9 5553.6 5589.7 5594.6 5602.0 5397.4 5419.5 5425.3 5427.2 5429.0 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#1] ext.html Cycles:180 Average:60594.86 Median:23191.87 stddev:118310.60 (510.1%) stddev-sans-first:118556.69 05:42:04 INFO - PROCESS | 3500 | Values: 580.1 591.1 597.0 602.1 617.0 32053.8 43480.3 44249.1 44287.8 44315.0 44124.0 44438.8 44486.6 44527.3 44553.6 8828.7 8961.1 8967.2 8975.1 8979.9 8785.2 8886.9 8893.7 8893.9 8897.2 8936.7 8999.2 9002.2 9007.3 9010.7 8924.5 8968.0 8973.9 8974.4 8975.8 8840.6 8893.1 8893.2 8895.1 8897.8 42174.6 42461.0 42539.4 42579.6 42590.8 3729.3 3737.6 3974.2 4104.4 4209.2 32732.7 32837.2 33526.3 33910.3 34219.8 4019.2 4119.8 4146.3 4205.0 4255.7 326550.0 334732.0 334835.0 335230.0 335839.0 59145.0 59357.0 59437.7 59536.0 59634.0 61763.4 61780.0 62150.0 62226.4 62235.7 15138.5 15311.2 15314.2 15314.5 15320.5 12398.8 12427.6 12450.1 12455.1 12456.0 14932.9 17268.7 17294.2 17315.9 17538.5 6019.3 6049.7 6069.0 6077.2 6229.9 948.7 1088.3 1107.4 1147.6 1210.2 32136.4 32552.0 32694.0 32877.7 33519.5 1123.5 1133.6 1156.2 1170.1 1244.4 17251.4 17263.0 17353.7 17429.6 17600.7 519697.0 520751.0 521931.0 522393.0 523127.0 58849.1 58962.4 58966.7 59026.7 59052.4 1257.1 1294.6 1363.8 1399.0 1411.5 31879.4 33170.0 33968.7 34221.3 34474.0 44795.0 55452.2 57125.7 57209.0 60758.7 459116.0 463325.0 464249.0 464757.0 466056.0 25728.7 28293.9 28525.6 28622.0 29076.4 47782.0 47782.8 47978.0 48280.5 48485.3 38752.0 40181.8 40683.6 41089.4 41767.4 39617.6 39815.8 40965.4 41006.4 41246.8 40301.2 40678.2 40929.6 41049.0 41652.2 34930.0 37777.4 44016.0 44424.8 45748.8 32106.7 35219.2 35264.8 35265.5 35312.8 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#2] jquery.html Cycles:180 Average:28506.69 Median:24184.64 stddev:76465.84 (316.2%) stddev-sans-first:76651.20 05:42:04 INFO - PROCESS | 3500 | Values: 384.0 387.6 389.7 390.6 412.9 14467.1 17480.6 18715.3 20240.0 20255.1 19248.0 19764.2 19911.4 20466.4 20488.7 5827.2 6007.4 6022.1 6024.5 6045.1 4281.5 5900.0 5976.6 6430.3 6733.1 6678.0 6761.7 6768.8 6781.4 6783.9 6477.2 6587.5 6655.3 6663.2 6665.8 5645.2 5848.5 5853.5 5857.7 5902.1 24023.5 24104.5 24174.5 24194.8 24246.2 2179.6 2331.3 2351.2 2422.5 3128.2 10406.0 10425.0 10703.9 10944.9 10962.5 1975.4 2014.4 2020.8 2024.7 2030.9 79575.6 81757.0 82372.0 83597.0 85863.6 11375.0 11375.7 11434.0 11449.2 11600.7 15972.7 15990.5 16001.6 16005.9 16021.9 8106.4 8325.3 8336.7 8413.7 8453.2 7914.0 7961.2 8118.7 8163.9 8174.4 4605.0 4665.9 4666.4 4671.1 4841.7 1987.4 2049.8 2069.2 2070.1 2076.7 982.3 989.6 1018.0 1055.6 1082.2 19034.3 19891.5 20122.0 20233.6 20272.9 980.0 1000.2 1000.8 1010.3 1016.0 10455.0 11068.5 11182.6 11289.9 11300.4 456686.0 456778.0 459259.0 467508.0 474726.0 58827.7 87933.0 88428.0 92600.5 93579.5 994.6 1021.1 1038.0 1041.1 1044.0 17451.2 17893.8 18277.3 18441.0 18657.3 43662.3 43905.3 44334.3 44348.1 45838.5 64289.0 64727.4 65255.0 65329.3 65499.0 8456.7 8539.2 8613.6 8689.5 8832.4 11130.3 12934.6 13186.7 13205.7 13224.0 11658.8 11665.6 11670.5 11735.5 11843.5 10930.2 11083.9 11164.8 11411.3 11540.8 7099.5 11471.0 11553.6 11798.2 12242.2 8082.6 8563.5 8639.2 8739.3 8858.9 11108.3 11510.7 11529.9 11585.7 11638.0 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#3] mootools.html Cycles:180 Average:5898.53 Median:478.59 stddev:3391.96 (708.7%) stddev-sans-first:3384.36 05:42:04 INFO - PROCESS | 3500 | Values: 1364.0 1472.3 1514.7 1637.5 1794.6 8610.0 9003.1 9042.1 9240.8 9260.4 9043.2 9182.9 9185.0 9187.6 9190.0 2405.9 2441.3 2441.5 2441.7 2445.8 2316.6 2374.2 2393.8 2395.5 2429.8 2383.4 2393.5 2403.6 2432.2 2437.0 2219.8 2261.0 2262.1 2266.0 2267.4 2296.2 2315.6 2318.8 2323.4 2325.0 9042.0 9113.8 9131.6 9207.5 9224.1 5394.1 5526.6 5539.1 5545.0 5549.3 3383.4 3416.3 3436.6 3451.6 3464.1 1137.2 1143.2 1151.5 1181.3 1196.1 12642.4 12645.7 12699.9 12720.9 12734.6 4335.7 4391.2 4534.1 4558.7 4646.4 9982.9 9989.3 9989.5 9991.0 9994.7 5292.8 5300.3 5302.4 5312.0 5316.6 4056.8 4411.4 4560.0 4866.4 4949.1 3849.4 3851.8 3956.1 3957.9 3978.3 1178.8 1186.8 1190.6 1197.6 1203.1 862.6 954.3 960.6 986.4 1010.9 5969.9 6165.3 6181.8 6203.1 6371.7 466.6 467.4 478.4 478.8 481.2 4213.6 4272.3 4282.2 4355.8 4408.1 10290.5 10704.6 10709.5 10720.7 10748.3 10641.8 10670.8 11082.3 11130.7 11325.4 8345.4 8545.8 8551.7 8551.9 8565.2 6199.6 6347.1 6399.1 6449.7 6526.9 10187.3 10391.9 10470.5 10595.3 10621.7 9397.0 10714.8 10806.9 10936.3 10939.8 7706.2 7892.4 7996.4 8170.1 8187.1 8442.7 8746.1 8804.9 8826.9 8839.6 7729.7 7855.0 7886.4 8122.2 8148.0 7775.6 7869.5 7901.0 7908.8 7976.8 6955.5 6980.6 7031.6 7033.1 7034.9 5028.6 5191.3 5211.9 5319.2 5327.3 5093.5 5106.2 5188.6 5288.7 5291.6 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#4] prototype.html Cycles:180 Average:4537.17 Median:5039.04 stddev:1318.65 (26.2%) stddev-sans-first:1283.90 05:42:04 INFO - PROCESS | 3500 | Values: 325.7 332.9 335.8 336.6 340.0 5214.5 5270.9 5271.2 5281.3 5286.2 5156.8 5198.5 5236.5 5236.5 5249.0 3902.6 3930.4 4076.7 4089.6 4118.7 4096.1 4096.7 4110.9 4124.5 4125.6 4060.8 4062.7 4065.2 4076.0 4078.0 3908.6 3969.0 4049.2 4074.7 4087.0 3624.2 3635.2 3636.6 3636.6 3639.5 5073.7 5082.9 5096.5 5146.6 5171.9 4637.5 4667.2 4679.2 4692.9 4717.3 5385.5 5393.8 5396.1 5396.2 5414.4 3981.4 4003.3 4016.3 4023.0 4038.0 5424.0 5567.0 5584.9 5620.7 5713.3 4090.8 4092.6 4092.9 4093.1 4096.2 4137.8 4142.4 4178.5 4197.0 4209.3 4604.6 4711.5 4745.5 4756.2 4760.4 5370.0 5428.8 5442.5 5443.6 5519.8 1401.6 1417.9 1419.1 1431.4 1433.7 878.5 937.1 942.9 945.5 956.4 5087.4 5169.4 5207.3 5267.5 5273.4 5529.0 5533.7 5539.4 5583.0 5616.7 4973.7 5240.4 5250.3 5263.8 5264.6 2922.8 2938.6 2951.1 2974.6 2987.2 5807.2 5842.7 5860.6 5869.7 5874.0 5566.8 5610.4 5652.8 5672.5 5712.5 5793.0 5795.6 5799.8 5857.2 5891.4 5414.4 5578.1 5674.4 5681.2 5690.9 5450.9 5546.8 5547.4 5558.4 5563.6 5762.7 5794.0 5819.9 5867.4 5875.3 3587.8 3668.6 3700.6 3715.7 3726.5 4902.6 4956.7 4977.7 4987.0 5004.4 4832.1 4869.2 4875.2 4877.9 4926.8 4727.8 4825.0 4873.3 4896.9 4921.7 4747.9 4808.7 4824.8 4829.8 4838.9 5225.7 5320.6 5434.9 5462.4 5462.8 5324.6 5325.9 5330.9 5359.5 5385.6 05:42:04 INFO - PROCESS | 3500 | 05:42:04 INFO - PROCESS | 3500 | [#5] yui.html Cycles:180 Average:21941.09 Median:4589.11 stddev:33020.29 (719.5%) stddev-sans-first:33074.53 05:42:04 INFO - PROCESS | 3500 | Values: 734.7 765.7 799.4 846.3 868.0 15449.9 15940.3 16492.9 16506.3 16526.8 15095.7 15120.2 15150.7 15189.2 15237.8 821.6 842.1 843.6 844.1 845.1 676.6 807.5 842.9 843.9 849.8 882.9 887.4 888.0 888.5 888.8 884.2 884.4 885.5 886.4 889.7 518.4 623.5 635.6 636.3 636.3 14838.4 14861.3 14865.8 14970.6 15020.5 14265.6 14383.6 14574.3 14691.9 14859.9 13146.8 13246.3 13422.5 13507.9 13931.4 4383.3 4429.8 4437.8 4488.0 4510.6 82908.6 83750.6 84988.2 90161.0 91174.1 10490.1 10697.3 10856.9 10953.0 11220.6 18013.4 18030.8 18042.4 18171.4 19974.6 8866.0 8886.8 8967.7 9068.5 9220.8 4860.1 4977.8 4989.3 5068.2 5202.4 3459.3 3546.9 3550.8 3554.3 3554.8 620.5 625.8 637.6 646.0 647.0 683.8 705.0 717.8 742.9 750.2 9162.8 9514.8 9698.1 9726.3 9844.7 652.4 700.8 711.7 720.8 738.4 4225.7 4667.6 4710.7 4791.7 4851.6 128554.0 131158.3 133305.3 133515.3 136574.0 109734.1 110727.4 112239.0 113930.4 115690.0 79040.6 80481.2 80583.0 81598.0 90567.5 9626.3 9717.8 9817.3 9884.1 10198.4 51288.0 52292.0 52987.7 53017.2 54763.0 72404.0 77415.6 77827.6 78052.0 78728.6 11852.6 12203.8 12369.8 12509.2 12780.4 14573.0 14609.9 14803.3 14867.0 14953.6 12796.6 13011.2 13236.7 13377.5 13808.7 13822.6 14116.2 14222.3 14350.4 14380.9 12348.8 12438.7 13112.7 13127.9 13170.7 10691.9 11054.4 11125.4 11528.6 11570.8 9327.3 10472.9 11264.6 11486.1 11918.0 05:42:04 INFO - PROCESS | 3500 | -------- Summary: end -------- 05:42:04 INFO - PROCESS | 3500 | 05:42:05 INFO - TEST-INFO | 3500: exit 0 05:42:05 INFO - TEST-OK | dromaeo_css | took 1115160ms 05:42:05 INFO - TEST-START | kraken 05:42:05 INFO - operating with platform_type : linux_ 05:42:05 INFO - Initialising browser for kraken test... 05:42:05 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCphBrX/profile http://localhost:44173/getInfo.html) 05:42:09 INFO - PROCESS | 3689 | __metrics Screen width/height:1600/1200 05:42:09 INFO - PROCESS | 3689 | colorDepth:24 05:42:09 INFO - PROCESS | 3689 | Browser inner width/height: 1024/697 05:42:09 INFO - PROCESS | 3689 | __metrics 05:42:10 INFO - PROCESS | 3689 | 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" 05:42:10 INFO - PROCESS | 3689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:10 INFO - PROCESS | 3689 | console.error: PushService: 05:42:10 INFO - PROCESS | 3689 | stateChangeProcessEnqueue: Error transitioning state 05:42:10 INFO - PROCESS | 3689 | UnknownError 05:42:11 INFO - TEST-INFO | 3689: exit 0 05:42:11 INFO - Browser initialized. 05:42:11 INFO - Running cycle 1/1 for kraken test... 05:42:11 INFO - TEST-INFO | started process 3770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCphBrX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:23 INFO - PROCESS | 3770 | RSS: Main: 156151808 05:42:23 INFO - PROCESS | 3770 | 05:42:25 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44173/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:26 INFO - PROCESS | 3770 | RSS: Main: 213274624 05:42:26 INFO - PROCESS | 3770 | 05:42:29 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44173/tests/kraken/driver.html?testName=audio-dft) 05:42:29 INFO - PROCESS | 3770 | RSS: Main: 193052672 05:42:29 INFO - PROCESS | 3770 | 05:42:32 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44173/tests/kraken/driver.html?testName=audio-fft) 05:42:33 INFO - PROCESS | 3770 | RSS: Main: 269123584 05:42:33 INFO - PROCESS | 3770 | 05:42:35 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44173/tests/kraken/driver.html?testName=audio-oscillator) 05:42:36 INFO - PROCESS | 3770 | RSS: Main: 179408896 05:42:36 INFO - PROCESS | 3770 | 05:42:38 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:38 INFO - PROCESS | 3770 | RSS: Main: 184098816 05:42:38 INFO - PROCESS | 3770 | 05:42:41 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44173/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:42 INFO - PROCESS | 3770 | RSS: Main: 219066368 05:42:42 INFO - PROCESS | 3770 | 05:42:45 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44173/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:46 INFO - PROCESS | 3770 | RSS: Main: 219795456 05:42:46 INFO - PROCESS | 3770 | 05:42:49 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44173/tests/kraken/driver.html?testName=json-parse-financial) 05:42:49 INFO - PROCESS | 3770 | RSS: Main: 219840512 05:42:49 INFO - PROCESS | 3770 | 05:42:51 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:51 INFO - PROCESS | 3770 | RSS: Main: 183431168 05:42:51 INFO - PROCESS | 3770 | 05:42:53 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:54 INFO - PROCESS | 3770 | RSS: Main: 188956672 05:42:54 INFO - PROCESS | 3770 | 05:42:56 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:56 INFO - PROCESS | 3770 | RSS: Main: 194711552 05:42:56 INFO - PROCESS | 3770 | 05:42:59 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:00 INFO - PROCESS | 3770 | RSS: Main: 189124608 05:43:00 INFO - PROCESS | 3770 | 05:43:02 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:03 INFO - PROCESS | 3770 | RSS: Main: 192819200 05:43:03 INFO - PROCESS | 3770 | 05:43:04 INFO - PROCESS | 3770 | Cycle 1(1): loaded http://localhost:44173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44173/tests/kraken/driver.html?testName=ai-astar) 05:43:05 INFO - PROCESS | 3770 | RSS: Main: 243417088 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | __start_tp_report 05:43:05 INFO - PROCESS | 3770 | _x_x_mozilla_page_load 05:43:05 INFO - PROCESS | 3770 | _x_x_mozilla_page_load_details 05:43:05 INFO - PROCESS | 3770 | |i|pagename|runs| 05:43:05 INFO - PROCESS | 3770 | |0;ai-astar;101;110;110;110;111;111;110;110;110;111 05:43:05 INFO - PROCESS | 3770 | |1;audio-beat-detection;150;116;119;183;118;124;141;118;147;117 05:43:05 INFO - PROCESS | 3770 | |2;audio-dft;161;161;162;160;162;160;160;160;161;163 05:43:05 INFO - PROCESS | 3770 | |3;audio-fft;74;76;76;114;74;76;75;74;98;74 05:43:05 INFO - PROCESS | 3770 | |4;audio-oscillator;83;83;127;84;83;85;121;83;84;130 05:43:05 INFO - PROCESS | 3770 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 05:43:05 INFO - PROCESS | 3770 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;147;146 05:43:05 INFO - PROCESS | 3770 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 05:43:05 INFO - PROCESS | 3770 | |8;json-parse-financial;51;49;50;50;49;51;50;50;49;51 05:43:05 INFO - PROCESS | 3770 | |9;json-stringify-tinderbox;60;60;59;60;59;59;59;58;60;60 05:43:05 INFO - PROCESS | 3770 | |10;stanford-crypto-aes;75;76;75;75;75;75;76;75;74;81 05:43:05 INFO - PROCESS | 3770 | |11;stanford-crypto-ccm;123;129;122;126;120;119;129;120;154;124 05:43:05 INFO - PROCESS | 3770 | |12;stanford-crypto-pbkdf2;161;155;155;156;159;157;154;158;155;156 05:43:05 INFO - PROCESS | 3770 | |13;stanford-crypto-sha256-iterative;63;63;63;73;62;63;63;62;62;61 05:43:05 INFO - PROCESS | 3770 | __end_tp_report 05:43:05 INFO - PROCESS | 3770 | __start_cc_report 05:43:05 INFO - PROCESS | 3770 | _x_x_mozilla_cycle_collect,1655 05:43:05 INFO - PROCESS | 3770 | __end_cc_report 05:43:05 INFO - PROCESS | 3770 | __startTimestamp1470746585206__endTimestamp 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | ------- Summary: start ------- 05:43:05 INFO - PROCESS | 3770 | Number of tests: 14 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.99 (2.7%) stddev-sans-first:0.50 05:43:05 INFO - PROCESS | 3770 | Values: 101.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:132.50 stddev:21.91 (16.5%) stddev-sans-first:22.39 05:43:05 INFO - PROCESS | 3770 | Values: 150.0 116.0 119.0 183.0 118.0 124.0 141.0 118.0 147.0 117.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 05:43:05 INFO - PROCESS | 3770 | Values: 161.0 161.0 162.0 160.0 162.0 160.0 160.0 160.0 161.0 163.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:13.68 (18.1%) stddev-sans-first:14.27 05:43:05 INFO - PROCESS | 3770 | Values: 74.0 76.0 76.0 114.0 74.0 76.0 75.0 74.0 98.0 74.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:83.00 stddev:20.62 (24.8%) stddev-sans-first:21.30 05:43:05 INFO - PROCESS | 3770 | Values: 83.0 83.0 127.0 84.0 83.0 85.0 121.0 83.0 84.0 130.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:43:05 INFO - PROCESS | 3770 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:43:05 INFO - PROCESS | 3770 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:43:05 INFO - PROCESS | 3770 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.78 05:43:05 INFO - PROCESS | 3770 | Values: 51.0 49.0 50.0 50.0 49.0 51.0 50.0 50.0 49.0 51.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:43:05 INFO - PROCESS | 3770 | Values: 60.0 60.0 59.0 60.0 59.0 59.0 59.0 58.0 60.0 60.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:1.95 (2.6%) stddev-sans-first:2.05 05:43:05 INFO - PROCESS | 3770 | Values: 75.0 76.0 75.0 75.0 75.0 75.0 76.0 75.0 74.0 81.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:125.00 stddev:10.27 (8.2%) stddev-sans-first:10.81 05:43:05 INFO - PROCESS | 3770 | Values: 123.0 129.0 122.0 126.0 120.0 119.0 129.0 120.0 154.0 124.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:156.50 stddev:2.17 (1.4%) stddev-sans-first:1.62 05:43:05 INFO - PROCESS | 3770 | Values: 161.0 155.0 155.0 156.0 159.0 157.0 154.0 158.0 155.0 156.0 05:43:05 INFO - PROCESS | 3770 | 05:43:05 INFO - PROCESS | 3770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:3.41 (5.4%) stddev-sans-first:3.61 05:43:05 INFO - PROCESS | 3770 | Values: 63.0 63.0 63.0 73.0 62.0 63.0 63.0 62.0 62.0 61.0 05:43:05 INFO - PROCESS | 3770 | -------- Summary: end -------- 05:43:05 INFO - PROCESS | 3770 | 05:43:06 INFO - TEST-INFO | 3770: exit 0 05:43:06 INFO - TEST-OK | kraken | took 61048ms 05:43:06 INFO - SUITE-END | took 1176s 05:43:06 INFO - Completed test suite (00:19:36) 05:43:06 INFO - javascript benchmark 05:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.3913217356526, 3045.939081218377, 3051.725344718975, 3077.5383692446144, 3093.6906309369065, 5137.434882162959, 5249.422563518019, 5356.410794812572, 5432.212329212267, 5450.0189965806185, 5305.734713264341, 5338.519533242007, 5380.112281473552, 5407.053765591016, 5412.404635490093, 4791.041791641668, 4791.616670666347, 4866.07544566533, 4867.123917694814, 4961.8511444656715, 4896.951030489703, 4926.0, 4957.25641153828, 4963.106640804654, 4964.0, 4703.623710103184, 4743.905121897543, 4793.784279707422, 4855.028994201174, 4896.951030489685, 4770.522947705236, 4785.976070119662, 4796.760161991921, 4856.17445034345, 4910.508949105097, 4779.091972525209, 4800.735959522225, 4810.35060266863, 4831.154547954129, 4872.9512704873205, 5150.793968241266, 5276.393214780311, 5329.920051199235, 5333.173358129496, 5336.252924590561, 5731.0, 5771.249737534135, 5775.018246898037, 5777.855553611152, 5781.364049954502, 5775.306963164405, 5816.040353341694, 5816.912746308809, 5823.737931793079, 5825.504832089277, 5105.693658380472, 5204.661696989683, 5257.921131183035, 5265.578753699695, 5357.330333708286, 5823.184754134425, 5828.6211396259105, 5829.213056237354, 5834.0373838317055, 5834.766609335664, 5552.278203833556, 5556.111022236423, 5576.609637325349, 5593.328800543879, 5610.13042978339, 5386.676799392049, 5575.916361254584, 5628.409017053151, 5641.915371269434, 5644.85887852807, 5623.297087864017, 5629.943700563023, 5633.380328163898, 5639.689817060101, 5659.5755318351285, 5603.047481928082, 5639.859003524863, 5646.802361917313, 5648.802291919763, 5657.57568182388, 4199.160167966419, 4209.536950935395, 4237.258479766028, 4299.634531064895, 4318.913621727548, 3736.290104880064, 3767.05823544114, 3773.0755964788805, 3850.7689538627774, 3853.9807300963316, 5251.579873610102, 5267.473252674778, 5283.471652834686, 5285.920711189336, 5332.813351532678, 5593.692346920877, 5602.915956260659, 5604.775808967677, 5611.6352437091455, 5629.605927585029, 5188.662736922088, 5350.27771250884, 5413.323334583177, 5420.430854760272, 5488.533474654699, 4912.6561140719805, 4914.459409464956, 4918.409790825052, 4919.950800491949, 4924.0, 5989.460948514655, 5997.310309314397, 5998.280206375263, 6001.819945401645, 6005.309389420273, 5440.891182176413, 5651.152327150796, 5730.856728581819, 5736.082226843685, 5809.012467880555, 5927.199828023162, 5931.733072011683, 5957.314908785545, 5958.19564358806, 5996.760129594942, 5547.583931205257, 5569.415211402745, 5571.470710282517, 5571.582131340085, 5575.804846830504, 5429.755660995185, 5649.943500564942, 5689.288838895138, 5689.800856969986, 5703.08750599902, 5577.860553486033, 5617.269754931833, 5628.831135065954, 5631.63394379364, 5637.689927054052, 5576.386597474356, 5604.075327570905, 5614.270144881302, 5615.831525054255, 5623.859403514781, 5383.838484845461, 5405.459454054563, 5434.3750468695025, 5450.700211488406, 5460.508554229979, 5546.916796247979, 5553.555715542828, 5589.664620122806, 5594.580406469612, 5601.971990140023, 5397.379301380234, 5419.458054194549, 5425.267588875451, 5427.213054107054, 5429.0], "value": 5232.072661280743, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.147183640049, 591.1133300049925, 596.9553281756926, 602.1209034809178, 617.0497433951713, 32053.83973080134, 43480.34779478306, 44249.11501769962, 44287.77856110723, 44314.999999999956, 44124.0, 44438.77780611093, 44486.555134448645, 44527.33209001867, 44553.554464455345, 8828.690995815165, 8961.103889611051, 8967.192952634294, 8975.057618950013, 8979.865302020475, 8785.165409286108, 8886.911130888673, 8893.73318800437, 8893.911060889373, 8897.199252067312, 8936.731898043068, 8999.190072893438, 9002.234810041122, 9007.324450666194, 9010.729678109667, 8924.509151996637, 8967.955160224223, 8973.910260897406, 8974.371793974424, 8975.820483590292, 8840.602172902234, 8893.066228046091, 8893.155150260714, 8895.066018068075, 8897.777555561162, 42174.57825421737, 42461.0, 42539.361909571075, 42579.57420425787, 42590.787046064885, 3729.272791805599, 3737.626237376268, 3974.225026119908, 4104.445899803518, 4209.158168366339, 32732.672673273202, 32837.17907052319, 33526.32947341064, 33910.32179356399, 34219.82890085533, 4019.2363450944517, 4119.752814831119, 4146.295129827937, 4204.957950420488, 4255.659547236213, 326550.0, 334732.0, 334835.0, 335230.0, 335839.0, 59145.0, 59357.0, 59437.702811485666, 59536.0, 59634.0, 61763.38236617576, 61780.0, 62150.0, 62226.37773622206, 62235.688821556505, 15138.545843624708, 15311.15788631636, 15314.234288285541, 15314.463993760164, 15320.540383788504, 12398.75202495945, 12427.627171184879, 12450.066245031478, 12455.128141030222, 12456.0, 14932.925335373471, 17268.654626907643, 17294.221760020577, 17315.91342043307, 17538.473845784647, 6019.337872833985, 6049.727762250709, 6069.0, 6077.17958075663, 6229.906551401733, 948.6964171465065, 1088.2654208409292, 1107.3521989636154, 1147.5581900968186, 1210.2435977514053, 32136.35727285488, 32552.0, 32694.0, 32877.671223287936, 33519.49720754142, 1123.545232638497, 1133.6032388663903, 1156.1791128298835, 1170.0581032268935, 1244.3715923458597, 17251.3962011329, 17263.0, 17353.65292694139, 17429.564260893327, 17600.735988960176, 519697.0, 520751.0, 521931.0, 522393.0, 523127.0, 58849.11726324109, 58962.41037589655, 58966.70516647475, 59026.704866476255, 59052.40947590555, 1257.057207094679, 1294.5533790842144, 1363.8090667306585, 1399.0486469201041, 1411.5412490940485, 31879.362412752078, 33170.0, 33968.66031339655, 34221.31557368889, 34474.0, 44795.0, 55452.16821747758, 57125.71437142788, 57209.0, 60758.69620651868, 459116.0, 463325.0, 464249.0, 464757.0, 466056.0, 25728.742712572635, 28293.858530707214, 28525.572116418687, 28622.0, 29076.418471630874, 47782.0, 47782.76108619435, 47978.0, 48280.51719482901, 48485.272720908506, 38752.0, 40181.79909100553, 40683.59316406798, 41089.38365924573, 41767.373489397076, 39617.60382396254, 39815.80092099521, 40965.38551921664, 41006.384904225866, 41246.793766030976, 40301.19397611973, 40678.1864362717, 40929.59070409377, 41049.0, 41652.16695666009, 34930.0, 37777.433338500494, 44016.0, 44424.77787611041, 45748.771256143504, 32106.67893321037, 35219.23903804748, 35264.82367588145, 35265.47101793526, 35312.82343588266], "value": 20304.193794282135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9596842331555, 387.5543125405783, 389.6629415555544, 390.6136695447029, 412.90090378309196, 14467.131972081655, 17480.562985925357, 18715.3449629263, 20240.0, 20255.088521016572, 19248.0, 19764.20943162272, 19911.402657920287, 20466.386008419733, 20488.69266960993, 5827.213326200951, 6007.429294217064, 6022.066579680157, 6024.487918526908, 6045.063015232624, 4281.464816897887, 5900.0, 5976.581639285252, 6430.292667806538, 6733.09103271057, 6678.0, 6761.729530818761, 6768.7630932917355, 6781.389674929255, 6783.864322713543, 6477.222733272014, 6587.473002159816, 6655.301193374675, 6663.16710411201, 6665.833354166136, 5645.209670646072, 5848.5321174305955, 5853.5317174625925, 5857.736401861926, 5902.08517679756, 24023.519529609486, 24104.517909641883, 24174.516509669884, 24194.758052419602, 24246.15138470163, 2179.6294629912954, 2331.3122628824367, 2351.247600767755, 2422.527607116613, 3128.1553980425383, 10406.0, 10425.0, 10703.946480267627, 10944.890551094546, 10962.506687199095, 1975.3580086471811, 2014.3956812956055, 2020.7676117246558, 2024.7469066366705, 2030.9390718278476, 79575.60212198959, 81757.0, 82372.0, 83597.0, 85863.57068214682, 11375.03312218454, 11375.715607109889, 11434.0, 11449.198556100993, 11600.709982250512, 15972.68054638924, 15990.520284391487, 16001.599960001093, 16005.919970400073, 16021.919890400706, 8106.4325497215805, 8325.250727434439, 8336.708215212439, 8413.663453461793, 8453.239208471266, 7914.0, 7961.203879612109, 8118.715844945516, 8163.877541836877, 8174.427790054639, 4604.953950460453, 4665.86002419928, 4666.393368862026, 4671.131547381075, 4841.661083724105, 1987.4335814293147, 2049.7950204979384, 2069.1619893942975, 2070.1408915300285, 2076.7404074490687, 982.3467394182788, 989.564591579717, 1017.9949100254452, 1055.6199768083484, 1082.220801023262, 19034.33379831699, 19891.502712432306, 20122.0, 20233.559673950276, 20272.898635506728, 979.9657012004545, 1000.1898462245605, 1000.8048430555972, 1010.2978429991233, 1015.97460063499, 10455.0, 11068.501917413736, 11182.608608698656, 11289.887101129048, 11300.434978251054, 456686.0, 456778.0, 459259.0, 467508.0, 474726.0, 58827.70586147042, 87933.0, 88428.0, 92600.53699731592, 93579.53210234041, 994.6170724271063, 1021.0861279155263, 1038.0449986013036, 1041.141058626636, 1044.0, 17451.214695338487, 17893.821061789215, 18277.26890924348, 18441.0, 18657.253709851455, 43662.34506482469, 43905.34141987937, 44334.33498497461, 44348.11303773971, 45838.541614583424, 64289.0, 64727.352726472134, 65255.0, 65329.34670653233, 65499.0, 8456.746297611082, 8539.188777066169, 8613.612387442705, 8689.522076285612, 8832.38173327861, 11130.332180069221, 12934.611961641165, 13186.736265274832, 13205.669858253235, 13224.0, 11658.76682466363, 11665.618856589768, 11670.474828632561, 11735.471903764523, 11843.46704398287, 10930.180236482454, 11083.944580277048, 11164.832527511931, 11411.258268212872, 11540.826887596524, 7099.538529995534, 11471.0, 11553.595624153115, 11798.233114847508, 12242.204256723284, 8082.595870206584, 8563.529005904735, 8639.222469977733, 8739.257163141205, 8858.911410886067, 11108.333499990027, 11510.654680359603, 11529.942350288195, 11585.6524304271, 11638.0], "value": 9430.669812122464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.0042768778796, 1472.3080152328405, 1514.7046325966435, 1637.5005623284894, 1794.6051868588913, 8609.956950215248, 9003.099690031002, 9042.140996605329, 9240.768980775483, 9260.351775375726, 9043.231325337354, 9182.86225706615, 9185.035571265005, 9187.632494700221, 9189.954050229757, 2405.9157929472426, 2441.3042282949273, 2441.4750828571855, 2441.706995160583, 2445.7798798108165, 2316.5714342846545, 2374.2283757778705, 2393.7965272951733, 2395.508920671267, 2429.8056155507516, 2383.4041489627593, 2393.4854006388623, 2403.639454081884, 2432.2338463384067, 2437.049550675238, 2219.7891200336103, 2261.027758064032, 2262.1177740681064, 2265.988670056656, 2267.365137761421, 2296.1733775840685, 2315.560043591729, 2318.7681231876845, 2323.4307594639254, 2325.0, 9041.954790226073, 9113.81772364549, 9131.589078491485, 9207.539623018822, 9224.07759224079, 5394.109971854639, 5526.590719366536, 5539.086050801613, 5545.00189965806, 5549.250851135085, 3383.407903616882, 3416.26550291686, 3436.60479044908, 3451.5685539307588, 3464.0820182651364, 1137.203957229934, 1143.2168964259508, 1151.5106079916086, 1181.3325471108797, 1196.114874992508, 12642.431090600852, 12645.683857903534, 12699.936500317532, 12720.87279127206, 12734.554290599785, 4335.674824388184, 4391.231534481453, 4534.115847409789, 4558.703684260512, 4646.442426908792, 9982.900170998197, 9989.250806189564, 9989.450580218012, 9990.950045249727, 9994.650187243411, 5292.814751483679, 5300.31095957523, 5302.416734159239, 5312.043832110257, 5316.601254905898, 4056.8377264909072, 4411.426514553087, 4559.954400456019, 4866.416030076413, 4949.133901567283, 3849.364854798927, 3851.8459261629782, 3956.050547868491, 3957.92084158321, 3978.3236849735613, 1178.7642471505733, 1186.839776630144, 1190.6487586162102, 1197.6167626359481, 1203.061611942686, 862.6204470033165, 954.3367359684952, 960.6349587156975, 986.4180133721139, 1010.8534262531891, 5969.940300597025, 6165.290991535941, 6181.8454538636, 6203.069539569011, 6371.681415929185, 466.59406316504857, 467.38072054527885, 478.37810845900884, 478.80129746155654, 481.194000049915, 4213.620774130343, 4272.295071313199, 4282.186384586918, 4355.825766969349, 4408.096340250241, 10290.485475726184, 10704.571817127384, 10709.46452677363, 10720.731981700364, 10748.301360411548, 10641.840372394421, 10670.839937400946, 11082.279651822606, 11130.666080017612, 11325.433728313552, 8345.374096942754, 8545.829083418297, 8551.74344769658, 8551.931008624046, 8565.229129378386, 6199.582162956541, 6347.143135676809, 6399.104125422352, 6449.7097630605795, 6526.869462610816, 10187.337823041478, 10391.896081039395, 10470.528826202992, 10595.258331916692, 10621.681349559525, 9396.95301523488, 10714.785704286027, 10806.891931080903, 10936.289141205796, 10939.781204376028, 7706.152323244327, 7892.447528672938, 7996.3602911768085, 8170.101288858102, 8187.099419064018, 8442.66229350819, 8746.081661425713, 8804.911950880409, 8826.91173088261, 8839.602217900081, 7729.690812367442, 7854.960725196337, 7886.369090472863, 8122.228388303101, 8148.022237331558, 7775.572343520935, 7869.544134335167, 7900.960495197487, 7908.84182316362, 7976.760697179094, 6955.513114081966, 6980.581165130108, 7031.578105313698, 7033.120859892513, 7034.859302813813, 5028.64799464034, 5191.273221748883, 5211.895762084813, 5319.175527793198, 5327.3074500314715, 5093.490650934877, 5106.208537676666, 5188.610854186027, 5288.735563221747, 5291.550218231493], "value": 4621.469958284969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.7426632959962, 332.8735080669347, 335.7649645248326, 336.63979541890154, 339.97667022263, 5214.452482489341, 5270.890174796869, 5271.235670827732, 5281.313429254192, 5286.2070689396605, 5156.767945442455, 5198.45416231296, 5236.460316746375, 5236.476352364771, 5249.002689488994, 3902.6487616114546, 3930.449737036817, 4076.694247931417, 4089.5705950875176, 4118.732282401635, 4096.119334343116, 4096.651784598313, 4110.938335924949, 4124.505059392877, 4125.64931980782, 4060.7563546187175, 4062.6749860011128, 4065.2072845795083, 4075.9592404075875, 4077.979610101945, 3908.6482216600502, 3968.9801550992206, 4049.2104039712267, 4074.6740260779065, 4087.0, 3624.238909828939, 3635.2366003139373, 3636.5999740028574, 3636.61815509373, 3639.508666330038, 5073.695578265316, 5082.872928176788, 5096.464871188509, 5146.562542183919, 5171.870703232412, 4637.489876113625, 4667.183242932473, 4679.15775160471, 4692.8683494528395, 4717.33470589116, 5385.515303622654, 5393.78424863005, 5396.136618141118, 5396.163594642837, 5414.35027796667, 3981.422693709425, 4003.339448990913, 4016.3172260715746, 4022.959770402317, 4038.0308725905866, 5424.0, 5567.025770490148, 5584.888302233973, 5620.66276023444, 5713.257456475773, 4090.795460226977, 4092.5702801205443, 4092.856750013735, 4093.1199792044854, 4096.242195193899, 4137.834486620562, 4142.420061191436, 4178.540360560336, 4196.979015104966, 4209.34755112958, 4604.631629469634, 4711.481737008926, 4745.454272758608, 4756.191447453941, 4760.357351757538, 5370.0, 5428.75570599324, 5442.482964118402, 5443.577607964417, 5519.751611177507, 1401.6425811418023, 1417.9432822687183, 1419.0917812599944, 1431.439730693549, 1433.72042451723, 878.5299864572551, 937.1097457415483, 942.853857652065, 945.5366870233536, 956.3783540698463, 5087.440381558025, 5169.397486779036, 5207.270982062514, 5267.473252674778, 5273.446288139767, 5528.9723551381985, 5533.6956467393875, 5539.446055394428, 5582.97208513963, 5616.69108199053, 4973.651844370932, 5240.4497527759795, 5250.291210686509, 5263.763130659129, 5264.631475796734, 2922.824630522133, 2938.6032885560176, 2951.1294168220425, 2974.598429212072, 2987.208389776711, 5807.157962095473, 5842.678652674059, 5860.648361098348, 5869.6771677558145, 5873.970630146908, 5566.803137325494, 5610.401035704886, 5652.795409790185, 5672.546196304285, 5712.457636438138, 5793.0, 5795.623284486495, 5799.797007104816, 5857.20927674767, 5891.351951285441, 5414.35027796667, 5578.135389014709, 5674.404187560412, 5681.2330335404195, 5690.914636280542, 5450.863728406822, 5546.805861794818, 5547.44525547442, 5558.388577256418, 5563.638363506359, 5762.7237241290295, 5794.0439827428, 5819.94180058194, 5867.413258674099, 5875.3243377010485, 3587.833953965024, 3668.63313668631, 3700.5744339401313, 3715.7027437804372, 3726.515552978204, 4902.607791376753, 4956.653034287565, 4977.726225057657, 4986.952739924512, 5004.374453193351, 4832.081904438145, 4869.151546345428, 4875.19559272716, 4877.853664390074, 4926.802927882844, 4727.837326450499, 4824.975875120602, 4873.293372461044, 4896.853094407174, 4921.744955036586, 4747.907981164282, 4808.687435316833, 4824.758762061953, 4829.782659780248, 4838.919264716065, 5225.667454799154, 5320.627556071193, 5434.891302174014, 5462.371827239918, 5462.808801691922, 5324.600654950972, 5325.866853328698, 5330.866728331823, 5359.544438722753, 5385.626665200349], "value": 4122.742054805779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6914295995682, 765.7128576783705, 799.4044436894515, 846.2637505370325, 867.9652813887445, 15449.922750386246, 15940.282687279101, 16492.917535412307, 16506.27646438336, 16526.83473165268, 15095.698086038301, 15120.243987800593, 15150.696986060273, 15189.240537973112, 15237.84762152378, 821.6302663801298, 842.0779246724826, 843.569779412501, 844.0630899701326, 845.1421806866036, 676.5703778100892, 807.4630370803409, 842.8567143585575, 843.8987321521427, 849.8045449546609, 882.8984666763308, 887.4497811356968, 888.0409158109259, 888.4580405952364, 888.7955770172832, 884.1997991817448, 884.44280103535, 885.5306687455627, 886.4326830828275, 889.6574818694785, 518.3701802310173, 623.5043140703152, 635.6249812610536, 636.2651137935692, 636.3318515558645, 14838.406463741438, 14861.331240094114, 14865.777013344808, 14970.62573435662, 15020.474283400028, 14265.57203283903, 14383.568492945229, 14574.344154512966, 14691.926540367229, 14859.851401485956, 13146.802797958038, 13246.271455069967, 13422.463101476027, 13507.86492135076, 13931.373088211054, 4383.3424986252, 4429.800658970354, 4437.800298986521, 4487.955120448786, 4510.594046535794, 82908.58545707233, 83750.58124709337, 84988.15011849864, 90161.0, 91174.08825911723, 10490.108340790966, 10697.304675196086, 10856.891431085745, 10953.0, 11220.551177952953, 18013.369532066314, 18030.819691802913, 18042.368517101837, 18171.364002259856, 19974.60050799005, 8866.024737278894, 8886.777830554287, 8967.730968070968, 9068.54657267134, 9220.769480763034, 4860.076585448754, 4977.751112444364, 4989.326440930428, 5068.239764035424, 5202.4277329493725, 3459.3427248822645, 3546.929061418757, 3550.840212190458, 3554.253606742613, 3554.7689400189424, 620.5407998081387, 625.8185126313409, 637.5887552528593, 646.0148273882273, 647.0294558162756, 683.7777722240291, 705.0, 717.8241330873865, 742.9219931907072, 750.152327869504, 9162.770930726652, 9514.809703805886, 9698.127168554864, 9726.319157658896, 9844.704658860246, 652.3574279334852, 700.7897630710767, 711.7437722419925, 720.7585458871232, 738.3723834740535, 4225.704200705983, 4667.6265898728025, 4710.6702530823195, 4791.65011519819, 4851.636127290467, 128554.0, 131158.34420827834, 133305.33347333202, 133515.3324233392, 136574.0, 109734.12392884519, 110727.44636276927, 112239.0, 113930.43034784938, 115690.0, 79040.60479697565, 80481.19518804736, 80583.0, 81597.9999999988, 90567.54716226508, 9626.32615716893, 9717.757056073655, 9817.26370522228, 9884.061014203638, 10198.43908585035, 51287.97424051573, 52292.0, 52987.73506132445, 53017.20474192813, 54763.0, 72404.0, 77415.61292193728, 77827.61086194533, 78052.0, 78728.60635696785, 11852.58024305086, 12203.75592488163, 12369.752604947671, 12509.186902851285, 12780.424880880197, 14573.0, 14609.853901460849, 14803.333849976992, 14867.0, 14953.626159346104, 12796.61610151697, 13011.21932684042, 13236.669083272995, 13377.53178638743, 13808.654783630489, 13822.585322440344, 14116.223607701675, 14222.288885555474, 14350.354234059701, 14380.856191437952, 12348.753024939631, 12438.689032774253, 13112.672183195496, 13127.949764019046, 13170.670733231746, 10691.946540267249, 11054.392008439612, 11125.44372781374, 11528.59649912249, 11570.826437603275, 9327.347085704207, 10472.895271047497, 11264.605738799102, 11486.138539609396, 11918.0], "value": 7714.3700492150765, "unit": "score"}], "name": "dromaeo_css", "value": 7266.959083276872, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 119.0, 183.0, 118.0, 124.0, 141.0, 118.0, 147.0, 117.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 114.0, 74.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 127.0, 84.0, 83.0, 85.0, 121.0, 83.0, 84.0, 130.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 50.0, 49.0, 51.0, 50.0, 50.0, 49.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 58.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 76.0, 75.0, 74.0, 81.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 122.0, 126.0, 120.0, 119.0, 129.0, 120.0, 154.0, 124.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 155.0, 156.0, 159.0, 157.0, 154.0, 158.0, 155.0, 156.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 73.0, 62.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1471.1999999999998, "alertThreshold": 2.0}]} 05:43:06 INFO - Return code: 0 05:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:43:06 INFO - # TBPL SUCCESS # 05:43:06 INFO - Running post-action listener: _resource_record_post_action 05:43:06 INFO - [mozharness: 2016-08-09 12:43:06.524244Z] Finished run-tests step (success) 05:43:06 INFO - Running post-run listener: _resource_record_post_run 05:43:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 411881472; Read time: 0; Write time: 261972 05:43:06 INFO - TinderboxPrint: CPU usage
13.0% 05:43:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:43:06 INFO - TinderboxPrint: I/O write bytes / time
411,881,472 / 261,972 05:43:06 INFO - TinderboxPrint: CPU idle
8,288.5 (87.0%) 05:43:06 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 05:43:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:43:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117997568; Read time: 0; Write time: 73220 05:43:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293269504; Read time: 0; Write time: 188752 05:43:07 INFO - Running post-run listener: _upload_blobber_files 05:43:07 INFO - Blob upload gear active. 05:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:07 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 05:43:07 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'] 05:43:07 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 05:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:08 INFO - (blobuploader) - INFO - Done attempting. 05:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:09 INFO - (blobuploader) - INFO - Done attempting. 05:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:18 INFO - (blobuploader) - INFO - Done attempting. 05:43:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:18 INFO - Return code: 0 05:43:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bb0f6994899c552120325b83b494a51bb5be21ffc9d46187c8f285ba9b04d552ea55a5bb380da93ad411cf88c569c08b10612074ae36de8571a659062019213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa430ba479d08acc7392deba65967d8b0f88a16633f69483a58b016d06fac9945963e424ac443df5d649eb9dd407a66429ba1efa37800906fac5aa7a3f929587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcbd487e138620249886eb12eb19c9224f9dff6b14458169ff1fdbce83b75ca7a10c748a2a07dbd971906f7a73c3a1676b57d90e0c212fe9547db6697965f11c"} 05:43:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:18 INFO - Contents: 05:43:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bb0f6994899c552120325b83b494a51bb5be21ffc9d46187c8f285ba9b04d552ea55a5bb380da93ad411cf88c569c08b10612074ae36de8571a659062019213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa430ba479d08acc7392deba65967d8b0f88a16633f69483a58b016d06fac9945963e424ac443df5d649eb9dd407a66429ba1efa37800906fac5aa7a3f929587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcbd487e138620249886eb12eb19c9224f9dff6b14458169ff1fdbce83b75ca7a10c748a2a07dbd971906f7a73c3a1676b57d90e0c212fe9547db6697965f11c"} 05:43:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:18 INFO - Copying logs to upload dir... 05:43:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.930479 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-09 05:43:18.060283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:18.063751) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 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/5bb0f6994899c552120325b83b494a51bb5be21ffc9d46187c8f285ba9b04d552ea55a5bb380da93ad411cf88c569c08b10612074ae36de8571a659062019213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa430ba479d08acc7392deba65967d8b0f88a16633f69483a58b016d06fac9945963e424ac443df5d649eb9dd407a66429ba1efa37800906fac5aa7a3f929587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcbd487e138620249886eb12eb19c9224f9dff6b14458169ff1fdbce83b75ca7a10c748a2a07dbd971906f7a73c3a1676b57d90e0c212fe9547db6697965f11c"} build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bb0f6994899c552120325b83b494a51bb5be21ffc9d46187c8f285ba9b04d552ea55a5bb380da93ad411cf88c569c08b10612074ae36de8571a659062019213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa430ba479d08acc7392deba65967d8b0f88a16633f69483a58b016d06fac9945963e424ac443df5d649eb9dd407a66429ba1efa37800906fac5aa7a3f929587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcbd487e138620249886eb12eb19c9224f9dff6b14458169ff1fdbce83b75ca7a10c748a2a07dbd971906f7a73c3a1676b57d90e0c212fe9547db6697965f11c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:18.089008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:18.089305) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1470740368.186378-1425944468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:43:18.173968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:43:18.174285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:43:18.174559) ========= ========= Total master_lag: 0.18 =========