builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0093 starttime: 1471100030.69 results: success (0) buildid: 20160813045415 builduid: 721258b7e380414f809460c46470db4b revision: d33489bb88626f512cf7aa58d631f6875aa2d696 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:50.690313) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:50.690676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:50.690944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:50.741741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:50.742071) ========= 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.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-08-13 07:53:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 60.0M=0s 2016-08-13 07:53:51 (60.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.514542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:51.280274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:51.280612) ========= 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.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.027854 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:51.331224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:53:51.331829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d33489bb88626f512cf7aa58d631f6875aa2d696 --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 d33489bb88626f512cf7aa58d631f6875aa2d696 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-08-13 07:53:51,410 truncating revision to first 12 chars 2016-08-13 07:53:51,410 Setting DEBUG logging. 2016-08-13 07:53:51,411 attempt 1/10 2016-08-13 07:53:51,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d33489bb8862?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 07:53:52,261 unpacking tar archive at: fx-team-d33489bb8862/testing/mozharness/ program finished with exit code 0 elapsedTime=1.117369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:53:52.472950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:52.473308) ========= script_repo_revision: d33489bb88626f512cf7aa58d631f6875aa2d696 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:52.473817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:52.474167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:53:52.525218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-08-13 07:53:52.525781) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:53:52 INFO - MultiFileLogger online at 20160813 07:53:52 in /builds/slave/test 07:53:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:53:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:52 INFO - {'append_to_log': False, 07:53:52 INFO - 'base_work_dir': '/builds/slave/test', 07:53:52 INFO - 'blob_upload_branch': 'Fx-Team', 07:53:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:52 INFO - 'branch': 'Fx-Team', 07:53:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:52 INFO - 'config_files': ('talos/mac_config.py',), 07:53:52 INFO - 'default_actions': ('clobber', 07:53:52 INFO - 'read-buildbot-config', 07:53:52 INFO - 'download-and-extract', 07:53:52 INFO - 'populate-webroot', 07:53:52 INFO - 'create-virtualenv', 07:53:52 INFO - 'install', 07:53:52 INFO - 'run-tests'), 07:53:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:52 INFO - 'download_minidump_stackwalk': True, 07:53:52 INFO - 'download_symbols': 'ondemand', 07:53:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:52 INFO - 'installer_path': 'installer.exe', 07:53:52 INFO - 'log_level': 'info', 07:53:52 INFO - 'log_name': 'talos', 07:53:52 INFO - 'log_to_console': True, 07:53:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:53:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:53:52 INFO - 'opt_config_files': (), 07:53:52 INFO - 'pip_index': False, 07:53:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:52 INFO - 'cmd': ('bash', 07:53:52 INFO - '-c', 07:53:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:52 INFO - 'enabled': True, 07:53:52 INFO - 'halt_on_failure': False, 07:53:52 INFO - 'name': 'check_screen_resolution'},), 07:53:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:52 INFO - 'cmd': ('bash', 07:53:52 INFO - '-c', 07:53:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:52 INFO - 'enabled': True, 07:53:52 INFO - 'halt_on_failure': False, 07:53:52 INFO - 'name': 'check_screen_resolution'},), 07:53:52 INFO - 'run_cmd_checks_enabled': True, 07:53:52 INFO - 'sps_profile': False, 07:53:52 INFO - 'sps_profile_interval': 0, 07:53:52 INFO - 'suite': 'dromaeojs', 07:53:52 INFO - 'system_bits': '32', 07:53:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:52 INFO - 'title': 't-yosemite-r7-0093', 07:53:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:52 INFO - 'use_talos_json': True, 07:53:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:52 INFO - 'work_dir': 'build'} 07:53:52 INFO - [mozharness: 2016-08-13 14:53:52.748430Z] Running clobber step. 07:53:52 INFO - Running pre-action listener: _resource_record_pre_action 07:53:52 INFO - Running main action method: clobber 07:53:52 INFO - rmtree: /builds/slave/test/build 07:53:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:55 INFO - Running post-action listener: _resource_record_post_action 07:53:55 INFO - [mozharness: 2016-08-13 14:53:55.018270Z] Finished clobber step (success) 07:53:55 INFO - [mozharness: 2016-08-13 14:53:55.018461Z] Running read-buildbot-config step. 07:53:55 INFO - Running pre-action listener: _resource_record_pre_action 07:53:55 INFO - Running main action method: read_buildbot_config 07:53:55 INFO - Using buildbot properties: 07:53:55 INFO - { 07:53:55 INFO - "project": "", 07:53:55 INFO - "product": "firefox", 07:53:55 INFO - "script_repo_revision": "production", 07:53:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:53:55 INFO - "repository": "", 07:53:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:53:55 INFO - "buildid": "20160813045415", 07:53:55 INFO - "pgo_build": "False", 07:53:55 INFO - "basedir": "/builds/slave/test", 07:53:55 INFO - "buildnumber": 85, 07:53:55 INFO - "slavename": "t-yosemite-r7-0093", 07:53:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:53:55 INFO - "platform": "yosemite_r7", 07:53:55 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:53:55 INFO - "branch": "fx-team", 07:53:55 INFO - "repo_path": "integration/fx-team", 07:53:55 INFO - "revision": "d33489bb88626f512cf7aa58d631f6875aa2d696", 07:53:55 INFO - "stage_platform": "macosx64", 07:53:55 INFO - "builduid": "721258b7e380414f809460c46470db4b", 07:53:55 INFO - "slavebuilddir": "test" 07:53:55 INFO - } 07:53:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:53:55 INFO - Running post-action listener: _resource_record_post_action 07:53:55 INFO - [mozharness: 2016-08-13 14:53:55.021881Z] Finished read-buildbot-config step (success) 07:53:55 INFO - [mozharness: 2016-08-13 14:53:55.021991Z] Running download-and-extract step. 07:53:55 INFO - Running pre-action listener: _resource_record_pre_action 07:53:55 INFO - Running main action method: download_and_extract 07:53:55 INFO - mkdir: /builds/slave/test/build/tests 07:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:55 INFO - trying https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:53:55 INFO - Downloading https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 07:53:55 INFO - Downloaded 1199 bytes. 07:53:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:53:55 INFO - Using the following test package requirements: 07:53:55 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:53:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:53:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:53:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'jsshell-mac.zip'], 07:53:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:53:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:53:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:53:55 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:53:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:53:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:53:55 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:53:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:55 INFO - trying https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:53:55 INFO - Downloading https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:53:56 INFO - Downloaded 16330496 bytes. 07:53:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:54:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:03 INFO - trying https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:54:03 INFO - Downloading https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:54:04 INFO - Downloaded 16330496 bytes. 07:54:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:11 INFO - trying https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:54:11 INFO - Downloading https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:54:11 INFO - Downloaded 14413719 bytes. 07:54:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:12 INFO - trying https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:54:12 INFO - Downloading https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 07:54:23 INFO - Downloaded 111041842 bytes. 07:54:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:54:23 INFO - mkdir: /builds/slave/test/properties 07:54:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:23 INFO - Contents: 07:54:23 INFO - build_url:https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:54:24 INFO - Running post-action listener: _resource_record_post_action 07:54:24 INFO - Running post-action listener: set_extra_try_arguments 07:54:24 INFO - [mozharness: 2016-08-13 14:54:24.422943Z] Finished download-and-extract step (success) 07:54:24 INFO - [mozharness: 2016-08-13 14:54:24.423074Z] Running populate-webroot step. 07:54:24 INFO - Running pre-action listener: _resource_record_pre_action 07:54:24 INFO - Running main action method: populate_webroot 07:54:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:24 INFO - '--tppagecycles', 07:54:24 INFO - '7'], 07:54:24 INFO - 'tests': ['tsvgm']}}, 07:54:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['damp', 'tps']}, 07:54:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'tests': ['damp', 'tps']}, 07:54:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['dromaeo_dom']}, 07:54:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['basic_compositor_video']}, 07:54:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:54:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['a11yr', 07:54:24 INFO - 'ts_paint', 07:54:24 INFO - 'tpaint', 07:54:24 INFO - 'sessionrestore', 07:54:24 INFO - 'sessionrestore_no_auto_restore', 07:54:24 INFO - 'tabpaint']}, 07:54:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['tsvgx', 07:54:24 INFO - 'tsvgr_opacity', 07:54:24 INFO - 'tart', 07:54:24 INFO - 'tscrollx', 07:54:24 INFO - 'cart']}, 07:54:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:24 INFO - 'tsvgr_opacity', 07:54:24 INFO - 'tart', 07:54:24 INFO - 'tscrollx', 07:54:24 INFO - 'cart']}, 07:54:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'talos_options': ['--disable-e10s'], 07:54:24 INFO - 'tests': ['tp5o']}, 07:54:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'tests': ['tp5o']}, 07:54:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'talos_options': ['--disable-e10s', 07:54:24 INFO - '--xperf_path', 07:54:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:24 INFO - 'tests': ['tp5n']}, 07:54:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:24 INFO - 'talos_options': ['--xperf_path', 07:54:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:24 INFO - 'tests': ['tp5n']}}, 07:54:24 INFO - 'talos.zip': {'path': '', 07:54:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:24 INFO - Running post-action listener: _resource_record_post_action 07:54:24 INFO - [mozharness: 2016-08-13 14:54:24.441583Z] Finished populate-webroot step (success) 07:54:24 INFO - [mozharness: 2016-08-13 14:54:24.441696Z] Running create-virtualenv step. 07:54:24 INFO - Running pre-action listener: _resource_record_pre_action 07:54:24 INFO - Running main action method: create_virtualenv 07:54:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:54:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:24 INFO - Using real prefix '/tools/python27' 07:54:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:28 INFO - Installing pip.................done. 07:54:28 INFO - Return code: 0 07:54:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54: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', 'pip>=1.5'] in /builds/slave/test/build 07:54: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 pip>=1.5 07:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:28 INFO - 'HOME': '/Users/cltbld', 07:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:28 INFO - 'LOGNAME': 'cltbld', 07:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:28 INFO - 'MOZ_NO_REMOTE': '1', 07:54:28 INFO - 'NO_EM_RESTART': '1', 07:54:28 INFO - 'PAGER': '/bin/cat', 07:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:28 INFO - 'PWD': '/builds/slave/test', 07:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:28 INFO - 'SHELL': '/bin/bash', 07:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:28 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:28 INFO - 'USER': 'cltbld', 07:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:28 INFO - 'XPC_FLAGS': '0x0', 07:54:28 INFO - 'XPC_SERVICE_NAME': '0', 07:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:28 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 07:54:28 INFO - Cleaning up... 07:54:28 INFO - Return code: 0 07:54:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', '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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:54: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 psutil>=3.1.1 07:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:28 INFO - 'HOME': '/Users/cltbld', 07:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:28 INFO - 'LOGNAME': 'cltbld', 07:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:28 INFO - 'MOZ_NO_REMOTE': '1', 07:54:28 INFO - 'NO_EM_RESTART': '1', 07:54:28 INFO - 'PAGER': '/bin/cat', 07:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:28 INFO - 'PWD': '/builds/slave/test', 07:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:28 INFO - 'SHELL': '/bin/bash', 07:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:28 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:28 INFO - 'USER': 'cltbld', 07:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:28 INFO - 'XPC_FLAGS': '0x0', 07:54:28 INFO - 'XPC_SERVICE_NAME': '0', 07:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:28 INFO - Downloading/unpacking psutil>=3.1.1 07:54:28 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 07:54:28 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 07:54:28 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 07:54:28 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 07:54:28 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 07:54:28 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 07:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:32 INFO - Installing collected packages: psutil 07:54:32 INFO - Running setup.py install for psutil 07:54:32 INFO - building 'psutil._psutil_osx' extension 07:54:32 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 07:54:33 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 07:54:33 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 07:54:33 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 07:54:33 INFO - building 'psutil._psutil_posix' extension 07:54:33 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 07:54:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:54:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:54:33 INFO - ^ 07:54:33 INFO - 1 warning generated. 07:54:33 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 07:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:33 INFO - Successfully installed psutil 07:54:33 INFO - Cleaning up... 07:54:33 INFO - Return code: 0 07:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:33 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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:33 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 07:54:33 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 07:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:33 INFO - 'HOME': '/Users/cltbld', 07:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:33 INFO - 'LOGNAME': 'cltbld', 07:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:33 INFO - 'MOZ_NO_REMOTE': '1', 07:54:33 INFO - 'NO_EM_RESTART': '1', 07:54:33 INFO - 'PAGER': '/bin/cat', 07:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:33 INFO - 'PWD': '/builds/slave/test', 07:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:33 INFO - 'SHELL': '/bin/bash', 07:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:33 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:33 INFO - 'USER': 'cltbld', 07:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:33 INFO - 'XPC_FLAGS': '0x0', 07:54:33 INFO - 'XPC_SERVICE_NAME': '0', 07:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:36 INFO - Installing collected packages: mozsystemmonitor 07:54:36 INFO - Running setup.py install for mozsystemmonitor 07:54:36 INFO - Successfully installed mozsystemmonitor 07:54:36 INFO - Cleaning up... 07:54:36 INFO - Return code: 0 07:54:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:36 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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:36 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 07:54:36 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 07:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:36 INFO - 'HOME': '/Users/cltbld', 07:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:36 INFO - 'LOGNAME': 'cltbld', 07:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:36 INFO - 'MOZ_NO_REMOTE': '1', 07:54:36 INFO - 'NO_EM_RESTART': '1', 07:54:36 INFO - 'PAGER': '/bin/cat', 07:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:36 INFO - 'PWD': '/builds/slave/test', 07:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:36 INFO - 'SHELL': '/bin/bash', 07:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:36 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:36 INFO - 'USER': 'cltbld', 07:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:36 INFO - 'XPC_FLAGS': '0x0', 07:54:36 INFO - 'XPC_SERVICE_NAME': '0', 07:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54:39 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 07:54:39 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 07:54:39 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 07:54:39 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 07:54:39 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 07:54:39 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 07:54:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:39 INFO - warning: no files found matching '*.txt' 07:54:39 INFO - no previously-included directories found matching 'build' 07:54:39 INFO - no previously-included directories found matching 'dist' 07:54:39 INFO - no previously-included directories found matching '.git*' 07:54:39 INFO - Installing collected packages: jsonschema, functools32 07:54:40 INFO - Running setup.py install for functools32 07:54:40 INFO - warning: no files found matching '*.txt' 07:54:40 INFO - no previously-included directories found matching 'build' 07:54:40 INFO - no previously-included directories found matching 'dist' 07:54:40 INFO - no previously-included directories found matching '.git*' 07:54:40 INFO - Successfully installed jsonschema functools32 07:54:40 INFO - Cleaning up... 07:54:40 INFO - Return code: 0 07:54:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:40 INFO - 'HOME': '/Users/cltbld', 07:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:40 INFO - 'LOGNAME': 'cltbld', 07:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:40 INFO - 'MOZ_NO_REMOTE': '1', 07:54:40 INFO - 'NO_EM_RESTART': '1', 07:54:40 INFO - 'PAGER': '/bin/cat', 07:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:40 INFO - 'PWD': '/builds/slave/test', 07:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:40 INFO - 'SHELL': '/bin/bash', 07:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:40 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:40 INFO - 'USER': 'cltbld', 07:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:40 INFO - 'XPC_FLAGS': '0x0', 07:54:40 INFO - 'XPC_SERVICE_NAME': '0', 07:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:40 INFO - Cleaning up... 07:54:40 INFO - Return code: 0 07:54:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:40 INFO - 'HOME': '/Users/cltbld', 07:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:40 INFO - 'LOGNAME': 'cltbld', 07:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:40 INFO - 'MOZ_NO_REMOTE': '1', 07:54:40 INFO - 'NO_EM_RESTART': '1', 07:54:40 INFO - 'PAGER': '/bin/cat', 07:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:40 INFO - 'PWD': '/builds/slave/test', 07:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:40 INFO - 'SHELL': '/bin/bash', 07:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:40 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:40 INFO - 'USER': 'cltbld', 07:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:40 INFO - 'XPC_FLAGS': '0x0', 07:54:40 INFO - 'XPC_SERVICE_NAME': '0', 07:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:44 INFO - Downloading docopt-0.6.1.tar.gz 07:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:44 INFO - Running setup.py install for blobuploader 07:54:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:44 INFO - Running setup.py install for requests 07:54:45 INFO - Running setup.py install for docopt 07:54:45 INFO - Successfully installed blobuploader requests docopt 07:54:45 INFO - Cleaning up... 07:54:45 INFO - Return code: 0 07:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:45 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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:45 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 07:54:45 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 07:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:45 INFO - 'HOME': '/Users/cltbld', 07:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:45 INFO - 'LOGNAME': 'cltbld', 07:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:45 INFO - 'MOZ_NO_REMOTE': '1', 07:54:45 INFO - 'NO_EM_RESTART': '1', 07:54:45 INFO - 'PAGER': '/bin/cat', 07:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:45 INFO - 'PWD': '/builds/slave/test', 07:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:45 INFO - 'SHELL': '/bin/bash', 07:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:45 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:45 INFO - 'USER': 'cltbld', 07:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:45 INFO - 'XPC_FLAGS': '0x0', 07:54:45 INFO - 'XPC_SERVICE_NAME': '0', 07:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:45 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-fpAibZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:45 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-JptvZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:45 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-L8CP6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:45 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-6uRjH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:45 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-xmagM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-CShZ5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-APBuB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-NimTvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wBiar_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-HCTR3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-OhIA1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-O0fBOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qouP2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:46 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-EHxy_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:47 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-5WLL1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:47 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-jnLN70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:47 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-9O3fJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:47 INFO - Running setup.py install for manifestparser 07:54:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:47 INFO - Running setup.py install for mozcrash 07:54:47 INFO - Running setup.py install for mozdebug 07:54:47 INFO - Running setup.py install for mozdevice 07:54:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:47 INFO - Running setup.py install for mozfile 07:54:48 INFO - Running setup.py install for mozhttpd 07:54:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Running setup.py install for mozinfo 07:54:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Running setup.py install for mozInstall 07:54:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Running setup.py install for mozleak 07:54:48 INFO - Running setup.py install for mozlog 07:54:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Running setup.py install for moznetwork 07:54:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:48 INFO - Running setup.py install for mozprocess 07:54:49 INFO - Running setup.py install for mozprofile 07:54:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:49 INFO - Running setup.py install for mozrunner 07:54:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:49 INFO - Running setup.py install for mozscreenshot 07:54:49 INFO - Running setup.py install for moztest 07:54:49 INFO - Running setup.py install for mozversion 07:54:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:49 INFO - Cleaning up... 07:54:49 INFO - Return code: 0 07:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:49 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 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:49 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 07:54:49 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 07:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:49 INFO - 'HOME': '/Users/cltbld', 07:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:49 INFO - 'LOGNAME': 'cltbld', 07:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:49 INFO - 'MOZ_NO_REMOTE': '1', 07:54:49 INFO - 'NO_EM_RESTART': '1', 07:54:49 INFO - 'PAGER': '/bin/cat', 07:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:49 INFO - 'PWD': '/builds/slave/test', 07:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:49 INFO - 'SHELL': '/bin/bash', 07:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:49 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:49 INFO - 'USER': 'cltbld', 07:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:49 INFO - 'XPC_FLAGS': '0x0', 07:54:49 INFO - 'XPC_SERVICE_NAME': '0', 07:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Sr7juI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-2U4Lh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-sGgLHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-iZvOLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-KQfKcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-CuFl6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-8XHFPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:50 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)) 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:50 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-0DT29f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-CK3yvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-kNsn_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-OWB_e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-xoyvuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-zoE7lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-kLiWnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-HnZM3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Imyiw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:51 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)) 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:51 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-KuVEs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:52 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)) 07:54:52 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)) 07:54:52 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)) 07:54:52 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)) 07:54:52 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)) 07:54:52 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)) 07:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:52 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 07:54:52 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 07:54:52 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 07:54:52 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 07:54:52 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 07:54:52 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 07:54:54 INFO - Downloading blessings-1.6.tar.gz 07:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:54 INFO - Installing collected packages: blessings 07:54:54 INFO - Running setup.py install for blessings 07:54:54 INFO - Successfully installed blessings 07:54:54 INFO - Cleaning up... 07:54:54 INFO - Return code: 0 07:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:55 INFO - Reading from file tmpfile_stdout 07:54:55 INFO - Current package versions: 07:54:55 INFO - blessings == 1.6 07:54:55 INFO - blobuploader == 1.2.4 07:54:55 INFO - docopt == 0.6.1 07:54:55 INFO - functools32 == 3.2.3-2 07:54:55 INFO - jsonschema == 2.5.1 07:54:55 INFO - manifestparser == 1.1 07:54:55 INFO - mozInstall == 1.12 07:54:55 INFO - mozcrash == 0.17 07:54:55 INFO - mozdebug == 0.1 07:54:55 INFO - mozdevice == 0.48 07:54:55 INFO - mozfile == 1.2 07:54:55 INFO - mozhttpd == 0.7 07:54:55 INFO - mozinfo == 0.9 07:54:55 INFO - mozleak == 0.1 07:54:55 INFO - mozlog == 3.3 07:54:55 INFO - moznetwork == 0.27 07:54:55 INFO - mozprocess == 0.23 07:54:55 INFO - mozprofile == 0.28 07:54:55 INFO - mozrunner == 6.12 07:54:55 INFO - mozscreenshot == 0.1 07:54:55 INFO - mozsystemmonitor == 0.3 07:54:55 INFO - moztest == 0.7 07:54:55 INFO - mozversion == 1.4 07:54:55 INFO - psutil == 3.1.1 07:54:55 INFO - requests == 1.2.3 07:54:55 INFO - wsgiref == 0.1.2 07:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:55 INFO - 'HOME': '/Users/cltbld', 07:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:55 INFO - 'LOGNAME': 'cltbld', 07:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:55 INFO - 'MOZ_NO_REMOTE': '1', 07:54:55 INFO - 'NO_EM_RESTART': '1', 07:54:55 INFO - 'PAGER': '/bin/cat', 07:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:55 INFO - 'PWD': '/builds/slave/test', 07:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:55 INFO - 'SHELL': '/bin/bash', 07:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:55 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:55 INFO - 'USER': 'cltbld', 07:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:55 INFO - 'XPC_FLAGS': '0x0', 07:54:55 INFO - 'XPC_SERVICE_NAME': '0', 07:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:54:55 INFO - Cleaning up... 07:54:55 INFO - Return code: 0 07:54:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f1b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc04adfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, '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.SBLoCDA0YD/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.zirAETPH0B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 07:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:55 INFO - 'HOME': '/Users/cltbld', 07:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:55 INFO - 'LOGNAME': 'cltbld', 07:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:55 INFO - 'MOZ_NO_REMOTE': '1', 07:54:55 INFO - 'NO_EM_RESTART': '1', 07:54:55 INFO - 'PAGER': '/bin/cat', 07:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:55 INFO - 'PWD': '/builds/slave/test', 07:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:55 INFO - 'SHELL': '/bin/bash', 07:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:54:55 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:55 INFO - 'USER': 'cltbld', 07:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:55 INFO - 'XPC_FLAGS': '0x0', 07:54:55 INFO - 'XPC_SERVICE_NAME': '0', 07:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:55 INFO - Cleaning up... 07:54:55 INFO - Return code: 0 07:54:55 INFO - Running post-action listener: _resource_record_post_action 07:54:55 INFO - Running post-action listener: _start_resource_monitoring 07:54:55 INFO - Starting resource monitoring. 07:54:55 INFO - [mozharness: 2016-08-13 14:54:55.604139Z] Finished create-virtualenv step (success) 07:54:55 INFO - [mozharness: 2016-08-13 14:54:55.605089Z] Running install step. 07:54:55 INFO - Running pre-action listener: _resource_record_pre_action 07:54:55 INFO - Running main action method: install 07:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:55 INFO - Reading from file tmpfile_stdout 07:54:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:55 INFO - Reading from file tmpfile_stdout 07:54:55 INFO - Output received: 07:54:55 INFO - Usage: mozinstall [options] installer 07:54:55 INFO - Options: 07:54:55 INFO - -h, --help show this help message and exit 07:54:55 INFO - -d DEST, --destination=DEST 07:54:55 INFO - Directory to install application into. [default: 07:54:55 INFO - "/builds/slave/test"] 07:54:55 INFO - --app=APP Application being installed. [default: firefox] 07:54:55 INFO - mkdir: /builds/slave/test/build/application 07:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:55:30 INFO - Reading from file tmpfile_stdout 07:55:30 INFO - Output received: 07:55:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:55:30 INFO - Running post-action listener: _resource_record_post_action 07:55:30 INFO - [mozharness: 2016-08-13 14:55:30.890167Z] Finished install step (success) 07:55:30 INFO - [mozharness: 2016-08-13 14:55:30.890302Z] Running run-tests step. 07:55:30 INFO - Running pre-action listener: _resource_record_pre_action 07:55:30 INFO - Running main action method: run_tests 07:55:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:30 INFO - 2016-08-13 07:55:30.903 screenresolution[1639:8212] starting screenresolution argv=screenresolution get 07:55:30 INFO - 2016-08-13 07:55:30.905 screenresolution[1639:8212] Display 0: 1600x1200x32@60 07:55:30 INFO - 2016-08-13 07:55:30.911 screenresolution[1640:8215] starting screenresolution argv=screenresolution list 07:55:30 INFO - Available Modes on Display 0 07:55:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:31 INFO - Intel Iris: 07:55:31 INFO - Chipset Model: Intel Iris 07:55:31 INFO - Type: GPU 07:55:31 INFO - Bus: Built-In 07:55:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:31 INFO - Vendor: Intel (0x8086) 07:55:31 INFO - Device ID: 0x0a2e 07:55:31 INFO - Revision ID: 0x0009 07:55:31 INFO - Displays: 07:55:31 INFO - Display: 07:55:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:31 INFO - Display Serial Number: 1600x1200 60 07:55:31 INFO - Main Display: Yes 07:55:31 INFO - Mirror: Off 07:55:31 INFO - Online: Yes 07:55:31 INFO - Rotation: Supported 07:55:31 INFO - Return code: 0 07:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:31 INFO - Python 2.7.3 07:55:31 INFO - Return code: 0 07:55:31 INFO - grabbing minidump binary from tooltool 07:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:31 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 0x101dead30>, '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 0x101b4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:31 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 07:55:31 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 07:55:31 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 07:55:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:31 INFO - Return code: 0 07:55:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:55:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:55:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SBLoCDA0YD/Render', 07:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:31 INFO - 'HOME': '/Users/cltbld', 07:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:31 INFO - 'LOGNAME': 'cltbld', 07:55:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:31 INFO - 'MOZ_NO_REMOTE': '1', 07:55:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:31 INFO - 'NO_EM_RESTART': '1', 07:55:31 INFO - 'PAGER': '/bin/cat', 07:55:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:31 INFO - 'PWD': '/builds/slave/test', 07:55:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:31 INFO - 'SHELL': '/bin/bash', 07:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zirAETPH0B/Listeners', 07:55:31 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 07:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:31 INFO - 'USER': 'cltbld', 07:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:31 INFO - 'XPC_FLAGS': '0x0', 07:55:31 INFO - 'XPC_SERVICE_NAME': '0', 07:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:55:31 INFO - mozversion application_buildid: 20160813045415 07:55:31 INFO - mozversion application_changeset: d33489bb88626f512cf7aa58d631f6875aa2d696 07:55:31 INFO - mozversion application_display_name: Nightly 07:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:31 INFO - mozversion application_name: Firefox 07:55:31 INFO - mozversion application_remotingname: firefox 07:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:55:31 INFO - mozversion application_vendor: Mozilla 07:55:31 INFO - mozversion application_version: 51.0a1 07:55:31 INFO - mozversion platform_buildid: 20160813045415 07:55:31 INFO - mozversion platform_changeset: d33489bb88626f512cf7aa58d631f6875aa2d696 07:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:55:31 INFO - mozversion platform_version: 51.0a1 07:55:31 INFO - using testdate: 1471100131 07:55:31 INFO - actual date: 1471100131 07:55:31 INFO - starting webserver on 'localhost:49277' 07:55:31 INFO - SUITE-START | Running 2 tests 07:55:31 INFO - TEST-START | dromaeo_css 07:55:31 INFO - operating with platform_type : mac_ 07:55:31 INFO - Initialising browser for dromaeo_css test... 07:55:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpW0Qynz/profile http://localhost:49277/getInfo.html) 07:55:34 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:55:34 INFO - PROCESS | 1650 | colorDepth:24 07:55:34 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:55:34 INFO - PROCESS | 1650 | __metrics 07:55:34 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:34 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:35 INFO - TEST-INFO | 1650: exit 0 07:55:35 INFO - Browser initialized. 07:55:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:35 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpW0Qynz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:47 INFO - PROCESS | 1653 | RSS: Main: 228495360 07:55:47 INFO - PROCESS | 1653 | 07:56:38 INFO - PROCESS | 1653 | 1471100198684 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] 07:58:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 07:58:51 INFO - PROCESS | 1653 | RSS: Main: 305614848 07:58:51 INFO - PROCESS | 1653 | 08:01:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 08:01:55 INFO - PROCESS | 1653 | RSS: Main: 374984704 08:01:55 INFO - PROCESS | 1653 | 08:04:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 08:04:58 INFO - PROCESS | 1653 | RSS: Main: 364290048 08:04:58 INFO - PROCESS | 1653 | 08:08:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 08:08:01 INFO - PROCESS | 1653 | RSS: Main: 341569536 08:08:01 INFO - PROCESS | 1653 | 08:11:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 08:11:05 INFO - PROCESS | 1653 | RSS: Main: 325877760 08:11:05 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 08:14:08 INFO - PROCESS | 1653 | RSS: Main: 395042816 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | __start_tp_report 08:14:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:14:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:14:08 INFO - PROCESS | 1653 | |i|pagename|runs| 08:14:08 INFO - PROCESS | 1653 | |0;dojo.html;2831.653412012561;3389.7457690673205;3398.524206611075;3402.9149271268197;3417.829108544572;5573.136163894593;5724.169995350671;5743.597948143632;5760.740766665504;5817.8836423271505;5265.86783841474;5508;5750.568707346955;5880.500157486619;5892.9705351473185;5169.922451163236;5206.062908676456;5234.7120908350025;5253.842384728464;5315.840524784263;5308.362996440433;5311.282976798121;5316.840494785143;5320.813771517997;5350.839474815762;5234.0840352938085;5253.605979551549;5257.5005374489365;5276.419593844674;5278.102722537178;4323.437953066113;5272;5274.208868669692;5278.604104692164;5281;5168.250603662448;5207.817726379596;5230.34620672416;5245.055889939809;5261.4475480074425;4790.377250957388;5730.025895597759;5773.9422605773825;5805;5809.796657116981;6162.506999440034;6244.718987645521;6245.500359971192;6257;6267.373262673742;6114.388610881752;6154.969225153845;6274.592151510183;6294.905576416358;6299.275583307933;4900.901981960341;5841.007028805113;5860.355360910296;5902.203202567642;5980.282366116007;5967.850803729942;6076.939230607726;6293.842653933688;6296.590721603081;6317;6037.909431358533;6088.001827990062;6135.693215339215;6204.627722336674;6218.409251121137;5093.923591146136;5964.552658550626;6300.936990630126;6307.432331090132;6321.399467050623;5605.411431799684;6236.594621349598;6255.562110652301;6266.436020758154;6276.874462510724;6026.096085587197;6126.456603435028;6227.283862355796;6253.343398943045;6259.186305780219;4970.403551573834;5004.174311238678;5004.3994720633755;5029.874253143701;5049.293098966147;4489.281714925662;4495.078508905666;4502.594766471033;4524.389207457017;4550.84072057483;5166.948330516647;5573.662321042921;5677.205191273225;5743.0811070228565;5760.913586296209;6150.862090513269;6175.505959523227;6193.876122477525;6209.472194863487;6228.937710622836;5774;5787.8553036174435;5805.883882322414;5810.912836307459;5842.152887831241;5364.919526207032;5497.147942068986;5497.862553436196;5513.283273174542;5513.365962914236;6110.558759196641;6179.969100154651;6191.442770150528;6211.161493198541;6230.283517395557;6121.635889161074;6173.567850250619;6200.255969283715;6220.875582488416;6221.751129954751;6313.210848643919;6313.873722525615;6318.747250110128;6323.399277068671;6346.460550853045;6108.267007959073;6128.050152226412;6212.658303793335;6220.222472190976;6222.533310001859;5024;6130.612163469812;6144.893919094606;6146.938530614815;6154.076888466766;4289.871303860889;6175.62946223228;6179.351168127461;6191.040388739752;6194.969025154845;6112.908306375497;6133.233345831771;6145.877082458415;6152.354002829638;6177.382261773787;5045.621578381562;5873;5959.851003724942;6038;6104.725287362168;6133.6319820810895;6137.324894261538;6162.352952940056;6167.198264225622;6173.290071641639;4705.882352941204;5910.497607703393;5997.280326360865;6013.87972240544;6067.787627433018 08:14:08 INFO - PROCESS | 1653 | |1;ext.html;507.9282713474566;508.3188527373319;512.4619149892612;518.3132349636732;526.812981391606;40920.59079409205;42352.788236058776;42503.57496425035;42514.57485425145;44496.110077798425;43785;44159.55840441595;44265;44291.55708442914;44298.11403771923;8976.775580610472;9096.63613455461;9860.506974651256;10057.647982320621;10094.192464602815;12131.696707582338;12376.690582735413;12383.25700457971;12609.558665446712;12613.558525451612;9978.501074946224;12028.879711202864;12084.516619335216;12097.516099356015;12147.514099436012;12202;12250.387480626023;12267.325297108655;12274.447649855778;12281.69295767604;12038.097142714332;12119.93940030303;12133.150679452441;12135;12159.817602735966;41394.58605413938;41745.79127104375;41785.58214417847;41792.582074179474;41835.7908210457;3446.5174875517446;3572.732045096628;3703.037210325335;3869.2648396804516;4133.81397837095;31556.526652100238;32792.01623951285;32809.3438131236;32944.83527582371;32952.011439656846;3227.5481432599454;3293.4236508610898;3323.5513205717402;3361.9495707564406;3437.1407148212948;526624;526703;526785.366073171;528694;530204;59914.70042649846;60325;60372;60411;60430;65417.018744718865;65482;66009.6798064036;66098.33901661017;66152;16126.354945802037;16335.754963675317;16338.591535211715;16353.264103115389;16369;11430.542778288775;11709.473073711704;12510.81233781494;12720.300383478998;12833.294168820805;15337.846621533865;16274.75587866183;18037;18043.729344059848;18208.362707305445;6152.569320147547;6160.322364539897;6162.907556386658;6235.376462353728;6260.092286618415;855.9471849624872;942.599395257013;1008.4503945349802;1013.3565186106728;1054.3568423261804;30216.395672086433;31251.531227031614;31651.683483164874;31744.523832142535;32703.672963270063;915.2632131134501;987.3039507147444;995.4574756757585;1073.1254027967182;1081.259337353915;15134.243287835785;15793.070764011965;15799.210039497979;15955.441559545361;16019.759703604455;625040;638727;639095;639373;641013;58402;58542;58732.11901821476;58745;58778;1116.9497372618089;1219.5731493977214;1258.452573130691;1360.415021540747;1386.7018591002782;28392.716072839008;30980;32507.512387313735;32879.67120328766;33310.5003424944;57911.420885790605;58736.706316468146;58757;58852;59009;588958;592499;592718.0364098152;593690;593924;26534;26935;27182.72817271802;27822.304442388293;27841.721582783914;48957.020859583325;49578.25632615586;49588.752056239486;49917;50149.49850501448;39443.605563943995;39698.80150599228;40206.597934021454;40952.385714214906;41170.38244426276;33265;39664.80167599144;39760;40335.1932961345;41239.587604124776;37971.620283797914;39257.803710981265;39283;39463.80268098641;39517.60482395254;31171.688283116877;34757;34844.12889677677;35221.82389088038;35323.82338088293;24595;25237.495250095264;25819.870900645376;25850.35374115662;25890.87054564715 08:14:08 INFO - PROCESS | 1653 | |2;jquery.html;354.5922189482097;368.13855577947595;376.8304263081613;382.7990305089828;404.3873531599627;15571.610709732247;16071.51785446437;20244.797552024513;20624;20710.585788284243;21214.04536795844;21315;21716.782832171673;21791.891040544775;21989;5898.528117750569;6035.54733394996;6067.120267561201;6146.262448506185;6233.532485063615;4200.138971510848;6059.091136329542;6165.0752387142065;6165.876682466348;6166.475849552793;6430.164078669766;6697.397234248917;6726.327367263283;6820.11338525991;6828.317168283182;6551.082848401227;6668.366505182;6754.088198093244;6787.2534021257625;6801.591904485697;5092.9745351273;5698.945695046388;5862.648241105505;5873.383294754075;5873.85315367115;13568;13805.723885522233;23240.53518929612;24806.751932480624;25640.230793076236;2120.4062862398555;2202.678392964209;2217.634090375086;2641.735826417362;3025.8789648414036;9989.850152247722;10156.289059765819;10306.278560500768;10369.118624916891;10492.842607360895;1891.489297889562;1896.535348839543;2008.367364280247;2055.4758536573077;2062.257587268582;119193;126231.36884315612;126856;127564;134940.6505934938;11073.612423565137;11186.944065279622;11546.247469572254;11666.600007998924;12093.57672481459;14684.926575367055;14712;14716.33776480061;14717.337719802634;14719.632009199855;8594.054653988182;8731.126887311346;8737.38838281327;8775.912240877637;8927.151920567536;7437.809950407909;7504.699812007568;8360.916390836135;8702.608382622797;8920.197182253629;4389.1660584488845;4530.841420550265;4544.590986811203;4550.977245113753;4671.929921051187;1850.9074546272632;1895.2229585870002;1907.3515004898402;1909.3508207209616;1910.2740958435706;663.6250518457057;731.381982225019;839.47532792005;904.5251243097426;996.8884693566621;20777.896110519654;21547.353579392642;21621.783782162292;21676.024578893986;21678.34964951054;838.4328061670512;933.5985526223789;942.8973833114989;1019.4462870509327;1026.2867307221559;10421.635242766466;11224.887751122547;11314.60398886035;11462.885371146349;11498.482568284448;598054;601158;611768;623877;627932;47932.760336198095;101107.86705595376;123973.38013310057;136377.63622363648;138450;753.1335736188038;929.1916033051289;936.4849332866896;948.061419194992;974.5906719177821;16769.245383957506;19145.712814307517;19381.224751009802;19487.584232899775;19669.901650491654;54264.75955265195;55532.88934221374;55751.721241393534;56515.71742141263;56610.58473538195;78936;80389.59805200937;83145.16854831616;85631;87073;7099.751508697171;7354.712925237955;7790.649420775965;7825.139234684294;8096.635651395819;9298.814023719622;12637.304948227937;13040.673983150118;13183.472661093449;13236.205827650372;10728.624498142528;10844.728881778019;10923.78152436931;11044.558217671525;11091.5563377464;10863;10873.619423320146;11199.66401007971;11215.786060464996;11381.886181138083;8971;10364.274500784873;11331.773364532499;11440.313581185155;11769.352685602375;6063.757449701962;7944.689126294097;7985.880211796712;8106.959465202636;8110;9241.896731719386;10097.44464054484;11292.943535282271;11362.829557556808;11427.942860285646 08:14:08 INFO - PROCESS | 1653 | |3;mootools.html;1267.961961141166;1333.253378108259;1495.3569964915087;1628.3079691131265;1690.298526111663;7769.223077692228;8505.48967061976;8733.083026282236;8741.694040708577;8853.203211710961;8599.613017414216;8672.91327086729;8673.653053877853;8693.913060869389;8694.043655197924;2216.2907869481733;2243.4391402149463;2247.1236217875044;2248.022110381981;2250.5723912456665;2212.3141826033902;2233.7207849018873;2253.481699209183;2254.278630838124;2257.063318722728;2212.524307273936;2231.4867580456503;2239.395363251921;2241.7197850268717;2250.6061439248065;2185.9507436430604;2201.438633148545;2206.382212980352;2207.5033117548664;2210;2200.4388880835445;2215.4129155773735;2216.2243214874825;2216.789405006522;2217.1463986365366;8734.47593144407;8736.432131911406;8914.598843052014;8926.910730892738;8934.329925255632;5143.511366420222;5301.0723123453245;5336.573074154058;5340.759665815048;5355.6251062425645;3455.2053027803745;3627.8004709740953;3707.295613833363;3711.164987877733;3712.888613341577;1092.4974511724615;1099.3184225779987;1101.4492753623188;1109.9223054386196;1124.3928278729477;11542.711432214262;11561.017313528277;11644.708882278012;11670.183087183901;11675.532978680843;4346.391505189276;4491.573300536444;4618.67669263155;4621.584057434847;4646.094011667692;9163.358564900393;9164.6792362267;9168.174864262115;9173.908260917306;9175.220106290906;5222.451642577475;5224.346956630421;5226.503482169188;5227.059129356752;5243.973780131075;4121.639858846574;4494.9325760113625;4875.926861097087;4901.044296362246;4904.141775189328;3745.2696724139078;3770.245950809849;3828.0429892526868;3857.7685338879755;3861.826217820205;1153.3425947210178;1172.0974849365941;1173.4308860202796;1177.9941100294616;1181.0728578066178;840.6973489543759;854.7008547008512;900.0516016353739;916.4409710076848;935.0976307862809;5652.773889044474;5767.394423585547;6016.488598469179;6019.638821670714;6112.572119951561;445.9197344478025;459.5014409365809;460.1556144474859;1005.3214080495636;1009.5406590001531;3877.747946383476;3991.5409727881083;4025.496812898388;4031.7782521960985;4042.2521833460905;10271.589136434459;10660.360378377321;10909.23635345534;10982.890171098346;11004.834927476095;10581.894181058246;10904.34573925567;10918.344899306067;10930.939336985657;10937.507812148473;6816.965915170492;7925.405594580314;8112.472689275178;8292.087870334259;8342.332613390914;5772.5381969441505;5950.613210141327;5993.250843644544;6172.6913654318005;6190.535709821871;10011.499425028574;10223.182145428496;10267.332623379456;10278.434686092336;10299.3820370778;9060.411073280216;10097.19222462216;10115.443650599287;10271.378435665049;10318.019788120117;6326.778562750282;7523.924760752541;7538.434617403826;7599.544027358376;7599.582022988789;7484.288992545699;7575.356094732009;7707.460477766726;8194.426390152632;8195.508269503849;7461.776146715607;7463.813404664709;7510.662020208994;7518.173000969779;7604.581748003913;7438.479306448497;7460.626968651654;7475.775726728207;7501.399888009056;7536.849263014599;6735.663216839236;6883.7590684325805;6966.7213311469;7007.054047703698;7080.327368899946;4996.425411077773;4998.525140111684;5040.84877453677;5083.618728595444;5141.0232055909255;4683.625309975126;4993.550580447777;5067.189249720027;5128.230765385222;5151.793928242978 08:14:08 INFO - PROCESS | 1653 | |4;prototype.html;296.1441434255002;302.91669790807526;310.8911880841705;315.1773870198782;318.17116411747395;5176.240078373352;5343.89312213756;5372.382176049756;5386.757595908184;5429.701366424845;5170.974145129278;5278.630495865282;5301.602379821509;5302.390225124112;5452.781888724447;3382.7293816494685;3940.901477463072;4099.467069281004;4124.401961715549;4212.705110642256;3216.823074730889;3389.542411774416;4002.9592306000504;4136.875893723193;4155.729877557964;3521.8906044595997;3544.954238499649;3788.916096147122;4074.1851629674034;4113.609207125318;3085.691430856919;3179.920501987457;3574.891783547109;3838.808059597009;3890.949443650227;2843.530817415124;3417.9145521361916;3451.6030656474327;3467.289205712823;3604.387254166798;5166.199239117943;5215.843524694265;5244.606654500928;5246.921296180561;5258.342707161605;4477.776111194427;4752.643551733634;4756.7859446325;4757.429108506966;4769.451513075971;4654.813807447698;5635.971820140873;5654.6324488908085;5658.377578466366;5708.486236238717;3948.269570129535;3950.960490395088;3952.960470395288;3975.2447035063246;3982.76103433792;4571.839985600488;4960.776765045545;5067.695938243717;5593.825296687701;5904.2029326040865;3251.3659836332163;3850.7111966602056;3888;3894.3963685628773;3898.6101389860787;3195.5526226328334;3717.4423836424753;3787.617519605324;3952.754882212094;3971.3050216212046;4024.2555127301544;4037.4953130858644;4488.730676159375;4612.607928326062;4658.624101708086;5213.582913366998;5602.607817452821;5732.914006289909;5795.724940513081;5810.854728631733;1202.687301301668;1272.3713646532453;1308.156239225713;1316.394458549059;1323.6829354792044;739.8927155562413;769.5036701327613;812.7642983534827;972.644984580623;976.2531663277598;5267.7366131694025;5301.655392399482;5339.439358867263;5362.410134885159;5366.7048312343195;4912.287718280829;5156.905856486153;5417.968261901787;5469.890602187934;5619.213310136584;5254.579633629377;5255.474452554714;5264.5525130363585;5280.366356037223;5327.840164795062;2534.176392672389;2543.936401589938;3016.291171574678;3033.2720147164523;3035.2260173655577;5352.518273355417;5392.245085688007;5690.780595567732;5960.284765828128;5983.551233657493;5165.793368265303;5810.680412577349;5866.413358664185;5900.468957793819;5911.290645122613;4956.810365512251;5208.91643342666;5811.651300921873;5886.440788125121;5913.29040515141;4270.722403043792;5238.292830467991;5639.533721232591;5746.367899531132;5748;5127.46161653021;5325.695204674879;5624.987502249634;5683.3748287687495;5690.914636280542;5642.463965923231;5890.028145355968;5913.231279933581;5919.289685237799;5946.702664866826;3990.4612877261197;3992.461017762681;4009.218202450494;4027.234825383285;4050.1899620075515;5077.517635824591;5532.2254884315425;5727.427257274239;5739.827805165852;5767.7981270657;5389;5645.745941432728;5665.971670141623;5673.716314184357;5716.255852416673;4915.827946021872;5035.823746168867;5087.771050302671;5592.568546171772;5607.8878422432135;4767.996162417655;5331.866703332447;5445.727713614383;5488.271194573696;5508.669479831223;4681.789319480564;4880.731559764247;4985.800567977385;5531.865967476577;5622.987862184846;4782.545658162469;5480.205370221216;5484.407712948026;5561.888762224814;5623.3814280428305 08:14:08 INFO - PROCESS | 1653 | |5;yui.html;707.8548897476018;711.2176605733694;756.9621518924056;774.5043172369681;842.1746688245521;15453;16431.67136657266;16433.17834108294;17211.741823872653;17960.281588736434;16545.090020048894;16906;16930.661386772255;16934.153292335366;17113.82886171138;674.56153500225;836.8661014237723;858.6307887608326;860.9139086091373;861.1474640106312;687.549654975989;839.3998291221775;861.7156338408311;872.7992561710811;874.7638137702817;910.512875611548;911.968081117161;914.8124634449922;914.8170365926808;915.9496227707474;641.6182371489003;838.8825564420986;907.2469850024464;907.3376435202273;907.8728977943093;531.3278702441414;593.1814096546781;646.8221239159221;664.3821246240994;666.4934649666241;15266.542003739905;15313.770293445607;15334.539963801104;15343.156126413043;15346.386144554204;13624.795628065587;13984.720305593934;14037.929810350985;14046.92976535121;14095.78856317156;12949;13131.303085155065;13260;13410.731785364238;13486.39311230997;4519.661025423106;4547.772611369418;4567.725936443824;4577.5880170784785;4686.554777296152;96866.5156674212;126923;127096.65485124021;127107.72892271144;128289;10713.517891694892;10742.838857417146;10923.836142457869;11131.666050018512;11407.08743300534;21634.350969470943;21635.67546486804;21636.9444902734;21642.35072947814;21643.35069947904;6617.908045172589;7625.275598818103;7631.084269887649;7760.573168475675;7812.882806757903;4107.54816970133;4131.318332475168;4319.892002699958;4339.9783001085425;4351.303791393425;3427.657234276602;3462.0306314232057;3540.1149712571855;3541.0793193769805;3548.6451354864307;633.7369991453495;637.4645297949744;658.1016911915297;674.6626686656672;682.2120450879243;597.3399393670019;602.466816867067;654.1365397675119;671.8155940840381;697.2225968045694;8294.875576866352;9418.293627977791;9778.804423911624;9810.11708946184;9822.803543929223;634.8857205702925;674.652553934724;691.7647999680133;697.5814511293183;709.609714656947;4546.227141385973;4650.441946966385;4791.281307803857;4799.880002999953;4806.807727690853;158012;160338.39661603468;162088;163971;165447;140438.2978085103;142341;144042;144763;144868;113359;121566.3921680386;123724.38137809253;124485.75514244923;125367;8623.525706086226;8635.784105397415;9264;9288.72133835986;9391.483468409304;65684;67383;67744;68441;69074.54627268515;83209;97059;100197.99802002178;101974;102308;11827.349495777815;11967.222130561486;12082.51669933228;12117.15179937396;12674.112812103065;13241;13294.667633309246;13394.397252123483;13402.329883505981;13528.39122239482;10008.549615267477;12425.31660758667;12430.378481076092;12674.873251267738;12687.22378866941;12367;12392.81410778821;12433.06751993586;12662.556810511587;12671.17637353569;12032.939835300767;12159.635210943687;12170.817437738619;12284.754304914031;12315.630531084082;9823.901760982584;9900.702978910644;10291.092905699783;10848.945755271174;11042.061424778984;8423.820665106767;10241.692749217535;10497.317674351143;10671.253012289375;10681.924195357276 08:14:08 INFO - PROCESS | 1653 | __end_tp_report 08:14:08 INFO - PROCESS | 1653 | __start_cc_report 08:14:08 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1495 08:14:08 INFO - PROCESS | 1653 | __end_cc_report 08:14:08 INFO - PROCESS | 1653 | __startTimestamp1471101248923__endTimestamp 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:14:08 INFO - PROCESS | 1653 | Number of tests: 6 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5702.89 Median:5959.85 stddev:663.13 (11.1%) stddev-sans-first:625.74 08:14:08 INFO - PROCESS | 1653 | Values: 2831.7 3389.7 3398.5 3402.9 3417.8 5573.1 5724.2 5743.6 5760.7 5817.9 5265.9 5508.0 5750.6 5880.5 5893.0 5169.9 5206.1 5234.7 5253.8 5315.8 5308.4 5311.3 5316.8 5320.8 5350.8 5234.1 5253.6 5257.5 5276.4 5278.1 4323.4 5272.0 5274.2 5278.6 5281.0 5168.3 5207.8 5230.3 5245.1 5261.4 4790.4 5730.0 5773.9 5805.0 5809.8 6162.5 6244.7 6245.5 6257.0 6267.4 6114.4 6155.0 6274.6 6294.9 6299.3 4900.9 5841.0 5860.4 5902.2 5980.3 5967.9 6076.9 6293.8 6296.6 6317.0 6037.9 6088.0 6135.7 6204.6 6218.4 5093.9 5964.6 6300.9 6307.4 6321.4 5605.4 6236.6 6255.6 6266.4 6276.9 6026.1 6126.5 6227.3 6253.3 6259.2 4970.4 5004.2 5004.4 5029.9 5049.3 4489.3 4495.1 4502.6 4524.4 4550.8 5166.9 5573.7 5677.2 5743.1 5760.9 6150.9 6175.5 6193.9 6209.5 6228.9 5774.0 5787.9 5805.9 5810.9 5842.2 5364.9 5497.1 5497.9 5513.3 5513.4 6110.6 6180.0 6191.4 6211.2 6230.3 6121.6 6173.6 6200.3 6220.9 6221.8 6313.2 6313.9 6318.7 6323.4 6346.5 6108.3 6128.1 6212.7 6220.2 6222.5 5024.0 6130.6 6144.9 6146.9 6154.1 4289.9 6175.6 6179.4 6191.0 6195.0 6112.9 6133.2 6145.9 6152.4 6177.4 5045.6 5873.0 5959.9 6038.0 6104.7 6133.6 6137.3 6162.4 6167.2 6173.3 4705.9 5910.5 5997.3 6013.9 6067.8 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:72662.89 Median:20920.44 stddev:156745.20 (749.2%) stddev-sans-first:157091.29 08:14:08 INFO - PROCESS | 1653 | Values: 507.9 508.3 512.5 518.3 526.8 40920.6 42352.8 42503.6 42514.6 44496.1 43785.0 44159.6 44265.0 44291.6 44298.1 8976.8 9096.6 9860.5 10057.6 10094.2 12131.7 12376.7 12383.3 12609.6 12613.6 9978.5 12028.9 12084.5 12097.5 12147.5 12202.0 12250.4 12267.3 12274.4 12281.7 12038.1 12119.9 12133.2 12135.0 12159.8 41394.6 41745.8 41785.6 41792.6 41835.8 3446.5 3572.7 3703.0 3869.3 4133.8 31556.5 32792.0 32809.3 32944.8 32952.0 3227.5 3293.4 3323.6 3361.9 3437.1 526624.0 526703.0 526785.4 528694.0 530204.0 59914.7 60325.0 60372.0 60411.0 60430.0 65417.0 65482.0 66009.7 66098.3 66152.0 16126.4 16335.8 16338.6 16353.3 16369.0 11430.5 11709.5 12510.8 12720.3 12833.3 15337.8 16274.8 18037.0 18043.7 18208.4 6152.6 6160.3 6162.9 6235.4 6260.1 855.9 942.6 1008.5 1013.4 1054.4 30216.4 31251.5 31651.7 31744.5 32703.7 915.3 987.3 995.5 1073.1 1081.3 15134.2 15793.1 15799.2 15955.4 16019.8 625040.0 638727.0 639095.0 639373.0 641013.0 58402.0 58542.0 58732.1 58745.0 58778.0 1116.9 1219.6 1258.5 1360.4 1386.7 28392.7 30980.0 32507.5 32879.7 33310.5 57911.4 58736.7 58757.0 58852.0 59009.0 588958.0 592499.0 592718.0 593690.0 593924.0 26534.0 26935.0 27182.7 27822.3 27841.7 48957.0 49578.3 49588.8 49917.0 50149.5 39443.6 39698.8 40206.6 40952.4 41170.4 33265.0 39664.8 39760.0 40335.2 41239.6 37971.6 39257.8 39283.0 39463.8 39517.6 31171.7 34757.0 34844.1 35221.8 35323.8 24595.0 25237.5 25819.9 25850.4 25890.9 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35254.62 Median:2833.81 stddev:102167.13 (3605.3%) stddev-sans-first:102420.13 08:14:08 INFO - PROCESS | 1653 | Values: 354.6 368.1 376.8 382.8 404.4 15571.6 16071.5 20244.8 20624.0 20710.6 21214.0 21315.0 21716.8 21791.9 21989.0 5898.5 6035.5 6067.1 6146.3 6233.5 4200.1 6059.1 6165.1 6165.9 6166.5 6430.2 6697.4 6726.3 6820.1 6828.3 6551.1 6668.4 6754.1 6787.3 6801.6 5093.0 5698.9 5862.6 5873.4 5873.9 13568.0 13805.7 23240.5 24806.8 25640.2 2120.4 2202.7 2217.6 2641.7 3025.9 9989.9 10156.3 10306.3 10369.1 10492.8 1891.5 1896.5 2008.4 2055.5 2062.3 119193.0 126231.4 126856.0 127564.0 134940.7 11073.6 11186.9 11546.2 11666.6 12093.6 14684.9 14712.0 14716.3 14717.3 14719.6 8594.1 8731.1 8737.4 8775.9 8927.2 7437.8 7504.7 8360.9 8702.6 8920.2 4389.2 4530.8 4544.6 4551.0 4671.9 1850.9 1895.2 1907.4 1909.4 1910.3 663.6 731.4 839.5 904.5 996.9 20777.9 21547.4 21621.8 21676.0 21678.3 838.4 933.6 942.9 1019.4 1026.3 10421.6 11224.9 11314.6 11462.9 11498.5 598054.0 601158.0 611768.0 623877.0 627932.0 47932.8 101107.9 123973.4 136377.6 138450.0 753.1 929.2 936.5 948.1 974.6 16769.2 19145.7 19381.2 19487.6 19669.9 54264.8 55532.9 55751.7 56515.7 56610.6 78936.0 80389.6 83145.2 85631.0 87073.0 7099.8 7354.7 7790.6 7825.1 8096.6 9298.8 12637.3 13040.7 13183.5 13236.2 10728.6 10844.7 10923.8 11044.6 11091.6 10863.0 10873.6 11199.7 11215.8 11381.9 8971.0 10364.3 11331.8 11440.3 11769.4 6063.8 7944.7 7985.9 8107.0 8110.0 9241.9 10097.4 11292.9 11362.8 11427.9 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5645.38 Median:4664.86 stddev:3208.85 (68.8%) stddev-sans-first:3200.99 08:14:08 INFO - PROCESS | 1653 | Values: 1268.0 1333.3 1495.4 1628.3 1690.3 7769.2 8505.5 8733.1 8741.7 8853.2 8599.6 8672.9 8673.7 8693.9 8694.0 2216.3 2243.4 2247.1 2248.0 2250.6 2212.3 2233.7 2253.5 2254.3 2257.1 2212.5 2231.5 2239.4 2241.7 2250.6 2186.0 2201.4 2206.4 2207.5 2210.0 2200.4 2215.4 2216.2 2216.8 2217.1 8734.5 8736.4 8914.6 8926.9 8934.3 5143.5 5301.1 5336.6 5340.8 5355.6 3455.2 3627.8 3707.3 3711.2 3712.9 1092.5 1099.3 1101.4 1109.9 1124.4 11542.7 11561.0 11644.7 11670.2 11675.5 4346.4 4491.6 4618.7 4621.6 4646.1 9163.4 9164.7 9168.2 9173.9 9175.2 5222.5 5224.3 5226.5 5227.1 5244.0 4121.6 4494.9 4875.9 4901.0 4904.1 3745.3 3770.2 3828.0 3857.8 3861.8 1153.3 1172.1 1173.4 1178.0 1181.1 840.7 854.7 900.1 916.4 935.1 5652.8 5767.4 6016.5 6019.6 6112.6 445.9 459.5 460.2 1005.3 1009.5 3877.7 3991.5 4025.5 4031.8 4042.3 10271.6 10660.4 10909.2 10982.9 11004.8 10581.9 10904.3 10918.3 10930.9 10937.5 6817.0 7925.4 8112.5 8292.1 8342.3 5772.5 5950.6 5993.3 6172.7 6190.5 10011.5 10223.2 10267.3 10278.4 10299.4 9060.4 10097.2 10115.4 10271.4 10318.0 6326.8 7523.9 7538.4 7599.5 7599.6 7484.3 7575.4 7707.5 8194.4 8195.5 7461.8 7463.8 7510.7 7518.2 7604.6 7438.5 7460.6 7475.8 7501.4 7536.8 6735.7 6883.8 6966.7 7007.1 7080.3 4996.4 4998.5 5040.8 5083.6 5141.0 4683.6 4993.6 5067.2 5128.2 5151.8 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4506.48 Median:5173.61 stddev:1404.85 (27.2%) stddev-sans-first:1372.79 08:14:08 INFO - PROCESS | 1653 | Values: 296.1 302.9 310.9 315.2 318.2 5176.2 5343.9 5372.4 5386.8 5429.7 5171.0 5278.6 5301.6 5302.4 5452.8 3382.7 3940.9 4099.5 4124.4 4212.7 3216.8 3389.5 4003.0 4136.9 4155.7 3521.9 3545.0 3788.9 4074.2 4113.6 3085.7 3179.9 3574.9 3838.8 3890.9 2843.5 3417.9 3451.6 3467.3 3604.4 5166.2 5215.8 5244.6 5246.9 5258.3 4477.8 4752.6 4756.8 4757.4 4769.5 4654.8 5636.0 5654.6 5658.4 5708.5 3948.3 3951.0 3953.0 3975.2 3982.8 4571.8 4960.8 5067.7 5593.8 5904.2 3251.4 3850.7 3888.0 3894.4 3898.6 3195.6 3717.4 3787.6 3952.8 3971.3 4024.3 4037.5 4488.7 4612.6 4658.6 5213.6 5602.6 5732.9 5795.7 5810.9 1202.7 1272.4 1308.2 1316.4 1323.7 739.9 769.5 812.8 972.6 976.3 5267.7 5301.7 5339.4 5362.4 5366.7 4912.3 5156.9 5418.0 5469.9 5619.2 5254.6 5255.5 5264.6 5280.4 5327.8 2534.2 2543.9 3016.3 3033.3 3035.2 5352.5 5392.2 5690.8 5960.3 5983.6 5165.8 5810.7 5866.4 5900.5 5911.3 4956.8 5208.9 5811.7 5886.4 5913.3 4270.7 5238.3 5639.5 5746.4 5748.0 5127.5 5325.7 5625.0 5683.4 5690.9 5642.5 5890.0 5913.2 5919.3 5946.7 3990.5 3992.5 4009.2 4027.2 4050.2 5077.5 5532.2 5727.4 5739.8 5767.8 5389.0 5645.7 5666.0 5673.7 5716.3 4915.8 5035.8 5087.8 5592.6 5607.9 4768.0 5331.9 5445.7 5488.3 5508.7 4681.8 4880.7 4985.8 5531.9 5623.0 4782.5 5480.2 5484.4 5561.9 5623.4 08:14:08 INFO - PROCESS | 1653 | 08:14:08 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:26501.96 Median:3501.07 stddev:43664.80 (1247.2%) stddev-sans-first:43744.34 08:14:08 INFO - PROCESS | 1653 | Values: 707.9 711.2 757.0 774.5 842.2 15453.0 16431.7 16433.2 17211.7 17960.3 16545.1 16906.0 16930.7 16934.2 17113.8 674.6 836.9 858.6 860.9 861.1 687.5 839.4 861.7 872.8 874.8 910.5 912.0 914.8 914.8 915.9 641.6 838.9 907.2 907.3 907.9 531.3 593.2 646.8 664.4 666.5 15266.5 15313.8 15334.5 15343.2 15346.4 13624.8 13984.7 14037.9 14046.9 14095.8 12949.0 13131.3 13260.0 13410.7 13486.4 4519.7 4547.8 4567.7 4577.6 4686.6 96866.5 126923.0 127096.7 127107.7 128289.0 10713.5 10742.8 10923.8 11131.7 11407.1 21634.4 21635.7 21636.9 21642.4 21643.4 6617.9 7625.3 7631.1 7760.6 7812.9 4107.5 4131.3 4319.9 4340.0 4351.3 3427.7 3462.0 3540.1 3541.1 3548.6 633.7 637.5 658.1 674.7 682.2 597.3 602.5 654.1 671.8 697.2 8294.9 9418.3 9778.8 9810.1 9822.8 634.9 674.7 691.8 697.6 709.6 4546.2 4650.4 4791.3 4799.9 4806.8 158012.0 160338.4 162088.0 163971.0 165447.0 140438.3 142341.0 144042.0 144763.0 144868.0 113359.0 121566.4 123724.4 124485.8 125367.0 8623.5 8635.8 9264.0 9288.7 9391.5 65684.0 67383.0 67744.0 68441.0 69074.5 83209.0 97059.0 100198.0 101974.0 102308.0 11827.3 11967.2 12082.5 12117.2 12674.1 13241.0 13294.7 13394.4 13402.3 13528.4 10008.5 12425.3 12430.4 12674.9 12687.2 12367.0 12392.8 12433.1 12662.6 12671.2 12032.9 12159.6 12170.8 12284.8 12315.6 9823.9 9900.7 10291.1 10848.9 11042.1 8423.8 10241.7 10497.3 10671.3 10681.9 08:14:08 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:14:08 INFO - PROCESS | 1653 | 08:14:09 INFO - TEST-INFO | 1653: exit 0 08:14:09 INFO - TEST-OK | dromaeo_css | took 1118036ms 08:14:09 INFO - TEST-START | kraken 08:14:09 INFO - operating with platform_type : mac_ 08:14:09 INFO - Initialising browser for kraken test... 08:14:09 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpOz4Hbr/profile http://localhost:49277/getInfo.html) 08:14:11 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:14:11 INFO - PROCESS | 1658 | colorDepth:24 08:14:11 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 08:14:11 INFO - PROCESS | 1658 | __metrics 08:14:12 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:14:12 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:12 INFO - TEST-INFO | 1658: exit 0 08:14:12 INFO - Browser initialized. 08:14:12 INFO - Running cycle 1/1 for kraken test... 08:14:12 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpOz4Hbr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:24 INFO - PROCESS | 1659 | RSS: Main: 228687872 08:14:24 INFO - PROCESS | 1659 | 08:14:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:28 INFO - PROCESS | 1659 | RSS: Main: 285368320 08:14:28 INFO - PROCESS | 1659 | 08:14:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 08:14:31 INFO - PROCESS | 1659 | RSS: Main: 298065920 08:14:31 INFO - PROCESS | 1659 | 08:14:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 08:14:35 INFO - PROCESS | 1659 | RSS: Main: 386412544 08:14:35 INFO - PROCESS | 1659 | 08:14:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 08:14:38 INFO - PROCESS | 1659 | RSS: Main: 289746944 08:14:38 INFO - PROCESS | 1659 | 08:14:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:40 INFO - PROCESS | 1659 | RSS: Main: 293871616 08:14:40 INFO - PROCESS | 1659 | 08:14:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:44 INFO - PROCESS | 1659 | RSS: Main: 331898880 08:14:44 INFO - PROCESS | 1659 | 08:14:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:47 INFO - PROCESS | 1659 | RSS: Main: 332713984 08:14:47 INFO - PROCESS | 1659 | 08:14:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 08:14:51 INFO - PROCESS | 1659 | RSS: Main: 329687040 08:14:51 INFO - PROCESS | 1659 | 08:14:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:53 INFO - PROCESS | 1659 | RSS: Main: 302104576 08:14:53 INFO - PROCESS | 1659 | 08:14:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:55 INFO - PROCESS | 1659 | RSS: Main: 309002240 08:14:55 INFO - PROCESS | 1659 | 08:14:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:58 INFO - PROCESS | 1659 | RSS: Main: 305696768 08:14:58 INFO - PROCESS | 1659 | 08:15:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:02 INFO - PROCESS | 1659 | RSS: Main: 314347520 08:15:02 INFO - PROCESS | 1659 | 08:15:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:05 INFO - PROCESS | 1659 | RSS: Main: 315842560 08:15:05 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 08:15:07 INFO - PROCESS | 1659 | RSS: Main: 359133184 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | __start_tp_report 08:15:07 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 08:15:07 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 08:15:07 INFO - PROCESS | 1659 | |i|pagename|runs| 08:15:07 INFO - PROCESS | 1659 | |0;ai-astar;101;111;112;113;106;111;110;111;112;112 08:15:07 INFO - PROCESS | 1659 | |1;audio-beat-detection;142;115;107;187;137;106;128;107;142;108 08:15:07 INFO - PROCESS | 1659 | |2;audio-dft;184;186;185;182;182;179;182;182;182;182 08:15:07 INFO - PROCESS | 1659 | |3;audio-fft;79;58;60;88;61;58;62;62;84;57 08:15:07 INFO - PROCESS | 1659 | |4;audio-oscillator;87;70;103;71;80;69;95;70;67;103 08:15:07 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;94;109;125;83;86;83;87;85;86;84 08:15:07 INFO - PROCESS | 1659 | |6;imaging-darkroom;92;94;94;94;92;93;93;92;94;107 08:15:07 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;85;86;86;86;84;84;83;86;86 08:15:07 INFO - PROCESS | 1659 | |8;json-parse-financial;55;54;54;54;54;56;54;54;54;54 08:15:07 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;63;65;80;76;71;68;68;69;68;68 08:15:07 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;80;83;84;85;88;86;82;75;87;98 08:15:07 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;137;140;135;144;150;153;147;136;171;143 08:15:07 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;166;166;167;164;167;165;168;170;224;183 08:15:07 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;69;67;67;68;66;66;67;65;68;67 08:15:07 INFO - PROCESS | 1659 | __end_tp_report 08:15:07 INFO - PROCESS | 1659 | __start_cc_report 08:15:07 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2072 08:15:07 INFO - PROCESS | 1659 | __end_cc_report 08:15:07 INFO - PROCESS | 1659 | __startTimestamp1471101307808__endTimestamp 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | ------- Summary: start ------- 08:15:07 INFO - PROCESS | 1659 | Number of tests: 14 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.67 (3.3%) stddev-sans-first:2.03 08:15:07 INFO - PROCESS | 1659 | Values: 101.0 111.0 112.0 113.0 106.0 111.0 110.0 111.0 112.0 112.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:132.50 stddev:25.58 (19.3%) stddev-sans-first:26.62 08:15:07 INFO - PROCESS | 1659 | Values: 142.0 115.0 107.0 187.0 137.0 106.0 128.0 107.0 142.0 108.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.00 stddev:1.96 (1.1%) stddev-sans-first:2.01 08:15:07 INFO - PROCESS | 1659 | Values: 184.0 186.0 185.0 182.0 182.0 179.0 182.0 182.0 182.0 182.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:66.90 Median:62.00 stddev:11.88 (19.2%) stddev-sans-first:11.77 08:15:07 INFO - PROCESS | 1659 | Values: 79.0 58.0 60.0 88.0 61.0 58.0 62.0 62.0 84.0 57.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:70.50 stddev:14.45 (20.5%) stddev-sans-first:15.19 08:15:07 INFO - PROCESS | 1659 | Values: 87.0 70.0 103.0 71.0 80.0 69.0 95.0 70.0 67.0 103.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:85.50 stddev:13.96 (16.3%) stddev-sans-first:14.79 08:15:07 INFO - PROCESS | 1659 | Values: 94.0 109.0 125.0 83.0 86.0 83.0 87.0 85.0 86.0 84.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:93.50 stddev:4.48 (4.8%) stddev-sans-first:4.66 08:15:07 INFO - PROCESS | 1659 | Values: 92.0 94.0 94.0 94.0 92.0 93.0 93.0 92.0 94.0 107.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.17 08:15:07 INFO - PROCESS | 1659 | Values: 86.0 85.0 86.0 86.0 86.0 84.0 84.0 83.0 86.0 86.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 08:15:07 INFO - PROCESS | 1659 | Values: 55.0 54.0 54.0 54.0 54.0 56.0 54.0 54.0 54.0 54.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:68.50 stddev:5.02 (7.3%) stddev-sans-first:4.72 08:15:07 INFO - PROCESS | 1659 | Values: 63.0 65.0 80.0 76.0 71.0 68.0 68.0 69.0 68.0 68.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:5.98 (7.0%) stddev-sans-first:6.08 08:15:07 INFO - PROCESS | 1659 | Values: 80.0 83.0 84.0 85.0 88.0 86.0 82.0 75.0 87.0 98.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:145.50 stddev:10.75 (7.4%) stddev-sans-first:10.94 08:15:07 INFO - PROCESS | 1659 | Values: 137.0 140.0 135.0 144.0 150.0 153.0 147.0 136.0 171.0 143.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:167.50 stddev:18.38 (11.0%) stddev-sans-first:19.26 08:15:07 INFO - PROCESS | 1659 | Values: 166.0 166.0 167.0 164.0 167.0 165.0 168.0 170.0 224.0 183.0 08:15:07 INFO - PROCESS | 1659 | 08:15:07 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 08:15:07 INFO - PROCESS | 1659 | Values: 69.0 67.0 67.0 68.0 66.0 66.0 67.0 65.0 68.0 67.0 08:15:07 INFO - PROCESS | 1659 | -------- Summary: end -------- 08:15:07 INFO - PROCESS | 1659 | 08:15:08 INFO - TEST-INFO | 1659: exit 0 08:15:08 INFO - TEST-OK | kraken | took 59121ms 08:15:08 INFO - SUITE-END | took 1177s 08:15:08 INFO - Completed test suite (00:19:37) 08:15:08 INFO - javascript benchmark 08:15:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2831.653412012561, 3389.7457690673205, 3398.524206611075, 3402.9149271268197, 3417.829108544572, 5573.136163894593, 5724.169995350671, 5743.597948143632, 5760.740766665504, 5817.8836423271505, 5265.86783841474, 5508.0, 5750.568707346955, 5880.500157486619, 5892.9705351473185, 5169.922451163236, 5206.062908676456, 5234.7120908350025, 5253.842384728464, 5315.840524784263, 5308.362996440433, 5311.282976798121, 5316.840494785143, 5320.813771517997, 5350.839474815762, 5234.0840352938085, 5253.605979551549, 5257.5005374489365, 5276.419593844674, 5278.102722537178, 4323.437953066113, 5272.0, 5274.208868669692, 5278.604104692164, 5281.0, 5168.250603662448, 5207.817726379596, 5230.34620672416, 5245.055889939809, 5261.4475480074425, 4790.377250957388, 5730.025895597759, 5773.9422605773825, 5805.0, 5809.796657116981, 6162.506999440034, 6244.718987645521, 6245.500359971192, 6257.0, 6267.373262673742, 6114.388610881752, 6154.969225153845, 6274.592151510183, 6294.905576416358, 6299.275583307933, 4900.901981960341, 5841.007028805113, 5860.355360910296, 5902.203202567642, 5980.282366116007, 5967.850803729942, 6076.939230607726, 6293.842653933688, 6296.590721603081, 6317.0, 6037.909431358533, 6088.001827990062, 6135.693215339215, 6204.627722336674, 6218.409251121137, 5093.923591146136, 5964.552658550626, 6300.936990630126, 6307.432331090132, 6321.399467050623, 5605.411431799684, 6236.594621349598, 6255.562110652301, 6266.436020758154, 6276.874462510724, 6026.096085587197, 6126.456603435028, 6227.283862355796, 6253.343398943045, 6259.186305780219, 4970.403551573834, 5004.174311238678, 5004.3994720633755, 5029.874253143701, 5049.293098966147, 4489.281714925662, 4495.078508905666, 4502.594766471033, 4524.389207457017, 4550.84072057483, 5166.948330516647, 5573.662321042921, 5677.205191273225, 5743.0811070228565, 5760.913586296209, 6150.862090513269, 6175.505959523227, 6193.876122477525, 6209.472194863487, 6228.937710622836, 5774.0, 5787.8553036174435, 5805.883882322414, 5810.912836307459, 5842.152887831241, 5364.919526207032, 5497.147942068986, 5497.862553436196, 5513.283273174542, 5513.365962914236, 6110.558759196641, 6179.969100154651, 6191.442770150528, 6211.161493198541, 6230.283517395557, 6121.635889161074, 6173.567850250619, 6200.255969283715, 6220.875582488416, 6221.751129954751, 6313.210848643919, 6313.873722525615, 6318.747250110128, 6323.399277068671, 6346.460550853045, 6108.267007959073, 6128.050152226412, 6212.658303793335, 6220.222472190976, 6222.533310001859, 5024.0, 6130.612163469812, 6144.893919094606, 6146.938530614815, 6154.076888466766, 4289.871303860889, 6175.62946223228, 6179.351168127461, 6191.040388739752, 6194.969025154845, 6112.908306375497, 6133.233345831771, 6145.877082458415, 6152.354002829638, 6177.382261773787, 5045.621578381562, 5873.0, 5959.851003724942, 6038.0, 6104.725287362168, 6133.6319820810895, 6137.324894261538, 6162.352952940056, 6167.198264225622, 6173.290071641639, 4705.882352941204, 5910.497607703393, 5997.280326360865, 6013.87972240544, 6067.787627433018], "value": 5663.508631477617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.9282713474566, 508.3188527373319, 512.4619149892612, 518.3132349636732, 526.812981391606, 40920.59079409205, 42352.788236058776, 42503.57496425035, 42514.57485425145, 44496.110077798425, 43785.0, 44159.55840441595, 44265.0, 44291.55708442914, 44298.11403771923, 8976.775580610472, 9096.63613455461, 9860.506974651256, 10057.647982320621, 10094.192464602815, 12131.696707582338, 12376.690582735413, 12383.25700457971, 12609.558665446712, 12613.558525451612, 9978.501074946224, 12028.879711202864, 12084.516619335216, 12097.516099356015, 12147.514099436012, 12202.0, 12250.387480626023, 12267.325297108655, 12274.447649855778, 12281.69295767604, 12038.097142714332, 12119.93940030303, 12133.150679452441, 12135.0, 12159.817602735966, 41394.58605413938, 41745.79127104375, 41785.58214417847, 41792.582074179474, 41835.7908210457, 3446.5174875517446, 3572.732045096628, 3703.037210325335, 3869.2648396804516, 4133.81397837095, 31556.526652100238, 32792.01623951285, 32809.3438131236, 32944.83527582371, 32952.011439656846, 3227.5481432599454, 3293.4236508610898, 3323.5513205717402, 3361.9495707564406, 3437.1407148212948, 526624.0, 526703.0, 526785.366073171, 528694.0, 530204.0, 59914.70042649846, 60325.0, 60372.0, 60411.0, 60430.0, 65417.018744718865, 65482.0, 66009.6798064036, 66098.33901661017, 66152.0, 16126.354945802037, 16335.754963675317, 16338.591535211715, 16353.264103115389, 16369.0, 11430.542778288775, 11709.473073711704, 12510.81233781494, 12720.300383478998, 12833.294168820805, 15337.846621533865, 16274.75587866183, 18037.0, 18043.729344059848, 18208.362707305445, 6152.569320147547, 6160.322364539897, 6162.907556386658, 6235.376462353728, 6260.092286618415, 855.9471849624872, 942.599395257013, 1008.4503945349802, 1013.3565186106728, 1054.3568423261804, 30216.395672086433, 31251.531227031614, 31651.683483164874, 31744.523832142535, 32703.672963270063, 915.2632131134501, 987.3039507147444, 995.4574756757585, 1073.1254027967182, 1081.259337353915, 15134.243287835785, 15793.070764011965, 15799.210039497979, 15955.441559545361, 16019.759703604455, 625040.0, 638727.0, 639095.0, 639373.0, 641013.0, 58402.0, 58542.0, 58732.11901821476, 58745.0, 58778.0, 1116.9497372618089, 1219.5731493977214, 1258.452573130691, 1360.415021540747, 1386.7018591002782, 28392.716072839008, 30980.0, 32507.512387313735, 32879.67120328766, 33310.5003424944, 57911.420885790605, 58736.706316468146, 58757.0, 58852.0, 59009.0, 588958.0, 592499.0, 592718.0364098152, 593690.0, 593924.0, 26534.0, 26935.0, 27182.72817271802, 27822.304442388293, 27841.721582783914, 48957.020859583325, 49578.25632615586, 49588.752056239486, 49917.0, 50149.49850501448, 39443.605563943995, 39698.80150599228, 40206.597934021454, 40952.385714214906, 41170.38244426276, 33265.0, 39664.80167599144, 39760.0, 40335.1932961345, 41239.587604124776, 37971.620283797914, 39257.803710981265, 39283.0, 39463.80268098641, 39517.60482395254, 31171.688283116877, 34757.0, 34844.12889677677, 35221.82389088038, 35323.82338088293, 24595.0, 25237.495250095264, 25819.870900645376, 25850.35374115662, 25890.87054564715], "value": 20793.926529495868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5922189482097, 368.13855577947595, 376.8304263081613, 382.7990305089828, 404.3873531599627, 15571.610709732247, 16071.51785446437, 20244.797552024513, 20624.0, 20710.585788284243, 21214.04536795844, 21315.0, 21716.782832171673, 21791.891040544775, 21989.0, 5898.528117750569, 6035.54733394996, 6067.120267561201, 6146.262448506185, 6233.532485063615, 4200.138971510848, 6059.091136329542, 6165.0752387142065, 6165.876682466348, 6166.475849552793, 6430.164078669766, 6697.397234248917, 6726.327367263283, 6820.11338525991, 6828.317168283182, 6551.082848401227, 6668.366505182, 6754.088198093244, 6787.2534021257625, 6801.591904485697, 5092.9745351273, 5698.945695046388, 5862.648241105505, 5873.383294754075, 5873.85315367115, 13568.0, 13805.723885522233, 23240.53518929612, 24806.751932480624, 25640.230793076236, 2120.4062862398555, 2202.678392964209, 2217.634090375086, 2641.735826417362, 3025.8789648414036, 9989.850152247722, 10156.289059765819, 10306.278560500768, 10369.118624916891, 10492.842607360895, 1891.489297889562, 1896.535348839543, 2008.367364280247, 2055.4758536573077, 2062.257587268582, 119193.0, 126231.36884315612, 126856.0, 127564.0, 134940.6505934938, 11073.612423565137, 11186.944065279622, 11546.247469572254, 11666.600007998924, 12093.57672481459, 14684.926575367055, 14712.0, 14716.33776480061, 14717.337719802634, 14719.632009199855, 8594.054653988182, 8731.126887311346, 8737.38838281327, 8775.912240877637, 8927.151920567536, 7437.809950407909, 7504.699812007568, 8360.916390836135, 8702.608382622797, 8920.197182253629, 4389.1660584488845, 4530.841420550265, 4544.590986811203, 4550.977245113753, 4671.929921051187, 1850.9074546272632, 1895.2229585870002, 1907.3515004898402, 1909.3508207209616, 1910.2740958435706, 663.6250518457057, 731.381982225019, 839.47532792005, 904.5251243097426, 996.8884693566621, 20777.896110519654, 21547.353579392642, 21621.783782162292, 21676.024578893986, 21678.34964951054, 838.4328061670512, 933.5985526223789, 942.8973833114989, 1019.4462870509327, 1026.2867307221559, 10421.635242766466, 11224.887751122547, 11314.60398886035, 11462.885371146349, 11498.482568284448, 598054.0, 601158.0, 611768.0, 623877.0, 627932.0, 47932.760336198095, 101107.86705595376, 123973.38013310057, 136377.63622363648, 138450.0, 753.1335736188038, 929.1916033051289, 936.4849332866896, 948.061419194992, 974.5906719177821, 16769.245383957506, 19145.712814307517, 19381.224751009802, 19487.584232899775, 19669.901650491654, 54264.75955265195, 55532.88934221374, 55751.721241393534, 56515.71742141263, 56610.58473538195, 78936.0, 80389.59805200937, 83145.16854831616, 85631.0, 87073.0, 7099.751508697171, 7354.712925237955, 7790.649420775965, 7825.139234684294, 8096.635651395819, 9298.814023719622, 12637.304948227937, 13040.673983150118, 13183.472661093449, 13236.205827650372, 10728.624498142528, 10844.728881778019, 10923.78152436931, 11044.558217671525, 11091.5563377464, 10863.0, 10873.619423320146, 11199.66401007971, 11215.786060464996, 11381.886181138083, 8971.0, 10364.274500784873, 11331.773364532499, 11440.313581185155, 11769.352685602375, 6063.757449701962, 7944.689126294097, 7985.880211796712, 8106.959465202636, 8110.0, 9241.896731719386, 10097.44464054484, 11292.943535282271, 11362.829557556808, 11427.942860285646], "value": 9539.448751934597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.961961141166, 1333.253378108259, 1495.3569964915087, 1628.3079691131265, 1690.298526111663, 7769.223077692228, 8505.48967061976, 8733.083026282236, 8741.694040708577, 8853.203211710961, 8599.613017414216, 8672.91327086729, 8673.653053877853, 8693.913060869389, 8694.043655197924, 2216.2907869481733, 2243.4391402149463, 2247.1236217875044, 2248.022110381981, 2250.5723912456665, 2212.3141826033902, 2233.7207849018873, 2253.481699209183, 2254.278630838124, 2257.063318722728, 2212.524307273936, 2231.4867580456503, 2239.395363251921, 2241.7197850268717, 2250.6061439248065, 2185.9507436430604, 2201.438633148545, 2206.382212980352, 2207.5033117548664, 2210.0, 2200.4388880835445, 2215.4129155773735, 2216.2243214874825, 2216.789405006522, 2217.1463986365366, 8734.47593144407, 8736.432131911406, 8914.598843052014, 8926.910730892738, 8934.329925255632, 5143.511366420222, 5301.0723123453245, 5336.573074154058, 5340.759665815048, 5355.6251062425645, 3455.2053027803745, 3627.8004709740953, 3707.295613833363, 3711.164987877733, 3712.888613341577, 1092.4974511724615, 1099.3184225779987, 1101.4492753623188, 1109.9223054386196, 1124.3928278729477, 11542.711432214262, 11561.017313528277, 11644.708882278012, 11670.183087183901, 11675.532978680843, 4346.391505189276, 4491.573300536444, 4618.67669263155, 4621.584057434847, 4646.094011667692, 9163.358564900393, 9164.6792362267, 9168.174864262115, 9173.908260917306, 9175.220106290906, 5222.451642577475, 5224.346956630421, 5226.503482169188, 5227.059129356752, 5243.973780131075, 4121.639858846574, 4494.9325760113625, 4875.926861097087, 4901.044296362246, 4904.141775189328, 3745.2696724139078, 3770.245950809849, 3828.0429892526868, 3857.7685338879755, 3861.826217820205, 1153.3425947210178, 1172.0974849365941, 1173.4308860202796, 1177.9941100294616, 1181.0728578066178, 840.6973489543759, 854.7008547008512, 900.0516016353739, 916.4409710076848, 935.0976307862809, 5652.773889044474, 5767.394423585547, 6016.488598469179, 6019.638821670714, 6112.572119951561, 445.9197344478025, 459.5014409365809, 460.1556144474859, 1005.3214080495636, 1009.5406590001531, 3877.747946383476, 3991.5409727881083, 4025.496812898388, 4031.7782521960985, 4042.2521833460905, 10271.589136434459, 10660.360378377321, 10909.23635345534, 10982.890171098346, 11004.834927476095, 10581.894181058246, 10904.34573925567, 10918.344899306067, 10930.939336985657, 10937.507812148473, 6816.965915170492, 7925.405594580314, 8112.472689275178, 8292.087870334259, 8342.332613390914, 5772.5381969441505, 5950.613210141327, 5993.250843644544, 6172.6913654318005, 6190.535709821871, 10011.499425028574, 10223.182145428496, 10267.332623379456, 10278.434686092336, 10299.3820370778, 9060.411073280216, 10097.19222462216, 10115.443650599287, 10271.378435665049, 10318.019788120117, 6326.778562750282, 7523.924760752541, 7538.434617403826, 7599.544027358376, 7599.582022988789, 7484.288992545699, 7575.356094732009, 7707.460477766726, 8194.426390152632, 8195.508269503849, 7461.776146715607, 7463.813404664709, 7510.662020208994, 7518.173000969779, 7604.581748003913, 7438.479306448497, 7460.626968651654, 7475.775726728207, 7501.399888009056, 7536.849263014599, 6735.663216839236, 6883.7590684325805, 6966.7213311469, 7007.054047703698, 7080.327368899946, 4996.425411077773, 4998.525140111684, 5040.84877453677, 5083.618728595444, 5141.0232055909255, 4683.625309975126, 4993.550580447777, 5067.189249720027, 5128.230765385222, 5151.793928242978], "value": 4476.4522570617055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.1441434255002, 302.91669790807526, 310.8911880841705, 315.1773870198782, 318.17116411747395, 5176.240078373352, 5343.89312213756, 5372.382176049756, 5386.757595908184, 5429.701366424845, 5170.974145129278, 5278.630495865282, 5301.602379821509, 5302.390225124112, 5452.781888724447, 3382.7293816494685, 3940.901477463072, 4099.467069281004, 4124.401961715549, 4212.705110642256, 3216.823074730889, 3389.542411774416, 4002.9592306000504, 4136.875893723193, 4155.729877557964, 3521.8906044595997, 3544.954238499649, 3788.916096147122, 4074.1851629674034, 4113.609207125318, 3085.691430856919, 3179.920501987457, 3574.891783547109, 3838.808059597009, 3890.949443650227, 2843.530817415124, 3417.9145521361916, 3451.6030656474327, 3467.289205712823, 3604.387254166798, 5166.199239117943, 5215.843524694265, 5244.606654500928, 5246.921296180561, 5258.342707161605, 4477.776111194427, 4752.643551733634, 4756.7859446325, 4757.429108506966, 4769.451513075971, 4654.813807447698, 5635.971820140873, 5654.6324488908085, 5658.377578466366, 5708.486236238717, 3948.269570129535, 3950.960490395088, 3952.960470395288, 3975.2447035063246, 3982.76103433792, 4571.839985600488, 4960.776765045545, 5067.695938243717, 5593.825296687701, 5904.2029326040865, 3251.3659836332163, 3850.7111966602056, 3888.0, 3894.3963685628773, 3898.6101389860787, 3195.5526226328334, 3717.4423836424753, 3787.617519605324, 3952.754882212094, 3971.3050216212046, 4024.2555127301544, 4037.4953130858644, 4488.730676159375, 4612.607928326062, 4658.624101708086, 5213.582913366998, 5602.607817452821, 5732.914006289909, 5795.724940513081, 5810.854728631733, 1202.687301301668, 1272.3713646532453, 1308.156239225713, 1316.394458549059, 1323.6829354792044, 739.8927155562413, 769.5036701327613, 812.7642983534827, 972.644984580623, 976.2531663277598, 5267.7366131694025, 5301.655392399482, 5339.439358867263, 5362.410134885159, 5366.7048312343195, 4912.287718280829, 5156.905856486153, 5417.968261901787, 5469.890602187934, 5619.213310136584, 5254.579633629377, 5255.474452554714, 5264.5525130363585, 5280.366356037223, 5327.840164795062, 2534.176392672389, 2543.936401589938, 3016.291171574678, 3033.2720147164523, 3035.2260173655577, 5352.518273355417, 5392.245085688007, 5690.780595567732, 5960.284765828128, 5983.551233657493, 5165.793368265303, 5810.680412577349, 5866.413358664185, 5900.468957793819, 5911.290645122613, 4956.810365512251, 5208.91643342666, 5811.651300921873, 5886.440788125121, 5913.29040515141, 4270.722403043792, 5238.292830467991, 5639.533721232591, 5746.367899531132, 5748.0, 5127.46161653021, 5325.695204674879, 5624.987502249634, 5683.3748287687495, 5690.914636280542, 5642.463965923231, 5890.028145355968, 5913.231279933581, 5919.289685237799, 5946.702664866826, 3990.4612877261197, 3992.461017762681, 4009.218202450494, 4027.234825383285, 4050.1899620075515, 5077.517635824591, 5532.2254884315425, 5727.427257274239, 5739.827805165852, 5767.7981270657, 5389.0, 5645.745941432728, 5665.971670141623, 5673.716314184357, 5716.255852416673, 4915.827946021872, 5035.823746168867, 5087.771050302671, 5592.568546171772, 5607.8878422432135, 4767.996162417655, 5331.866703332447, 5445.727713614383, 5488.271194573696, 5508.669479831223, 4681.789319480564, 4880.731559764247, 4985.800567977385, 5531.865967476577, 5622.987862184846, 4782.545658162469, 5480.205370221216, 5484.407712948026, 5561.888762224814, 5623.3814280428305], "value": 4056.7124883582537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8548897476018, 711.2176605733694, 756.9621518924056, 774.5043172369681, 842.1746688245521, 15453.0, 16431.67136657266, 16433.17834108294, 17211.741823872653, 17960.281588736434, 16545.090020048894, 16906.0, 16930.661386772255, 16934.153292335366, 17113.82886171138, 674.56153500225, 836.8661014237723, 858.6307887608326, 860.9139086091373, 861.1474640106312, 687.549654975989, 839.3998291221775, 861.7156338408311, 872.7992561710811, 874.7638137702817, 910.512875611548, 911.968081117161, 914.8124634449922, 914.8170365926808, 915.9496227707474, 641.6182371489003, 838.8825564420986, 907.2469850024464, 907.3376435202273, 907.8728977943093, 531.3278702441414, 593.1814096546781, 646.8221239159221, 664.3821246240994, 666.4934649666241, 15266.542003739905, 15313.770293445607, 15334.539963801104, 15343.156126413043, 15346.386144554204, 13624.795628065587, 13984.720305593934, 14037.929810350985, 14046.92976535121, 14095.78856317156, 12949.0, 13131.303085155065, 13260.0, 13410.731785364238, 13486.39311230997, 4519.661025423106, 4547.772611369418, 4567.725936443824, 4577.5880170784785, 4686.554777296152, 96866.5156674212, 126923.0, 127096.65485124021, 127107.72892271144, 128289.0, 10713.517891694892, 10742.838857417146, 10923.836142457869, 11131.666050018512, 11407.08743300534, 21634.350969470943, 21635.67546486804, 21636.9444902734, 21642.35072947814, 21643.35069947904, 6617.908045172589, 7625.275598818103, 7631.084269887649, 7760.573168475675, 7812.882806757903, 4107.54816970133, 4131.318332475168, 4319.892002699958, 4339.9783001085425, 4351.303791393425, 3427.657234276602, 3462.0306314232057, 3540.1149712571855, 3541.0793193769805, 3548.6451354864307, 633.7369991453495, 637.4645297949744, 658.1016911915297, 674.6626686656672, 682.2120450879243, 597.3399393670019, 602.466816867067, 654.1365397675119, 671.8155940840381, 697.2225968045694, 8294.875576866352, 9418.293627977791, 9778.804423911624, 9810.11708946184, 9822.803543929223, 634.8857205702925, 674.652553934724, 691.7647999680133, 697.5814511293183, 709.609714656947, 4546.227141385973, 4650.441946966385, 4791.281307803857, 4799.880002999953, 4806.807727690853, 158012.0, 160338.39661603468, 162088.0, 163971.0, 165447.0, 140438.2978085103, 142341.0, 144042.0, 144763.0, 144868.0, 113359.0, 121566.3921680386, 123724.38137809253, 124485.75514244923, 125367.0, 8623.525706086226, 8635.784105397415, 9264.0, 9288.72133835986, 9391.483468409304, 65684.0, 67383.0, 67744.0, 68441.0, 69074.54627268515, 83209.0, 97059.0, 100197.99802002178, 101974.0, 102308.0, 11827.349495777815, 11967.222130561486, 12082.51669933228, 12117.15179937396, 12674.112812103065, 13241.0, 13294.667633309246, 13394.397252123483, 13402.329883505981, 13528.39122239482, 10008.549615267477, 12425.31660758667, 12430.378481076092, 12674.873251267738, 12687.22378866941, 12367.0, 12392.81410778821, 12433.06751993586, 12662.556810511587, 12671.17637353569, 12032.939835300767, 12159.635210943687, 12170.817437738619, 12284.754304914031, 12315.630531084082, 9823.901760982584, 9900.702978910644, 10291.092905699783, 10848.945755271174, 11042.061424778984, 8423.820665106767, 10241.692749217535, 10497.317674351143, 10671.253012289375, 10681.924195357276], "value": 7888.132366035775, "unit": "score"}], "name": "dromaeo_css", "value": 7375.295712126398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 113.0, 106.0, 111.0, 110.0, 111.0, 112.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 107.0, 187.0, 137.0, 106.0, 128.0, 107.0, 142.0, 108.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 185.0, 182.0, 182.0, 179.0, 182.0, 182.0, 182.0, 182.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 61.0, 58.0, 62.0, 62.0, 84.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 103.0, 71.0, 80.0, 69.0, 95.0, 70.0, 67.0, 103.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 109.0, 125.0, 83.0, 86.0, 83.0, 87.0, 85.0, 86.0, 84.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 94.0, 92.0, 93.0, 93.0, 92.0, 94.0, 107.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 86.0, 84.0, 84.0, 83.0, 86.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 80.0, 76.0, 71.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 84.0, 85.0, 88.0, 86.0, 82.0, 75.0, 87.0, 98.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 135.0, 144.0, 150.0, 153.0, 147.0, 136.0, 171.0, 143.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 164.0, 167.0, 165.0, 168.0, 170.0, 224.0, 183.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 66.0, 66.0, 67.0, 65.0, 68.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1436.0, "alertThreshold": 2.0}]} 08:15:09 INFO - Return code: 0 08:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:15:09 INFO - # TBPL SUCCESS # 08:15:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:09 INFO - 2016-08-13 08:15:09.112 screenresolution[1663:10381] starting screenresolution argv=screenresolution get 08:15:09 INFO - 2016-08-13 08:15:09.115 screenresolution[1663:10381] Display 0: 1600x1200x32@60 08:15:09 INFO - 2016-08-13 08:15:09.121 screenresolution[1664:10384] starting screenresolution argv=screenresolution list 08:15:09 INFO - Available Modes on Display 0 08:15:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:09 INFO - Intel Iris: 08:15:09 INFO - Chipset Model: Intel Iris 08:15:09 INFO - Type: GPU 08:15:09 INFO - Bus: Built-In 08:15:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:09 INFO - Vendor: Intel (0x8086) 08:15:09 INFO - Device ID: 0x0a2e 08:15:09 INFO - Revision ID: 0x0009 08:15:09 INFO - Displays: 08:15:09 INFO - Display: 08:15:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:09 INFO - Display Serial Number: 1600x1200 60 08:15:09 INFO - Main Display: Yes 08:15:09 INFO - Mirror: Off 08:15:09 INFO - Online: Yes 08:15:09 INFO - Rotation: Supported 08:15:09 INFO - Return code: 0 08:15:09 INFO - Running post-action listener: _resource_record_post_action 08:15:09 INFO - [mozharness: 2016-08-13 15:15:09.356780Z] Finished run-tests step (success) 08:15:09 INFO - Running post-run listener: _resource_record_post_run 08:15:09 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 32889856; Write bytes: 706466816; Read time: 312; Write time: 1954 08:15:09 INFO - TinderboxPrint: CPU usage
53.5% 08:15:09 INFO - TinderboxPrint: I/O read bytes / time
32,889,856 / 312 08:15:09 INFO - TinderboxPrint: I/O write bytes / time
706,466,816 / 1,954 08:15:09 INFO - TinderboxPrint: CPU idle
2,259.1 (46.5%) 08:15:09 INFO - TinderboxPrint: CPU system
973.2 (20.1%) 08:15:09 INFO - TinderboxPrint: CPU user
1,621.4 (33.4%) 08:15:09 INFO - TinderboxPrint: Swap in / out
433,475,584 / 0 08:15:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 402516480; Write bytes: 396564480; Read time: 30699; Write time: 759 08:15:09 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30776320; Write bytes: 297896960; Read time: 288; Write time: 1158 08:15:09 INFO - Running post-run listener: _upload_blobber_files 08:15:09 INFO - Blob upload gear active. 08:15:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:09 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 08:15:09 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'] 08:15:09 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 08:15:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:11 INFO - (blobuploader) - INFO - Done attempting. 08:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:12 INFO - (blobuploader) - INFO - Done attempting. 08:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:14 INFO - (blobuploader) - INFO - Done attempting. 08:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:14 INFO - Return code: 0 08:15:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/906d0d22616f094c5bc613634e7155e6a12147293bf07cd7dca02de0e6e1764137632d3f736c2bbcce8276f2e34686ddb922696e1641e9cb1acd3ac0f5096c81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5a5aab3a23e6035877e424d065814981296f14702ae238455376bda101deb386aeb7c231c7dab8be3a3a1ac739722a889e0fd33b2a6ecad7a174fa28e165346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4a6de7a11d3dee5cb277e209c3e7d58ee4223dbbdc225c0583f664283e6691c7a3f64c729202a4fc6498fec7e28cefa9461f552a0aebc8f4f60a24a87364788"} 08:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:14 INFO - Contents: 08:15:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/906d0d22616f094c5bc613634e7155e6a12147293bf07cd7dca02de0e6e1764137632d3f736c2bbcce8276f2e34686ddb922696e1641e9cb1acd3ac0f5096c81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5a5aab3a23e6035877e424d065814981296f14702ae238455376bda101deb386aeb7c231c7dab8be3a3a1ac739722a889e0fd33b2a6ecad7a174fa28e165346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4a6de7a11d3dee5cb277e209c3e7d58ee4223dbbdc225c0583f664283e6691c7a3f64c729202a4fc6498fec7e28cefa9461f552a0aebc8f4f60a24a87364788"} 08:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:14 INFO - Copying logs to upload dir... 08:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.464052 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-08-13 08:15:15.033925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 08:15:15.038172) ========= 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.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/906d0d22616f094c5bc613634e7155e6a12147293bf07cd7dca02de0e6e1764137632d3f736c2bbcce8276f2e34686ddb922696e1641e9cb1acd3ac0f5096c81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5a5aab3a23e6035877e424d065814981296f14702ae238455376bda101deb386aeb7c231c7dab8be3a3a1ac739722a889e0fd33b2a6ecad7a174fa28e165346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4a6de7a11d3dee5cb277e209c3e7d58ee4223dbbdc225c0583f664283e6691c7a3f64c729202a4fc6498fec7e28cefa9461f552a0aebc8f4f60a24a87364788"} build_url:https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/J5MnscbqRtSESsA3HinRvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/906d0d22616f094c5bc613634e7155e6a12147293bf07cd7dca02de0e6e1764137632d3f736c2bbcce8276f2e34686ddb922696e1641e9cb1acd3ac0f5096c81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5a5aab3a23e6035877e424d065814981296f14702ae238455376bda101deb386aeb7c231c7dab8be3a3a1ac739722a889e0fd33b2a6ecad7a174fa28e165346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4a6de7a11d3dee5cb277e209c3e7d58ee4223dbbdc225c0583f664283e6691c7a3f64c729202a4fc6498fec7e28cefa9461f552a0aebc8f4f60a24a87364788"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 08:15:15.072419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 08:15:15.072828) ========= 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.SBLoCDA0YD/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.zirAETPH0B/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005158 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 08:15:15.121910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 08:15:15.122339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 08:15:15.122762) ========= ========= Total master_lag: 0.18 =========