builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1467143076.47 results: success (0) buildid: 20160628091623 builduid: bad89d10b3d449fbb95a01a45dc1f0ce revision: 101de7dd28aa446f0c23cc701647d6399ed7490b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:36.471721) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:36.477880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:36.478200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:36.505171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:36.506002) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-28 12:44:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 165M=0s 2016-06-28 12:44:36 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.465299 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:37.024363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:37.024753) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027663 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:37.074479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:37.074834) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 101de7dd28aa446f0c23cc701647d6399ed7490b --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 101de7dd28aa446f0c23cc701647d6399ed7490b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-28 12:44:37,146 truncating revision to first 12 chars 2016-06-28 12:44:37,146 Setting DEBUG logging. 2016-06-28 12:44:37,146 attempt 1/10 2016-06-28 12:44:37,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/101de7dd28aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 12:44:37,787 unpacking tar archive at: fx-team-101de7dd28aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913529 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:38.015075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:38.016066) ========= script_repo_revision: 101de7dd28aa446f0c23cc701647d6399ed7490b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:38.017023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:38.017671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 12:44:38.036383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2016-06-28 12:44:38.037121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:44:38 INFO - MultiFileLogger online at 20160628 12:44:38 in /builds/slave/test 12:44:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:44:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:38 INFO - {'append_to_log': False, 12:44:38 INFO - 'base_work_dir': '/builds/slave/test', 12:44:38 INFO - 'blob_upload_branch': 'Fx-Team', 12:44:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:38 INFO - 'branch': 'Fx-Team', 12:44:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:38 INFO - 'config_files': ('talos/mac_config.py',), 12:44:38 INFO - 'default_actions': ('clobber', 12:44:38 INFO - 'read-buildbot-config', 12:44:38 INFO - 'download-and-extract', 12:44:38 INFO - 'populate-webroot', 12:44:38 INFO - 'create-virtualenv', 12:44:38 INFO - 'install', 12:44:38 INFO - 'run-tests'), 12:44:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:38 INFO - 'download_minidump_stackwalk': True, 12:44:38 INFO - 'download_symbols': 'ondemand', 12:44:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:38 INFO - 'installer_path': 'installer.exe', 12:44:38 INFO - 'log_level': 'info', 12:44:38 INFO - 'log_name': 'talos', 12:44:38 INFO - 'log_to_console': True, 12:44:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:44:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:44:38 INFO - 'opt_config_files': (), 12:44:38 INFO - 'pip_index': False, 12:44:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:38 INFO - 'cmd': ('bash', 12:44:38 INFO - '-c', 12:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:38 INFO - 'enabled': True, 12:44:38 INFO - 'halt_on_failure': False, 12:44:38 INFO - 'name': 'check_screen_resolution'},), 12:44:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:38 INFO - 'cmd': ('bash', 12:44:38 INFO - '-c', 12:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:38 INFO - 'enabled': True, 12:44:38 INFO - 'halt_on_failure': False, 12:44:38 INFO - 'name': 'check_screen_resolution'},), 12:44:38 INFO - 'run_cmd_checks_enabled': True, 12:44:38 INFO - 'sps_profile': False, 12:44:38 INFO - 'sps_profile_interval': 0, 12:44:38 INFO - 'suite': 'dromaeojs-e10s', 12:44:38 INFO - 'system_bits': '32', 12:44:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:38 INFO - 'title': 't-yosemite-r7-0029', 12:44:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:38 INFO - 'use_talos_json': True, 12:44:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:38 INFO - 'work_dir': 'build'} 12:44:38 INFO - ##### 12:44:38 INFO - ##### Running clobber step. 12:44:38 INFO - ##### 12:44:38 INFO - Running pre-action listener: _resource_record_pre_action 12:44:38 INFO - Running main action method: clobber 12:44:38 INFO - rmtree: /builds/slave/test/build 12:44:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:44:40 INFO - Running post-action listener: _resource_record_post_action 12:44:40 INFO - ##### 12:44:40 INFO - ##### Finished clobber step (success) 12:44:40 INFO - ##### 12:44:40 INFO - ##### 12:44:40 INFO - ##### Running read-buildbot-config step. 12:44:40 INFO - ##### 12:44:40 INFO - Running pre-action listener: _resource_record_pre_action 12:44:40 INFO - Running main action method: read_buildbot_config 12:44:40 INFO - Using buildbot properties: 12:44:40 INFO - { 12:44:40 INFO - "project": "", 12:44:40 INFO - "product": "firefox", 12:44:40 INFO - "script_repo_revision": "production", 12:44:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:44:40 INFO - "repository": "", 12:44:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:44:40 INFO - "buildid": "20160628091623", 12:44:40 INFO - "pgo_build": "False", 12:44:40 INFO - "basedir": "/builds/slave/test", 12:44:40 INFO - "buildnumber": 3, 12:44:40 INFO - "slavename": "t-yosemite-r7-0029", 12:44:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 12:44:40 INFO - "platform": "yosemite_r7", 12:44:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:44:40 INFO - "branch": "fx-team", 12:44:40 INFO - "repo_path": "integration/fx-team", 12:44:40 INFO - "revision": "101de7dd28aa446f0c23cc701647d6399ed7490b", 12:44:40 INFO - "stage_platform": "macosx64", 12:44:40 INFO - "builduid": "bad89d10b3d449fbb95a01a45dc1f0ce", 12:44:40 INFO - "slavebuilddir": "test" 12:44:40 INFO - } 12:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 12:44:40 INFO - Running post-action listener: _resource_record_post_action 12:44:40 INFO - ##### 12:44:40 INFO - ##### Finished read-buildbot-config step (success) 12:44:40 INFO - ##### 12:44:40 INFO - ##### 12:44:40 INFO - ##### Running download-and-extract step. 12:44:40 INFO - ##### 12:44:40 INFO - Running pre-action listener: _resource_record_pre_action 12:44:40 INFO - Running main action method: download_and_extract 12:44:40 INFO - mkdir: /builds/slave/test/build/tests 12:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:40 INFO - https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 12:44:42 INFO - Downloaded 1199 bytes. 12:44:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:44:42 INFO - Using the following test package requirements: 12:44:42 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:44:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 12:44:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 12:44:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'jsshell-mac.zip'], 12:44:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 12:44:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:44:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 12:44:42 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 12:44:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 12:44:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:44:42 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 12:44:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:42 INFO - https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:46:26 INFO - Downloaded 18786896 bytes. 12:46:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:46:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:46:29 INFO - Return code: 0 12:46:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:46: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:29 INFO - https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:46:31 INFO - Downloaded 18786896 bytes. 12:46:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:46:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:46:34 INFO - Return code: 0 12:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:34 INFO - https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:46:37 INFO - Downloaded 14405245 bytes. 12:46:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:46:38 INFO - Return code: 0 12:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:38 INFO - https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 12:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 12:46:56 INFO - Downloaded 112374252 bytes. 12:46:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:46:56 INFO - mkdir: /builds/slave/test/properties 12:46:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:46:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:46:56 INFO - Contents: 12:46:56 INFO - build_url:https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:46:57 INFO - Running post-action listener: _resource_record_post_action 12:46:57 INFO - Running post-action listener: set_extra_try_arguments 12:46:57 INFO - ##### 12:46:57 INFO - ##### Finished download-and-extract step (success) 12:46:57 INFO - ##### 12:46:57 INFO - ##### 12:46:57 INFO - ##### Running populate-webroot step. 12:46:57 INFO - ##### 12:46:57 INFO - Running pre-action listener: _resource_record_pre_action 12:46:57 INFO - Running main action method: populate_webroot 12:46:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:46:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:46:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:46:58 INFO - '--tppagecycles', 12:46:58 INFO - '7'], 12:46:58 INFO - 'tests': ['tsvgm']}}, 12:46:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:46:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:46:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:46:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:46:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['damp', 'tps']}, 12:46:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'tests': ['damp', 'tps']}, 12:46:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['dromaeo_dom']}, 12:46:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:46:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['basic_compositor_video']}, 12:46:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:46:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'other-e10s': {'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['a11yr', 12:46:58 INFO - 'ts_paint', 12:46:58 INFO - 'tpaint', 12:46:58 INFO - 'sessionrestore', 12:46:58 INFO - 'sessionrestore_no_auto_restore', 12:46:58 INFO - 'tabpaint']}, 12:46:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['tsvgx', 12:46:58 INFO - 'tsvgr_opacity', 12:46:58 INFO - 'tart', 12:46:58 INFO - 'tscrollx', 12:46:58 INFO - 'cart']}, 12:46:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:46:58 INFO - 'tsvgr_opacity', 12:46:58 INFO - 'tart', 12:46:58 INFO - 'tscrollx', 12:46:58 INFO - 'cart']}, 12:46:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'talos_options': ['--disable-e10s'], 12:46:58 INFO - 'tests': ['tp5o']}, 12:46:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'tests': ['tp5o']}, 12:46:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'talos_options': ['--disable-e10s', 12:46:58 INFO - '--xperf_path', 12:46:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:58 INFO - 'tests': ['tp5n']}, 12:46:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:58 INFO - 'talos_options': ['--xperf_path', 12:46:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:58 INFO - 'tests': ['tp5n']}}, 12:46:58 INFO - 'talos.zip': {'path': '', 12:46:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:46:58 INFO - Running post-action listener: _resource_record_post_action 12:46:58 INFO - ##### 12:46:58 INFO - ##### Finished populate-webroot step (success) 12:46:58 INFO - ##### 12:46:58 INFO - ##### 12:46:58 INFO - ##### Running create-virtualenv step. 12:46:58 INFO - ##### 12:46:58 INFO - Running pre-action listener: _resource_record_pre_action 12:46:58 INFO - Running main action method: create_virtualenv 12:46:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:46:58 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 12:46:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:46:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:46:58 INFO - Using real prefix '/tools/python27' 12:46:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:46:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:01 INFO - Installing pip.................done. 12:47:01 INFO - Return code: 0 12:47:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:47:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:01 INFO - 'HOME': '/Users/cltbld', 12:47:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:01 INFO - 'LOGNAME': 'cltbld', 12:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:01 INFO - 'MOZ_NO_REMOTE': '1', 12:47:01 INFO - 'NO_EM_RESTART': '1', 12:47:01 INFO - 'PAGER': '/bin/cat', 12:47:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:01 INFO - 'PWD': '/builds/slave/test', 12:47:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:01 INFO - 'SHELL': '/bin/bash', 12:47:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:01 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:01 INFO - 'USER': 'cltbld', 12:47:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:01 INFO - 'XPC_FLAGS': '0x0', 12:47:01 INFO - 'XPC_SERVICE_NAME': '0', 12:47:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:02 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 12:47:02 INFO - Cleaning up... 12:47:02 INFO - Return code: 0 12:47:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:02 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:02 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 12:47:02 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 12:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:02 INFO - 'HOME': '/Users/cltbld', 12:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:02 INFO - 'LOGNAME': 'cltbld', 12:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:02 INFO - 'MOZ_NO_REMOTE': '1', 12:47:02 INFO - 'NO_EM_RESTART': '1', 12:47:02 INFO - 'PAGER': '/bin/cat', 12:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:02 INFO - 'PWD': '/builds/slave/test', 12:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:02 INFO - 'SHELL': '/bin/bash', 12:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:02 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:02 INFO - 'USER': 'cltbld', 12:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:02 INFO - 'XPC_FLAGS': '0x0', 12:47:02 INFO - 'XPC_SERVICE_NAME': '0', 12:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:02 INFO - Downloading/unpacking psutil>=3.1.1 12:47:02 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 12:47:02 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 12:47:02 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 12:47:02 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 12:47:02 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 12:47:02 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 12:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:05 INFO - Installing collected packages: psutil 12:47:05 INFO - Running setup.py install for psutil 12:47:06 INFO - building 'psutil._psutil_osx' extension 12:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:47:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:47:06 INFO - building 'psutil._psutil_posix' extension 12:47:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:47:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:47:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:47:06 INFO - ^ 12:47:06 INFO - 1 warning generated. 12:47:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:07 INFO - Successfully installed psutil 12:47:07 INFO - Cleaning up... 12:47:07 INFO - Return code: 0 12:47:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:07 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:07 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 12:47:07 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 12:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:07 INFO - 'HOME': '/Users/cltbld', 12:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:07 INFO - 'LOGNAME': 'cltbld', 12:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:07 INFO - 'MOZ_NO_REMOTE': '1', 12:47:07 INFO - 'NO_EM_RESTART': '1', 12:47:07 INFO - 'PAGER': '/bin/cat', 12:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:07 INFO - 'PWD': '/builds/slave/test', 12:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:07 INFO - 'SHELL': '/bin/bash', 12:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:07 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:07 INFO - 'USER': 'cltbld', 12:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:07 INFO - 'XPC_FLAGS': '0x0', 12:47:07 INFO - 'XPC_SERVICE_NAME': '0', 12:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:47:07 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 12:47:07 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 12:47:07 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 12:47:07 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 12:47:07 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 12:47:07 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 12:47:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:47:09 INFO - Installing collected packages: mozsystemmonitor 12:47:09 INFO - Running setup.py install for mozsystemmonitor 12:47:10 INFO - Successfully installed mozsystemmonitor 12:47:10 INFO - Cleaning up... 12:47:10 INFO - Return code: 0 12:47:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:10 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:10 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 12:47:10 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 12:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:10 INFO - 'HOME': '/Users/cltbld', 12:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:10 INFO - 'LOGNAME': 'cltbld', 12:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:10 INFO - 'MOZ_NO_REMOTE': '1', 12:47:10 INFO - 'NO_EM_RESTART': '1', 12:47:10 INFO - 'PAGER': '/bin/cat', 12:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:10 INFO - 'PWD': '/builds/slave/test', 12:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:10 INFO - 'SHELL': '/bin/bash', 12:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:10 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:10 INFO - 'USER': 'cltbld', 12:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:10 INFO - 'XPC_FLAGS': '0x0', 12:47:10 INFO - 'XPC_SERVICE_NAME': '0', 12:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:10 INFO - Downloading/unpacking jsonschema==2.5.1 12:47:10 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 12:47:10 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 12:47:10 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 12:47:10 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 12:47:10 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 12:47:10 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 12:47:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:13 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:13 INFO - warning: no files found matching '*.txt' 12:47:13 INFO - no previously-included directories found matching 'build' 12:47:13 INFO - no previously-included directories found matching 'dist' 12:47:13 INFO - no previously-included directories found matching '.git*' 12:47:13 INFO - Installing collected packages: jsonschema, functools32 12:47:13 INFO - Running setup.py install for functools32 12:47:13 INFO - warning: no files found matching '*.txt' 12:47:13 INFO - no previously-included directories found matching 'build' 12:47:13 INFO - no previously-included directories found matching 'dist' 12:47:13 INFO - no previously-included directories found matching '.git*' 12:47:13 INFO - Successfully installed jsonschema functools32 12:47:13 INFO - Cleaning up... 12:47:13 INFO - Return code: 0 12:47:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:13 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:13 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 12:47:13 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 12:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:13 INFO - 'HOME': '/Users/cltbld', 12:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:13 INFO - 'LOGNAME': 'cltbld', 12:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:13 INFO - 'MOZ_NO_REMOTE': '1', 12:47:13 INFO - 'NO_EM_RESTART': '1', 12:47:13 INFO - 'PAGER': '/bin/cat', 12:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:13 INFO - 'PWD': '/builds/slave/test', 12:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:13 INFO - 'SHELL': '/bin/bash', 12:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:13 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:13 INFO - 'USER': 'cltbld', 12:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:13 INFO - 'XPC_FLAGS': '0x0', 12:47:13 INFO - 'XPC_SERVICE_NAME': '0', 12:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:13 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:13 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 12:47:13 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 12:47:13 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 12:47:13 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 12:47:13 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 12:47:13 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 12:47:16 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:16 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 12:47:16 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 12:47:16 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 12:47:16 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 12:47:16 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 12:47:16 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 12:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:47:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47:17 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 12:47:17 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 12:47:17 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 12:47:17 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 12:47:17 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 12:47:17 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 12:47:17 INFO - Downloading docopt-0.6.1.tar.gz 12:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:17 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:17 INFO - Running setup.py install for blobuploader 12:47:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:17 INFO - Running setup.py install for requests 12:47:18 INFO - Running setup.py install for docopt 12:47:18 INFO - Successfully installed blobuploader requests docopt 12:47:18 INFO - Cleaning up... 12:47:18 INFO - Return code: 0 12:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:18 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 12:47:18 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 12:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:18 INFO - 'HOME': '/Users/cltbld', 12:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:18 INFO - 'LOGNAME': 'cltbld', 12:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:18 INFO - 'MOZ_NO_REMOTE': '1', 12:47:18 INFO - 'NO_EM_RESTART': '1', 12:47:18 INFO - 'PAGER': '/bin/cat', 12:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:18 INFO - 'PWD': '/builds/slave/test', 12:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:18 INFO - 'SHELL': '/bin/bash', 12:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:18 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:18 INFO - 'USER': 'cltbld', 12:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:18 INFO - 'XPC_FLAGS': '0x0', 12:47:18 INFO - 'XPC_SERVICE_NAME': '0', 12:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-8YwOSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-i0Ini_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-m4cFFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-spseS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dL9ROC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-vSS97Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VztZWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-QudABA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-w00nqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VwTvEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XRgHJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DLt0Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-FY9ugM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-6VQDsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-GfvDKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-LdMocZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NbhJ9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:20 INFO - Running setup.py install for manifestparser 12:47:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:20 INFO - Running setup.py install for mozcrash 12:47:20 INFO - Running setup.py install for mozdebug 12:47:20 INFO - Running setup.py install for mozdevice 12:47:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Running setup.py install for mozfile 12:47:21 INFO - Running setup.py install for mozhttpd 12:47:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Running setup.py install for mozinfo 12:47:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Running setup.py install for mozInstall 12:47:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:21 INFO - Running setup.py install for mozleak 12:47:21 INFO - Running setup.py install for mozlog 12:47:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Running setup.py install for moznetwork 12:47:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Running setup.py install for mozprocess 12:47:22 INFO - Running setup.py install for mozprofile 12:47:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Running setup.py install for mozrunner 12:47:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:22 INFO - Running setup.py install for mozscreenshot 12:47:22 INFO - Running setup.py install for moztest 12:47:22 INFO - Running setup.py install for mozversion 12:47:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:23 INFO - Cleaning up... 12:47:23 INFO - Return code: 0 12:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:23 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:23 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 12:47:23 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 12:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:23 INFO - 'HOME': '/Users/cltbld', 12:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:23 INFO - 'LOGNAME': 'cltbld', 12:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:23 INFO - 'MOZ_NO_REMOTE': '1', 12:47:23 INFO - 'NO_EM_RESTART': '1', 12:47:23 INFO - 'PAGER': '/bin/cat', 12:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:23 INFO - 'PWD': '/builds/slave/test', 12:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:23 INFO - 'SHELL': '/bin/bash', 12:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:23 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:23 INFO - 'USER': 'cltbld', 12:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:23 INFO - 'XPC_FLAGS': '0x0', 12:47:23 INFO - 'XPC_SERVICE_NAME': '0', 12:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OsCve8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:23 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)) 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-n8zvYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:23 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)) 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-aTHpDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:23 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)) 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4nrc0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:23 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)) 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4vBNgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:23 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)) 12:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:23 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-KXiVU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jQyLtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-8ZU_zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-f3jJ6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Gz1i59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Bo7Pf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5wEPtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-KaU9K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YGYa8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ARhQbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:24 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)) 12:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:24 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VSHrw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:25 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)) 12:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:25 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-vl1Ivs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:25 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)) 12:47:25 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)) 12:47:25 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)) 12:47:25 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)) 12:47:25 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)) 12:47:25 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)) 12:47:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:25 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 12:47:25 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 12:47:25 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 12:47:25 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 12:47:25 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 12:47:25 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 12:47:27 INFO - Downloading blessings-1.6.tar.gz 12:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:27 INFO - Installing collected packages: blessings 12:47:27 INFO - Running setup.py install for blessings 12:47:27 INFO - Successfully installed blessings 12:47:27 INFO - Cleaning up... 12:47:27 INFO - Return code: 0 12:47:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:47:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:28 INFO - Reading from file tmpfile_stdout 12:47:28 INFO - Current package versions: 12:47:28 INFO - blessings == 1.6 12:47:28 INFO - blobuploader == 1.2.4 12:47:28 INFO - docopt == 0.6.1 12:47:28 INFO - functools32 == 3.2.3-2 12:47:28 INFO - jsonschema == 2.5.1 12:47:28 INFO - manifestparser == 1.1 12:47:28 INFO - mozInstall == 1.12 12:47:28 INFO - mozcrash == 0.17 12:47:28 INFO - mozdebug == 0.1 12:47:28 INFO - mozdevice == 0.48 12:47:28 INFO - mozfile == 1.2 12:47:28 INFO - mozhttpd == 0.7 12:47:28 INFO - mozinfo == 0.9 12:47:28 INFO - mozleak == 0.1 12:47:28 INFO - mozlog == 3.2 12:47:28 INFO - moznetwork == 0.27 12:47:28 INFO - mozprocess == 0.22 12:47:28 INFO - mozprofile == 0.28 12:47:28 INFO - mozrunner == 6.11 12:47:28 INFO - mozscreenshot == 0.1 12:47:28 INFO - mozsystemmonitor == 0.3 12:47:28 INFO - moztest == 0.7 12:47:28 INFO - mozversion == 1.4 12:47:28 INFO - psutil == 3.1.1 12:47:28 INFO - requests == 1.2.3 12:47:28 INFO - wsgiref == 0.1.2 12:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:28 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:28 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 12:47:28 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 12:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:28 INFO - 'HOME': '/Users/cltbld', 12:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:28 INFO - 'LOGNAME': 'cltbld', 12:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:28 INFO - 'MOZ_NO_REMOTE': '1', 12:47:28 INFO - 'NO_EM_RESTART': '1', 12:47:28 INFO - 'PAGER': '/bin/cat', 12:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:28 INFO - 'PWD': '/builds/slave/test', 12:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:28 INFO - 'SHELL': '/bin/bash', 12:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:28 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:28 INFO - 'USER': 'cltbld', 12:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:28 INFO - 'XPC_FLAGS': '0x0', 12:47:28 INFO - 'XPC_SERVICE_NAME': '0', 12:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 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)) 12:47:28 INFO - Cleaning up... 12:47:28 INFO - Return code: 0 12:47:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:28 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 0x10b006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97ac95370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:28 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 12:47:28 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 12:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:28 INFO - 'HOME': '/Users/cltbld', 12:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:28 INFO - 'LOGNAME': 'cltbld', 12:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:28 INFO - 'MOZ_NO_REMOTE': '1', 12:47:28 INFO - 'NO_EM_RESTART': '1', 12:47:28 INFO - 'PAGER': '/bin/cat', 12:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:28 INFO - 'PWD': '/builds/slave/test', 12:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:28 INFO - 'SHELL': '/bin/bash', 12:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:47:28 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:28 INFO - 'USER': 'cltbld', 12:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:28 INFO - 'XPC_FLAGS': '0x0', 12:47:28 INFO - 'XPC_SERVICE_NAME': '0', 12:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:47:28 INFO - Cleaning up... 12:47:28 INFO - Return code: 0 12:47:28 INFO - Running post-action listener: _resource_record_post_action 12:47:28 INFO - Running post-action listener: _start_resource_monitoring 12:47:28 INFO - Starting resource monitoring. 12:47:28 INFO - ##### 12:47:28 INFO - ##### Finished create-virtualenv step (success) 12:47:28 INFO - ##### 12:47:28 INFO - ##### 12:47:28 INFO - ##### Running install step. 12:47:28 INFO - ##### 12:47:28 INFO - Running pre-action listener: _resource_record_pre_action 12:47:28 INFO - Running main action method: install 12:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:29 INFO - Reading from file tmpfile_stdout 12:47:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:47:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:47:29 INFO - Reading from file tmpfile_stdout 12:47:29 INFO - Output received: 12:47:29 INFO - Usage: mozinstall [options] installer 12:47:29 INFO - Options: 12:47:29 INFO - -h, --help show this help message and exit 12:47:29 INFO - -d DEST, --destination=DEST 12:47:29 INFO - Directory to install application into. [default: 12:47:29 INFO - "/builds/slave/test"] 12:47:29 INFO - --app=APP Application being installed. [default: firefox] 12:47:29 INFO - mkdir: /builds/slave/test/build/application 12:47:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:48:03 INFO - Reading from file tmpfile_stdout 12:48:03 INFO - Output received: 12:48:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:48:03 INFO - Running post-action listener: _resource_record_post_action 12:48:03 INFO - ##### 12:48:03 INFO - ##### Finished install step (success) 12:48:03 INFO - ##### 12:48:03 INFO - ##### 12:48:03 INFO - ##### Running run-tests step. 12:48:03 INFO - ##### 12:48:03 INFO - Running pre-action listener: _resource_record_pre_action 12:48:03 INFO - Running main action method: run_tests 12:48:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:03 INFO - 2016-06-28 12:48:03.832 screenresolution[1645:8901] starting screenresolution argv=screenresolution get 12:48:03 INFO - 2016-06-28 12:48:03.835 screenresolution[1645:8901] Display 0: 1600x1200x32@60 12:48:03 INFO - 2016-06-28 12:48:03.840 screenresolution[1646:8903] starting screenresolution argv=screenresolution list 12:48:03 INFO - Available Modes on Display 0 12:48:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:04 INFO - Intel Iris: 12:48:04 INFO - Chipset Model: Intel Iris 12:48:04 INFO - Type: GPU 12:48:04 INFO - Bus: Built-In 12:48:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:04 INFO - Vendor: Intel (0x8086) 12:48:04 INFO - Device ID: 0x0a2e 12:48:04 INFO - Revision ID: 0x0009 12:48:04 INFO - Displays: 12:48:04 INFO - Display: 12:48:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:04 INFO - Display Serial Number: 1600x1200 60 12:48:04 INFO - Main Display: Yes 12:48:04 INFO - Mirror: Off 12:48:04 INFO - Online: Yes 12:48:04 INFO - Rotation: Supported 12:48:04 INFO - Return code: 0 12:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:04 INFO - Python 2.7.3 12:48:04 INFO - Return code: 0 12:48:04 INFO - grabbing minidump binary from tooltool 12:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:04 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/macosx64/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 0x10af6ad30>, '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 0x10accfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af62b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:04 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:48:04 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:48:04 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:48:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:04 INFO - Return code: 0 12:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.62jkUp0VWi/Render', 12:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:04 INFO - 'HOME': '/Users/cltbld', 12:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:04 INFO - 'LOGNAME': 'cltbld', 12:48:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:04 INFO - 'MOZ_NO_REMOTE': '1', 12:48:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:04 INFO - 'NO_EM_RESTART': '1', 12:48:04 INFO - 'PAGER': '/bin/cat', 12:48:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:04 INFO - 'PWD': '/builds/slave/test', 12:48:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:04 INFO - 'SHELL': '/bin/bash', 12:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners', 12:48:04 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 12:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:04 INFO - 'USER': 'cltbld', 12:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:04 INFO - 'XPC_FLAGS': '0x0', 12:48:04 INFO - 'XPC_SERVICE_NAME': '0', 12:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:48:04 INFO - mozversion application_buildid: 20160628091623 12:48:04 INFO - mozversion application_changeset: 101de7dd28aa446f0c23cc701647d6399ed7490b 12:48:04 INFO - mozversion application_display_name: Nightly 12:48:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:04 INFO - mozversion application_name: Firefox 12:48:04 INFO - mozversion application_remotingname: firefox 12:48:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:48:04 INFO - mozversion application_vendor: Mozilla 12:48:04 INFO - mozversion application_version: 50.0a1 12:48:04 INFO - mozversion platform_buildid: 20160628091623 12:48:04 INFO - mozversion platform_changeset: 101de7dd28aa446f0c23cc701647d6399ed7490b 12:48:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:48:04 INFO - mozversion platform_version: 50.0a1 12:48:04 INFO - using testdate: 1467143284 12:48:04 INFO - actual date: 1467143284 12:48:04 INFO - starting webserver on 'localhost:49266' 12:48:04 INFO - SUITE-START | Running 2 tests 12:48:04 INFO - TEST-START | dromaeo_css 12:48:04 INFO - operating with platform_type : mac_ 12:48:04 INFO - Initialising browser for dromaeo_css test... 12:48:04 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpJK3CFp/profile http://localhost:49266/getInfo.html) 12:48:07 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 12:48:07 INFO - PROCESS | 1656 | colorDepth:24 12:48:07 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 12:48:07 INFO - PROCESS | 1656 | __metrics 12:48:07 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:48:08 INFO - TEST-INFO | 1656: exit 0 12:48:08 INFO - Browser initialized. 12:48:08 INFO - Running cycle 1/1 for dromaeo_css test... 12:48:08 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpJK3CFp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:20 INFO - PROCESS | 1661 | RSS: Main: 254939136 12:48:20 INFO - PROCESS | 1661 | 12:49:10 INFO - PROCESS | 1661 | 1467143350211 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] 12:51:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 12:51:22 INFO - PROCESS | 1661 | RSS: Main: 267235328 12:51:22 INFO - PROCESS | 1661 | 12:54:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:54:25 INFO - PROCESS | 1661 | RSS: Main: 278470656 12:54:25 INFO - PROCESS | 1661 | 12:57:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:57:28 INFO - PROCESS | 1661 | RSS: Main: 280612864 12:57:28 INFO - PROCESS | 1661 | 13:00:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 13:00:30 INFO - PROCESS | 1661 | RSS: Main: 282091520 13:00:30 INFO - PROCESS | 1661 | 13:03:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 13:03:33 INFO - PROCESS | 1661 | RSS: Main: 285618176 13:03:33 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 13:06:36 INFO - PROCESS | 1661 | RSS: Main: 285872128 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | __start_tp_report 13:06:36 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 13:06:36 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 13:06:36 INFO - PROCESS | 1661 | |i|pagename|runs| 13:06:36 INFO - PROCESS | 1661 | |0;dojo.html;2833.9716602833973;3396.9490457643124;3442.259914118464;3444.2594842108942;3454.740894432918;5013.298138260647;5806.187133801272;5811.215485909401;5824.330202026768;5978.043513037915;5717;5878.882422351561;5912.7930522431725;5962.850928726784;5993.400659934005;5250.868728281795;5283.762230699628;5296.152615581508;5399.271098401724;5451.236826844245;4891.03157390651;5415.296011518497;5468.671879687212;5470.753816078266;5530;5218.982298451803;5251.553617942442;5283.128283833163;5309.946900531003;5329.440408757083;5315.973420132913;5323.414424413311;5338.62629615927;5341.813036543703;5348.171033489815;4918.409790825124;5333.546648534879;5351.866203344947;5352.170413585862;5390.865228369283;4371.453568303962;4893.4617192108835;5739.110437882093;5896.705164741788;5928.02187639039;5631.746571404296;5900.672348721546;6209.6895155242055;6243.43809057187;6247.718852651642;6207.037909124093;6268.059791031336;6269.592476489013;6274.592151510137;6298.2442106947;5341.145416733343;5608.887822243532;5783.21926539916;5858.648481091105;5891.027980383189;6267.059941008885;6269.937300627026;6271.592346497463;6272.5922815016875;6294.024426213944;5049.722265275445;6114.966544785233;6198;6221.595596286227;6231.4391704746795;6216.471599913967;6221.9377806222265;6277.811665650038;6283.434490895841;6291.213598300213;6160.44555989963;6233.096201050822;6246.531510136758;6280.026595877646;6303.212098487689;6150.138980542728;6263.404976527223;6266.404691554295;6267.059941008885;6301.590396624205;4963.950360496348;5006.924896126561;5016.0971025215085;5017.54842064216;5036.043151801146;4438.934655682613;4469.977650111794;4474.194644963938;4493.7977790999485;4496.7301961882395;5971.164037034819;5990.73041713124;6097.908531372033;6143.539234557426;6148.4773794227995;6161.568690191733;6224;6255.96872015637;6284.402981716821;6289.96855015722;6065.8180254592435;6067.150598916155;6085.148079268906;6087.391260873877;6089.969550152309;5430.239766432703;5491.835244942658;5522.144067669517;5537.972310138504;5555.722213889289;6504.772332968323;6521.576097553644;6534.313897040837;6534.771283005262;6545.770898018546;6270.15352927349;6283.120363149254;6283.5601507895835;6291.937080629135;6298.275698294755;6208.0998255253635;6386.393292637192;6390.201224846895;6421.8073457796345;6525.445337146206;6253.6560489173535;6282.560220784684;6292.150559674568;6303.338149494421;6322.557420980487;6266.874662506815;6294.024426213944;6297.716602752796;6300.338464461165;6312.242530896322;5884.558658100746;6139.969300153471;6190.81427557174;6196.938030619636;6234.251889773256;5822.184894114743;6208.937910620836;6221.751129954751;6240.375962403723;6253.218347706536;5916.26046744157;6062.211912451353;6110.297315808739;6137.41694539018;6143.805221284818;6103.176071230327;6151.292601350723;6176;6194.256689197326;6288.119663247057;6145.907811382744;6151.6001459904965;6157;6170.10533472635;6185.350538193605 13:06:36 INFO - PROCESS | 1661 | |1;ext.html;487.47109386315867;509.17513627922773;512.6104160837765;529.1771295635288;560.456357333387;28735;41068.38397424041;41147.79426102869;41148.79425602871;41163;41484.17031659373;42009.579904200946;42237.366439503356;42294.94262643436;42338.57661423385;9571.808563828738;9775.169110625606;9779.315447918649;9784.559694813715;9796;8673;9643.276754243425;9662.5168741563;9681.12869841714;9712.22302215821;9738.074882886114;9761.658341958033;9782.461964591945;9798.510074496247;9801.509924503782;9706.66026689066;9759.560819763128;9766.658166964122;9774.657886973922;9828.606855725726;9555.18780903624;9625.759356016086;9650.08324209199;9656.662016829447;9678.661246856327;39551;39815.8009209955;39998;40014.79992600047;40581.78254652365;3172.191091271734;3378.560787097686;3643.125649844045;4006.7395619284653;4046.534648515429;31025.22436939072;31577.526337104962;31788.887388941275;31796.04611861648;32232.516512252336;2952.7490163336142;3305.3389322135667;3350.5644266245477;3402.2174899772945;3450.1202193440513;489658;494905;495517;497001;498496.9999999964;29960.85019574888;30676.53985190224;60336.69831650901;60345;61028.694856525435;34524.13689657779;34623;34856.82571587126;35019.64980350164;35028.82485587556;13828.239446830521;13923.443062277598;14462.493812716715;14486.130832149895;14513.419463221353;11604.129690273263;11729.941350293195;11917.702057448632;12114.0914431418;12133.5146594137;7800;7862.449628526063;7908.327792137733;7924.564148971862;7949.682012719427;3332.766706330582;3344.5317655528247;3349.413852575838;3350.246194606194;3372.629010808809;905.3300557587338;950.5199874063553;1081.8323159910226;1093.6937657455926;1098.9725256868483;30221.395572088873;30623.540646890313;30698.23254418613;30966.845165774026;30986.380272394425;917.8990311065777;1029.629333439961;1063.739383850946;1070.6252811515908;1180.2033627301537;12932.094753367363;13565.660858478617;14063.226522541358;15981.440649577442;16156.192190390433;646422;692286;702613;705635;709387;59143;59528.80942381215;59820.10269845956;60189.69905150446;60496.58013679404;1346.811446397505;1408.0917808013774;1423.5017743789797;1453.2080016391092;1453.25157543865;25488.872555637103;30009.099727008226;30157.547636785028;30352.392952141276;30820.22949426282;51511.2273315893;51788;52077.7396113017;52109.47890521046;52206.95586088181;586476.0676196591;597135;603059;604522;604945;26942.73057269402;26983.325416864736;27080.864595676896;27356;27432.451350973268;47855.76072119617;48691.756541217066;49116;50057;50349.74825125851;39106.41340379953;40219;40433.1913361737;40734.57428989971;41962;34330.82834585811;35447;38926.04121674324;39920.80237592877;40739;31749.523757144125;35093.82453087718;37661.81169094137;39009.41485877771;39148.02129946774;34203.31593368168;34858.302833942675;34886.476702849985;35462.936111916686;35632.28735425329;21060.7363558187;22497;25618.71906404635;25775.484490310464;25816.741832582185 13:06:36 INFO - PROCESS | 1661 | |2;jquery.html;376.27003612990796;380.11054133328014;381.27747917695956;397.56466668997473;403.02468027373754;17757.733633995467;19531.511712207182;21039.368818935418;21243.150273989042;21827.345179644595;20645.070971806268;21415.785842141573;21663.37524685651;21889.343319700434;21935.451613709665;5279.868003299929;5772.393898640635;6074.119252708355;6074.301455332627;6083.695815209244;5913.763449462016;5980.700964951735;5987.371326010772;6046.818595442144;6078.5441091918065;5835.387284335147;5936.257967754031;5964.970175149118;5990.490808281302;6027.216461859974;5850.297964244275;5866.032104702719;6006.8498287542725;6030.939690603103;6031.155638210654;4270.7864606769535;5073.061483625541;5161.870953226199;5185.6888586684545;5209.947900521022;16527.669446611122;19650.606987860163;20898.58202835935;24796.628050579257;25764.355891102685;2201.7027701260286;2204.4488877780555;2301.171578231852;2596.7533084356955;2828.420173864353;10256.179505639606;10365.481725913749;10471.790564188674;10494.055535001886;15367.770578353704;1846.3814622101613;1883.274939148424;1884.745559349484;1912.1204246046834;1940.602176553803;94425;100392;123001;125599;126961;11551.191416600757;11629.59296424621;11637.88362116368;11754.353510557;11852.822207666892;14318.99767016299;14426.278686065654;14558.927205363905;14604.05073670208;14605.85394146045;6949.7567585134275;8394.950631171103;8587.313014958789;8626.00800907891;8674.392792504465;7644.579548124907;7694.038245219348;8143.837123257502;8416.579171041545;8441.620127094295;3679.5400574928135;3910.569837317893;4519.367288579601;4585.839495617637;4598.712360539054;1603.2224371179968;1819.7907240667228;1894.8294653481253;1908.5324095596668;1917.8178073083034;842.5997651115671;855.4268640011084;925.3846192282057;932.7947851472666;982.29274922056;21074.683879741817;21701.674474882573;21775.564488710137;21801.67297490539;21924.794136322336;902.1024081039277;930.3348106104168;973.3478569358547;974.6345120579782;1061.4904845673966;8553.315734741205;10354.741131471774;10591.099756520627;11365.431728413712;11419.657410277705;599151;604186;618453;619795;622202;132751;134037;135541.32229338988;150366.24816875847;152405;993.6770549571419;1018.3787889387468;1027.1885210683477;1047.3297089862494;1053.257453495284;18905.621887562447;19060.714089288394;19394.8060519393;19410.90294548575;19507.414777556696;56249.718751405984;56627;56804;57652.42347576471;58348.54128646648;85396;86803.56598216969;86944;87320.5633971826;88329.55835220782;7913.564753938589;8128;8162.224588664068;8192;8329.458585191944;9192.678256260999;13172.209667419986;13214.735705286033;13309.80035299452;13403.396847142098;10893.727656808644;11069.612563560237;11202.91919722083;11309;11470.254433461798;11078;11255.887441125484;11322.94338528302;11436.71408214768;11472.369019703663;11652.53389864396;11675.065994720571;11683.299002059903;11716.94141529287;11942.34317112567;7069.575825450489;8033;8118.675252989814;8128.959355203423;8230.300424463987;9943.453110079015;11858.40707964581;11916.702082448008;12014.33921134346;12023.797620238256 13:06:36 INFO - PROCESS | 1661 | |3;mootools.html;1382.0601990646362;1415.6460884778805;1675.5727289541164;1835.9357422490207;1891.7824450188232;7993.5203887766775;8474.703385381514;8588.098249683788;8960.283177345813;8963.507007114615;8651.394402391836;8746.344024198195;8824.382293239476;8906.153915378029;8960.551972401387;2333.46330344021;2344.109238489372;2361.4332560185517;2367.3016460144213;2373.774491423321;2047.9862468078247;2314.5023819878725;2341.203990643181;2341.9297421077395;2373.288013595923;1964.8919309437974;2210.8894555272173;2289.8511596746243;2336.053898171235;2362.70466191726;2332.0322066342446;2334.5914464968646;2336.4859730859184;2339.883005849709;2342.180236917091;2323.779240972105;2324.360800779799;2325.197806756666;2325.988370058156;2326.174208156097;8850.601722922484;8882.15619516145;8899.733008009705;8940.910590894073;9022.278217742565;5178.818741344035;5336.733163341856;5338.386085600128;5344.706041167734;5345.946540534584;3457.8271086445575;3528.947065794015;3590.730695197871;3645.562532496091;3670.0457880950876;1070.0904231403322;1086.2450596835204;1098.8241881298954;1110.766738984814;1117.4245263689206;11637.069034477307;11799.292042477478;11799.764004719858;11800.70498237551;11834.112441566916;4574.908501830011;4629.768511574408;4681.95318046822;4755.57199852008;4758.78585463655;9977.950110249547;9997.350172238781;9999.800003999879;10010.54952527138;10176.084152426318;5295.920561191585;5298.549623282064;5299.735013249399;5310.654807437504;5311.7078560678765;4120.670346372283;4336.609705126553;4450.955490445119;4679.27471241958;4844.079624871263;3276.8033917965;3972.6424621784176;4035.4955630546183;4084.0402505411203;4102.2410853992105;1085.5060947268973;1266.2339284732789;1275.387813849339;1280.7630588341187;1288.4137717338588;807.2492581898773;851.2168804699692;943.32080901752;956.5647630328184;977.7408986618552;6079.148919151322;6083.27199665804;6144.477719393813;6148.585825260216;6177.444030037318;425.78072292769247;427.90883247718193;427.9379489973936;441.2939297124575;441.32036663538435;4086.4687590613626;4098.262312783728;4125.855595054159;4145.108801607669;4155.896102597399;10499.94750026245;10705.83941240882;10741.248112632196;10853.620123295646;10922.72693182661;10791.24461287718;10807.40559269232;10844.403557804239;10844.837327440095;10844.945775271073;6962.651867406508;8248.8350232995;8355.331573474108;8355.498670079814;8394.118617545191;6208.906866397098;6209.316975132822;6217.844553886189;6289.371062893674;6383.39357761012;8296.419250652396;9332.486713230837;10191.643292484727;10229.74425639365;10431.217658675781;10129;10303.330283531546;10326.328788628714;10372.11836993864;10409.9479502602;5806.361300256884;7465.664045118091;7629.771106866581;7722.498037627536;7792.571408572583;8259.132791056853;8541.188587084218;8656.653733850828;8659.48043117415;8678.828358171566;7214.74748383804;7418.703251869865;7657.69819130738;7661.348785353307;7700.653470593948;6711.395974362331;7240.98626192344;7458.627068646654;7507.324340809353;7570.05374328209;6578.276389597045;6794.558353706993;7092.25531319204;7141.535800172972;7195.604241766753;4997.800087996439;5113.897722045613;5158.716270605003;5179.274901513866;5210.166373380241;5084.567811736044;5194.298769666047;5197.532222100029;5233.790648374023;5265.973670131625 13:06:36 INFO - PROCESS | 1661 | |4;prototype.html;289.91592438192924;292.654667492359;306.1458530699349;309.98788954064975;311.51092784328614;4926.866820631248;5440.585447783575;5709.314882214135;5752.261030330287;5760.942390576093;4083.775392353427;5599.216109744639;5668.234788303588;5686.232358631583;5706.202546197945;3417.299453612016;3876.9839683364635;4009.498812648419;4301.333293339538;4312.482502099752;3425.914352141204;4258.254805409057;4279.251131052069;4313.849015284466;4340.327249276352;4148.502179738421;4161.854335098272;4171.830648063005;4175.515568236894;4179.414881916534;4197.488903994559;4198.433211516437;4200.1599680063955;4213.873583792491;4237.978810105929;3622.981885090584;3625.764325318872;3628.4419484263794;3628.8367023484006;3639.70882329413;5298.072837253465;5465.371482279549;5484.2047903053835;5486.3690675572025;5510.641808282448;4761.26200438929;4772.2125849234835;4797.904041919177;4810.5670489656095;4833.85498435044;5719.771209151629;5904.734286957054;5941.910871336933;5975.970120149372;5984.760609575612;3508.982455087734;3879.844806207748;3947.914323561015;3957.8021098945223;3965.504311961005;5204.375474942994;5716.542676585863;6077;6092.66490343031;6209.503239740855;3951.209758048402;3985.5815139410524;3985.847642273198;3989.501312335958;4001.9995001249686;3465.3935561276676;3605.891823245307;3708.517892673935;4040.2323558523785;4055.7769322687536;4714.57568818808;4775.617950563947;4791.281307803857;4831.140011095754;4832.033593281358;4663.626909847272;4816.4220293564995;5572.275604171432;5764.798232061941;5930.347661757203;1334.8731870472484;1375.3810785146725;1381.5855243427134;1383.2737812648238;1385.9099158554661;713.0231582731587;739.9075115610549;809.7935026568188;810.9837803243902;826.669332267098;4605.042856785853;4752.097101550694;4764.666473346832;4795.448523419851;4812.711237325771;4376.912461750747;4725.64557658177;5196.610254230872;5234.712090835041;5424.728763561806;4102.446169767103;4324;4394.912101758011;4398.604125628709;4687.789049492781;2386.8925898334614;2423.975760242375;2566.8577483019876;2660.5876089205817;2769.2799872033415;4591.540845915449;4705.835295764632;4925.24186455586;5397.704550907754;5413.431589683027;4739.383880095635;5253.264886459012;5254.553362964114;5396.487333703292;5397.703126328011;5691.430856914276;5713.485786279338;6364.427201551883;6475.222973243241;6489.643069631215;5660.801871934463;5672.43275672446;5965.403459654;6140.4473597376455;6271.122042913905;5712.314522257356;6172.845678858064;6192.225971753531;6193.84515387119;6205.286392064971;6464.256610489854;6489.675516224075;6490.805275841543;6523.412892839668;6539.411452969255;3904.4338570907626;3907.2185562888103;4010.1177740896956;4019.7990100495444;4060.7360521566;4904.485029071896;5113.667611605234;6142.293636231711;6187.257529096357;6235.194162626927;5226.608004399762;5311.097113490639;5748.597598168088;5860.882782344244;6049.909251361145;4986.47641997585;5173.870653233549;5538.252335934597;5972.552058595709;5984;5156.922646160236;5372.179605707035;5861.882762344644;5866.6186697864505;5893.675847828411;5725.760928750147;5905.065409263662;5993.310769261417;6004.579679422399;6050.58142149684;5122.462141475092;5175.4565770593545;5433.022056029952;5663.830085097454;5672.901026620177 13:06:36 INFO - PROCESS | 1661 | |5;yui.html;700.5761514283859;741.4957828676504;763.0957315581037;790.67977469125;871.020102384817;14927.701445971074;15379;15859.286332115054;15867.603309917244;15911.363545458167;14475.855241447582;15729.134897580629;16389;16418.26117824698;16767.32930682774;710.481348615511;878.1306506558525;905.361719987409;908.4095338030301;922.1055576091181;898.6046139698544;901.292485398962;902.7788191892995;903.6204793986509;903.9683611073614;928.9256859451227;942.2367882015556;955.3837774635356;955.5652178258875;956.9904300957006;923.0907556057311;950.2777888804524;950.8193443245831;951.3673407184215;953.9554188163984;567.4183961439517;689.5517913356308;703.9968045535143;704.7920863345274;708.6040500214621;16080.035197888164;16223;16228.918855405765;16254.268557914922;16254.349826007065;11323.660290191307;14135.293235338191;14250.429982800675;14519.78220326696;14744;10386.584536618602;11865.288082715064;11962.700932476671;12019.399030048462;12122.939385303105;3865.903352416184;3905.1994341159993;3923.313420151462;3948.8025598720237;4006.979965100185;96921.51539242259;108711;109991.35012974891;110432;112191;9334.253259739204;10022.998554518577;11025.83461248082;11272.774544509064;11460.312381257152;22139.1144354224;22160;22166.889165554392;22174.334769956928;22186.334409967403;7939.483933544301;7952.443328967032;8043.959780201179;8072.233137851895;8077.8788318175275;3956.940645890314;4185.602367775056;4187.5184353799095;4203.159368126387;4305;3617.3127105849803;3704.962950370462;3739.6634302912867;3741.0086327123336;3744.7753134811996;635.1647583427778;649.2857856358063;664.5945972956492;671.6306031682556;675.4933799650262;598.5152026858259;687.7352219395468;700.6041586503609;704.1831475488409;704.359033279713;9222;9326.114019168168;9626.892907315609;9645.180159686504;9668.178204852526;493.363561006305;537.4517991648497;654.7021105397129;677.4072686399401;681.4854784637566;4483.686141970031;4571.657125715585;4633.166030114612;4641.930371044437;4671.532846715301;89097;122536.38731806284;134184.32907835397;137698.3115084418;148799;128276;128600;131797.34101329432;133472;134982.3250883759;80456.59771701104;96427.1071867845;109566.45216774025;109892.4505377468;109957.9999999984;8920.063393343866;8926.241269491906;8937.553122343726;8949.686760963335;9079.68221112258;45902;46966.182029078365;52863.942721144595;54776;55517.7224113893;68794;73945;89101;90737.6389354147;94417;12954.740905182032;13199.20804751718;13317.334133293103;13336.466541338237;13455.035163848805;15052.322645480761;15067.171305578298;15258.237088145326;15353.385864565738;15480.612984675023;13757.491199237556;13896.51362202318;14010.159390436607;14373.496927607484;14427.062240954305;13750.449982000608;14007.719845603235;14099.224542650252;14253.35859886287;14434;13550.186988780704;13859.168449893039;13872.861271387157;13970.231637260049;14202.360893759598;9470.905290947278;11351.195906548703;11490.712732181762;11784.882151178379;11889.227200231957;11378.886211138113;11405.942970285096;11439.142064345373;11704.70738231551;11709.76580468403 13:06:36 INFO - PROCESS | 1661 | __end_tp_report 13:06:36 INFO - PROCESS | 1661 | __start_cc_report 13:06:36 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,443 13:06:36 INFO - PROCESS | 1661 | __end_cc_report 13:06:36 INFO - PROCESS | 1661 | __startTimestamp1467144396899__endTimestamp 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | ------- Summary: start ------- 13:06:36 INFO - PROCESS | 1661 | Number of tests: 6 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5808.96 Median:6114.97 stddev:671.17 (11.0%) stddev-sans-first:631.35 13:06:36 INFO - PROCESS | 1661 | Values: 2834.0 3396.9 3442.3 3444.3 3454.7 5013.3 5806.2 5811.2 5824.3 5978.0 5717.0 5878.9 5912.8 5962.9 5993.4 5250.9 5283.8 5296.2 5399.3 5451.2 4891.0 5415.3 5468.7 5470.8 5530.0 5219.0 5251.6 5283.1 5309.9 5329.4 5316.0 5323.4 5338.6 5341.8 5348.2 4918.4 5333.5 5351.9 5352.2 5390.9 4371.5 4893.5 5739.1 5896.7 5928.0 5631.7 5900.7 6209.7 6243.4 6247.7 6207.0 6268.1 6269.6 6274.6 6298.2 5341.1 5608.9 5783.2 5858.6 5891.0 6267.1 6269.9 6271.6 6272.6 6294.0 5049.7 6115.0 6198.0 6221.6 6231.4 6216.5 6221.9 6277.8 6283.4 6291.2 6160.4 6233.1 6246.5 6280.0 6303.2 6150.1 6263.4 6266.4 6267.1 6301.6 4964.0 5006.9 5016.1 5017.5 5036.0 4438.9 4470.0 4474.2 4493.8 4496.7 5971.2 5990.7 6097.9 6143.5 6148.5 6161.6 6224.0 6256.0 6284.4 6290.0 6065.8 6067.2 6085.1 6087.4 6090.0 5430.2 5491.8 5522.1 5538.0 5555.7 6504.8 6521.6 6534.3 6534.8 6545.8 6270.2 6283.1 6283.6 6291.9 6298.3 6208.1 6386.4 6390.2 6421.8 6525.4 6253.7 6282.6 6292.2 6303.3 6322.6 6266.9 6294.0 6297.7 6300.3 6312.2 5884.6 6140.0 6190.8 6196.9 6234.3 5822.2 6208.9 6221.8 6240.4 6253.2 5916.3 6062.2 6110.3 6137.4 6143.8 6103.2 6151.3 6176.0 6194.3 6288.1 6145.9 6151.6 6157.0 6170.1 6185.4 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:70967.65 Median:40006.40 stddev:161144.05 (402.8%) stddev-sans-first:161509.22 13:06:36 INFO - PROCESS | 1661 | Values: 487.5 509.2 512.6 529.2 560.5 28735.0 41068.4 41147.8 41148.8 41163.0 41484.2 42009.6 42237.4 42294.9 42338.6 9571.8 9775.2 9779.3 9784.6 9796.0 8673.0 9643.3 9662.5 9681.1 9712.2 9738.1 9761.7 9782.5 9798.5 9801.5 9706.7 9759.6 9766.7 9774.7 9828.6 9555.2 9625.8 9650.1 9656.7 9678.7 39551.0 39815.8 39998.0 40014.8 40581.8 3172.2 3378.6 3643.1 4006.7 4046.5 31025.2 31577.5 31788.9 31796.0 32232.5 2952.7 3305.3 3350.6 3402.2 3450.1 489658.0 494905.0 495517.0 497001.0 498497.0 29960.9 30676.5 60336.7 60345.0 61028.7 34524.1 34623.0 34856.8 35019.6 35028.8 13828.2 13923.4 14462.5 14486.1 14513.4 11604.1 11729.9 11917.7 12114.1 12133.5 7800.0 7862.4 7908.3 7924.6 7949.7 3332.8 3344.5 3349.4 3350.2 3372.6 905.3 950.5 1081.8 1093.7 1099.0 30221.4 30623.5 30698.2 30966.8 30986.4 917.9 1029.6 1063.7 1070.6 1180.2 12932.1 13565.7 14063.2 15981.4 16156.2 646422.0 692286.0 702613.0 705635.0 709387.0 59143.0 59528.8 59820.1 60189.7 60496.6 1346.8 1408.1 1423.5 1453.2 1453.3 25488.9 30009.1 30157.5 30352.4 30820.2 51511.2 51788.0 52077.7 52109.5 52207.0 586476.1 597135.0 603059.0 604522.0 604945.0 26942.7 26983.3 27080.9 27356.0 27432.5 47855.8 48691.8 49116.0 50057.0 50349.7 39106.4 40219.0 40433.2 40734.6 41962.0 34330.8 35447.0 38926.0 39920.8 40739.0 31749.5 35093.8 37661.8 39009.4 39148.0 34203.3 34858.3 34886.5 35462.9 35632.3 21060.7 22497.0 25618.7 25775.5 25816.7 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:36035.57 Median:2252.81 stddev:102582.40 (4553.5%) stddev-sans-first:102835.22 13:06:36 INFO - PROCESS | 1661 | Values: 376.3 380.1 381.3 397.6 403.0 17757.7 19531.5 21039.4 21243.2 21827.3 20645.1 21415.8 21663.4 21889.3 21935.5 5279.9 5772.4 6074.1 6074.3 6083.7 5913.8 5980.7 5987.4 6046.8 6078.5 5835.4 5936.3 5965.0 5990.5 6027.2 5850.3 5866.0 6006.8 6030.9 6031.2 4270.8 5073.1 5161.9 5185.7 5209.9 16527.7 19650.6 20898.6 24796.6 25764.4 2201.7 2204.4 2301.2 2596.8 2828.4 10256.2 10365.5 10471.8 10494.1 15367.8 1846.4 1883.3 1884.7 1912.1 1940.6 94425.0 100392.0 123001.0 125599.0 126961.0 11551.2 11629.6 11637.9 11754.4 11852.8 14319.0 14426.3 14558.9 14604.1 14605.9 6949.8 8395.0 8587.3 8626.0 8674.4 7644.6 7694.0 8143.8 8416.6 8441.6 3679.5 3910.6 4519.4 4585.8 4598.7 1603.2 1819.8 1894.8 1908.5 1917.8 842.6 855.4 925.4 932.8 982.3 21074.7 21701.7 21775.6 21801.7 21924.8 902.1 930.3 973.3 974.6 1061.5 8553.3 10354.7 10591.1 11365.4 11419.7 599151.0 604186.0 618453.0 619795.0 622202.0 132751.0 134037.0 135541.3 150366.2 152405.0 993.7 1018.4 1027.2 1047.3 1053.3 18905.6 19060.7 19394.8 19410.9 19507.4 56249.7 56627.0 56804.0 57652.4 58348.5 85396.0 86803.6 86944.0 87320.6 88329.6 7913.6 8128.0 8162.2 8192.0 8329.5 9192.7 13172.2 13214.7 13309.8 13403.4 10893.7 11069.6 11202.9 11309.0 11470.3 11078.0 11255.9 11322.9 11436.7 11472.4 11652.5 11675.1 11683.3 11716.9 11942.3 7069.6 8033.0 8118.7 8129.0 8230.3 9943.5 11858.4 11916.7 12014.3 12023.8 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5731.95 Median:4680.61 stddev:3253.61 (69.5%) stddev-sans-first:3246.31 13:06:36 INFO - PROCESS | 1661 | Values: 1382.1 1415.6 1675.6 1835.9 1891.8 7993.5 8474.7 8588.1 8960.3 8963.5 8651.4 8746.3 8824.4 8906.2 8960.6 2333.5 2344.1 2361.4 2367.3 2373.8 2048.0 2314.5 2341.2 2341.9 2373.3 1964.9 2210.9 2289.9 2336.1 2362.7 2332.0 2334.6 2336.5 2339.9 2342.2 2323.8 2324.4 2325.2 2326.0 2326.2 8850.6 8882.2 8899.7 8940.9 9022.3 5178.8 5336.7 5338.4 5344.7 5345.9 3457.8 3528.9 3590.7 3645.6 3670.0 1070.1 1086.2 1098.8 1110.8 1117.4 11637.1 11799.3 11799.8 11800.7 11834.1 4574.9 4629.8 4682.0 4755.6 4758.8 9978.0 9997.4 9999.8 10010.5 10176.1 5295.9 5298.5 5299.7 5310.7 5311.7 4120.7 4336.6 4451.0 4679.3 4844.1 3276.8 3972.6 4035.5 4084.0 4102.2 1085.5 1266.2 1275.4 1280.8 1288.4 807.2 851.2 943.3 956.6 977.7 6079.1 6083.3 6144.5 6148.6 6177.4 425.8 427.9 427.9 441.3 441.3 4086.5 4098.3 4125.9 4145.1 4155.9 10499.9 10705.8 10741.2 10853.6 10922.7 10791.2 10807.4 10844.4 10844.8 10844.9 6962.7 8248.8 8355.3 8355.5 8394.1 6208.9 6209.3 6217.8 6289.4 6383.4 8296.4 9332.5 10191.6 10229.7 10431.2 10129.0 10303.3 10326.3 10372.1 10409.9 5806.4 7465.7 7629.8 7722.5 7792.6 8259.1 8541.2 8656.7 8659.5 8678.8 7214.7 7418.7 7657.7 7661.3 7700.7 6711.4 7241.0 7458.6 7507.3 7570.1 6578.3 6794.6 7092.3 7141.5 7195.6 4997.8 5113.9 5158.7 5179.3 5210.2 5084.6 5194.3 5197.5 5233.8 5266.0 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4628.36 Median:4956.67 stddev:1473.08 (29.7%) stddev-sans-first:1440.77 13:06:36 INFO - PROCESS | 1661 | Values: 289.9 292.7 306.1 310.0 311.5 4926.9 5440.6 5709.3 5752.3 5760.9 4083.8 5599.2 5668.2 5686.2 5706.2 3417.3 3877.0 4009.5 4301.3 4312.5 3425.9 4258.3 4279.3 4313.8 4340.3 4148.5 4161.9 4171.8 4175.5 4179.4 4197.5 4198.4 4200.2 4213.9 4238.0 3623.0 3625.8 3628.4 3628.8 3639.7 5298.1 5465.4 5484.2 5486.4 5510.6 4761.3 4772.2 4797.9 4810.6 4833.9 5719.8 5904.7 5941.9 5976.0 5984.8 3509.0 3879.8 3947.9 3957.8 3965.5 5204.4 5716.5 6077.0 6092.7 6209.5 3951.2 3985.6 3985.8 3989.5 4002.0 3465.4 3605.9 3708.5 4040.2 4055.8 4714.6 4775.6 4791.3 4831.1 4832.0 4663.6 4816.4 5572.3 5764.8 5930.3 1334.9 1375.4 1381.6 1383.3 1385.9 713.0 739.9 809.8 811.0 826.7 4605.0 4752.1 4764.7 4795.4 4812.7 4376.9 4725.6 5196.6 5234.7 5424.7 4102.4 4324.0 4394.9 4398.6 4687.8 2386.9 2424.0 2566.9 2660.6 2769.3 4591.5 4705.8 4925.2 5397.7 5413.4 4739.4 5253.3 5254.6 5396.5 5397.7 5691.4 5713.5 6364.4 6475.2 6489.6 5660.8 5672.4 5965.4 6140.4 6271.1 5712.3 6172.8 6192.2 6193.8 6205.3 6464.3 6489.7 6490.8 6523.4 6539.4 3904.4 3907.2 4010.1 4019.8 4060.7 4904.5 5113.7 6142.3 6187.3 6235.2 5226.6 5311.1 5748.6 5860.9 6049.9 4986.5 5173.9 5538.3 5972.6 5984.0 5156.9 5372.2 5861.9 5866.6 5893.7 5725.8 5905.1 5993.3 6004.6 6050.6 5122.5 5175.5 5433.0 5663.8 5672.9 13:06:36 INFO - PROCESS | 1661 | 13:06:36 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:23629.55 Median:3914.26 stddev:36827.47 (940.9%) stddev-sans-first:36890.54 13:06:36 INFO - PROCESS | 1661 | Values: 700.6 741.5 763.1 790.7 871.0 14927.7 15379.0 15859.3 15867.6 15911.4 14475.9 15729.1 16389.0 16418.3 16767.3 710.5 878.1 905.4 908.4 922.1 898.6 901.3 902.8 903.6 904.0 928.9 942.2 955.4 955.6 957.0 923.1 950.3 950.8 951.4 954.0 567.4 689.6 704.0 704.8 708.6 16080.0 16223.0 16228.9 16254.3 16254.3 11323.7 14135.3 14250.4 14519.8 14744.0 10386.6 11865.3 11962.7 12019.4 12122.9 3865.9 3905.2 3923.3 3948.8 4007.0 96921.5 108711.0 109991.4 110432.0 112191.0 9334.3 10023.0 11025.8 11272.8 11460.3 22139.1 22160.0 22166.9 22174.3 22186.3 7939.5 7952.4 8044.0 8072.2 8077.9 3956.9 4185.6 4187.5 4203.2 4305.0 3617.3 3705.0 3739.7 3741.0 3744.8 635.2 649.3 664.6 671.6 675.5 598.5 687.7 700.6 704.2 704.4 9222.0 9326.1 9626.9 9645.2 9668.2 493.4 537.5 654.7 677.4 681.5 4483.7 4571.7 4633.2 4641.9 4671.5 89097.0 122536.4 134184.3 137698.3 148799.0 128276.0 128600.0 131797.3 133472.0 134982.3 80456.6 96427.1 109566.5 109892.5 109958.0 8920.1 8926.2 8937.6 8949.7 9079.7 45902.0 46966.2 52863.9 54776.0 55517.7 68794.0 73945.0 89101.0 90737.6 94417.0 12954.7 13199.2 13317.3 13336.5 13455.0 15052.3 15067.2 15258.2 15353.4 15480.6 13757.5 13896.5 14010.2 14373.5 14427.1 13750.4 14007.7 14099.2 14253.4 14434.0 13550.2 13859.2 13872.9 13970.2 14202.4 9470.9 11351.2 11490.7 11784.9 11889.2 11378.9 11405.9 11439.1 11704.7 11709.8 13:06:36 INFO - PROCESS | 1661 | -------- Summary: end -------- 13:06:36 INFO - PROCESS | 1661 | 13:06:37 INFO - TEST-INFO | 1661: exit 0 13:06:37 INFO - TEST-OK | dromaeo_css | took 1113083ms 13:06:37 INFO - TEST-START | kraken 13:06:37 INFO - operating with platform_type : mac_ 13:06:37 INFO - Initialising browser for kraken test... 13:06:37 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpf7l4E3/profile http://localhost:49266/getInfo.html) 13:06:40 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 13:06:40 INFO - PROCESS | 1669 | colorDepth:24 13:06:40 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 13:06:40 INFO - PROCESS | 1669 | __metrics 13:06:40 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:06:41 INFO - TEST-INFO | 1669: exit 0 13:06:41 INFO - Browser initialized. 13:06:41 INFO - Running cycle 1/1 for kraken test... 13:06:41 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpf7l4E3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:53 INFO - PROCESS | 1671 | RSS: Main: 255008768 13:06:53 INFO - PROCESS | 1671 | 13:06:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 13:06:56 INFO - PROCESS | 1671 | RSS: Main: 268099584 13:06:56 INFO - PROCESS | 1671 | 13:06:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 13:07:00 INFO - PROCESS | 1671 | RSS: Main: 272076800 13:07:00 INFO - PROCESS | 1671 | 13:07:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 13:07:04 INFO - PROCESS | 1671 | RSS: Main: 272220160 13:07:04 INFO - PROCESS | 1671 | 13:07:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 13:07:06 INFO - PROCESS | 1671 | RSS: Main: 273252352 13:07:06 INFO - PROCESS | 1671 | 13:07:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:09 INFO - PROCESS | 1671 | RSS: Main: 273887232 13:07:09 INFO - PROCESS | 1671 | 13:07:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:13 INFO - PROCESS | 1671 | RSS: Main: 273993728 13:07:13 INFO - PROCESS | 1671 | 13:07:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:16 INFO - PROCESS | 1671 | RSS: Main: 274227200 13:07:16 INFO - PROCESS | 1671 | 13:07:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 13:07:20 INFO - PROCESS | 1671 | RSS: Main: 274423808 13:07:20 INFO - PROCESS | 1671 | 13:07:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:22 INFO - PROCESS | 1671 | RSS: Main: 274378752 13:07:22 INFO - PROCESS | 1671 | 13:07:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:25 INFO - PROCESS | 1671 | RSS: Main: 274661376 13:07:25 INFO - PROCESS | 1671 | 13:07:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:28 INFO - PROCESS | 1671 | RSS: Main: 274264064 13:07:28 INFO - PROCESS | 1671 | 13:07:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:31 INFO - PROCESS | 1671 | RSS: Main: 274427904 13:07:31 INFO - PROCESS | 1671 | 13:07:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:35 INFO - PROCESS | 1671 | RSS: Main: 274374656 13:07:35 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 13:07:37 INFO - PROCESS | 1671 | RSS: Main: 275308544 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | __start_tp_report 13:07:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 13:07:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 13:07:37 INFO - PROCESS | 1671 | |i|pagename|runs| 13:07:37 INFO - PROCESS | 1671 | |0;ai-astar;119;124;98;100;148;155;166;176;116;115 13:07:37 INFO - PROCESS | 1671 | |1;audio-beat-detection;160;124;148;177;137;130;176;149;182;119 13:07:37 INFO - PROCESS | 1671 | |2;audio-dft;196;204;209;220;192;197;195;194;198;199 13:07:37 INFO - PROCESS | 1671 | |3;audio-fft;69;83;76;173;84;62;58;59;131;59 13:07:37 INFO - PROCESS | 1671 | |4;audio-oscillator;70;75;129;105;104;124;134;69;72;116 13:07:37 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;92;90;92;94;129;130;92;126;92;89 13:07:37 INFO - PROCESS | 1671 | |6;imaging-darkroom;97;118;97;98;106;97;97;97;96;96 13:07:37 INFO - PROCESS | 1671 | |7;imaging-desaturate;150;144;91;90;89;90;91;91;92;91 13:07:37 INFO - PROCESS | 1671 | |8;json-parse-financial;55;59;73;52;55;72;76;84;66;85 13:07:37 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;63;68;68;72;70;82;105;68;84;105 13:07:37 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;81;78;101;74;78;98;108;107;100;85 13:07:37 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;141;149;150;166;137;140;140;138;150;133 13:07:37 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;179;175;208;175;181;202;216;179;177;179 13:07:37 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;66;89;92;80;68;58;75;71;59;71 13:07:37 INFO - PROCESS | 1671 | __end_tp_report 13:07:37 INFO - PROCESS | 1671 | __start_cc_report 13:07:37 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1138 13:07:37 INFO - PROCESS | 1671 | __end_cc_report 13:07:37 INFO - PROCESS | 1671 | __startTimestamp1467144457421__endTimestamp 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | ------- Summary: start ------- 13:07:37 INFO - PROCESS | 1671 | Number of tests: 14 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:131.70 Median:151.50 stddev:27.56 (18.2%) stddev-sans-first:28.84 13:07:37 INFO - PROCESS | 1671 | Values: 119.0 124.0 98.0 100.0 148.0 155.0 166.0 176.0 116.0 115.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:154.50 stddev:22.95 (14.9%) stddev-sans-first:24.06 13:07:37 INFO - PROCESS | 1671 | Values: 160.0 124.0 148.0 177.0 137.0 130.0 176.0 149.0 182.0 119.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:200.40 Median:198.50 stddev:8.50 (4.3%) stddev-sans-first:8.87 13:07:37 INFO - PROCESS | 1671 | Values: 196.0 204.0 209.0 220.0 192.0 197.0 195.0 194.0 198.0 199.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:85.40 Median:65.50 stddev:37.73 (57.6%) stddev-sans-first:39.55 13:07:37 INFO - PROCESS | 1671 | Values: 69.0 83.0 76.0 173.0 84.0 62.0 58.0 59.0 131.0 59.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:101.50 stddev:26.12 (25.7%) stddev-sans-first:25.38 13:07:37 INFO - PROCESS | 1671 | Values: 70.0 75.0 129.0 105.0 104.0 124.0 134.0 69.0 72.0 116.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:92.00 stddev:17.83 (19.4%) stddev-sans-first:18.50 13:07:37 INFO - PROCESS | 1671 | Values: 92.0 90.0 92.0 94.0 129.0 130.0 92.0 126.0 92.0 89.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:97.00 stddev:7.00 (7.2%) stddev-sans-first:7.34 13:07:37 INFO - PROCESS | 1671 | Values: 97.0 118.0 97.0 98.0 106.0 97.0 97.0 97.0 96.0 96.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:91.00 stddev:23.83 (26.2%) stddev-sans-first:17.81 13:07:37 INFO - PROCESS | 1671 | Values: 150.0 144.0 91.0 90.0 89.0 90.0 91.0 91.0 92.0 91.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:72.50 stddev:12.15 (16.8%) stddev-sans-first:11.98 13:07:37 INFO - PROCESS | 1671 | Values: 55.0 59.0 73.0 52.0 55.0 72.0 76.0 84.0 66.0 85.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:69.00 stddev:15.39 (22.3%) stddev-sans-first:15.27 13:07:37 INFO - PROCESS | 1671 | Values: 63.0 68.0 68.0 72.0 70.0 82.0 105.0 68.0 84.0 105.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:78.00 stddev:13.07 (16.8%) stddev-sans-first:13.36 13:07:37 INFO - PROCESS | 1671 | Values: 81.0 78.0 101.0 74.0 78.0 98.0 108.0 107.0 100.0 85.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:145.00 stddev:9.58 (6.6%) stddev-sans-first:10.08 13:07:37 INFO - PROCESS | 1671 | Values: 141.0 149.0 150.0 166.0 137.0 140.0 140.0 138.0 150.0 133.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:180.00 stddev:15.36 (8.5%) stddev-sans-first:16.01 13:07:37 INFO - PROCESS | 1671 | Values: 179.0 175.0 208.0 175.0 181.0 202.0 216.0 179.0 177.0 179.0 13:07:37 INFO - PROCESS | 1671 | 13:07:37 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:11.42 (15.6%) stddev-sans-first:11.83 13:07:37 INFO - PROCESS | 1671 | Values: 66.0 89.0 92.0 80.0 68.0 58.0 75.0 71.0 59.0 71.0 13:07:37 INFO - PROCESS | 1671 | -------- Summary: end -------- 13:07:37 INFO - PROCESS | 1671 | 13:07:38 INFO - TEST-INFO | 1671: exit 0 13:07:38 INFO - TEST-OK | kraken | took 60836ms 13:07:38 INFO - SUITE-END | took 1173s 13:07:38 INFO - Completed test suite (00:19:34) 13:07:38 INFO - javascript benchmark 13:07:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7314.607235391744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2833.9716602833973, 3396.9490457643124, 3442.259914118464, 3444.2594842108942, 3454.740894432918, 5013.298138260647, 5806.187133801272, 5811.215485909401, 5824.330202026768, 5978.043513037915, 5717.0, 5878.882422351561, 5912.7930522431725, 5962.850928726784, 5993.400659934005, 5250.868728281795, 5283.762230699628, 5296.152615581508, 5399.271098401724, 5451.236826844245, 4891.03157390651, 5415.296011518497, 5468.671879687212, 5470.753816078266, 5530.0, 5218.982298451803, 5251.553617942442, 5283.128283833163, 5309.946900531003, 5329.440408757083, 5315.973420132913, 5323.414424413311, 5338.62629615927, 5341.813036543703, 5348.171033489815, 4918.409790825124, 5333.546648534879, 5351.866203344947, 5352.170413585862, 5390.865228369283, 4371.453568303962, 4893.4617192108835, 5739.110437882093, 5896.705164741788, 5928.02187639039, 5631.746571404296, 5900.672348721546, 6209.6895155242055, 6243.43809057187, 6247.718852651642, 6207.037909124093, 6268.059791031336, 6269.592476489013, 6274.592151510137, 6298.2442106947, 5341.145416733343, 5608.887822243532, 5783.21926539916, 5858.648481091105, 5891.027980383189, 6267.059941008885, 6269.937300627026, 6271.592346497463, 6272.5922815016875, 6294.024426213944, 5049.722265275445, 6114.966544785233, 6198.0, 6221.595596286227, 6231.4391704746795, 6216.471599913967, 6221.9377806222265, 6277.811665650038, 6283.434490895841, 6291.213598300213, 6160.44555989963, 6233.096201050822, 6246.531510136758, 6280.026595877646, 6303.212098487689, 6150.138980542728, 6263.404976527223, 6266.404691554295, 6267.059941008885, 6301.590396624205, 4963.950360496348, 5006.924896126561, 5016.0971025215085, 5017.54842064216, 5036.043151801146, 4438.934655682613, 4469.977650111794, 4474.194644963938, 4493.7977790999485, 4496.7301961882395, 5971.164037034819, 5990.73041713124, 6097.908531372033, 6143.539234557426, 6148.4773794227995, 6161.568690191733, 6224.0, 6255.96872015637, 6284.402981716821, 6289.96855015722, 6065.8180254592435, 6067.150598916155, 6085.148079268906, 6087.391260873877, 6089.969550152309, 5430.239766432703, 5491.835244942658, 5522.144067669517, 5537.972310138504, 5555.722213889289, 6504.772332968323, 6521.576097553644, 6534.313897040837, 6534.771283005262, 6545.770898018546, 6270.15352927349, 6283.120363149254, 6283.5601507895835, 6291.937080629135, 6298.275698294755, 6208.0998255253635, 6386.393292637192, 6390.201224846895, 6421.8073457796345, 6525.445337146206, 6253.6560489173535, 6282.560220784684, 6292.150559674568, 6303.338149494421, 6322.557420980487, 6266.874662506815, 6294.024426213944, 6297.716602752796, 6300.338464461165, 6312.242530896322, 5884.558658100746, 6139.969300153471, 6190.81427557174, 6196.938030619636, 6234.251889773256, 5822.184894114743, 6208.937910620836, 6221.751129954751, 6240.375962403723, 6253.218347706536, 5916.26046744157, 6062.211912451353, 6110.297315808739, 6137.41694539018, 6143.805221284818, 6103.176071230327, 6151.292601350723, 6176.0, 6194.256689197326, 6288.119663247057, 6145.907811382744, 6151.6001459904965, 6157.0, 6170.10533472635, 6185.350538193605], "value": 5765.619340334452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.47109386315867, 509.17513627922773, 512.6104160837765, 529.1771295635288, 560.456357333387, 28735.0, 41068.38397424041, 41147.79426102869, 41148.79425602871, 41163.0, 41484.17031659373, 42009.579904200946, 42237.366439503356, 42294.94262643436, 42338.57661423385, 9571.808563828738, 9775.169110625606, 9779.315447918649, 9784.559694813715, 9796.0, 8673.0, 9643.276754243425, 9662.5168741563, 9681.12869841714, 9712.22302215821, 9738.074882886114, 9761.658341958033, 9782.461964591945, 9798.510074496247, 9801.509924503782, 9706.66026689066, 9759.560819763128, 9766.658166964122, 9774.657886973922, 9828.606855725726, 9555.18780903624, 9625.759356016086, 9650.08324209199, 9656.662016829447, 9678.661246856327, 39551.0, 39815.8009209955, 39998.0, 40014.79992600047, 40581.78254652365, 3172.191091271734, 3378.560787097686, 3643.125649844045, 4006.7395619284653, 4046.534648515429, 31025.22436939072, 31577.526337104962, 31788.887388941275, 31796.04611861648, 32232.516512252336, 2952.7490163336142, 3305.3389322135667, 3350.5644266245477, 3402.2174899772945, 3450.1202193440513, 489658.0, 494905.0, 495517.0, 497001.0, 498496.9999999964, 29960.85019574888, 30676.53985190224, 60336.69831650901, 60345.0, 61028.694856525435, 34524.13689657779, 34623.0, 34856.82571587126, 35019.64980350164, 35028.82485587556, 13828.239446830521, 13923.443062277598, 14462.493812716715, 14486.130832149895, 14513.419463221353, 11604.129690273263, 11729.941350293195, 11917.702057448632, 12114.0914431418, 12133.5146594137, 7800.0, 7862.449628526063, 7908.327792137733, 7924.564148971862, 7949.682012719427, 3332.766706330582, 3344.5317655528247, 3349.413852575838, 3350.246194606194, 3372.629010808809, 905.3300557587338, 950.5199874063553, 1081.8323159910226, 1093.6937657455926, 1098.9725256868483, 30221.395572088873, 30623.540646890313, 30698.23254418613, 30966.845165774026, 30986.380272394425, 917.8990311065777, 1029.629333439961, 1063.739383850946, 1070.6252811515908, 1180.2033627301537, 12932.094753367363, 13565.660858478617, 14063.226522541358, 15981.440649577442, 16156.192190390433, 646422.0, 692286.0, 702613.0, 705635.0, 709387.0, 59143.0, 59528.80942381215, 59820.10269845956, 60189.69905150446, 60496.58013679404, 1346.811446397505, 1408.0917808013774, 1423.5017743789797, 1453.2080016391092, 1453.25157543865, 25488.872555637103, 30009.099727008226, 30157.547636785028, 30352.392952141276, 30820.22949426282, 51511.2273315893, 51788.0, 52077.7396113017, 52109.47890521046, 52206.95586088181, 586476.0676196591, 597135.0, 603059.0, 604522.0, 604945.0, 26942.73057269402, 26983.325416864736, 27080.864595676896, 27356.0, 27432.451350973268, 47855.76072119617, 48691.756541217066, 49116.0, 50057.0, 50349.74825125851, 39106.41340379953, 40219.0, 40433.1913361737, 40734.57428989971, 41962.0, 34330.82834585811, 35447.0, 38926.04121674324, 39920.80237592877, 40739.0, 31749.523757144125, 35093.82453087718, 37661.81169094137, 39009.41485877771, 39148.02129946774, 34203.31593368168, 34858.302833942675, 34886.476702849985, 35462.936111916686, 35632.28735425329, 21060.7363558187, 22497.0, 25618.71906404635, 25775.484490310464, 25816.741832582185], "value": 18748.837986686172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.27003612990796, 380.11054133328014, 381.27747917695956, 397.56466668997473, 403.02468027373754, 17757.733633995467, 19531.511712207182, 21039.368818935418, 21243.150273989042, 21827.345179644595, 20645.070971806268, 21415.785842141573, 21663.37524685651, 21889.343319700434, 21935.451613709665, 5279.868003299929, 5772.393898640635, 6074.119252708355, 6074.301455332627, 6083.695815209244, 5913.763449462016, 5980.700964951735, 5987.371326010772, 6046.818595442144, 6078.5441091918065, 5835.387284335147, 5936.257967754031, 5964.970175149118, 5990.490808281302, 6027.216461859974, 5850.297964244275, 5866.032104702719, 6006.8498287542725, 6030.939690603103, 6031.155638210654, 4270.7864606769535, 5073.061483625541, 5161.870953226199, 5185.6888586684545, 5209.947900521022, 16527.669446611122, 19650.606987860163, 20898.58202835935, 24796.628050579257, 25764.355891102685, 2201.7027701260286, 2204.4488877780555, 2301.171578231852, 2596.7533084356955, 2828.420173864353, 10256.179505639606, 10365.481725913749, 10471.790564188674, 10494.055535001886, 15367.770578353704, 1846.3814622101613, 1883.274939148424, 1884.745559349484, 1912.1204246046834, 1940.602176553803, 94425.0, 100392.0, 123001.0, 125599.0, 126961.0, 11551.191416600757, 11629.59296424621, 11637.88362116368, 11754.353510557, 11852.822207666892, 14318.99767016299, 14426.278686065654, 14558.927205363905, 14604.05073670208, 14605.85394146045, 6949.7567585134275, 8394.950631171103, 8587.313014958789, 8626.00800907891, 8674.392792504465, 7644.579548124907, 7694.038245219348, 8143.837123257502, 8416.579171041545, 8441.620127094295, 3679.5400574928135, 3910.569837317893, 4519.367288579601, 4585.839495617637, 4598.712360539054, 1603.2224371179968, 1819.7907240667228, 1894.8294653481253, 1908.5324095596668, 1917.8178073083034, 842.5997651115671, 855.4268640011084, 925.3846192282057, 932.7947851472666, 982.29274922056, 21074.683879741817, 21701.674474882573, 21775.564488710137, 21801.67297490539, 21924.794136322336, 902.1024081039277, 930.3348106104168, 973.3478569358547, 974.6345120579782, 1061.4904845673966, 8553.315734741205, 10354.741131471774, 10591.099756520627, 11365.431728413712, 11419.657410277705, 599151.0, 604186.0, 618453.0, 619795.0, 622202.0, 132751.0, 134037.0, 135541.32229338988, 150366.24816875847, 152405.0, 993.6770549571419, 1018.3787889387468, 1027.1885210683477, 1047.3297089862494, 1053.257453495284, 18905.621887562447, 19060.714089288394, 19394.8060519393, 19410.90294548575, 19507.414777556696, 56249.718751405984, 56627.0, 56804.0, 57652.42347576471, 58348.54128646648, 85396.0, 86803.56598216969, 86944.0, 87320.5633971826, 88329.55835220782, 7913.564753938589, 8128.0, 8162.224588664068, 8192.0, 8329.458585191944, 9192.678256260999, 13172.209667419986, 13214.735705286033, 13309.80035299452, 13403.396847142098, 10893.727656808644, 11069.612563560237, 11202.91919722083, 11309.0, 11470.254433461798, 11078.0, 11255.887441125484, 11322.94338528302, 11436.71408214768, 11472.369019703663, 11652.53389864396, 11675.065994720571, 11683.299002059903, 11716.94141529287, 11942.34317112567, 7069.575825450489, 8033.0, 8118.675252989814, 8128.959355203423, 8230.300424463987, 9943.453110079015, 11858.40707964581, 11916.702082448008, 12014.33921134346, 12023.797620238256], "value": 9650.490623115586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.0601990646362, 1415.6460884778805, 1675.5727289541164, 1835.9357422490207, 1891.7824450188232, 7993.5203887766775, 8474.703385381514, 8588.098249683788, 8960.283177345813, 8963.507007114615, 8651.394402391836, 8746.344024198195, 8824.382293239476, 8906.153915378029, 8960.551972401387, 2333.46330344021, 2344.109238489372, 2361.4332560185517, 2367.3016460144213, 2373.774491423321, 2047.9862468078247, 2314.5023819878725, 2341.203990643181, 2341.9297421077395, 2373.288013595923, 1964.8919309437974, 2210.8894555272173, 2289.8511596746243, 2336.053898171235, 2362.70466191726, 2332.0322066342446, 2334.5914464968646, 2336.4859730859184, 2339.883005849709, 2342.180236917091, 2323.779240972105, 2324.360800779799, 2325.197806756666, 2325.988370058156, 2326.174208156097, 8850.601722922484, 8882.15619516145, 8899.733008009705, 8940.910590894073, 9022.278217742565, 5178.818741344035, 5336.733163341856, 5338.386085600128, 5344.706041167734, 5345.946540534584, 3457.8271086445575, 3528.947065794015, 3590.730695197871, 3645.562532496091, 3670.0457880950876, 1070.0904231403322, 1086.2450596835204, 1098.8241881298954, 1110.766738984814, 1117.4245263689206, 11637.069034477307, 11799.292042477478, 11799.764004719858, 11800.70498237551, 11834.112441566916, 4574.908501830011, 4629.768511574408, 4681.95318046822, 4755.57199852008, 4758.78585463655, 9977.950110249547, 9997.350172238781, 9999.800003999879, 10010.54952527138, 10176.084152426318, 5295.920561191585, 5298.549623282064, 5299.735013249399, 5310.654807437504, 5311.7078560678765, 4120.670346372283, 4336.609705126553, 4450.955490445119, 4679.27471241958, 4844.079624871263, 3276.8033917965, 3972.6424621784176, 4035.4955630546183, 4084.0402505411203, 4102.2410853992105, 1085.5060947268973, 1266.2339284732789, 1275.387813849339, 1280.7630588341187, 1288.4137717338588, 807.2492581898773, 851.2168804699692, 943.32080901752, 956.5647630328184, 977.7408986618552, 6079.148919151322, 6083.27199665804, 6144.477719393813, 6148.585825260216, 6177.444030037318, 425.78072292769247, 427.90883247718193, 427.9379489973936, 441.2939297124575, 441.32036663538435, 4086.4687590613626, 4098.262312783728, 4125.855595054159, 4145.108801607669, 4155.896102597399, 10499.94750026245, 10705.83941240882, 10741.248112632196, 10853.620123295646, 10922.72693182661, 10791.24461287718, 10807.40559269232, 10844.403557804239, 10844.837327440095, 10844.945775271073, 6962.651867406508, 8248.8350232995, 8355.331573474108, 8355.498670079814, 8394.118617545191, 6208.906866397098, 6209.316975132822, 6217.844553886189, 6289.371062893674, 6383.39357761012, 8296.419250652396, 9332.486713230837, 10191.643292484727, 10229.74425639365, 10431.217658675781, 10129.0, 10303.330283531546, 10326.328788628714, 10372.11836993864, 10409.9479502602, 5806.361300256884, 7465.664045118091, 7629.771106866581, 7722.498037627536, 7792.571408572583, 8259.132791056853, 8541.188587084218, 8656.653733850828, 8659.48043117415, 8678.828358171566, 7214.74748383804, 7418.703251869865, 7657.69819130738, 7661.348785353307, 7700.653470593948, 6711.395974362331, 7240.98626192344, 7458.627068646654, 7507.324340809353, 7570.05374328209, 6578.276389597045, 6794.558353706993, 7092.25531319204, 7141.535800172972, 7195.604241766753, 4997.800087996439, 5113.897722045613, 5158.716270605003, 5179.274901513866, 5210.166373380241, 5084.567811736044, 5194.298769666047, 5197.532222100029, 5233.790648374023, 5265.973670131625], "value": 4510.241912505802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.91592438192924, 292.654667492359, 306.1458530699349, 309.98788954064975, 311.51092784328614, 4926.866820631248, 5440.585447783575, 5709.314882214135, 5752.261030330287, 5760.942390576093, 4083.775392353427, 5599.216109744639, 5668.234788303588, 5686.232358631583, 5706.202546197945, 3417.299453612016, 3876.9839683364635, 4009.498812648419, 4301.333293339538, 4312.482502099752, 3425.914352141204, 4258.254805409057, 4279.251131052069, 4313.849015284466, 4340.327249276352, 4148.502179738421, 4161.854335098272, 4171.830648063005, 4175.515568236894, 4179.414881916534, 4197.488903994559, 4198.433211516437, 4200.1599680063955, 4213.873583792491, 4237.978810105929, 3622.981885090584, 3625.764325318872, 3628.4419484263794, 3628.8367023484006, 3639.70882329413, 5298.072837253465, 5465.371482279549, 5484.2047903053835, 5486.3690675572025, 5510.641808282448, 4761.26200438929, 4772.2125849234835, 4797.904041919177, 4810.5670489656095, 4833.85498435044, 5719.771209151629, 5904.734286957054, 5941.910871336933, 5975.970120149372, 5984.760609575612, 3508.982455087734, 3879.844806207748, 3947.914323561015, 3957.8021098945223, 3965.504311961005, 5204.375474942994, 5716.542676585863, 6077.0, 6092.66490343031, 6209.503239740855, 3951.209758048402, 3985.5815139410524, 3985.847642273198, 3989.501312335958, 4001.9995001249686, 3465.3935561276676, 3605.891823245307, 3708.517892673935, 4040.2323558523785, 4055.7769322687536, 4714.57568818808, 4775.617950563947, 4791.281307803857, 4831.140011095754, 4832.033593281358, 4663.626909847272, 4816.4220293564995, 5572.275604171432, 5764.798232061941, 5930.347661757203, 1334.8731870472484, 1375.3810785146725, 1381.5855243427134, 1383.2737812648238, 1385.9099158554661, 713.0231582731587, 739.9075115610549, 809.7935026568188, 810.9837803243902, 826.669332267098, 4605.042856785853, 4752.097101550694, 4764.666473346832, 4795.448523419851, 4812.711237325771, 4376.912461750747, 4725.64557658177, 5196.610254230872, 5234.712090835041, 5424.728763561806, 4102.446169767103, 4324.0, 4394.912101758011, 4398.604125628709, 4687.789049492781, 2386.8925898334614, 2423.975760242375, 2566.8577483019876, 2660.5876089205817, 2769.2799872033415, 4591.540845915449, 4705.835295764632, 4925.24186455586, 5397.704550907754, 5413.431589683027, 4739.383880095635, 5253.264886459012, 5254.553362964114, 5396.487333703292, 5397.703126328011, 5691.430856914276, 5713.485786279338, 6364.427201551883, 6475.222973243241, 6489.643069631215, 5660.801871934463, 5672.43275672446, 5965.403459654, 6140.4473597376455, 6271.122042913905, 5712.314522257356, 6172.845678858064, 6192.225971753531, 6193.84515387119, 6205.286392064971, 6464.256610489854, 6489.675516224075, 6490.805275841543, 6523.412892839668, 6539.411452969255, 3904.4338570907626, 3907.2185562888103, 4010.1177740896956, 4019.7990100495444, 4060.7360521566, 4904.485029071896, 5113.667611605234, 6142.293636231711, 6187.257529096357, 6235.194162626927, 5226.608004399762, 5311.097113490639, 5748.597598168088, 5860.882782344244, 6049.909251361145, 4986.47641997585, 5173.870653233549, 5538.252335934597, 5972.552058595709, 5984.0, 5156.922646160236, 5372.179605707035, 5861.882762344644, 5866.6186697864505, 5893.675847828411, 5725.760928750147, 5905.065409263662, 5993.310769261417, 6004.579679422399, 6050.58142149684, 5122.462141475092, 5175.4565770593545, 5433.022056029952, 5663.830085097454, 5672.901026620177], "value": 4146.999467822777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5761514283859, 741.4957828676504, 763.0957315581037, 790.67977469125, 871.020102384817, 14927.701445971074, 15379.0, 15859.286332115054, 15867.603309917244, 15911.363545458167, 14475.855241447582, 15729.134897580629, 16389.0, 16418.26117824698, 16767.32930682774, 710.481348615511, 878.1306506558525, 905.361719987409, 908.4095338030301, 922.1055576091181, 898.6046139698544, 901.292485398962, 902.7788191892995, 903.6204793986509, 903.9683611073614, 928.9256859451227, 942.2367882015556, 955.3837774635356, 955.5652178258875, 956.9904300957006, 923.0907556057311, 950.2777888804524, 950.8193443245831, 951.3673407184215, 953.9554188163984, 567.4183961439517, 689.5517913356308, 703.9968045535143, 704.7920863345274, 708.6040500214621, 16080.035197888164, 16223.0, 16228.918855405765, 16254.268557914922, 16254.349826007065, 11323.660290191307, 14135.293235338191, 14250.429982800675, 14519.78220326696, 14744.0, 10386.584536618602, 11865.288082715064, 11962.700932476671, 12019.399030048462, 12122.939385303105, 3865.903352416184, 3905.1994341159993, 3923.313420151462, 3948.8025598720237, 4006.979965100185, 96921.51539242259, 108711.0, 109991.35012974891, 110432.0, 112191.0, 9334.253259739204, 10022.998554518577, 11025.83461248082, 11272.774544509064, 11460.312381257152, 22139.1144354224, 22160.0, 22166.889165554392, 22174.334769956928, 22186.334409967403, 7939.483933544301, 7952.443328967032, 8043.959780201179, 8072.233137851895, 8077.8788318175275, 3956.940645890314, 4185.602367775056, 4187.5184353799095, 4203.159368126387, 4305.0, 3617.3127105849803, 3704.962950370462, 3739.6634302912867, 3741.0086327123336, 3744.7753134811996, 635.1647583427778, 649.2857856358063, 664.5945972956492, 671.6306031682556, 675.4933799650262, 598.5152026858259, 687.7352219395468, 700.6041586503609, 704.1831475488409, 704.359033279713, 9222.0, 9326.114019168168, 9626.892907315609, 9645.180159686504, 9668.178204852526, 493.363561006305, 537.4517991648497, 654.7021105397129, 677.4072686399401, 681.4854784637566, 4483.686141970031, 4571.657125715585, 4633.166030114612, 4641.930371044437, 4671.532846715301, 89097.0, 122536.38731806284, 134184.32907835397, 137698.3115084418, 148799.0, 128276.0, 128600.0, 131797.34101329432, 133472.0, 134982.3250883759, 80456.59771701104, 96427.1071867845, 109566.45216774025, 109892.4505377468, 109957.9999999984, 8920.063393343866, 8926.241269491906, 8937.553122343726, 8949.686760963335, 9079.68221112258, 45902.0, 46966.182029078365, 52863.942721144595, 54776.0, 55517.7224113893, 68794.0, 73945.0, 89101.0, 90737.6389354147, 94417.0, 12954.740905182032, 13199.20804751718, 13317.334133293103, 13336.466541338237, 13455.035163848805, 15052.322645480761, 15067.171305578298, 15258.237088145326, 15353.385864565738, 15480.612984675023, 13757.491199237556, 13896.51362202318, 14010.159390436607, 14373.496927607484, 14427.062240954305, 13750.449982000608, 14007.719845603235, 14099.224542650252, 14253.35859886287, 14434.0, 13550.186988780704, 13859.168449893039, 13872.861271387157, 13970.231637260049, 14202.360893759598, 9470.905290947278, 11351.195906548703, 11490.712732181762, 11784.882151178379, 11889.227200231957, 11378.886211138113, 11405.942970285096, 11439.142064345373, 11704.70738231551, 11709.76580468403], "value": 7848.7220558359595, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 98.0, 100.0, 148.0, 155.0, 166.0, 176.0, 116.0, 115.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 148.0, 177.0, 137.0, 130.0, 176.0, 149.0, 182.0, 119.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 209.0, 220.0, 192.0, 197.0, 195.0, 194.0, 198.0, 199.0], "value": 200.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 76.0, 173.0, 84.0, 62.0, 58.0, 59.0, 131.0, 59.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 129.0, 105.0, 104.0, 124.0, 134.0, 69.0, 72.0, 116.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 92.0, 94.0, 129.0, 130.0, 92.0, 126.0, 92.0, 89.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 118.0, 97.0, 98.0, 106.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 144.0, 91.0, 90.0, 89.0, 90.0, 91.0, 91.0, 92.0, 91.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 73.0, 52.0, 55.0, 72.0, 76.0, 84.0, 66.0, 85.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 68.0, 72.0, 70.0, 82.0, 105.0, 68.0, 84.0, 105.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 101.0, 74.0, 78.0, 98.0, 108.0, 107.0, 100.0, 85.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 150.0, 166.0, 137.0, 140.0, 140.0, 138.0, 150.0, 133.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 208.0, 175.0, 181.0, 202.0, 216.0, 179.0, 177.0, 179.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 89.0, 92.0, 80.0, 68.0, 58.0, 75.0, 71.0, 59.0, 71.0], "value": 72.9, "unit": "score"}]}]} 13:07:38 INFO - Return code: 0 13:07:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:07:38 ERROR - # TBPL SUCCESS # 13:07:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:07:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:07:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:07:38 INFO - 2016-06-28 13:07:38.762 screenresolution[1676:11680] starting screenresolution argv=screenresolution get 13:07:38 INFO - 2016-06-28 13:07:38.766 screenresolution[1676:11680] Display 0: 1600x1200x32@60 13:07:38 INFO - 2016-06-28 13:07:38.773 screenresolution[1677:11683] starting screenresolution argv=screenresolution list 13:07:38 INFO - Available Modes on Display 0 13:07:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:07:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:07:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:07:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:07:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:07:39 INFO - Intel Iris: 13:07:39 INFO - Chipset Model: Intel Iris 13:07:39 INFO - Type: GPU 13:07:39 INFO - Bus: Built-In 13:07:39 INFO - VRAM (Dynamic, Max): 1536 MB 13:07:39 INFO - Vendor: Intel (0x8086) 13:07:39 INFO - Device ID: 0x0a2e 13:07:39 INFO - Revision ID: 0x0009 13:07:39 INFO - Displays: 13:07:39 INFO - Display: 13:07:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:07:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:07:39 INFO - Display Serial Number: 1600x1200 60 13:07:39 INFO - Main Display: Yes 13:07:39 INFO - Mirror: Off 13:07:39 INFO - Online: Yes 13:07:39 INFO - Rotation: Supported 13:07:39 INFO - Return code: 0 13:07:39 INFO - Running post-action listener: _resource_record_post_action 13:07:39 INFO - ##### 13:07:39 INFO - ##### Finished run-tests step (success) 13:07:39 INFO - ##### 13:07:39 INFO - Running post-run listener: _resource_record_post_run 13:07:39 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 39227392; Write bytes: 710195200; Read time: 374; Write time: 2131 13:07:39 INFO - TinderboxPrint: CPU usage
54.8% 13:07:39 INFO - TinderboxPrint: I/O read bytes / time
39,227,392 / 374 13:07:39 INFO - TinderboxPrint: I/O write bytes / time
710,195,200 / 2,131 13:07:39 INFO - TinderboxPrint: CPU idle
2,186.8 (45.2%) 13:07:39 INFO - TinderboxPrint: CPU system
979.1 (20.2%) 13:07:39 INFO - TinderboxPrint: CPU user
1,671.8 (34.6%) 13:07:39 INFO - TinderboxPrint: Swap in / out
449,966,080 / 0 13:07:39 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 383715840; Write bytes: 380876288; Read time: 28826; Write time: 984 13:07:39 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 38305792; Write bytes: 298779136; Read time: 361; Write time: 1089 13:07:39 INFO - Running post-run listener: _upload_blobber_files 13:07:39 INFO - Blob upload gear active. 13:07:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:07:39 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 13:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:07:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:07:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:40 INFO - (blobuploader) - INFO - Done attempting. 13:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:07:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:41 INFO - (blobuploader) - INFO - Done attempting. 13:07:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:07:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:44 INFO - (blobuploader) - INFO - Done attempting. 13:07:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:07:44 INFO - Return code: 0 13:07:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:07:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:07:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e2f344d85edb36c4ba1e6ad8b5996e35cd4f5e7dcfdb091296e743a3add184d71b19fd5c32dab9b622fc6079995c1397705d17dfdb42aca58b705ef4f08d81a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d4b3c1cfee2dbf26ccfea8a2011c1e7c6bf90c73969a9eff44c57d1a25c7f4d04528a49f54255ccd38662b1eb0009a96e0d0e376a3ad6ffa769ff0b03db892", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d0ba26264bf8dc323969039395cfad93f7853d2b13c3b37463d52588f2e35d9290e423c42f409591d5049d041665dcdc663be4ccce91b92a0d8307e4cea4bb"} 13:07:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:07:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:07:44 INFO - Contents: 13:07:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e2f344d85edb36c4ba1e6ad8b5996e35cd4f5e7dcfdb091296e743a3add184d71b19fd5c32dab9b622fc6079995c1397705d17dfdb42aca58b705ef4f08d81a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d4b3c1cfee2dbf26ccfea8a2011c1e7c6bf90c73969a9eff44c57d1a25c7f4d04528a49f54255ccd38662b1eb0009a96e0d0e376a3ad6ffa769ff0b03db892", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d0ba26264bf8dc323969039395cfad93f7853d2b13c3b37463d52588f2e35d9290e423c42f409591d5049d041665dcdc663be4ccce91b92a0d8307e4cea4bb"} 13:07:44 INFO - Running post-run listener: copy_logs_to_upload_dir 13:07:44 INFO - Copying logs to upload dir... 13:07:44 INFO - mkdir: /builds/slave/test/build/upload/logs 13:07:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1386.337486 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2016-06-28 13:07:44.416672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:07:44.420143) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e2f344d85edb36c4ba1e6ad8b5996e35cd4f5e7dcfdb091296e743a3add184d71b19fd5c32dab9b622fc6079995c1397705d17dfdb42aca58b705ef4f08d81a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d4b3c1cfee2dbf26ccfea8a2011c1e7c6bf90c73969a9eff44c57d1a25c7f4d04528a49f54255ccd38662b1eb0009a96e0d0e376a3ad6ffa769ff0b03db892", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d0ba26264bf8dc323969039395cfad93f7853d2b13c3b37463d52588f2e35d9290e423c42f409591d5049d041665dcdc663be4ccce91b92a0d8307e4cea4bb"} build_url:https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/B3rSNSMRRJCv6pbwAi6uJw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e2f344d85edb36c4ba1e6ad8b5996e35cd4f5e7dcfdb091296e743a3add184d71b19fd5c32dab9b622fc6079995c1397705d17dfdb42aca58b705ef4f08d81a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d4b3c1cfee2dbf26ccfea8a2011c1e7c6bf90c73969a9eff44c57d1a25c7f4d04528a49f54255ccd38662b1eb0009a96e0d0e376a3ad6ffa769ff0b03db892", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d0ba26264bf8dc323969039395cfad93f7853d2b13c3b37463d52588f2e35d9290e423c42f409591d5049d041665dcdc663be4ccce91b92a0d8307e4cea4bb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 13:07:44.456661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:07:44.457023) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.62jkUp0VWi/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.lhxhA0BeWe/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005385 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 13:07:44.508827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:07:44.509634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 13:07:44.510396) ========= ========= Total master_lag: 0.22 =========