builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1470732744.34 results: success (0) buildid: 20160809000920 builduid: b750acbbc39a478f8762334247c4ef18 revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.340578) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.341084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.341395) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.358468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.358769) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 01:52:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-08-09 01:52:24 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.447837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.448161) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:24.498261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 01:52:24.498611) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 01:52:24,810 truncating revision to first 12 chars 2016-08-09 01:52:24,810 Setting DEBUG logging. 2016-08-09 01:52:24,810 attempt 1/10 2016-08-09 01:52:24,810 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 01:52:26,143 unpacking tar archive at: fx-team-2edc35144ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.699674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 01:52:26.212345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:26.212691) ========= script_repo_revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:26.213131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:26.213420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 01:52:26.224373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-09 01:52:26.224706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:52:26 INFO - MultiFileLogger online at 20160809 01:52:26 in /builds/slave/test 01:52:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:52:26 INFO - {'append_to_log': False, 01:52:26 INFO - 'base_work_dir': '/builds/slave/test', 01:52:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:52:26 INFO - 'branch': 'Fx-Team-Non-PGO', 01:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:52:26 INFO - 'config_files': ('talos/linux_config.py',), 01:52:26 INFO - 'default_actions': ('clobber', 01:52:26 INFO - 'read-buildbot-config', 01:52:26 INFO - 'download-and-extract', 01:52:26 INFO - 'populate-webroot', 01:52:26 INFO - 'create-virtualenv', 01:52:26 INFO - 'install', 01:52:26 INFO - 'run-tests'), 01:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:52:26 INFO - 'download_minidump_stackwalk': True, 01:52:26 INFO - 'download_symbols': 'ondemand', 01:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:52:26 INFO - 'installer_path': 'installer.exe', 01:52:26 INFO - 'log_level': 'info', 01:52:26 INFO - 'log_name': 'talos', 01:52:26 INFO - 'log_to_console': True, 01:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:52:26 INFO - 'opt_config_files': (), 01:52:26 INFO - 'pip_index': False, 01:52:26 INFO - 'sps_profile': False, 01:52:26 INFO - 'sps_profile_interval': 0, 01:52:26 INFO - 'suite': 'dromaeojs', 01:52:26 INFO - 'system_bits': '32', 01:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:52:26 INFO - 'title': 'talos-linux64-ix-055', 01:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:52:26 INFO - 'use_talos_json': True, 01:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:52:26 INFO - 'work_dir': 'build'} 01:52:26 INFO - [mozharness: 2016-08-09 08:52:26.626070Z] Running clobber step. 01:52:26 INFO - Running pre-action listener: _resource_record_pre_action 01:52:26 INFO - Running main action method: clobber 01:52:26 INFO - rmtree: /builds/slave/test/build 01:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:52:27 INFO - Running post-action listener: _resource_record_post_action 01:52:27 INFO - [mozharness: 2016-08-09 08:52:27.083755Z] Finished clobber step (success) 01:52:27 INFO - [mozharness: 2016-08-09 08:52:27.083858Z] Running read-buildbot-config step. 01:52:27 INFO - Running pre-action listener: _resource_record_pre_action 01:52:27 INFO - Running main action method: read_buildbot_config 01:52:27 INFO - Using buildbot properties: 01:52:27 INFO - { 01:52:27 INFO - "project": "", 01:52:27 INFO - "product": "firefox", 01:52:27 INFO - "script_repo_revision": "production", 01:52:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:52:27 INFO - "repository": "", 01:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:52:27 INFO - "buildid": "20160809000920", 01:52:27 INFO - "pgo_build": "False", 01:52:27 INFO - "basedir": "/builds/slave/test", 01:52:27 INFO - "buildnumber": 2084, 01:52:27 INFO - "slavename": "talos-linux64-ix-055", 01:52:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:52:27 INFO - "platform": "ubuntu64_hw", 01:52:27 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 01:52:27 INFO - "branch": "fx-team", 01:52:27 INFO - "repo_path": "integration/fx-team", 01:52:27 INFO - "revision": "2edc35144ebf50ca6339e686e766e200cc4b04b8", 01:52:27 INFO - "stage_platform": "linux64", 01:52:27 INFO - "builduid": "b750acbbc39a478f8762334247c4ef18", 01:52:27 INFO - "slavebuilddir": "test" 01:52:27 INFO - } 01:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 01:52:27 INFO - Running post-action listener: _resource_record_post_action 01:52:27 INFO - [mozharness: 2016-08-09 08:52:27.086588Z] Finished read-buildbot-config step (success) 01:52:27 INFO - [mozharness: 2016-08-09 08:52:27.086677Z] Running download-and-extract step. 01:52:27 INFO - Running pre-action listener: _resource_record_pre_action 01:52:27 INFO - Running main action method: download_and_extract 01:52:27 INFO - mkdir: /builds/slave/test/build/tests 01:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:27 INFO - trying https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:27 INFO - Downloaded 1361 bytes. 01:52:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:52:27 INFO - Using the following test package requirements: 01:52:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:52:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:52:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'jsshell-linux-x86_64.zip'], 01:52:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:52:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:52:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:52:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:52:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:52:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:27 INFO - trying https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:28 INFO - Downloaded 20257787 bytes. 01:52:28 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'] 01:52:28 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 01:52:29 INFO - Return code: 0 01:52:29 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 01:52: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')]} 01:52:29 INFO - trying https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:52:29 INFO - Downloading https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:30 INFO - Downloaded 20257787 bytes. 01:52:30 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'] 01:52:30 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 01:52:32 INFO - Return code: 0 01:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:32 INFO - trying https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:32 INFO - Downloading https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:33 INFO - Downloaded 14413723 bytes. 01:52:33 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'] 01:52:33 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 01:52:33 INFO - Return code: 0 01:52: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')]} 01:52:33 INFO - trying https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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 01:52:36 INFO - Downloaded 56136986 bytes. 01:52:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:52:36 INFO - mkdir: /builds/slave/test/properties 01:52:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:52:36 INFO - Writing to file /builds/slave/test/properties/build_url 01:52:36 INFO - Contents: 01:52:36 INFO - build_url:https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:52:37 INFO - Running post-action listener: _resource_record_post_action 01:52:37 INFO - Running post-action listener: set_extra_try_arguments 01:52:37 INFO - [mozharness: 2016-08-09 08:52:37.126325Z] Finished download-and-extract step (success) 01:52:37 INFO - [mozharness: 2016-08-09 08:52:37.126558Z] Running populate-webroot step. 01:52:37 INFO - Running pre-action listener: _resource_record_pre_action 01:52:37 INFO - Running main action method: populate_webroot 01:52:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:52:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:52:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:52:37 INFO - '--tppagecycles', 01:52:37 INFO - '7'], 01:52:37 INFO - 'tests': ['tsvgm']}}, 01:52:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:52:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:52:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:52:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:52:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['damp', 'tps']}, 01:52:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'tests': ['damp', 'tps']}, 01:52:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['dromaeo_dom']}, 01:52:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:52:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['basic_compositor_video']}, 01:52:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:52:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['a11yr', 01:52:37 INFO - 'ts_paint', 01:52:37 INFO - 'tpaint', 01:52:37 INFO - 'sessionrestore', 01:52:37 INFO - 'sessionrestore_no_auto_restore', 01:52:37 INFO - 'tabpaint']}, 01:52:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['tsvgx', 01:52:37 INFO - 'tsvgr_opacity', 01:52:37 INFO - 'tart', 01:52:37 INFO - 'tscrollx', 01:52:37 INFO - 'cart']}, 01:52:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:52:37 INFO - 'tsvgr_opacity', 01:52:37 INFO - 'tart', 01:52:37 INFO - 'tscrollx', 01:52:37 INFO - 'cart']}, 01:52:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'talos_options': ['--disable-e10s'], 01:52:37 INFO - 'tests': ['tp5o']}, 01:52:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'tests': ['tp5o']}, 01:52:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'talos_options': ['--disable-e10s', 01:52:37 INFO - '--xperf_path', 01:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:37 INFO - 'tests': ['tp5n']}, 01:52:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:37 INFO - 'talos_options': ['--xperf_path', 01:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:37 INFO - 'tests': ['tp5n']}}, 01:52:37 INFO - 'talos.zip': {'path': '', 01:52:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:52:37 INFO - Running post-action listener: _resource_record_post_action 01:52:37 INFO - [mozharness: 2016-08-09 08:52:37.146766Z] Finished populate-webroot step (success) 01:52:37 INFO - [mozharness: 2016-08-09 08:52:37.146855Z] Running create-virtualenv step. 01:52:37 INFO - Running pre-action listener: _resource_record_pre_action 01:52:37 INFO - Running main action method: create_virtualenv 01:52:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:52:37 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 01:52:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:52:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:52:37 INFO - Using real prefix '/usr' 01:52:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:52:37 INFO - Installing distribute.............................................................................................................................................................................................done. 01:52:39 INFO - Installing pip.................done. 01:52:39 INFO - Return code: 0 01:52:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:52:39 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')]} 01:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 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')]} 01:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:39 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 01:52:39 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 01:52:39 INFO - Using env: {'DISPLAY': ':0', 01:52:39 INFO - 'HOME': '/home/cltbld', 01:52:39 INFO - 'LANG': 'en_US.UTF-8', 01:52:39 INFO - 'LANGUAGE': 'en_US:en', 01:52:39 INFO - 'LOGNAME': 'cltbld', 01:52:39 INFO - 'MAIL': '/var/mail/cltbld', 01:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:39 INFO - 'MOZ_NO_REMOTE': '1', 01:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:39 INFO - 'NO_EM_RESTART': '1', 01:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:39 INFO - 'PWD': '/builds/slave/test', 01:52:39 INFO - 'SHELL': '/bin/bash', 01:52:39 INFO - 'SHLVL': '1', 01:52:39 INFO - 'TERM': 'linux', 01:52:39 INFO - 'TMOUT': '86400', 01:52:39 INFO - 'USER': 'cltbld', 01:52:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:39 INFO - '_': '/tools/buildbot/bin/python'} 01:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:39 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 01:52:39 INFO - Cleaning up... 01:52:39 INFO - Return code: 0 01:52:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:52:39 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')]} 01:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 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')]} 01:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:39 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 01:52:39 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 01:52:39 INFO - Using env: {'DISPLAY': ':0', 01:52:39 INFO - 'HOME': '/home/cltbld', 01:52:39 INFO - 'LANG': 'en_US.UTF-8', 01:52:39 INFO - 'LANGUAGE': 'en_US:en', 01:52:39 INFO - 'LOGNAME': 'cltbld', 01:52:39 INFO - 'MAIL': '/var/mail/cltbld', 01:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:39 INFO - 'MOZ_NO_REMOTE': '1', 01:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:39 INFO - 'NO_EM_RESTART': '1', 01:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:39 INFO - 'PWD': '/builds/slave/test', 01:52:39 INFO - 'SHELL': '/bin/bash', 01:52:39 INFO - 'SHLVL': '1', 01:52:39 INFO - 'TERM': 'linux', 01:52:39 INFO - 'TMOUT': '86400', 01:52:39 INFO - 'USER': 'cltbld', 01:52:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:39 INFO - '_': '/tools/buildbot/bin/python'} 01:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:40 INFO - Downloading/unpacking psutil>=3.1.1 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:42 INFO - Installing collected packages: psutil 01:52:42 INFO - Running setup.py install for psutil 01:52:42 INFO - building 'psutil._psutil_linux' extension 01:52:42 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 01:52:42 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 01:52:42 INFO - building 'psutil._psutil_posix' extension 01:52:42 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 01:52:42 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 01:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:42 INFO - Successfully installed psutil 01:52:42 INFO - Cleaning up... 01:52:42 INFO - Return code: 0 01:52:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:52:42 INFO - Using env: {'DISPLAY': ':0', 01:52:42 INFO - 'HOME': '/home/cltbld', 01:52:42 INFO - 'LANG': 'en_US.UTF-8', 01:52:42 INFO - 'LANGUAGE': 'en_US:en', 01:52:42 INFO - 'LOGNAME': 'cltbld', 01:52:42 INFO - 'MAIL': '/var/mail/cltbld', 01:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:42 INFO - 'MOZ_NO_REMOTE': '1', 01:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:42 INFO - 'NO_EM_RESTART': '1', 01:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:42 INFO - 'PWD': '/builds/slave/test', 01:52:42 INFO - 'SHELL': '/bin/bash', 01:52:42 INFO - 'SHLVL': '1', 01:52:42 INFO - 'TERM': 'linux', 01:52:42 INFO - 'TMOUT': '86400', 01:52:42 INFO - 'USER': 'cltbld', 01:52:42 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:42 INFO - '_': '/tools/buildbot/bin/python'} 01:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:52:44 INFO - Installing collected packages: mozsystemmonitor 01:52:44 INFO - Running setup.py install for mozsystemmonitor 01:52:44 INFO - Successfully installed mozsystemmonitor 01:52:44 INFO - Cleaning up... 01:52:45 INFO - Return code: 0 01:52:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:52:45 INFO - Using env: {'DISPLAY': ':0', 01:52:45 INFO - 'HOME': '/home/cltbld', 01:52:45 INFO - 'LANG': 'en_US.UTF-8', 01:52:45 INFO - 'LANGUAGE': 'en_US:en', 01:52:45 INFO - 'LOGNAME': 'cltbld', 01:52:45 INFO - 'MAIL': '/var/mail/cltbld', 01:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:45 INFO - 'MOZ_NO_REMOTE': '1', 01:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:45 INFO - 'NO_EM_RESTART': '1', 01:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:45 INFO - 'PWD': '/builds/slave/test', 01:52:45 INFO - 'SHELL': '/bin/bash', 01:52:45 INFO - 'SHLVL': '1', 01:52:45 INFO - 'TERM': 'linux', 01:52:45 INFO - 'TMOUT': '86400', 01:52:45 INFO - 'USER': 'cltbld', 01:52:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:45 INFO - '_': '/tools/buildbot/bin/python'} 01:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:45 INFO - Downloading/unpacking jsonschema==2.5.1 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:47 INFO - warning: no files found matching '*.txt' 01:52:47 INFO - no previously-included directories found matching 'build' 01:52:47 INFO - no previously-included directories found matching 'dist' 01:52:47 INFO - no previously-included directories found matching '.git*' 01:52:47 INFO - Installing collected packages: jsonschema, functools32 01:52:47 INFO - Running setup.py install for functools32 01:52:47 INFO - warning: no files found matching '*.txt' 01:52:47 INFO - no previously-included directories found matching 'build' 01:52:47 INFO - no previously-included directories found matching 'dist' 01:52:47 INFO - no previously-included directories found matching '.git*' 01:52:47 INFO - Successfully installed jsonschema functools32 01:52:47 INFO - Cleaning up... 01:52:47 INFO - Return code: 0 01:52:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:52:47 INFO - Using env: {'DISPLAY': ':0', 01:52:47 INFO - 'HOME': '/home/cltbld', 01:52:47 INFO - 'LANG': 'en_US.UTF-8', 01:52:47 INFO - 'LANGUAGE': 'en_US:en', 01:52:47 INFO - 'LOGNAME': 'cltbld', 01:52:47 INFO - 'MAIL': '/var/mail/cltbld', 01:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:47 INFO - 'MOZ_NO_REMOTE': '1', 01:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:47 INFO - 'NO_EM_RESTART': '1', 01:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:47 INFO - 'PWD': '/builds/slave/test', 01:52:47 INFO - 'SHELL': '/bin/bash', 01:52:47 INFO - 'SHLVL': '1', 01:52:47 INFO - 'TERM': 'linux', 01:52:47 INFO - 'TMOUT': '86400', 01:52:47 INFO - 'USER': 'cltbld', 01:52:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:47 INFO - '_': '/tools/buildbot/bin/python'} 01:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:52:47 INFO - Cleaning up... 01:52:47 INFO - Return code: 0 01:52:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:52:47 INFO - Using env: {'DISPLAY': ':0', 01:52:47 INFO - 'HOME': '/home/cltbld', 01:52:47 INFO - 'LANG': 'en_US.UTF-8', 01:52:47 INFO - 'LANGUAGE': 'en_US:en', 01:52:47 INFO - 'LOGNAME': 'cltbld', 01:52:47 INFO - 'MAIL': '/var/mail/cltbld', 01:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:47 INFO - 'MOZ_NO_REMOTE': '1', 01:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:47 INFO - 'NO_EM_RESTART': '1', 01:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:47 INFO - 'PWD': '/builds/slave/test', 01:52:47 INFO - 'SHELL': '/bin/bash', 01:52:47 INFO - 'SHLVL': '1', 01:52:47 INFO - 'TERM': 'linux', 01:52:47 INFO - 'TMOUT': '86400', 01:52:47 INFO - 'USER': 'cltbld', 01:52:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:47 INFO - '_': '/tools/buildbot/bin/python'} 01:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:47 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52:49 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 01:52:49 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 01:52:49 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 01:52:49 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 01:52:49 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 01:52:49 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 01:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:52:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52:50 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 01:52:50 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 01:52:50 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 01:52:50 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 01:52:50 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 01:52:50 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 01:52:50 INFO - Downloading docopt-0.6.1.tar.gz 01:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:50 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:50 INFO - Running setup.py install for blobuploader 01:52:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:52:50 INFO - Running setup.py install for requests 01:52:51 INFO - Running setup.py install for docopt 01:52:51 INFO - Successfully installed blobuploader requests docopt 01:52:51 INFO - Cleaning up... 01:52:51 INFO - Return code: 0 01:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:51 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:51 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 01:52:51 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 01:52:51 INFO - Using env: {'DISPLAY': ':0', 01:52:51 INFO - 'HOME': '/home/cltbld', 01:52:51 INFO - 'LANG': 'en_US.UTF-8', 01:52:51 INFO - 'LANGUAGE': 'en_US:en', 01:52:51 INFO - 'LOGNAME': 'cltbld', 01:52:51 INFO - 'MAIL': '/var/mail/cltbld', 01:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:51 INFO - 'MOZ_NO_REMOTE': '1', 01:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:51 INFO - 'NO_EM_RESTART': '1', 01:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:51 INFO - 'PWD': '/builds/slave/test', 01:52:51 INFO - 'SHELL': '/bin/bash', 01:52:51 INFO - 'SHLVL': '1', 01:52:51 INFO - 'TERM': 'linux', 01:52:51 INFO - 'TMOUT': '86400', 01:52:51 INFO - 'USER': 'cltbld', 01:52:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:51 INFO - '_': '/tools/buildbot/bin/python'} 01:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:51 INFO - Running setup.py (path:/tmp/pip-B8lERt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:51 INFO - Running setup.py (path:/tmp/pip-dyNVZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:51 INFO - Running setup.py (path:/tmp/pip-cbNlqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:51 INFO - Running setup.py (path:/tmp/pip-L6YZEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:51 INFO - Running setup.py (path:/tmp/pip-tCJa2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:51 INFO - Running setup.py (path:/tmp/pip-cc70WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:51 INFO - Running setup.py (path:/tmp/pip-AM91cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:51 INFO - Running setup.py (path:/tmp/pip-xpVMIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:52 INFO - Running setup.py (path:/tmp/pip-jFjhNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:52 INFO - Running setup.py (path:/tmp/pip-f76vD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:52 INFO - Running setup.py (path:/tmp/pip-hODHne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:52 INFO - Running setup.py (path:/tmp/pip-hLaqnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:52 INFO - Running setup.py (path:/tmp/pip-ksf6qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:52 INFO - Running setup.py (path:/tmp/pip-Ko5BpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:52 INFO - Running setup.py (path:/tmp/pip-KMhPsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:52 INFO - Running setup.py (path:/tmp/pip-KIGD8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:52 INFO - Running setup.py (path:/tmp/pip-8OKRmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:52 INFO - Running setup.py install for manifestparser 01:52:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:52:52 INFO - Running setup.py install for mozcrash 01:52:52 INFO - Running setup.py install for mozdebug 01:52:52 INFO - Running setup.py install for mozdevice 01:52:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for mozfile 01:52:53 INFO - Running setup.py install for mozhttpd 01:52:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for mozinfo 01:52:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for mozInstall 01:52:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for mozleak 01:52:53 INFO - Running setup.py install for mozlog 01:52:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for moznetwork 01:52:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:52:53 INFO - Running setup.py install for mozprocess 01:52:53 INFO - Running setup.py install for mozprofile 01:52:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:52:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:52:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:52:54 INFO - Running setup.py install for mozrunner 01:52:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:52:54 INFO - Running setup.py install for mozscreenshot 01:52:54 INFO - Running setup.py install for moztest 01:52:54 INFO - Running setup.py install for mozversion 01:52:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:52:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:54 INFO - Cleaning up... 01:52:54 INFO - Return code: 0 01:52:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52:54 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')]} 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:54 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')]} 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:54 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:54 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 01:52:54 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 01:52:54 INFO - Using env: {'DISPLAY': ':0', 01:52:54 INFO - 'HOME': '/home/cltbld', 01:52:54 INFO - 'LANG': 'en_US.UTF-8', 01:52:54 INFO - 'LANGUAGE': 'en_US:en', 01:52:54 INFO - 'LOGNAME': 'cltbld', 01:52:54 INFO - 'MAIL': '/var/mail/cltbld', 01:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:54 INFO - 'MOZ_NO_REMOTE': '1', 01:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:54 INFO - 'NO_EM_RESTART': '1', 01:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:54 INFO - 'PWD': '/builds/slave/test', 01:52:54 INFO - 'SHELL': '/bin/bash', 01:52:54 INFO - 'SHLVL': '1', 01:52:54 INFO - 'TERM': 'linux', 01:52:54 INFO - 'TMOUT': '86400', 01:52:54 INFO - 'USER': 'cltbld', 01:52:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:54 INFO - '_': '/tools/buildbot/bin/python'} 01:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:52:54 INFO - Running setup.py (path:/tmp/pip-Odn0eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:52:54 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)) 01:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:52:54 INFO - Running setup.py (path:/tmp/pip-nTrOFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:52:54 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)) 01:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:52:54 INFO - Running setup.py (path:/tmp/pip-hadZgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:52:54 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)) 01:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:52:54 INFO - Running setup.py (path:/tmp/pip-0DrZtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:52:55 INFO - Running setup.py (path:/tmp/pip-7B92bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:52:55 INFO - Running setup.py (path:/tmp/pip-BMD8Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:52:55 INFO - Running setup.py (path:/tmp/pip-8BISl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:52:55 INFO - Running setup.py (path:/tmp/pip-gr1Zgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:52:55 INFO - Running setup.py (path:/tmp/pip-_q0zxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:52:55 INFO - Running setup.py (path:/tmp/pip-iP1BAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:52:55 INFO - Running setup.py (path:/tmp/pip-N_s8FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:52:55 INFO - Running setup.py (path:/tmp/pip-8Tx1hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:52:55 INFO - Running setup.py (path:/tmp/pip-vYAXdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:52:55 INFO - Running setup.py (path:/tmp/pip-yHrMXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:55 INFO - Running setup.py (path:/tmp/pip-5UADKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:52:55 INFO - Running setup.py (path:/tmp/pip-gLa7lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:52:55 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)) 01:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:52:55 INFO - Running setup.py (path:/tmp/pip-hFEmKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:52:55 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)) 01:52:55 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)) 01:52:55 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)) 01:52:55 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)) 01:52:55 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)) 01:52:55 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)) 01:52:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:55 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 01:52:55 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 01:52:55 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 01:52:55 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 01:52:55 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 01:52:55 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 01:52:57 INFO - Downloading blessings-1.6.tar.gz 01:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:57 INFO - Installing collected packages: blessings 01:52:57 INFO - Running setup.py install for blessings 01:52:58 INFO - Successfully installed blessings 01:52:58 INFO - Cleaning up... 01:52:58 INFO - Return code: 0 01:52:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:58 INFO - Reading from file tmpfile_stdout 01:52:58 INFO - Current package versions: 01:52:58 INFO - argparse == 1.2.1 01:52:58 INFO - blessings == 1.6 01:52:58 INFO - blobuploader == 1.2.4 01:52:58 INFO - docopt == 0.6.1 01:52:58 INFO - functools32 == 3.2.3-2 01:52:58 INFO - jsonschema == 2.5.1 01:52:58 INFO - manifestparser == 1.1 01:52:58 INFO - mozInstall == 1.12 01:52:58 INFO - mozcrash == 0.17 01:52:58 INFO - mozdebug == 0.1 01:52:58 INFO - mozdevice == 0.48 01:52:58 INFO - mozfile == 1.2 01:52:58 INFO - mozhttpd == 0.7 01:52:58 INFO - mozinfo == 0.9 01:52:58 INFO - mozleak == 0.1 01:52:58 INFO - mozlog == 3.3 01:52:58 INFO - moznetwork == 0.27 01:52:58 INFO - mozprocess == 0.23 01:52:58 INFO - mozprofile == 0.28 01:52:58 INFO - mozrunner == 6.12 01:52:58 INFO - mozscreenshot == 0.1 01:52:58 INFO - mozsystemmonitor == 0.3 01:52:58 INFO - moztest == 0.7 01:52:58 INFO - mozversion == 1.4 01:52:58 INFO - psutil == 3.1.1 01:52:58 INFO - requests == 1.2.3 01:52:58 INFO - wsgiref == 0.1.2 01:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:58 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 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52:58 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 01:52:58 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 01:52:58 INFO - Using env: {'DISPLAY': ':0', 01:52:58 INFO - 'HOME': '/home/cltbld', 01:52:58 INFO - 'LANG': 'en_US.UTF-8', 01:52:58 INFO - 'LANGUAGE': 'en_US:en', 01:52:58 INFO - 'LOGNAME': 'cltbld', 01:52:58 INFO - 'MAIL': '/var/mail/cltbld', 01:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:58 INFO - 'MOZ_NO_REMOTE': '1', 01:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:58 INFO - 'NO_EM_RESTART': '1', 01:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:58 INFO - 'PWD': '/builds/slave/test', 01:52:58 INFO - 'SHELL': '/bin/bash', 01:52:58 INFO - 'SHLVL': '1', 01:52:58 INFO - 'TERM': 'linux', 01:52:58 INFO - 'TMOUT': '86400', 01:52:58 INFO - 'USER': 'cltbld', 01:52:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:58 INFO - '_': '/tools/buildbot/bin/python'} 01:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 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)) 01:52:58 INFO - Cleaning up... 01:52:58 INFO - Return code: 0 01:52:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:52: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')]} 01:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', '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 01:52: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'] in /builds/slave/test/build 01:52: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 01:52:58 INFO - Using env: {'DISPLAY': ':0', 01:52:58 INFO - 'HOME': '/home/cltbld', 01:52:58 INFO - 'LANG': 'en_US.UTF-8', 01:52:58 INFO - 'LANGUAGE': 'en_US:en', 01:52:58 INFO - 'LOGNAME': 'cltbld', 01:52:58 INFO - 'MAIL': '/var/mail/cltbld', 01:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:58 INFO - 'MOZ_NO_REMOTE': '1', 01:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:58 INFO - 'NO_EM_RESTART': '1', 01:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:52:58 INFO - 'PWD': '/builds/slave/test', 01:52:58 INFO - 'SHELL': '/bin/bash', 01:52:58 INFO - 'SHLVL': '1', 01:52:58 INFO - 'TERM': 'linux', 01:52:58 INFO - 'TMOUT': '86400', 01:52:58 INFO - 'USER': 'cltbld', 01:52:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:58 INFO - '_': '/tools/buildbot/bin/python'} 01:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:52:58 INFO - Cleaning up... 01:52:58 INFO - Return code: 0 01:52:58 INFO - Running post-action listener: _resource_record_post_action 01:52:58 INFO - Running post-action listener: _start_resource_monitoring 01:52:58 INFO - Starting resource monitoring. 01:52:58 INFO - [mozharness: 2016-08-09 08:52:58.780532Z] Finished create-virtualenv step (success) 01:52:58 INFO - [mozharness: 2016-08-09 08:52:58.781015Z] Running install step. 01:52:58 INFO - Running pre-action listener: _resource_record_pre_action 01:52:58 INFO - Running main action method: install 01:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:52:58 INFO - Reading from file tmpfile_stdout 01:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:52:59 INFO - Reading from file tmpfile_stdout 01:52:59 INFO - Output received: 01:52:59 INFO - Usage: mozinstall [options] installer 01:52:59 INFO - Options: 01:52:59 INFO - -h, --help show this help message and exit 01:52:59 INFO - -d DEST, --destination=DEST 01:52:59 INFO - Directory to install application into. [default: 01:52:59 INFO - "/builds/slave/test"] 01:52:59 INFO - --app=APP Application being installed. [default: firefox] 01:52:59 INFO - mkdir: /builds/slave/test/build/application 01:52:59 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'] 01:52:59 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 01:53:15 INFO - Reading from file tmpfile_stdout 01:53:15 INFO - Output received: 01:53:15 INFO - /builds/slave/test/build/application/firefox/firefox 01:53:15 INFO - Running post-action listener: _resource_record_post_action 01:53:15 INFO - [mozharness: 2016-08-09 08:53:15.291860Z] Finished install step (success) 01:53:15 INFO - [mozharness: 2016-08-09 08:53:15.292110Z] Running run-tests step. 01:53:15 INFO - Running pre-action listener: _resource_record_pre_action 01:53:15 INFO - Running main action method: run_tests 01:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:53:15 INFO - Python 2.7.3 01:53:15 INFO - Return code: 0 01:53:15 INFO - grabbing minidump binary from tooltool 01:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:53:15 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 0x29b73b0>, '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 0x29b82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:53:15 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 01:53:15 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 01:53:15 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 01:53:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:53:15 INFO - Return code: 0 01:53:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:53:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:53:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:53:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:53:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 01:53:15 INFO - Using env: {'DISPLAY': ':0', 01:53:15 INFO - 'HOME': '/home/cltbld', 01:53:15 INFO - 'LANG': 'en_US.UTF-8', 01:53:15 INFO - 'LANGUAGE': 'en_US:en', 01:53:15 INFO - 'LOGNAME': 'cltbld', 01:53:15 INFO - 'MAIL': '/var/mail/cltbld', 01:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:15 INFO - 'MOZ_NO_REMOTE': '1', 01:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:15 INFO - 'NO_EM_RESTART': '1', 01:53:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:53:15 INFO - 'PWD': '/builds/slave/test', 01:53:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:53:15 INFO - 'SHELL': '/bin/bash', 01:53:15 INFO - 'SHLVL': '1', 01:53:15 INFO - 'TERM': 'linux', 01:53:15 INFO - 'TMOUT': '86400', 01:53:15 INFO - 'USER': 'cltbld', 01:53:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599', 01:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:15 INFO - '_': '/tools/buildbot/bin/python'} 01:53:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:53:15 INFO - mozversion application_buildid: 20160809000920 01:53:15 INFO - mozversion application_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 01:53:15 INFO - mozversion application_display_name: Nightly 01:53:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:53:15 INFO - mozversion application_name: Firefox 01:53:15 INFO - mozversion application_remotingname: firefox 01:53:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:53:15 INFO - mozversion application_vendor: Mozilla 01:53:15 INFO - mozversion application_version: 51.0a1 01:53:15 INFO - mozversion platform_buildid: 20160809000920 01:53:15 INFO - mozversion platform_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 01:53:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:53:15 INFO - mozversion platform_version: 51.0a1 01:53:15 INFO - using testdate: 1470732795 01:53:15 INFO - actual date: 1470732795 01:53:15 INFO - starting webserver on 'localhost:41631' 01:53:15 INFO - SUITE-START | Running 2 tests 01:53:15 INFO - TEST-START | dromaeo_css 01:53:15 INFO - operating with platform_type : linux_ 01:53:15 INFO - Initialising browser for dromaeo_css test... 01:53:15 INFO - TEST-INFO | started process 1135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3WFcY/profile http://localhost:41631/getInfo.html) 01:53:19 INFO - PROCESS | 1135 | __metrics Screen width/height:1600/1200 01:53:19 INFO - PROCESS | 1135 | colorDepth:24 01:53:19 INFO - PROCESS | 1135 | Browser inner width/height: 1024/697 01:53:19 INFO - PROCESS | 1135 | __metrics 01:53:20 INFO - PROCESS | 1135 | 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" 01:53:20 INFO - PROCESS | 1135 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:53:21 INFO - TEST-INFO | 1135: exit 0 01:53:21 INFO - Browser initialized. 01:53:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:53:21 INFO - TEST-INFO | started process 1287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3WFcY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:33 INFO - PROCESS | 1287 | RSS: Main: 157712384 01:53:33 INFO - PROCESS | 1287 | 01:54:25 INFO - PROCESS | 1287 | 1470732865261 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] 01:56:37 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41631/tests/dromaeo/cssquery-ext.html) 01:56:38 INFO - PROCESS | 1287 | RSS: Main: 235794432 01:56:38 INFO - PROCESS | 1287 | 01:59:41 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-ext.html (next: http://localhost:41631/tests/dromaeo/cssquery-jquery.html) 01:59:41 INFO - PROCESS | 1287 | RSS: Main: 236961792 01:59:41 INFO - PROCESS | 1287 | 02:02:43 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41631/tests/dromaeo/cssquery-mootools.html) 02:02:44 INFO - PROCESS | 1287 | RSS: Main: 182218752 02:02:44 INFO - PROCESS | 1287 | 02:05:46 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41631/tests/dromaeo/cssquery-prototype.html) 02:05:47 INFO - PROCESS | 1287 | RSS: Main: 212795392 02:05:47 INFO - PROCESS | 1287 | 02:08:50 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41631/tests/dromaeo/cssquery-yui.html) 02:08:50 INFO - PROCESS | 1287 | RSS: Main: 185303040 02:08:50 INFO - PROCESS | 1287 | 02:11:53 INFO - PROCESS | 1287 | Cycle 1(1): loaded http://localhost:41631/tests/dromaeo/cssquery-yui.html (next: http://localhost:41631/tests/dromaeo/cssquery-dojo.html) 02:11:54 INFO - PROCESS | 1287 | RSS: Main: 279023616 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | __start_tp_report 02:11:54 INFO - PROCESS | 1287 | _x_x_mozilla_page_load 02:11:54 INFO - PROCESS | 1287 | _x_x_mozilla_page_load_details 02:11:54 INFO - PROCESS | 1287 | |i|pagename|runs| 02:11:54 INFO - PROCESS | 1287 | |0;dojo.html;2622.265765585636;2627.264365977527;2652.3634327761333;2664.6269522266884;2683.0743393529237;4579.816807327711;4659.440867095953;4729.2433210686295;4788.688735232207;4799.400074990626;4632.722036677802;4706.011737535113;4716.221823399143;4789.760511974396;4803.447603525596;4269.231538323101;4324.675649326297;4342.32693932441;4395.186890425265;4416.690831641787;4327.091310824715;4364.607185353318;4394.648428125758;4404.163208990281;4405.118976204756;4227.556106608823;4279.978600107011;4401.691881568291;4408.823647054114;4476.529964353745;4303.677224208165;4315.611594956469;4362.956370436286;4366.934495982563;4433.179861725559;4276.2516559601945;4279.079997800488;4288.0351920817875;4338.783060846945;4371.23503386906;4702.059588082363;4773.307870358779;4821.879453013667;4822.614190864722;4829.3480380148585;4822.951770482286;4888.657793954425;4963.627727920384;5097.184450487941;5122.590192784568;5118.641695081308;5134.974325128351;5189.974050129726;5194.3766747990485;5199.168133098724;4793.832215872428;4831.178699621073;4837.00841327527;4843.95156048435;4852.272159176081;4955.231939049453;5004.049230646166;5150.97424512875;5204.817831375959;5208.114620514521;5015.774290156952;5016.398032236155;5024.32171656829;5034.647574669738;5078.97460512695;5109.054824857413;5126.820561280338;5149;5167.302414174038;5171.2501687255135;4787.808487660524;4916.164252077156;5008.724520151354;5015.398152221756;5045.445001049881;4991.675541089818;4992.700437973734;5002.57478114357;5005.349304590452;5039.5968322534845;4351.82592696295;4353.825846966086;4367.847125350661;4383.1452866691325;4384.167008268419;3677.043968568138;3683.4843121962945;3727.813609319523;3730.7015438764834;3777.546694396635;4315.8273669053515;4367.694261401735;4388.868333949987;4405.515393306734;4408.911821763547;5091.87270318245;5099.36257967754;5101.668391554537;5107.923381149286;5150.124478838607;4219.704620676584;4349.173657005159;4361.80371883266;4365.80353884076;4404.273294906368;4521.9547804521535;4574.702644328108;4579.885502862455;4591.816327346869;4645.326427667969;4734.1005209011555;4757.833475828329;4762.666613337033;4767.118083154627;4808.783604737865;4860.125177467949;5069.746512674278;5084.669496482865;5099.23511473282;5134.024535338273;4719.032598317268;4793.472718001087;4794.856154315376;4800.615950724004;4853.417589889236;5025.095482813129;5035.84892453227;5036.748162591929;5041.470645582161;5095.464976177448;4856.320115183807;5108.770105345343;5126.666766660155;5128.153854613947;5129.79480820763;4879.170541008109;4931.9753401232765;4948.1835497142565;4965.4041515018425;4990.725510096834;4965.776540055778;4966.304717339648;4966.701997880139;4970.378702662168;5016.598672106295;4650.395448591661;4892.633052521146;4904.435989861212;4939.703617782944;4944.184209605519;4867.70793752376;4912.042151780369;4921.655484116078;4954.157793175097;4991.675541089818;4821.710697358169;4827.517248275144;4841.8547443576745;4866.586340161126;4873.95126048735 02:11:54 INFO - PROCESS | 1287 | |1;ext.html;550.0099820323417;553.1644541680798;559.8040685759987;591.5977135547827;596.221930380853;28348.433031339388;31217.375652486935;31800;31874.840625796838;31905.202369940762;40627.59372406275;41025.7948710256;41055;41067.794661026724;41098.58901410985;7679.347255483277;7824.5696486693205;7832.56920869352;7834.490758100734;7834.999999999972;7688.1927397623285;7755.6509957051785;7767;7771.222877712212;7775.261350171724;7734;7796.220377962187;7801.180876008023;7804.492707973992;7846.097698764658;7752.302292793647;7781.494202876795;7793.025871766029;7795.961020194863;7796.4932279401655;7706.19084996073;7769.922300777033;7793.29860312569;7796.181400952875;7798.2201779822135;30833.691663083308;31080.844595777104;31100.066997990096;31114.377712445625;31130.221744456343;3125.4061728271554;3539.3983022885914;3542.0613537412605;3558.3772839753196;3638.2359704462096;29449.41101177986;29800.701992980008;29907.401851963055;31184.844075779703;31188.844055779802;3386.2211691311136;3418.5214070030215;3475.131217195701;3485.3029394121277;3624.963750362489;254534;255153;255168;255362;255616.43835616476;31077.844610777254;31959.840200798848;32061.839690801397;51042.48957510452;51731;32827.835860820545;32834.671653283636;32904.34191316208;32931.3413731724;32946.67053329484;12126.151169418232;12150.878491214975;12174;12178.512859485698;12180.634580962585;10674.839877401846;10812.67561973142;10835.78328433427;10846.403447810288;10850.782984340269;7675.385969122457;7739.264769846855;7789;7799.142094369615;7826.804329891685;2958.955615665767;2981.806182598124;3032.757379409642;3033.8319746897164;3034.9393012139635;653.5686446944993;703.9859202815915;708.6279703155884;762.2606072110044;787.775483987061;26937.86531067332;27116.728832711422;27666.446671066467;28074.438511229662;28421.147365579065;935.3873213045466;941.4774799985937;947.9478628675352;969.5976169889558;977.6382738386842;14688.41246350134;14699.779503307458;14723.558293251219;15115.093094414371;15128.167950762814;416188;418379;419363;421183;422465;48842.755786221554;49460.50539494631;49505.50494495081;49526;49548;1057.1701214546545;1087.7063192937862;1154.694006088404;1163.5462169753803;1187.5665382135458;25306.620400693635;28714.282142945758;28916.132516024554;28937.855310724153;29533.114006579835;29741.256468588457;29917.70082299149;29970.25074373071;30023.399532009673;30049.248768780955;300959;300982;301902;302322;303665;22119.115235390404;23859;24549.754502454747;24855.50288994246;24872.626910595995;40512.59487405088;41141;41244.79377603213;41277;41676.58323416848;35344.82327588448;35574;35644;35940.82029589835;36208.27583448369;33010.83494582512;33194;33226;33308;33339.49990750189;34309.82845085759;34459.483107753906;34478.65521344754;34959.12602184965;35265.82367088148;29862.402751944406;32584.34831303408;32610.673893260762;32624.2056686875;32691.836540817145;24325.51348973046;24868.626970595094;25023.249302520955;25428.745712542637;25474.363140920883 02:11:54 INFO - PROCESS | 1287 | |2;jquery.html;345.68542626210154;354.7889006041405;358.5697163403916;366.8275910322151;373.5629313702967;16269.83730162698;16971.745423818636;17803.376881809123;17851.285948562043;17889;14970.850291497109;15534.456294029711;15624.531264062096;15705.21473926302;15717.056976581385;4909.705417674942;5145.845624631267;5168.638195326329;5169.922451163236;5172.379314482268;3738.831752571141;3924.489816323874;5081.6696914700615;5194.974025129869;5737.13942908565;5941.910871336933;6069.1806606108275;6074.453299203071;6075.787347442841;6079.240094988127;5738.8278351649515;5916.911246331309;5951.047832346847;5954.821355359346;6064.666443345614;5202.505761952609;5208.635395522277;5218.321618189611;5225.16397376418;5226.111561034633;21012.89493552538;21086.367408977756;21547;21590.24434144813;21635.026423810967;1875.8780679255806;1896.1629766480849;1910.9522261943423;1912.2159914435015;1943.3004118517322;12847.935760321232;13529.661758456019;13907.721845563032;14084.85915140856;14289.857101428957;1709.529879283207;1754.3771960953804;1772.6809174348612;1820.7359932809668;1820.8361247487658;70440.64779676069;71486.285137149;71594.64202679005;73317.26682733158;73780;9308.674196403093;9367.156955874005;9617.855732164024;9915.950420247853;9926.702198934043;13188.472461101448;13206.537771178155;13219.801702974462;13236;13236.470541178245;7298.96350518244;7441.962790186014;7531.472796904273;7536.623168841536;7596;7199.460040496983;7260.891086633599;7317.341439270491;7451.888221676679;7465;5978.641281523035;6065.75736970525;6097.237845269341;6099.939000610026;6247.156633854463;1556.5019193858084;1673.7405702116191;1707.39387517432;1716.6223430845193;1756.2184827751528;752.8230865746546;801.5631480842954;816.808050108224;873.5151990645126;910.9089091090838;17238.051907144978;17548.912255438896;17667.38164164248;18400.447986560157;18626.16182271801;831.3806214370333;843.2874221283006;851.0638297872291;867.4751775175928;882.2148288023664;10041.648542300984;10492;10522.894771052344;10545.918646054153;10561.366318020944;388150.177747334;389001;393956;395792;395955;43077;51345;74910;77198.2280177191;78923.60538197387;859.9312055035707;888.9244414224734;907.7912080221586;910.3036177324352;913.4793167894236;15192.924035379752;15402.15288159162;15856.60358491047;16337;16966.406175783788;33958.49062264118;34634.82682586571;34923.47614785729;38116.42825357677;38291.234175316895;52159.47840521698;52243.73878130585;52451.47548524466;52911.4708852922;53266.2010069857;6790.524663273523;7159.212486626363;7165.426765858614;7210.242924492853;7365.079365079365;9552.66565670226;11080.778384432428;11594.884051159717;12242.816357754818;12658.493660253855;9328.813423731352;9446.38598491096;9992.550335235077;10034.397936123856;10062.849057264293;10211.591536338463;10521.579136834442;10578.947105264424;10660.84008739854;11164.274322169033;9627.711168664951;10139.493025348851;10171.23715721309;10275.126614237874;10378.325408848401;6695.136110183668;6808.93191068083;6950.65246737651;7185.784426467214;7306.342429181399;9333.300002499704;10113.190944724258;10162.120007798581;10281.434521101412;10717.732056698333 02:11:54 INFO - PROCESS | 1287 | |3;mootools.html;1299.6750812296925;1371.2184055088596;1393.7909313602959;1601.3594562175135;1633.550773537277;7142.750003749863;7647.464677472579;7661.042369703787;7663.463557550974;7674;6375.266844312894;6541.574797638162;6576.835579110525;6733.562318449297;7479.700811967515;1853.0549419795934;2103.3584756649293;2153.257126291427;2178.477165480281;2191.4521369657587;2120.8409369297287;2148.076327179312;2163.1996161420298;2168.1327469012444;2171.1423987524995;2138.6791981202864;2143.9035243414082;2148.9785102149012;2149.4948687058527;2150.021740108255;2084.020510360136;2092.2677063027973;2140.1332460353583;2141.7215761951;2143.860649057822;2087.6659734442414;2088.1542975095113;2119.004068087996;2124.107874692633;2124.5538436928264;7697.884531732028;7744.612769361565;7746.264104910025;7747.690092396298;7760.767176984699;4265.680073994463;4366.366876802877;4385.276429389147;4400.6259467945265;4407.559244075599;2770.1551026936777;2815.42283831814;2885.1488810800656;2886.5525843494293;2892.898748543812;852.3181454836106;891.1801142948503;907.8275127725711;908.6325080753489;910.8041771019263;10320.94839525805;10361.222908281909;10369.637062702845;10380.896191038068;10406.947965260126;3686.746506187855;3957.881263562098;4074.5110586729784;4146.357314616239;4155.085881106152;9059.139381758723;9081.636734530677;9088.04575519574;9099.226565741854;9111.362204645611;4426.955730442654;4439.733615983051;4442.9777851111185;4443.200223959654;4446.5553444655925;3983.462232598562;3989.261986532501;3991.4611527444004;3994.520657521116;4011.659008984269;3037.665856755755;3487.128217945514;3606.5852426971232;3631.6368363164;3667.9266414671556;1121.43928035982;1122.93262404256;1124.050177599943;1130.7399298161304;1134.6993046842592;548.1585765849402;588.4938952500846;675.8850995330805;686.8935315026179;710.8649356622225;4862.9756851216225;4880.048390563806;4921.434035086011;4941.802327906916;5122.334096567497;810.7527204202775;821.856175169355;840.4537050916953;848.8259906719107;858.9742307730778;3248.382807266612;3263.7225835804225;3289.819059951678;3291.2923721399534;3299.257667024948;9159.175674189355;9362.110599493037;9400.435973841591;9418.29362797793;9446.480443575532;9366.578503967201;9379.624815007459;9387;9404.811903762024;9412.858807117898;6787.287334829871;6793.116894803644;7045.260247674023;7054.717811287491;7176.748813791597;5183.377994640517;5190.377154741304;5250.921236181537;5251.632385732962;5323.228131920927;8609.913900861162;8685.782855428664;8836;8929.241014513838;8930.86603700958;8923.70165415911;8948.73153805387;9028.90971090307;9038.638454461749;9093.090690930854;6328.683565821782;6358.809235722936;6441.323661015714;6445.355464453517;6448.871022579616;6117.84705382369;6547.214334279917;6748.865022699617;6786.287439818748;6787.321267873173;6295.370462953668;6422.614643121241;6504.252011018793;6511.38141876521;6519.08732777421;6401.743930242738;6429.6142231466265;6434.260060093149;6472.449841763503;6601.240857301472;5726.74229659658;5791.681457519877;5830.329512105993;5841.18223448726;5842.591018628656;4299.785010749512;4302.096559722493;4391.385206071089;4400.757958312323;4433.977830110829;4361.411209486679;4364.738115713068;4383.715058521186;4390.912181756411;4471.1057788443095 02:11:54 INFO - PROCESS | 1287 | |4;prototype.html;273.78644657167416;286.051738486916;287.4394929886721;287.6792376500202;295.7456587334892;4703.694259873106;4898.09385263726;4912.263160525923;4928.211486162215;4936.654434189603;4675.438947326317;4780;4783.258594917794;4789.640776941726;4799.320237916728;3829.253295607358;3831.6052467208065;3834.6357096075826;3845.288621604998;3874.9806250968845;3632.8193337165394;3655.4516822476576;3843.5579908310624;3857.3635350167187;3865.9806700966456;3755.117547376364;3783.754055986366;3810.7141964352645;3811.390177571589;3832.80835958201;3810.618938106195;3817.4846395736777;3821.197548514815;3826.6466123334226;3828.3683192273243;3341.5823022122236;3388.6611338866164;3409.710174635159;3410.6248312685584;3418.7094097001536;4626.86119416418;4716.316134160527;4727.64542659302;4735.147673418784;4801.863170888956;4340.153670034345;4341.176705783547;4346.500152482474;4363.6072753452345;4379.277419225824;5110.66780659256;5115.258287548285;5117.206832940863;5120.48795120485;5134.640575159703;3610.4403817408343;3641.7086633069557;3666.2484190740834;3730.5336832895887;3735.6077611850637;5261.316028916216;5270.815521456769;5292.867678308073;5336.279602253685;5368.463153684639;3791.8862434126468;3801.6768574671464;3803.258364618928;3808.409696497047;3813.523309586302;3847.249786291646;3859.1895701902354;3863.594322596087;3869.3615553433933;3873.9225215496094;4052.959470405317;4227.556106608762;4248.235317642854;4249;4251.744895306291;5060.696358218519;5063.417706963673;5074.416442109205;5083.415407228216;5085.415177254589;1201.819727040951;1223.5105957617025;1224.3633310678397;1269.631806776043;1291.0768800307637;809.2191035650626;819.7949014948017;824.9546274954935;860.5783166248493;864.85297499424;4416.514183439819;4450.310201918643;4469.150861336336;4495.662825288116;4536.8638940831825;5162.6386152968935;5189.520986518824;5224.686518808808;5236.973815130977;5253.369595648546;4306.80619372129;4454.329626390104;4509.571590698878;4535.138323718549;4541.409616749801;2779.6796521652054;2799.860006999642;2821.604975303459;2828.264651190705;2837.6311079559523;4780.760961951889;4976.651634385558;4995.100881841231;5015.749212539358;5024.145895197825;5356.7857285708915;5386.622936394415;5388.568914486832;5411.5129638331955;5437.510624043855;4954.950450495449;4962.007598480318;4991.6539226563455;5027;5027.84916452507;5081.8475445736685;5193.68837869729;5254.500822421864;5264;5346.732663366738;5109.514596113363;5141.897162056663;5147.974260128825;5149.459306772735;5165.302684137743;4858.785303674082;4962.727050012139;4972;4986.700797952134;4999.9750051240135;3426.126337783849;3677.632236776301;3717.20080182762;3727.7949712764976;3728.3102626014274;5169.147090729987;5174.534291913746;5188.429272780067;5199.584033277404;5235.947640523698;5063.544281014726;5067.138586440387;5124.385073791169;5131.589472842089;5148.9742551287;4874.2444921037295;5090.312807771052;5095.668781529337;5106.591472682102;5108.846734597968;4813.879653008703;4885.609151267819;4955.8265460710145;4997.700137991732;5043.87390315245;5114.9232761507865;5125.359330083739;5127.948720512747;5141.920196758722;5168.9483105169975;5005.149124648746;5019.924701129413;5030.4718004608985;5069.695818250917;5082.822101226439 02:11:54 INFO - PROCESS | 1287 | |5;yui.html;584.4798129664599;596.510861093903;610.4444955090868;657.3262406033812;673.3300366135694;12250.326232057234;13275.33623318835;13313.267770272643;13335.466581336736;13343.33283335833;12531;12586.748265034694;12587.559435419762;12601;12638.241705497654;610.0848726909636;728.6502478810174;733.7138515978772;749.61394881636;750.3846845586621;734.6179986407066;736.988945165823;737.1265050914657;737.439545945083;739.0244876762675;796.2992566541435;796.8525822722786;797.0515087046397;797.2784629909912;797.314309693663;639.2488825629889;658.4896705053574;667.869765395748;669.2838662630938;791.4183075439547;557.6849080269635;573.0315766354847;573.3807487913044;576.9249997500298;577.0248280406142;12351.629451116482;12377.071719621064;12387.504499819996;12409.193402428813;12424.37878106091;11545.422728863523;11864.406779660982;11896.464659090361;11923.463444145034;12640.862322391029;11763.35301558414;11838.348890811001;11850.051995840398;11856.466459009365;12040.638780836589;3226.91932701682;3297.093299342676;3456.913577160566;3463;4179.811908464127;60932.69533652392;61191.694041529954;61687.69156154236;62007.06989395163;62089;9867.506624668738;10147.173508768345;10148.594056237667;10278.948605256926;10439.425831579185;17094.316227350766;17193.140342982802;17341.132943352783;17356;17390.47828565145;6371.171747672865;6805.455563555002;6822.113125293779;6940.340667636567;7086;3762.4920635714375;3787.242551489713;3803.5625903020955;3804.334241507725;3815.904602384907;2850.717177270237;2966.1249931270327;2978.225661328027;2978.731914127739;2981.448432040036;488.333424875043;493.25272212597224;498.96756710814407;502.3168490852438;506.54664075652084;472.4967909176716;513.2967834067351;525.5138996428288;525.6740820691119;528.8862894477705;7100.893486597705;7203.459740519377;7524.097108347033;7581.772546823604;7686.615669216517;490.4090570862103;496.4960565026501;499.62528103922057;508.524529564858;512.3314075131914;3593.460980852893;3626.4741612466046;3629.510016147839;3680.576733675608;3710.35961794314;86970.1302986962;105451;108729;112518;112794;55027;63135.6843215781;91425.54287228521;93086;94118;77937;82208.58895705483;82453.58773206096;83765;84133.15866841376;6880.311968803079;7018.368346848808;7052.647367631495;7132.251113632994;7158.319959603829;46803.29795053145;48319;48340.03319933652;48557.93025871766;51500.48499515107;68093;72779;74516.62741686257;75568.62215688886;75823.24176758382;8734.912650873664;9657.082577155159;9808.80382392334;10763.515641796295;11158.888411115784;12412.131150819718;12581.182223155465;12591.118621696392;12808.359582021048;12891.290978996245;11149.665510034712;11160.720981975515;11219.887801122211;11713.41432928333;11745.765084698087;10232.488375581042;10537.683869483928;11316.660500185008;11835.349055802013;12205.816912746139;11673.941630291794;11722.765544688888;11813.527458901892;12185.817212741993;12201.267923924594;9029.548522573714;9133.360664753403;9317.813643727222;9468.268264283632;9591.664291749756;8368;9071.773205669648;9642.325037247325;9700.708978730649;9881.604735810488 02:11:54 INFO - PROCESS | 1287 | __end_tp_report 02:11:54 INFO - PROCESS | 1287 | __start_cc_report 02:11:54 INFO - PROCESS | 1287 | _x_x_mozilla_cycle_collect,1125 02:11:54 INFO - PROCESS | 1287 | __end_cc_report 02:11:54 INFO - PROCESS | 1287 | __startTimestamp1470733914032__endTimestamp 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | ------- Summary: start ------- 02:11:54 INFO - PROCESS | 1287 | Number of tests: 6 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#0] dojo.html Cycles:165 Average:4686.15 Median:4822.95 stddev:493.68 (10.2%) stddev-sans-first:467.89 02:11:54 INFO - PROCESS | 1287 | Values: 2622.3 2627.3 2652.4 2664.6 2683.1 4579.8 4659.4 4729.2 4788.7 4799.4 4632.7 4706.0 4716.2 4789.8 4803.4 4269.2 4324.7 4342.3 4395.2 4416.7 4327.1 4364.6 4394.6 4404.2 4405.1 4227.6 4280.0 4401.7 4408.8 4476.5 4303.7 4315.6 4363.0 4366.9 4433.2 4276.3 4279.1 4288.0 4338.8 4371.2 4702.1 4773.3 4821.9 4822.6 4829.3 4823.0 4888.7 4963.6 5097.2 5122.6 5118.6 5135.0 5190.0 5194.4 5199.2 4793.8 4831.2 4837.0 4844.0 4852.3 4955.2 5004.0 5151.0 5204.8 5208.1 5015.8 5016.4 5024.3 5034.6 5079.0 5109.1 5126.8 5149.0 5167.3 5171.3 4787.8 4916.2 5008.7 5015.4 5045.4 4991.7 4992.7 5002.6 5005.3 5039.6 4351.8 4353.8 4367.8 4383.1 4384.2 3677.0 3683.5 3727.8 3730.7 3777.5 4315.8 4367.7 4388.9 4405.5 4408.9 5091.9 5099.4 5101.7 5107.9 5150.1 4219.7 4349.2 4361.8 4365.8 4404.3 4522.0 4574.7 4579.9 4591.8 4645.3 4734.1 4757.8 4762.7 4767.1 4808.8 4860.1 5069.7 5084.7 5099.2 5134.0 4719.0 4793.5 4794.9 4800.6 4853.4 5025.1 5035.8 5036.7 5041.5 5095.5 4856.3 5108.8 5126.7 5128.2 5129.8 4879.2 4932.0 4948.2 4965.4 4990.7 4965.8 4966.3 4966.7 4970.4 5016.6 4650.4 4892.6 4904.4 4939.7 4944.2 4867.7 4912.0 4921.7 4954.2 4991.7 4821.7 4827.5 4841.9 4866.6 4874.0 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#1] ext.html Cycles:180 Average:45598.41 Median:33210.00 stddev:88123.06 (265.4%) stddev-sans-first:88305.36 02:11:54 INFO - PROCESS | 1287 | Values: 550.0 553.2 559.8 591.6 596.2 28348.4 31217.4 31800.0 31874.8 31905.2 40627.6 41025.8 41055.0 41067.8 41098.6 7679.3 7824.6 7832.6 7834.5 7835.0 7688.2 7755.7 7767.0 7771.2 7775.3 7734.0 7796.2 7801.2 7804.5 7846.1 7752.3 7781.5 7793.0 7796.0 7796.5 7706.2 7769.9 7793.3 7796.2 7798.2 30833.7 31080.8 31100.1 31114.4 31130.2 3125.4 3539.4 3542.1 3558.4 3638.2 29449.4 29800.7 29907.4 31184.8 31188.8 3386.2 3418.5 3475.1 3485.3 3625.0 254534.0 255153.0 255168.0 255362.0 255616.4 31077.8 31959.8 32061.8 51042.5 51731.0 32827.8 32834.7 32904.3 32931.3 32946.7 12126.2 12150.9 12174.0 12178.5 12180.6 10674.8 10812.7 10835.8 10846.4 10850.8 7675.4 7739.3 7789.0 7799.1 7826.8 2959.0 2981.8 3032.8 3033.8 3034.9 653.6 704.0 708.6 762.3 787.8 26937.9 27116.7 27666.4 28074.4 28421.1 935.4 941.5 947.9 969.6 977.6 14688.4 14699.8 14723.6 15115.1 15128.2 416188.0 418379.0 419363.0 421183.0 422465.0 48842.8 49460.5 49505.5 49526.0 49548.0 1057.2 1087.7 1154.7 1163.5 1187.6 25306.6 28714.3 28916.1 28937.9 29533.1 29741.3 29917.7 29970.3 30023.4 30049.2 300959.0 300982.0 301902.0 302322.0 303665.0 22119.1 23859.0 24549.8 24855.5 24872.6 40512.6 41141.0 41244.8 41277.0 41676.6 35344.8 35574.0 35644.0 35940.8 36208.3 33010.8 33194.0 33226.0 33308.0 33339.5 34309.8 34459.5 34478.7 34959.1 35265.8 29862.4 32584.3 32610.7 32624.2 32691.8 24325.5 24868.6 25023.2 25428.7 25474.4 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#2] jquery.html Cycles:180 Average:24331.46 Median:219516.00 stddev:64649.96 (29.5%) stddev-sans-first:64806.24 02:11:54 INFO - PROCESS | 1287 | Values: 345.7 354.8 358.6 366.8 373.6 16269.8 16971.7 17803.4 17851.3 17889.0 14970.9 15534.5 15624.5 15705.2 15717.1 4909.7 5145.8 5168.6 5169.9 5172.4 3738.8 3924.5 5081.7 5195.0 5737.1 5941.9 6069.2 6074.5 6075.8 6079.2 5738.8 5916.9 5951.0 5954.8 6064.7 5202.5 5208.6 5218.3 5225.2 5226.1 21012.9 21086.4 21547.0 21590.2 21635.0 1875.9 1896.2 1911.0 1912.2 1943.3 12847.9 13529.7 13907.7 14084.9 14289.9 1709.5 1754.4 1772.7 1820.7 1820.8 70440.6 71486.3 71594.6 73317.3 73780.0 9308.7 9367.2 9617.9 9916.0 9926.7 13188.5 13206.5 13219.8 13236.0 13236.5 7299.0 7442.0 7531.5 7536.6 7596.0 7199.5 7260.9 7317.3 7451.9 7465.0 5978.6 6065.8 6097.2 6099.9 6247.2 1556.5 1673.7 1707.4 1716.6 1756.2 752.8 801.6 816.8 873.5 910.9 17238.1 17548.9 17667.4 18400.4 18626.2 831.4 843.3 851.1 867.5 882.2 10041.6 10492.0 10522.9 10545.9 10561.4 388150.2 389001.0 393956.0 395792.0 395955.0 43077.0 51345.0 74910.0 77198.2 78923.6 859.9 888.9 907.8 910.3 913.5 15192.9 15402.2 15856.6 16337.0 16966.4 33958.5 34634.8 34923.5 38116.4 38291.2 52159.5 52243.7 52451.5 52911.5 53266.2 6790.5 7159.2 7165.4 7210.2 7365.1 9552.7 11080.8 11594.9 12242.8 12658.5 9328.8 9446.4 9992.6 10034.4 10062.8 10211.6 10521.6 10578.9 10660.8 11164.3 9627.7 10139.5 10171.2 10275.1 10378.3 6695.1 6808.9 6950.7 7185.8 7306.3 9333.3 10113.2 10162.1 10281.4 10717.7 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#3] mootools.html Cycles:180 Average:4935.93 Median:5186.88 stddev:2798.99 (54.0%) stddev-sans-first:2793.51 02:11:54 INFO - PROCESS | 1287 | Values: 1299.7 1371.2 1393.8 1601.4 1633.6 7142.8 7647.5 7661.0 7663.5 7674.0 6375.3 6541.6 6576.8 6733.6 7479.7 1853.1 2103.4 2153.3 2178.5 2191.5 2120.8 2148.1 2163.2 2168.1 2171.1 2138.7 2143.9 2149.0 2149.5 2150.0 2084.0 2092.3 2140.1 2141.7 2143.9 2087.7 2088.2 2119.0 2124.1 2124.6 7697.9 7744.6 7746.3 7747.7 7760.8 4265.7 4366.4 4385.3 4400.6 4407.6 2770.2 2815.4 2885.1 2886.6 2892.9 852.3 891.2 907.8 908.6 910.8 10320.9 10361.2 10369.6 10380.9 10406.9 3686.7 3957.9 4074.5 4146.4 4155.1 9059.1 9081.6 9088.0 9099.2 9111.4 4427.0 4439.7 4443.0 4443.2 4446.6 3983.5 3989.3 3991.5 3994.5 4011.7 3037.7 3487.1 3606.6 3631.6 3667.9 1121.4 1122.9 1124.1 1130.7 1134.7 548.2 588.5 675.9 686.9 710.9 4863.0 4880.0 4921.4 4941.8 5122.3 810.8 821.9 840.5 848.8 859.0 3248.4 3263.7 3289.8 3291.3 3299.3 9159.2 9362.1 9400.4 9418.3 9446.5 9366.6 9379.6 9387.0 9404.8 9412.9 6787.3 6793.1 7045.3 7054.7 7176.7 5183.4 5190.4 5250.9 5251.6 5323.2 8609.9 8685.8 8836.0 8929.2 8930.9 8923.7 8948.7 9028.9 9038.6 9093.1 6328.7 6358.8 6441.3 6445.4 6448.9 6117.8 6547.2 6748.9 6786.3 6787.3 6295.4 6422.6 6504.3 6511.4 6519.1 6401.7 6429.6 6434.3 6472.4 6601.2 5726.7 5791.7 5830.3 5841.2 5842.6 4299.8 4302.1 4391.4 4400.8 4434.0 4361.4 4364.7 4383.7 4390.9 4471.1 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#4] prototype.html Cycles:180 Average:4236.93 Median:4800.59 stddev:1232.34 (25.7%) stddev-sans-first:1199.36 02:11:54 INFO - PROCESS | 1287 | Values: 273.8 286.1 287.4 287.7 295.7 4703.7 4898.1 4912.3 4928.2 4936.7 4675.4 4780.0 4783.3 4789.6 4799.3 3829.3 3831.6 3834.6 3845.3 3875.0 3632.8 3655.5 3843.6 3857.4 3866.0 3755.1 3783.8 3810.7 3811.4 3832.8 3810.6 3817.5 3821.2 3826.6 3828.4 3341.6 3388.7 3409.7 3410.6 3418.7 4626.9 4716.3 4727.6 4735.1 4801.9 4340.2 4341.2 4346.5 4363.6 4379.3 5110.7 5115.3 5117.2 5120.5 5134.6 3610.4 3641.7 3666.2 3730.5 3735.6 5261.3 5270.8 5292.9 5336.3 5368.5 3791.9 3801.7 3803.3 3808.4 3813.5 3847.2 3859.2 3863.6 3869.4 3873.9 4053.0 4227.6 4248.2 4249.0 4251.7 5060.7 5063.4 5074.4 5083.4 5085.4 1201.8 1223.5 1224.4 1269.6 1291.1 809.2 819.8 825.0 860.6 864.9 4416.5 4450.3 4469.2 4495.7 4536.9 5162.6 5189.5 5224.7 5237.0 5253.4 4306.8 4454.3 4509.6 4535.1 4541.4 2779.7 2799.9 2821.6 2828.3 2837.6 4780.8 4976.7 4995.1 5015.7 5024.1 5356.8 5386.6 5388.6 5411.5 5437.5 4955.0 4962.0 4991.7 5027.0 5027.8 5081.8 5193.7 5254.5 5264.0 5346.7 5109.5 5141.9 5148.0 5149.5 5165.3 4858.8 4962.7 4972.0 4986.7 5000.0 3426.1 3677.6 3717.2 3727.8 3728.3 5169.1 5174.5 5188.4 5199.6 5235.9 5063.5 5067.1 5124.4 5131.6 5149.0 4874.2 5090.3 5095.7 5106.6 5108.8 4813.9 4885.6 4955.8 4997.7 5043.9 5114.9 5125.4 5127.9 5141.9 5168.9 5005.1 5019.9 5030.5 5069.7 5082.8 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - PROCESS | 1287 | [#5] yui.html Cycles:180 Average:18235.25 Median:500.97 stddev:27101.94 (5409.9%) stddev-sans-first:27145.57 02:11:54 INFO - PROCESS | 1287 | Values: 584.5 596.5 610.4 657.3 673.3 12250.3 13275.3 13313.3 13335.5 13343.3 12531.0 12586.7 12587.6 12601.0 12638.2 610.1 728.7 733.7 749.6 750.4 734.6 737.0 737.1 737.4 739.0 796.3 796.9 797.1 797.3 797.3 639.2 658.5 667.9 669.3 791.4 557.7 573.0 573.4 576.9 577.0 12351.6 12377.1 12387.5 12409.2 12424.4 11545.4 11864.4 11896.5 11923.5 12640.9 11763.4 11838.3 11850.1 11856.5 12040.6 3226.9 3297.1 3456.9 3463.0 4179.8 60932.7 61191.7 61687.7 62007.1 62089.0 9867.5 10147.2 10148.6 10278.9 10439.4 17094.3 17193.1 17341.1 17356.0 17390.5 6371.2 6805.5 6822.1 6940.3 7086.0 3762.5 3787.2 3803.6 3804.3 3815.9 2850.7 2966.1 2978.2 2978.7 2981.4 488.3 493.3 499.0 502.3 506.5 472.5 513.3 525.5 525.7 528.9 7100.9 7203.5 7524.1 7581.8 7686.6 490.4 496.5 499.6 508.5 512.3 3593.5 3626.5 3629.5 3680.6 3710.4 86970.1 105451.0 108729.0 112518.0 112794.0 55027.0 63135.7 91425.5 93086.0 94118.0 77937.0 82208.6 82453.6 83765.0 84133.2 6880.3 7018.4 7052.6 7132.3 7158.3 46803.3 48319.0 48340.0 48557.9 51500.5 68093.0 72779.0 74516.6 75568.6 75823.2 8734.9 9657.1 9808.8 10763.5 11158.9 12412.1 12581.2 12591.1 12808.4 12891.3 11149.7 11160.7 11219.9 11713.4 11745.8 10232.5 10537.7 11316.7 11835.3 12205.8 11673.9 11722.8 11813.5 12185.8 12201.3 9029.5 9133.4 9317.8 9468.3 9591.7 8368.0 9071.8 9642.3 9700.7 9881.6 02:11:54 INFO - PROCESS | 1287 | -------- Summary: end -------- 02:11:54 INFO - PROCESS | 1287 | 02:11:54 INFO - TEST-INFO | 1287: exit 0 02:11:54 INFO - TEST-OK | dromaeo_css | took 1119284ms 02:11:54 INFO - TEST-START | kraken 02:11:54 INFO - operating with platform_type : linux_ 02:11:54 INFO - Initialising browser for kraken test... 02:11:54 INFO - TEST-INFO | started process 1471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8dhfK/profile http://localhost:41631/getInfo.html) 02:11:59 INFO - PROCESS | 1471 | __metrics Screen width/height:1600/1200 02:11:59 INFO - PROCESS | 1471 | colorDepth:24 02:11:59 INFO - PROCESS | 1471 | Browser inner width/height: 1024/697 02:11:59 INFO - PROCESS | 1471 | __metrics 02:11:59 INFO - PROCESS | 1471 | 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" 02:11:59 INFO - PROCESS | 1471 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:00 INFO - TEST-INFO | 1471: exit 0 02:12:00 INFO - Browser initialized. 02:12:00 INFO - Running cycle 1/1 for kraken test... 02:12:00 INFO - TEST-INFO | started process 1552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8dhfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:12 INFO - PROCESS | 1552 | RSS: Main: 157782016 02:12:12 INFO - PROCESS | 1552 | 02:12:15 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41631/tests/kraken/driver.html?testName=audio-beat-detection) 02:12:16 INFO - PROCESS | 1552 | RSS: Main: 214204416 02:12:16 INFO - PROCESS | 1552 | 02:12:19 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41631/tests/kraken/driver.html?testName=audio-dft) 02:12:19 INFO - PROCESS | 1552 | RSS: Main: 192245760 02:12:19 INFO - PROCESS | 1552 | 02:12:23 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41631/tests/kraken/driver.html?testName=audio-fft) 02:12:23 INFO - PROCESS | 1552 | RSS: Main: 273301504 02:12:23 INFO - PROCESS | 1552 | 02:12:25 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41631/tests/kraken/driver.html?testName=audio-oscillator) 02:12:26 INFO - PROCESS | 1552 | RSS: Main: 181051392 02:12:26 INFO - PROCESS | 1552 | 02:12:28 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:12:29 INFO - PROCESS | 1552 | RSS: Main: 185352192 02:12:29 INFO - PROCESS | 1552 | 02:12:32 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41631/tests/kraken/driver.html?testName=imaging-darkroom) 02:12:33 INFO - PROCESS | 1552 | RSS: Main: 222056448 02:12:33 INFO - PROCESS | 1552 | 02:12:36 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41631/tests/kraken/driver.html?testName=imaging-desaturate) 02:12:37 INFO - PROCESS | 1552 | RSS: Main: 215339008 02:12:37 INFO - PROCESS | 1552 | 02:12:40 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41631/tests/kraken/driver.html?testName=json-parse-financial) 02:12:40 INFO - PROCESS | 1552 | RSS: Main: 218558464 02:12:40 INFO - PROCESS | 1552 | 02:12:42 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:12:43 INFO - PROCESS | 1552 | RSS: Main: 184238080 02:12:43 INFO - PROCESS | 1552 | 02:12:45 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:45 INFO - PROCESS | 1552 | RSS: Main: 190447616 02:12:45 INFO - PROCESS | 1552 | 02:12:47 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:48 INFO - PROCESS | 1552 | RSS: Main: 194588672 02:12:48 INFO - PROCESS | 1552 | 02:12:51 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:51 INFO - PROCESS | 1552 | RSS: Main: 189837312 02:12:51 INFO - PROCESS | 1552 | 02:12:54 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:55 INFO - PROCESS | 1552 | RSS: Main: 192352256 02:12:55 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | Cycle 1(1): loaded http://localhost:41631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41631/tests/kraken/driver.html?testName=ai-astar) 02:12:57 INFO - PROCESS | 1552 | RSS: Main: 243757056 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | __start_tp_report 02:12:57 INFO - PROCESS | 1552 | _x_x_mozilla_page_load 02:12:57 INFO - PROCESS | 1552 | _x_x_mozilla_page_load_details 02:12:57 INFO - PROCESS | 1552 | |i|pagename|runs| 02:12:57 INFO - PROCESS | 1552 | |0;ai-astar;104;114;114;115;113;114;113;115;113;113 02:12:57 INFO - PROCESS | 1552 | |1;audio-beat-detection;148;122;123;184;125;126;149;129;166;128 02:12:57 INFO - PROCESS | 1552 | |2;audio-dft;161;160;162;160;161;161;162;160;162;160 02:12:57 INFO - PROCESS | 1552 | |3;audio-fft;75;76;75;110;78;77;76;74;104;76 02:12:57 INFO - PROCESS | 1552 | |4;audio-oscillator;84;85;139;85;85;85;119;85;86;128 02:12:57 INFO - PROCESS | 1552 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;116 02:12:57 INFO - PROCESS | 1552 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;146;147 02:12:57 INFO - PROCESS | 1552 | |7;imaging-desaturate;95;94;95;96;95;95;95;95;95;95 02:12:57 INFO - PROCESS | 1552 | |8;json-parse-financial;64;62;63;63;63;65;64;63;63;63 02:12:57 INFO - PROCESS | 1552 | |9;json-stringify-tinderbox;64;65;65;64;65;64;65;66;65;65 02:12:57 INFO - PROCESS | 1552 | |10;stanford-crypto-aes;79;79;80;89;81;79;80;79;78;83 02:12:57 INFO - PROCESS | 1552 | |11;stanford-crypto-ccm;139;134;131;138;139;137;131;137;148;131 02:12:57 INFO - PROCESS | 1552 | |12;stanford-crypto-pbkdf2;169;164;165;165;173;169;169;169;164;163 02:12:57 INFO - PROCESS | 1552 | |13;stanford-crypto-sha256-iterative;67;67;69;73;67;71;67;66;82;68 02:12:57 INFO - PROCESS | 1552 | __end_tp_report 02:12:57 INFO - PROCESS | 1552 | __start_cc_report 02:12:57 INFO - PROCESS | 1552 | _x_x_mozilla_cycle_collect,1934 02:12:57 INFO - PROCESS | 1552 | __end_cc_report 02:12:57 INFO - PROCESS | 1552 | __startTimestamp1470733977438__endTimestamp 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | ------- Summary: start ------- 02:12:57 INFO - PROCESS | 1552 | Number of tests: 14 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 02:12:57 INFO - PROCESS | 1552 | Values: 104.0 114.0 114.0 115.0 113.0 114.0 113.0 115.0 113.0 113.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:138.50 stddev:21.23 (15.3%) stddev-sans-first:22.32 02:12:57 INFO - PROCESS | 1552 | Values: 148.0 122.0 123.0 184.0 125.0 126.0 149.0 129.0 166.0 128.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 02:12:57 INFO - PROCESS | 1552 | Values: 161.0 160.0 162.0 160.0 161.0 161.0 162.0 160.0 162.0 160.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.25 (17.4%) stddev-sans-first:13.80 02:12:57 INFO - PROCESS | 1552 | Values: 75.0 76.0 75.0 110.0 78.0 77.0 76.0 74.0 104.0 76.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:21.62 (25.4%) stddev-sans-first:22.32 02:12:57 INFO - PROCESS | 1552 | Values: 84.0 85.0 139.0 85.0 85.0 85.0 119.0 85.0 86.0 128.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:12:57 INFO - PROCESS | 1552 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:12:57 INFO - PROCESS | 1552 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:12:57 INFO - PROCESS | 1552 | Values: 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 02:12:57 INFO - PROCESS | 1552 | Values: 64.0 62.0 63.0 63.0 63.0 65.0 64.0 63.0 63.0 63.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:12:57 INFO - PROCESS | 1552 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.23 (4.0%) stddev-sans-first:3.37 02:12:57 INFO - PROCESS | 1552 | Values: 79.0 79.0 80.0 89.0 81.0 79.0 80.0 79.0 78.0 83.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:137.50 stddev:5.21 (3.8%) stddev-sans-first:5.45 02:12:57 INFO - PROCESS | 1552 | Values: 139.0 134.0 131.0 138.0 139.0 137.0 131.0 137.0 148.0 131.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:169.00 stddev:3.23 (1.9%) stddev-sans-first:3.35 02:12:57 INFO - PROCESS | 1552 | Values: 169.0 164.0 165.0 165.0 173.0 169.0 169.0 169.0 164.0 163.0 02:12:57 INFO - PROCESS | 1552 | 02:12:57 INFO - PROCESS | 1552 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:68.50 stddev:4.83 (7.1%) stddev-sans-first:5.02 02:12:57 INFO - PROCESS | 1552 | Values: 67.0 67.0 69.0 73.0 67.0 71.0 67.0 66.0 82.0 68.0 02:12:57 INFO - PROCESS | 1552 | -------- Summary: end -------- 02:12:57 INFO - PROCESS | 1552 | 02:12:58 INFO - TEST-INFO | 1552: exit 0 02:12:58 INFO - TEST-OK | kraken | took 63718ms 02:12:58 INFO - SUITE-END | took 1183s 02:12:58 INFO - Completed test suite (00:19:43) 02:12:58 INFO - javascript benchmark 02:12:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.265765585636, 2627.264365977527, 2652.3634327761333, 2664.6269522266884, 2683.0743393529237, 4579.816807327711, 4659.440867095953, 4729.2433210686295, 4788.688735232207, 4799.400074990626, 4632.722036677802, 4706.011737535113, 4716.221823399143, 4789.760511974396, 4803.447603525596, 4269.231538323101, 4324.675649326297, 4342.32693932441, 4395.186890425265, 4416.690831641787, 4327.091310824715, 4364.607185353318, 4394.648428125758, 4404.163208990281, 4405.118976204756, 4227.556106608823, 4279.978600107011, 4401.691881568291, 4408.823647054114, 4476.529964353745, 4303.677224208165, 4315.611594956469, 4362.956370436286, 4366.934495982563, 4433.179861725559, 4276.2516559601945, 4279.079997800488, 4288.0351920817875, 4338.783060846945, 4371.23503386906, 4702.059588082363, 4773.307870358779, 4821.879453013667, 4822.614190864722, 4829.3480380148585, 4822.951770482286, 4888.657793954425, 4963.627727920384, 5097.184450487941, 5122.590192784568, 5118.641695081308, 5134.974325128351, 5189.974050129726, 5194.3766747990485, 5199.168133098724, 4793.832215872428, 4831.178699621073, 4837.00841327527, 4843.95156048435, 4852.272159176081, 4955.231939049453, 5004.049230646166, 5150.97424512875, 5204.817831375959, 5208.114620514521, 5015.774290156952, 5016.398032236155, 5024.32171656829, 5034.647574669738, 5078.97460512695, 5109.054824857413, 5126.820561280338, 5149.0, 5167.302414174038, 5171.2501687255135, 4787.808487660524, 4916.164252077156, 5008.724520151354, 5015.398152221756, 5045.445001049881, 4991.675541089818, 4992.700437973734, 5002.57478114357, 5005.349304590452, 5039.5968322534845, 4351.82592696295, 4353.825846966086, 4367.847125350661, 4383.1452866691325, 4384.167008268419, 3677.043968568138, 3683.4843121962945, 3727.813609319523, 3730.7015438764834, 3777.546694396635, 4315.8273669053515, 4367.694261401735, 4388.868333949987, 4405.515393306734, 4408.911821763547, 5091.87270318245, 5099.36257967754, 5101.668391554537, 5107.923381149286, 5150.124478838607, 4219.704620676584, 4349.173657005159, 4361.80371883266, 4365.80353884076, 4404.273294906368, 4521.9547804521535, 4574.702644328108, 4579.885502862455, 4591.816327346869, 4645.326427667969, 4734.1005209011555, 4757.833475828329, 4762.666613337033, 4767.118083154627, 4808.783604737865, 4860.125177467949, 5069.746512674278, 5084.669496482865, 5099.23511473282, 5134.024535338273, 4719.032598317268, 4793.472718001087, 4794.856154315376, 4800.615950724004, 4853.417589889236, 5025.095482813129, 5035.84892453227, 5036.748162591929, 5041.470645582161, 5095.464976177448, 4856.320115183807, 5108.770105345343, 5126.666766660155, 5128.153854613947, 5129.79480820763, 4879.170541008109, 4931.9753401232765, 4948.1835497142565, 4965.4041515018425, 4990.725510096834, 4965.776540055778, 4966.304717339648, 4966.701997880139, 4970.378702662168, 5016.598672106295, 4650.395448591661, 4892.633052521146, 4904.435989861212, 4939.703617782944, 4944.184209605519, 4867.70793752376, 4912.042151780369, 4921.655484116078, 4954.157793175097, 4991.675541089818, 4821.710697358169, 4827.517248275144, 4841.8547443576745, 4866.586340161126, 4873.95126048735], "value": 4654.612919791845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.0099820323417, 553.1644541680798, 559.8040685759987, 591.5977135547827, 596.221930380853, 28348.433031339388, 31217.375652486935, 31800.0, 31874.840625796838, 31905.202369940762, 40627.59372406275, 41025.7948710256, 41055.0, 41067.794661026724, 41098.58901410985, 7679.347255483277, 7824.5696486693205, 7832.56920869352, 7834.490758100734, 7834.999999999972, 7688.1927397623285, 7755.6509957051785, 7767.0, 7771.222877712212, 7775.261350171724, 7734.0, 7796.220377962187, 7801.180876008023, 7804.492707973992, 7846.097698764658, 7752.302292793647, 7781.494202876795, 7793.025871766029, 7795.961020194863, 7796.4932279401655, 7706.19084996073, 7769.922300777033, 7793.29860312569, 7796.181400952875, 7798.2201779822135, 30833.691663083308, 31080.844595777104, 31100.066997990096, 31114.377712445625, 31130.221744456343, 3125.4061728271554, 3539.3983022885914, 3542.0613537412605, 3558.3772839753196, 3638.2359704462096, 29449.41101177986, 29800.701992980008, 29907.401851963055, 31184.844075779703, 31188.844055779802, 3386.2211691311136, 3418.5214070030215, 3475.131217195701, 3485.3029394121277, 3624.963750362489, 254534.0, 255153.0, 255168.0, 255362.0, 255616.43835616476, 31077.844610777254, 31959.840200798848, 32061.839690801397, 51042.48957510452, 51731.0, 32827.835860820545, 32834.671653283636, 32904.34191316208, 32931.3413731724, 32946.67053329484, 12126.151169418232, 12150.878491214975, 12174.0, 12178.512859485698, 12180.634580962585, 10674.839877401846, 10812.67561973142, 10835.78328433427, 10846.403447810288, 10850.782984340269, 7675.385969122457, 7739.264769846855, 7789.0, 7799.142094369615, 7826.804329891685, 2958.955615665767, 2981.806182598124, 3032.757379409642, 3033.8319746897164, 3034.9393012139635, 653.5686446944993, 703.9859202815915, 708.6279703155884, 762.2606072110044, 787.775483987061, 26937.86531067332, 27116.728832711422, 27666.446671066467, 28074.438511229662, 28421.147365579065, 935.3873213045466, 941.4774799985937, 947.9478628675352, 969.5976169889558, 977.6382738386842, 14688.41246350134, 14699.779503307458, 14723.558293251219, 15115.093094414371, 15128.167950762814, 416188.0, 418379.0, 419363.0, 421183.0, 422465.0, 48842.755786221554, 49460.50539494631, 49505.50494495081, 49526.0, 49548.0, 1057.1701214546545, 1087.7063192937862, 1154.694006088404, 1163.5462169753803, 1187.5665382135458, 25306.620400693635, 28714.282142945758, 28916.132516024554, 28937.855310724153, 29533.114006579835, 29741.256468588457, 29917.70082299149, 29970.25074373071, 30023.399532009673, 30049.248768780955, 300959.0, 300982.0, 301902.0, 302322.0, 303665.0, 22119.115235390404, 23859.0, 24549.754502454747, 24855.50288994246, 24872.626910595995, 40512.59487405088, 41141.0, 41244.79377603213, 41277.0, 41676.58323416848, 35344.82327588448, 35574.0, 35644.0, 35940.82029589835, 36208.27583448369, 33010.83494582512, 33194.0, 33226.0, 33308.0, 33339.49990750189, 34309.82845085759, 34459.483107753906, 34478.65521344754, 34959.12602184965, 35265.82367088148, 29862.402751944406, 32584.34831303408, 32610.673893260762, 32624.2056686875, 32691.836540817145, 24325.51348973046, 24868.626970595094, 25023.249302520955, 25428.745712542637, 25474.363140920883], "value": 15776.023097530207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.68542626210154, 354.7889006041405, 358.5697163403916, 366.8275910322151, 373.5629313702967, 16269.83730162698, 16971.745423818636, 17803.376881809123, 17851.285948562043, 17889.0, 14970.850291497109, 15534.456294029711, 15624.531264062096, 15705.21473926302, 15717.056976581385, 4909.705417674942, 5145.845624631267, 5168.638195326329, 5169.922451163236, 5172.379314482268, 3738.831752571141, 3924.489816323874, 5081.6696914700615, 5194.974025129869, 5737.13942908565, 5941.910871336933, 6069.1806606108275, 6074.453299203071, 6075.787347442841, 6079.240094988127, 5738.8278351649515, 5916.911246331309, 5951.047832346847, 5954.821355359346, 6064.666443345614, 5202.505761952609, 5208.635395522277, 5218.321618189611, 5225.16397376418, 5226.111561034633, 21012.89493552538, 21086.367408977756, 21547.0, 21590.24434144813, 21635.026423810967, 1875.8780679255806, 1896.1629766480849, 1910.9522261943423, 1912.2159914435015, 1943.3004118517322, 12847.935760321232, 13529.661758456019, 13907.721845563032, 14084.85915140856, 14289.857101428957, 1709.529879283207, 1754.3771960953804, 1772.6809174348612, 1820.7359932809668, 1820.8361247487658, 70440.64779676069, 71486.285137149, 71594.64202679005, 73317.26682733158, 73780.0, 9308.674196403093, 9367.156955874005, 9617.855732164024, 9915.950420247853, 9926.702198934043, 13188.472461101448, 13206.537771178155, 13219.801702974462, 13236.0, 13236.470541178245, 7298.96350518244, 7441.962790186014, 7531.472796904273, 7536.623168841536, 7596.0, 7199.460040496983, 7260.891086633599, 7317.341439270491, 7451.888221676679, 7465.0, 5978.641281523035, 6065.75736970525, 6097.237845269341, 6099.939000610026, 6247.156633854463, 1556.5019193858084, 1673.7405702116191, 1707.39387517432, 1716.6223430845193, 1756.2184827751528, 752.8230865746546, 801.5631480842954, 816.808050108224, 873.5151990645126, 910.9089091090838, 17238.051907144978, 17548.912255438896, 17667.38164164248, 18400.447986560157, 18626.16182271801, 831.3806214370333, 843.2874221283006, 851.0638297872291, 867.4751775175928, 882.2148288023664, 10041.648542300984, 10492.0, 10522.894771052344, 10545.918646054153, 10561.366318020944, 388150.177747334, 389001.0, 393956.0, 395792.0, 395955.0, 43077.0, 51345.0, 74910.0, 77198.2280177191, 78923.60538197387, 859.9312055035707, 888.9244414224734, 907.7912080221586, 910.3036177324352, 913.4793167894236, 15192.924035379752, 15402.15288159162, 15856.60358491047, 16337.0, 16966.406175783788, 33958.49062264118, 34634.82682586571, 34923.47614785729, 38116.42825357677, 38291.234175316895, 52159.47840521698, 52243.73878130585, 52451.47548524466, 52911.4708852922, 53266.2010069857, 6790.524663273523, 7159.212486626363, 7165.426765858614, 7210.242924492853, 7365.079365079365, 9552.66565670226, 11080.778384432428, 11594.884051159717, 12242.816357754818, 12658.493660253855, 9328.813423731352, 9446.38598491096, 9992.550335235077, 10034.397936123856, 10062.849057264293, 10211.591536338463, 10521.579136834442, 10578.947105264424, 10660.84008739854, 11164.274322169033, 9627.711168664951, 10139.493025348851, 10171.23715721309, 10275.126614237874, 10378.325408848401, 6695.136110183668, 6808.93191068083, 6950.65246737651, 7185.784426467214, 7306.342429181399, 9333.300002499704, 10113.190944724258, 10162.120007798581, 10281.434521101412, 10717.732056698333], "value": 8307.500052864394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.6750812296925, 1371.2184055088596, 1393.7909313602959, 1601.3594562175135, 1633.550773537277, 7142.750003749863, 7647.464677472579, 7661.042369703787, 7663.463557550974, 7674.0, 6375.266844312894, 6541.574797638162, 6576.835579110525, 6733.562318449297, 7479.700811967515, 1853.0549419795934, 2103.3584756649293, 2153.257126291427, 2178.477165480281, 2191.4521369657587, 2120.8409369297287, 2148.076327179312, 2163.1996161420298, 2168.1327469012444, 2171.1423987524995, 2138.6791981202864, 2143.9035243414082, 2148.9785102149012, 2149.4948687058527, 2150.021740108255, 2084.020510360136, 2092.2677063027973, 2140.1332460353583, 2141.7215761951, 2143.860649057822, 2087.6659734442414, 2088.1542975095113, 2119.004068087996, 2124.107874692633, 2124.5538436928264, 7697.884531732028, 7744.612769361565, 7746.264104910025, 7747.690092396298, 7760.767176984699, 4265.680073994463, 4366.366876802877, 4385.276429389147, 4400.6259467945265, 4407.559244075599, 2770.1551026936777, 2815.42283831814, 2885.1488810800656, 2886.5525843494293, 2892.898748543812, 852.3181454836106, 891.1801142948503, 907.8275127725711, 908.6325080753489, 910.8041771019263, 10320.94839525805, 10361.222908281909, 10369.637062702845, 10380.896191038068, 10406.947965260126, 3686.746506187855, 3957.881263562098, 4074.5110586729784, 4146.357314616239, 4155.085881106152, 9059.139381758723, 9081.636734530677, 9088.04575519574, 9099.226565741854, 9111.362204645611, 4426.955730442654, 4439.733615983051, 4442.9777851111185, 4443.200223959654, 4446.5553444655925, 3983.462232598562, 3989.261986532501, 3991.4611527444004, 3994.520657521116, 4011.659008984269, 3037.665856755755, 3487.128217945514, 3606.5852426971232, 3631.6368363164, 3667.9266414671556, 1121.43928035982, 1122.93262404256, 1124.050177599943, 1130.7399298161304, 1134.6993046842592, 548.1585765849402, 588.4938952500846, 675.8850995330805, 686.8935315026179, 710.8649356622225, 4862.9756851216225, 4880.048390563806, 4921.434035086011, 4941.802327906916, 5122.334096567497, 810.7527204202775, 821.856175169355, 840.4537050916953, 848.8259906719107, 858.9742307730778, 3248.382807266612, 3263.7225835804225, 3289.819059951678, 3291.2923721399534, 3299.257667024948, 9159.175674189355, 9362.110599493037, 9400.435973841591, 9418.29362797793, 9446.480443575532, 9366.578503967201, 9379.624815007459, 9387.0, 9404.811903762024, 9412.858807117898, 6787.287334829871, 6793.116894803644, 7045.260247674023, 7054.717811287491, 7176.748813791597, 5183.377994640517, 5190.377154741304, 5250.921236181537, 5251.632385732962, 5323.228131920927, 8609.913900861162, 8685.782855428664, 8836.0, 8929.241014513838, 8930.86603700958, 8923.70165415911, 8948.73153805387, 9028.90971090307, 9038.638454461749, 9093.090690930854, 6328.683565821782, 6358.809235722936, 6441.323661015714, 6445.355464453517, 6448.871022579616, 6117.84705382369, 6547.214334279917, 6748.865022699617, 6786.287439818748, 6787.321267873173, 6295.370462953668, 6422.614643121241, 6504.252011018793, 6511.38141876521, 6519.08732777421, 6401.743930242738, 6429.6142231466265, 6434.260060093149, 6472.449841763503, 6601.240857301472, 5726.74229659658, 5791.681457519877, 5830.329512105993, 5841.18223448726, 5842.591018628656, 4299.785010749512, 4302.096559722493, 4391.385206071089, 4400.757958312323, 4433.977830110829, 4361.411209486679, 4364.738115713068, 4383.715058521186, 4390.912181756411, 4471.1057788443095], "value": 3956.356956712614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.78644657167416, 286.051738486916, 287.4394929886721, 287.6792376500202, 295.7456587334892, 4703.694259873106, 4898.09385263726, 4912.263160525923, 4928.211486162215, 4936.654434189603, 4675.438947326317, 4780.0, 4783.258594917794, 4789.640776941726, 4799.320237916728, 3829.253295607358, 3831.6052467208065, 3834.6357096075826, 3845.288621604998, 3874.9806250968845, 3632.8193337165394, 3655.4516822476576, 3843.5579908310624, 3857.3635350167187, 3865.9806700966456, 3755.117547376364, 3783.754055986366, 3810.7141964352645, 3811.390177571589, 3832.80835958201, 3810.618938106195, 3817.4846395736777, 3821.197548514815, 3826.6466123334226, 3828.3683192273243, 3341.5823022122236, 3388.6611338866164, 3409.710174635159, 3410.6248312685584, 3418.7094097001536, 4626.86119416418, 4716.316134160527, 4727.64542659302, 4735.147673418784, 4801.863170888956, 4340.153670034345, 4341.176705783547, 4346.500152482474, 4363.6072753452345, 4379.277419225824, 5110.66780659256, 5115.258287548285, 5117.206832940863, 5120.48795120485, 5134.640575159703, 3610.4403817408343, 3641.7086633069557, 3666.2484190740834, 3730.5336832895887, 3735.6077611850637, 5261.316028916216, 5270.815521456769, 5292.867678308073, 5336.279602253685, 5368.463153684639, 3791.8862434126468, 3801.6768574671464, 3803.258364618928, 3808.409696497047, 3813.523309586302, 3847.249786291646, 3859.1895701902354, 3863.594322596087, 3869.3615553433933, 3873.9225215496094, 4052.959470405317, 4227.556106608762, 4248.235317642854, 4249.0, 4251.744895306291, 5060.696358218519, 5063.417706963673, 5074.416442109205, 5083.415407228216, 5085.415177254589, 1201.819727040951, 1223.5105957617025, 1224.3633310678397, 1269.631806776043, 1291.0768800307637, 809.2191035650626, 819.7949014948017, 824.9546274954935, 860.5783166248493, 864.85297499424, 4416.514183439819, 4450.310201918643, 4469.150861336336, 4495.662825288116, 4536.8638940831825, 5162.6386152968935, 5189.520986518824, 5224.686518808808, 5236.973815130977, 5253.369595648546, 4306.80619372129, 4454.329626390104, 4509.571590698878, 4535.138323718549, 4541.409616749801, 2779.6796521652054, 2799.860006999642, 2821.604975303459, 2828.264651190705, 2837.6311079559523, 4780.760961951889, 4976.651634385558, 4995.100881841231, 5015.749212539358, 5024.145895197825, 5356.7857285708915, 5386.622936394415, 5388.568914486832, 5411.5129638331955, 5437.510624043855, 4954.950450495449, 4962.007598480318, 4991.6539226563455, 5027.0, 5027.84916452507, 5081.8475445736685, 5193.68837869729, 5254.500822421864, 5264.0, 5346.732663366738, 5109.514596113363, 5141.897162056663, 5147.974260128825, 5149.459306772735, 5165.302684137743, 4858.785303674082, 4962.727050012139, 4972.0, 4986.700797952134, 4999.9750051240135, 3426.126337783849, 3677.632236776301, 3717.20080182762, 3727.7949712764976, 3728.3102626014274, 5169.147090729987, 5174.534291913746, 5188.429272780067, 5199.584033277404, 5235.947640523698, 5063.544281014726, 5067.138586440387, 5124.385073791169, 5131.589472842089, 5148.9742551287, 4874.2444921037295, 5090.312807771052, 5095.668781529337, 5106.591472682102, 5108.846734597968, 4813.879653008703, 4885.609151267819, 4955.8265460710145, 4997.700137991732, 5043.87390315245, 5114.9232761507865, 5125.359330083739, 5127.948720512747, 5141.920196758722, 5168.9483105169975, 5005.149124648746, 5019.924701129413, 5030.4718004608985, 5069.695818250917, 5082.822101226439], "value": 3835.562004917008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4798129664599, 596.510861093903, 610.4444955090868, 657.3262406033812, 673.3300366135694, 12250.326232057234, 13275.33623318835, 13313.267770272643, 13335.466581336736, 13343.33283335833, 12531.0, 12586.748265034694, 12587.559435419762, 12601.0, 12638.241705497654, 610.0848726909636, 728.6502478810174, 733.7138515978772, 749.61394881636, 750.3846845586621, 734.6179986407066, 736.988945165823, 737.1265050914657, 737.439545945083, 739.0244876762675, 796.2992566541435, 796.8525822722786, 797.0515087046397, 797.2784629909912, 797.314309693663, 639.2488825629889, 658.4896705053574, 667.869765395748, 669.2838662630938, 791.4183075439547, 557.6849080269635, 573.0315766354847, 573.3807487913044, 576.9249997500298, 577.0248280406142, 12351.629451116482, 12377.071719621064, 12387.504499819996, 12409.193402428813, 12424.37878106091, 11545.422728863523, 11864.406779660982, 11896.464659090361, 11923.463444145034, 12640.862322391029, 11763.35301558414, 11838.348890811001, 11850.051995840398, 11856.466459009365, 12040.638780836589, 3226.91932701682, 3297.093299342676, 3456.913577160566, 3463.0, 4179.811908464127, 60932.69533652392, 61191.694041529954, 61687.69156154236, 62007.06989395163, 62089.0, 9867.506624668738, 10147.173508768345, 10148.594056237667, 10278.948605256926, 10439.425831579185, 17094.316227350766, 17193.140342982802, 17341.132943352783, 17356.0, 17390.47828565145, 6371.171747672865, 6805.455563555002, 6822.113125293779, 6940.340667636567, 7086.0, 3762.4920635714375, 3787.242551489713, 3803.5625903020955, 3804.334241507725, 3815.904602384907, 2850.717177270237, 2966.1249931270327, 2978.225661328027, 2978.731914127739, 2981.448432040036, 488.333424875043, 493.25272212597224, 498.96756710814407, 502.3168490852438, 506.54664075652084, 472.4967909176716, 513.2967834067351, 525.5138996428288, 525.6740820691119, 528.8862894477705, 7100.893486597705, 7203.459740519377, 7524.097108347033, 7581.772546823604, 7686.615669216517, 490.4090570862103, 496.4960565026501, 499.62528103922057, 508.524529564858, 512.3314075131914, 3593.460980852893, 3626.4741612466046, 3629.510016147839, 3680.576733675608, 3710.35961794314, 86970.1302986962, 105451.0, 108729.0, 112518.0, 112794.0, 55027.0, 63135.6843215781, 91425.54287228521, 93086.0, 94118.0, 77937.0, 82208.58895705483, 82453.58773206096, 83765.0, 84133.15866841376, 6880.311968803079, 7018.368346848808, 7052.647367631495, 7132.251113632994, 7158.319959603829, 46803.29795053145, 48319.0, 48340.03319933652, 48557.93025871766, 51500.48499515107, 68093.0, 72779.0, 74516.62741686257, 75568.62215688886, 75823.24176758382, 8734.912650873664, 9657.082577155159, 9808.80382392334, 10763.515641796295, 11158.888411115784, 12412.131150819718, 12581.182223155465, 12591.118621696392, 12808.359582021048, 12891.290978996245, 11149.665510034712, 11160.720981975515, 11219.887801122211, 11713.41432928333, 11745.765084698087, 10232.488375581042, 10537.683869483928, 11316.660500185008, 11835.349055802013, 12205.816912746139, 11673.941630291794, 11722.765544688888, 11813.527458901892, 12185.817212741993, 12201.267923924594, 9029.548522573714, 9133.360664753403, 9317.813643727222, 9468.268264283632, 9591.664291749756, 8368.0, 9071.773205669648, 9642.325037247325, 9700.708978730649, 9881.604735810488], "value": 6368.90266327272, "unit": "score"}], "name": "dromaeo_css", "value": 6238.7539702642725, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 115.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 123.0, 184.0, 125.0, 126.0, 149.0, 129.0, 166.0, 128.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 161.0, 161.0, 162.0, 160.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 110.0, 78.0, 77.0, 76.0, 74.0, 104.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 139.0, 85.0, 85.0, 85.0, 119.0, 85.0, 86.0, 128.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 63.0, 65.0, 64.0, 63.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 89.0, 81.0, 79.0, 80.0, 79.0, 78.0, 83.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 131.0, 138.0, 139.0, 137.0, 131.0, 137.0, 148.0, 131.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 165.0, 165.0, 173.0, 169.0, 169.0, 169.0, 164.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 73.0, 67.0, 71.0, 67.0, 66.0, 82.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1534.4, "alertThreshold": 2.0}]} 02:12:58 INFO - Return code: 0 02:12:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:12:58 INFO - # TBPL SUCCESS # 02:12:58 INFO - Running post-action listener: _resource_record_post_action 02:12:58 INFO - [mozharness: 2016-08-09 09:12:58.716638Z] Finished run-tests step (success) 02:12:58 INFO - Running post-run listener: _resource_record_post_run 02:12:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 535588864; Read time: 0; Write time: 475672 02:12:58 INFO - TinderboxPrint: CPU usage
13.0% 02:12:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:12:58 INFO - TinderboxPrint: I/O write bytes / time
535,588,864 / 475,672 02:12:58 INFO - TinderboxPrint: CPU idle
8,327.8 (87.0%) 02:12:58 INFO - TinderboxPrint: CPU user
1,198.5 (12.5%) 02:12:58 INFO - TinderboxPrint: Swap in / out
0 / 0 02:12:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244744192; Read time: 0; Write time: 257496 02:12:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 287019008; Read time: 0; Write time: 217664 02:12:59 INFO - Running post-run listener: _upload_blobber_files 02:12:59 INFO - Blob upload gear active. 02:12:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:12:59 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 02:12:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:12:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:12:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:00 INFO - (blobuploader) - INFO - Done attempting. 02:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:01 INFO - (blobuploader) - INFO - Done attempting. 02:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:04 INFO - (blobuploader) - INFO - Done attempting. 02:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 02:13:05 INFO - Return code: 0 02:13:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:13:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:13:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0db09964938b4fde69da993e311b8993495292a2b35f84e3b5d829708c8f9e811b398026ef5be78b391e0eaedd7431e7f4dd4d2034ed709e5c676032d0febb82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f0f5b862e6854271e451aa9f9c81436dfb46f471fdf8323eb4ddb3909bfa3fa452db839c49a57b3e2ad2120a843ced077d2c03a9b054f16f2782fe477997dd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22553704fd311d3c485eb1c12079d34f5500467bf3d138d57f4cdd75285c1b2cb838e3b21f4890a7944a141504ae6b0dd16c1be7bd64afad4389b2e46c20db66"} 02:13:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:13:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:13:05 INFO - Contents: 02:13:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0db09964938b4fde69da993e311b8993495292a2b35f84e3b5d829708c8f9e811b398026ef5be78b391e0eaedd7431e7f4dd4d2034ed709e5c676032d0febb82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f0f5b862e6854271e451aa9f9c81436dfb46f471fdf8323eb4ddb3909bfa3fa452db839c49a57b3e2ad2120a843ced077d2c03a9b054f16f2782fe477997dd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22553704fd311d3c485eb1c12079d34f5500467bf3d138d57f4cdd75285c1b2cb838e3b21f4890a7944a141504ae6b0dd16c1be7bd64afad4389b2e46c20db66"} 02:13:05 INFO - Running post-run listener: copy_logs_to_upload_dir 02:13:05 INFO - Copying logs to upload dir... 02:13:05 INFO - mkdir: /builds/slave/test/build/upload/logs 02:13:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.546141 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-09 02:13:04.777889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 02:13:04.781672) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 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-Non-PGO/sha512/0db09964938b4fde69da993e311b8993495292a2b35f84e3b5d829708c8f9e811b398026ef5be78b391e0eaedd7431e7f4dd4d2034ed709e5c676032d0febb82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f0f5b862e6854271e451aa9f9c81436dfb46f471fdf8323eb4ddb3909bfa3fa452db839c49a57b3e2ad2120a843ced077d2c03a9b054f16f2782fe477997dd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22553704fd311d3c485eb1c12079d34f5500467bf3d138d57f4cdd75285c1b2cb838e3b21f4890a7944a141504ae6b0dd16c1be7bd64afad4389b2e46c20db66"} build_url:https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/aIFMLZXYTWy9i7V2LtNiJg/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-Non-PGO/sha512/0db09964938b4fde69da993e311b8993495292a2b35f84e3b5d829708c8f9e811b398026ef5be78b391e0eaedd7431e7f4dd4d2034ed709e5c676032d0febb82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f0f5b862e6854271e451aa9f9c81436dfb46f471fdf8323eb4ddb3909bfa3fa452db839c49a57b3e2ad2120a843ced077d2c03a9b054f16f2782fe477997dd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22553704fd311d3c485eb1c12079d34f5500467bf3d138d57f4cdd75285c1b2cb838e3b21f4890a7944a141504ae6b0dd16c1be7bd64afad4389b2e46c20db66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 02:13:04.806652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 02:13:04.806976) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470732521.565663-2033686599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 02:13:04.892122) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 02:13:04.892470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 02:13:04.892766) ========= ========= Total master_lag: 0.16 =========