builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0303 starttime: 1472852443.85 results: success (0) buildid: 20160902132549 builduid: 3a38dee679824e0787d7ab94849235f3 revision: b462b3ebc32cdd8a54b35e52773191d3081f17a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.849017) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.849507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.849816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.875245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.875658) ========= 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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-09-02 14:40:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.6M=0s 2016-09-02 14:40:43 (26.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.994892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:43.995220) ========= 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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.025708 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:44.044141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 14:40:44.044527) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b462b3ebc32cdd8a54b35e52773191d3081f17a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b462b3ebc32cdd8a54b35e52773191d3081f17a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-09-02 14:40:44,128 truncating revision to first 12 chars 2016-09-02 14:40:44,128 Setting DEBUG logging. 2016-09-02 14:40:44,128 attempt 1/10 2016-09-02 14:40:44,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b462b3ebc32c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 14:40:46,363 unpacking tar archive at: autoland-b462b3ebc32c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.504474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 14:40:46.572588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:46.572917) ========= script_repo_revision: b462b3ebc32cdd8a54b35e52773191d3081f17a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:46.573317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:46.573588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:40:46.592488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-02 14:40:46.592879) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:40:46 INFO - MultiFileLogger online at 20160902 14:40:46 in /builds/slave/test 14:40:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:40:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:40:46 INFO - {'append_to_log': False, 14:40:46 INFO - 'base_work_dir': '/builds/slave/test', 14:40:46 INFO - 'blob_upload_branch': 'Autoland', 14:40:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:40:46 INFO - 'branch': 'Autoland', 14:40:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:40:46 INFO - 'config_files': ('talos/mac_config.py',), 14:40:46 INFO - 'default_actions': ('clobber', 14:40:46 INFO - 'read-buildbot-config', 14:40:46 INFO - 'download-and-extract', 14:40:46 INFO - 'populate-webroot', 14:40:46 INFO - 'create-virtualenv', 14:40:46 INFO - 'install', 14:40:46 INFO - 'run-tests'), 14:40:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:40:46 INFO - 'download_minidump_stackwalk': True, 14:40:46 INFO - 'download_symbols': 'ondemand', 14:40:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:40:46 INFO - 'tooltool.py': '/tools/tooltool.py', 14:40:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:40:46 INFO - '/tools/misc-python/virtualenv.py')}, 14:40:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:40:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:40:46 INFO - 'installer_path': 'installer.exe', 14:40:46 INFO - 'log_level': 'info', 14:40:46 INFO - 'log_name': 'talos', 14:40:46 INFO - 'log_to_console': True, 14:40:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:40:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:40:46 INFO - 'opt_config_files': (), 14:40:46 INFO - 'pip_index': False, 14:40:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:40:46 INFO - 'cmd': ('bash', 14:40:46 INFO - '-c', 14:40:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:40:46 INFO - 'enabled': True, 14:40:46 INFO - 'halt_on_failure': False, 14:40:46 INFO - 'name': 'check_screen_resolution'},), 14:40:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:40:46 INFO - 'cmd': ('bash', 14:40:46 INFO - '-c', 14:40:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:40:46 INFO - 'enabled': True, 14:40:46 INFO - 'halt_on_failure': False, 14:40:46 INFO - 'name': 'check_screen_resolution'},), 14:40:46 INFO - 'run_cmd_checks_enabled': True, 14:40:46 INFO - 'sps_profile': False, 14:40:46 INFO - 'sps_profile_interval': 0, 14:40:46 INFO - 'suite': 'dromaeojs', 14:40:46 INFO - 'system_bits': '32', 14:40:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:40:46 INFO - 'title': 't-yosemite-r7-0303', 14:40:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:40:46 INFO - 'use_talos_json': True, 14:40:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:40:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:40:46 INFO - 'work_dir': 'build'} 14:40:46 INFO - [mozharness: 2016-09-02 21:40:46.785028Z] Running clobber step. 14:40:46 INFO - Running pre-action listener: _resource_record_pre_action 14:40:46 INFO - Running main action method: clobber 14:40:46 INFO - rmtree: /builds/slave/test/build 14:40:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:40:48 INFO - Running post-action listener: _resource_record_post_action 14:40:48 INFO - [mozharness: 2016-09-02 21:40:48.862548Z] Finished clobber step (success) 14:40:48 INFO - [mozharness: 2016-09-02 21:40:48.862815Z] Running read-buildbot-config step. 14:40:48 INFO - Running pre-action listener: _resource_record_pre_action 14:40:48 INFO - Running main action method: read_buildbot_config 14:40:48 INFO - Using buildbot properties: 14:40:48 INFO - { 14:40:48 INFO - "project": "", 14:40:48 INFO - "product": "firefox", 14:40:48 INFO - "script_repo_revision": "production", 14:40:48 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:40:48 INFO - "repository": "", 14:40:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:40:48 INFO - "buildid": "20160902132549", 14:40:48 INFO - "pgo_build": "False", 14:40:48 INFO - "basedir": "/builds/slave/test", 14:40:48 INFO - "buildnumber": 145, 14:40:48 INFO - "slavename": "t-yosemite-r7-0303", 14:40:48 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:40:48 INFO - "platform": "yosemite_r7", 14:40:48 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:40:48 INFO - "branch": "autoland", 14:40:48 INFO - "repo_path": "integration/autoland", 14:40:48 INFO - "revision": "b462b3ebc32cdd8a54b35e52773191d3081f17a7", 14:40:48 INFO - "stage_platform": "macosx64", 14:40:48 INFO - "builduid": "3a38dee679824e0787d7ab94849235f3", 14:40:48 INFO - "slavebuilddir": "test" 14:40:48 INFO - } 14:40:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:40:48 INFO - Running post-action listener: _resource_record_post_action 14:40:48 INFO - [mozharness: 2016-09-02 21:40:48.868292Z] Finished read-buildbot-config step (success) 14:40:48 INFO - [mozharness: 2016-09-02 21:40:48.868420Z] Running download-and-extract step. 14:40:48 INFO - Running pre-action listener: _resource_record_pre_action 14:40:48 INFO - Running main action method: download_and_extract 14:40:48 INFO - mkdir: /builds/slave/test/build/tests 14:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:48 INFO - trying https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:40:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/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 14:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/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 14:40:50 INFO - Downloaded 1199 bytes. 14:40:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:40:50 INFO - Using the following test package requirements: 14:40:50 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:40:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:40:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:40:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'jsshell-mac.zip'], 14:40:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:40:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:40:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:40:50 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:40:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:40:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:40:50 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:40:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:40:50 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 14:40:57 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 14:40:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:40:58 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 14:41:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:41:05 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 14:41:06 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')]} 14:41:06 INFO - trying https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:41:06 INFO - Downloading https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/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 14:41:09 INFO - Downloaded 111630582 bytes. 14:41:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:41:09 INFO - mkdir: /builds/slave/test/properties 14:41:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:41:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:41:09 INFO - Contents: 14:41:09 INFO - build_url:https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:41:09 INFO - Running post-action listener: _resource_record_post_action 14:41:09 INFO - Running post-action listener: set_extra_try_arguments 14:41:09 INFO - [mozharness: 2016-09-02 21:41:09.916320Z] Finished download-and-extract step (success) 14:41:09 INFO - [mozharness: 2016-09-02 21:41:09.916439Z] Running populate-webroot step. 14:41:09 INFO - Running pre-action listener: _resource_record_pre_action 14:41:09 INFO - Running main action method: populate_webroot 14:41:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:41:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:41:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:41:09 INFO - '--tppagecycles', 14:41:09 INFO - '7'], 14:41:09 INFO - 'tests': ['tsvgm']}}, 14:41:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:41:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:41:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:41:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:41:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['damp', 'tps']}, 14:41:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'tests': ['damp', 'tps']}, 14:41:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['dromaeo_dom']}, 14:41:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:41:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['basic_compositor_video']}, 14:41:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:41:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['a11yr', 14:41:09 INFO - 'ts_paint', 14:41:09 INFO - 'tpaint', 14:41:09 INFO - 'sessionrestore', 14:41:09 INFO - 'sessionrestore_no_auto_restore', 14:41:09 INFO - 'tabpaint']}, 14:41:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['tsvgx', 14:41:09 INFO - 'tsvgr_opacity', 14:41:09 INFO - 'tart', 14:41:09 INFO - 'tscrollx', 14:41:09 INFO - 'cart']}, 14:41:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:41:09 INFO - 'tsvgr_opacity', 14:41:09 INFO - 'tart', 14:41:09 INFO - 'tscrollx', 14:41:09 INFO - 'cart']}, 14:41:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'talos_options': ['--disable-e10s'], 14:41:09 INFO - 'tests': ['tp5o']}, 14:41:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'tests': ['tp5o']}, 14:41:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'talos_options': ['--disable-e10s', 14:41:09 INFO - '--xperf_path', 14:41:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:09 INFO - 'tests': ['tp5n']}, 14:41:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:09 INFO - 'talos_options': ['--xperf_path', 14:41:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:09 INFO - 'tests': ['tp5n']}}, 14:41:09 INFO - 'talos.zip': {'path': '', 14:41:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:41:09 INFO - Running post-action listener: _resource_record_post_action 14:41:09 INFO - [mozharness: 2016-09-02 21:41:09.935042Z] Finished populate-webroot step (success) 14:41:09 INFO - [mozharness: 2016-09-02 21:41:09.935147Z] Running create-virtualenv step. 14:41:09 INFO - Running pre-action listener: _resource_record_pre_action 14:41:09 INFO - Running main action method: create_virtualenv 14:41:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:41:09 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 14:41:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:41:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:41:10 INFO - Using real prefix '/tools/python27' 14:41:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:41:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:41:13 INFO - Installing pip.................done. 14:41:13 INFO - Return code: 0 14:41:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:13 INFO - 'HOME': '/Users/cltbld', 14:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:13 INFO - 'LOGNAME': 'cltbld', 14:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:13 INFO - 'MOZ_NO_REMOTE': '1', 14:41:13 INFO - 'NO_EM_RESTART': '1', 14:41:13 INFO - 'PAGER': '/bin/cat', 14:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:13 INFO - 'PWD': '/builds/slave/test', 14:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:13 INFO - 'SHELL': '/bin/bash', 14:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:13 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:13 INFO - 'USER': 'cltbld', 14:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:13 INFO - 'XPC_FLAGS': '0x0', 14:41:13 INFO - 'XPC_SERVICE_NAME': '0', 14:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:13 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 14:41:13 INFO - Cleaning up... 14:41:13 INFO - Return code: 0 14:41:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:13 INFO - 'HOME': '/Users/cltbld', 14:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:13 INFO - 'LOGNAME': 'cltbld', 14:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:13 INFO - 'MOZ_NO_REMOTE': '1', 14:41:13 INFO - 'NO_EM_RESTART': '1', 14:41:13 INFO - 'PAGER': '/bin/cat', 14:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:13 INFO - 'PWD': '/builds/slave/test', 14:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:13 INFO - 'SHELL': '/bin/bash', 14:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:13 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:13 INFO - 'USER': 'cltbld', 14:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:13 INFO - 'XPC_FLAGS': '0x0', 14:41:13 INFO - 'XPC_SERVICE_NAME': '0', 14:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:14 INFO - Downloading/unpacking psutil>=3.1.1 14:41:14 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 14:41:14 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 14:41:14 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 14:41:14 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 14:41:14 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 14:41:14 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 14:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:17 INFO - Installing collected packages: psutil 14:41:17 INFO - Running setup.py install for psutil 14:41:17 INFO - building 'psutil._psutil_osx' extension 14:41:17 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 14:41:17 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 14:41:17 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 14:41:17 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 14:41:18 INFO - building 'psutil._psutil_posix' extension 14:41:18 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 14:41:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:41:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:41:18 INFO - ^ 14:41:18 INFO - 1 warning generated. 14:41:18 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 14:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:18 INFO - Successfully installed psutil 14:41:18 INFO - Cleaning up... 14:41:18 INFO - Return code: 0 14:41:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:18 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:18 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 14:41:18 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 14:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:18 INFO - 'HOME': '/Users/cltbld', 14:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:18 INFO - 'LOGNAME': 'cltbld', 14:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:18 INFO - 'MOZ_NO_REMOTE': '1', 14:41:18 INFO - 'NO_EM_RESTART': '1', 14:41:18 INFO - 'PAGER': '/bin/cat', 14:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:18 INFO - 'PWD': '/builds/slave/test', 14:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:18 INFO - 'SHELL': '/bin/bash', 14:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:18 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:18 INFO - 'USER': 'cltbld', 14:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:18 INFO - 'XPC_FLAGS': '0x0', 14:41:18 INFO - 'XPC_SERVICE_NAME': '0', 14:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:41:18 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 14:41:18 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 14:41:18 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 14:41:18 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 14:41:18 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 14:41:18 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 14:41:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:41:21 INFO - Installing collected packages: mozsystemmonitor 14:41:21 INFO - Running setup.py install for mozsystemmonitor 14:41:21 INFO - Successfully installed mozsystemmonitor 14:41:21 INFO - Cleaning up... 14:41:21 INFO - Return code: 0 14:41:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:41:21 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')]} 14:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:21 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')]} 14:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:21 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:21 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 14:41:21 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 14:41:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:21 INFO - 'HOME': '/Users/cltbld', 14:41:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:21 INFO - 'LOGNAME': 'cltbld', 14:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:21 INFO - 'MOZ_NO_REMOTE': '1', 14:41:21 INFO - 'NO_EM_RESTART': '1', 14:41:21 INFO - 'PAGER': '/bin/cat', 14:41:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:21 INFO - 'PWD': '/builds/slave/test', 14:41:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:21 INFO - 'SHELL': '/bin/bash', 14:41:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:21 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:21 INFO - 'USER': 'cltbld', 14:41:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:21 INFO - 'XPC_FLAGS': '0x0', 14:41:21 INFO - 'XPC_SERVICE_NAME': '0', 14:41:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:21 INFO - Downloading/unpacking jsonschema==2.5.1 14:41:21 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 14:41:21 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 14:41:21 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 14:41:21 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 14:41:21 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 14:41:21 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 14:41:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:41:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:41:23 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 14:41:23 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 14:41:23 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 14:41:23 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 14:41:23 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 14:41:23 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 14:41:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:41:24 INFO - warning: no files found matching '*.txt' 14:41:24 INFO - no previously-included directories found matching 'build' 14:41:24 INFO - no previously-included directories found matching 'dist' 14:41:24 INFO - no previously-included directories found matching '.git*' 14:41:24 INFO - Installing collected packages: jsonschema, functools32 14:41:24 INFO - Running setup.py install for functools32 14:41:24 INFO - warning: no files found matching '*.txt' 14:41:24 INFO - no previously-included directories found matching 'build' 14:41:24 INFO - no previously-included directories found matching 'dist' 14:41:24 INFO - no previously-included directories found matching '.git*' 14:41:24 INFO - Successfully installed jsonschema functools32 14:41:24 INFO - Cleaning up... 14:41:24 INFO - Return code: 0 14:41:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:41:24 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')]} 14:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:24 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')]} 14:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:24 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:24 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 14:41:24 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 14:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:24 INFO - 'HOME': '/Users/cltbld', 14:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:24 INFO - 'LOGNAME': 'cltbld', 14:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:24 INFO - 'MOZ_NO_REMOTE': '1', 14:41:24 INFO - 'NO_EM_RESTART': '1', 14:41:24 INFO - 'PAGER': '/bin/cat', 14:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:24 INFO - 'PWD': '/builds/slave/test', 14:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:24 INFO - 'SHELL': '/bin/bash', 14:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:24 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:24 INFO - 'USER': 'cltbld', 14:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:24 INFO - 'XPC_FLAGS': '0x0', 14:41:24 INFO - 'XPC_SERVICE_NAME': '0', 14:41:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:41:24 INFO - Cleaning up... 14:41:24 INFO - Return code: 0 14:41:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:41:24 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')]} 14:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:24 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')]} 14:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:24 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:24 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 14:41:24 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 14:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:24 INFO - 'HOME': '/Users/cltbld', 14:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:24 INFO - 'LOGNAME': 'cltbld', 14:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:24 INFO - 'MOZ_NO_REMOTE': '1', 14:41:24 INFO - 'NO_EM_RESTART': '1', 14:41:24 INFO - 'PAGER': '/bin/cat', 14:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:24 INFO - 'PWD': '/builds/slave/test', 14:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:24 INFO - 'SHELL': '/bin/bash', 14:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:24 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:24 INFO - 'USER': 'cltbld', 14:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:25 INFO - 'XPC_FLAGS': '0x0', 14:41:25 INFO - 'XPC_SERVICE_NAME': '0', 14:41:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:25 INFO - Downloading/unpacking blobuploader==1.2.4 14:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:27 INFO - Downloading blobuploader-1.2.4.tar.gz 14:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:41:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:41:27 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 14:41:27 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 14:41:27 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 14:41:27 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 14:41:27 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 14:41:27 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 14:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:41:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:28 INFO - Downloading docopt-0.6.1.tar.gz 14:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:41:28 INFO - Installing collected packages: blobuploader, requests, docopt 14:41:28 INFO - Running setup.py install for blobuploader 14:41:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:41:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:41:29 INFO - Running setup.py install for requests 14:41:29 INFO - Running setup.py install for docopt 14:41:29 INFO - Successfully installed blobuploader requests docopt 14:41:29 INFO - Cleaning up... 14:41:29 INFO - Return code: 0 14:41:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:29 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:29 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 14:41:29 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 14:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:29 INFO - 'HOME': '/Users/cltbld', 14:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:29 INFO - 'LOGNAME': 'cltbld', 14:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:29 INFO - 'MOZ_NO_REMOTE': '1', 14:41:29 INFO - 'NO_EM_RESTART': '1', 14:41:29 INFO - 'PAGER': '/bin/cat', 14:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:29 INFO - 'PWD': '/builds/slave/test', 14:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:29 INFO - 'SHELL': '/bin/bash', 14:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:29 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:29 INFO - 'USER': 'cltbld', 14:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:29 INFO - 'XPC_FLAGS': '0x0', 14:41:29 INFO - 'XPC_SERVICE_NAME': '0', 14:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-s4ugrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-U3Ob8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-eNaiwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RDWIEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-EmAkg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-kgiufP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-CeQljJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-J_0ZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:30 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-TZ5ILy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-syzpn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-5TcJ9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-jCjzHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Uw6zJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-CDfHhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-TS3Nxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-arbr6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:31 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-uIPWiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:41:31 INFO - Running setup.py install for manifestparser 14:41:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:41:31 INFO - Running setup.py install for mozcrash 14:41:32 INFO - Running setup.py install for mozdebug 14:41:32 INFO - Running setup.py install for mozdevice 14:41:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozfile 14:41:32 INFO - Running setup.py install for mozhttpd 14:41:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozinfo 14:41:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozInstall 14:41:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozleak 14:41:33 INFO - Running setup.py install for mozlog 14:41:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for moznetwork 14:41:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozprocess 14:41:33 INFO - Running setup.py install for mozprofile 14:41:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozrunner 14:41:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozscreenshot 14:41:34 INFO - Running setup.py install for moztest 14:41:34 INFO - Running setup.py install for mozversion 14:41:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:41:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:41:34 INFO - Cleaning up... 14:41:34 INFO - Return code: 0 14:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:34 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:34 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 14:41:34 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 14:41:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:34 INFO - 'HOME': '/Users/cltbld', 14:41:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:34 INFO - 'LOGNAME': 'cltbld', 14:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:34 INFO - 'MOZ_NO_REMOTE': '1', 14:41:34 INFO - 'NO_EM_RESTART': '1', 14:41:34 INFO - 'PAGER': '/bin/cat', 14:41:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:34 INFO - 'PWD': '/builds/slave/test', 14:41:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:34 INFO - 'SHELL': '/bin/bash', 14:41:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:34 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:34 INFO - 'USER': 'cltbld', 14:41:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:34 INFO - 'XPC_FLAGS': '0x0', 14:41:34 INFO - 'XPC_SERVICE_NAME': '0', 14:41:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:34 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-vLwed7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:34 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)) 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:34 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-nIKmO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:34 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)) 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:34 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-2xjGWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:34 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)) 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:34 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-SZLyHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-T89jU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NVw2nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-V5igKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ZFvfGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-zRmezm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RLRX4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NGh3eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-eiqhRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:35 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)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:35 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-sFFLEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:36 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-WGBXQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:36 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-tr2i_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:36 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-bk9ODQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:36 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-oTIBLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:36 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)) 14:41:36 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)) 14:41:36 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)) 14:41:36 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)) 14:41:36 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)) 14:41:36 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)) 14:41:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:36 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 14:41:36 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 14:41:36 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 14:41:36 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 14:41:36 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 14:41:36 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 14:41:38 INFO - Downloading blessings-1.6.tar.gz 14:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:41:38 INFO - Installing collected packages: blessings 14:41:38 INFO - Running setup.py install for blessings 14:41:39 INFO - Successfully installed blessings 14:41:39 INFO - Cleaning up... 14:41:39 INFO - Return code: 0 14:41:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:41:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:39 INFO - Reading from file tmpfile_stdout 14:41:39 INFO - Current package versions: 14:41:39 INFO - blessings == 1.6 14:41:39 INFO - blobuploader == 1.2.4 14:41:39 INFO - docopt == 0.6.1 14:41:39 INFO - functools32 == 3.2.3-2 14:41:39 INFO - jsonschema == 2.5.1 14:41:39 INFO - manifestparser == 1.1 14:41:39 INFO - mozInstall == 1.12 14:41:39 INFO - mozcrash == 0.17 14:41:39 INFO - mozdebug == 0.1 14:41:39 INFO - mozdevice == 0.48 14:41:39 INFO - mozfile == 1.2 14:41:39 INFO - mozhttpd == 0.7 14:41:39 INFO - mozinfo == 0.9 14:41:39 INFO - mozleak == 0.1 14:41:39 INFO - mozlog == 3.3 14:41:39 INFO - moznetwork == 0.27 14:41:39 INFO - mozprocess == 0.23 14:41:39 INFO - mozprofile == 0.28 14:41:39 INFO - mozrunner == 6.12 14:41:39 INFO - mozscreenshot == 0.1 14:41:39 INFO - mozsystemmonitor == 0.3 14:41:39 INFO - moztest == 0.7 14:41:39 INFO - mozversion == 1.4 14:41:39 INFO - psutil == 3.1.1 14:41:39 INFO - requests == 1.2.3 14:41:39 INFO - wsgiref == 0.1.2 14:41:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:39 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 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41:39 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 14:41:39 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 14:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:39 INFO - 'HOME': '/Users/cltbld', 14:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:39 INFO - 'LOGNAME': 'cltbld', 14:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:39 INFO - 'MOZ_NO_REMOTE': '1', 14:41:39 INFO - 'NO_EM_RESTART': '1', 14:41:39 INFO - 'PAGER': '/bin/cat', 14:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:39 INFO - 'PWD': '/builds/slave/test', 14:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:39 INFO - 'SHELL': '/bin/bash', 14:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:39 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:39 INFO - 'USER': 'cltbld', 14:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:39 INFO - 'XPC_FLAGS': '0x0', 14:41:39 INFO - 'XPC_SERVICE_NAME': '0', 14:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 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)) 14:41:40 INFO - Cleaning up... 14:41:40 INFO - Return code: 0 14:41:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a85a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b1a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3a2d80190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, '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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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 14:41: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', 'jsonschema'] in /builds/slave/test/build 14:41: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 jsonschema 14:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:40 INFO - 'HOME': '/Users/cltbld', 14:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:40 INFO - 'LOGNAME': 'cltbld', 14:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:40 INFO - 'MOZ_NO_REMOTE': '1', 14:41:40 INFO - 'NO_EM_RESTART': '1', 14:41:40 INFO - 'PAGER': '/bin/cat', 14:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:40 INFO - 'PWD': '/builds/slave/test', 14:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:40 INFO - 'SHELL': '/bin/bash', 14:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:41:40 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:40 INFO - 'USER': 'cltbld', 14:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:40 INFO - 'XPC_FLAGS': '0x0', 14:41:40 INFO - 'XPC_SERVICE_NAME': '0', 14:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:41:40 INFO - Cleaning up... 14:41:40 INFO - Return code: 0 14:41:40 INFO - Running post-action listener: _resource_record_post_action 14:41:40 INFO - Running post-action listener: _start_resource_monitoring 14:41:40 INFO - Starting resource monitoring. 14:41:40 INFO - [mozharness: 2016-09-02 21:41:40.816293Z] Finished create-virtualenv step (success) 14:41:40 INFO - [mozharness: 2016-09-02 21:41:40.817254Z] Running install step. 14:41:40 INFO - Running pre-action listener: _resource_record_pre_action 14:41:40 INFO - Running main action method: install 14:41:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:41 INFO - Reading from file tmpfile_stdout 14:41:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:41:41 INFO - Reading from file tmpfile_stdout 14:41:41 INFO - Output received: 14:41:41 INFO - Usage: mozinstall [options] installer 14:41:41 INFO - Options: 14:41:41 INFO - -h, --help show this help message and exit 14:41:41 INFO - -d DEST, --destination=DEST 14:41:41 INFO - Directory to install application into. [default: 14:41:41 INFO - "/builds/slave/test"] 14:41:41 INFO - --app=APP Application being installed. [default: firefox] 14:41:41 INFO - mkdir: /builds/slave/test/build/application 14:41:41 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'] 14:41:41 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 14:42:15 INFO - Reading from file tmpfile_stdout 14:42:15 INFO - Output received: 14:42:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:42:15 INFO - Running post-action listener: _resource_record_post_action 14:42:15 INFO - [mozharness: 2016-09-02 21:42:15.229860Z] Finished install step (success) 14:42:15 INFO - [mozharness: 2016-09-02 21:42:15.229969Z] Running run-tests step. 14:42:15 INFO - Running pre-action listener: _resource_record_pre_action 14:42:15 INFO - Running main action method: run_tests 14:42:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:15 INFO - 2016-09-02 14:42:15.242 screenresolution[1645:7426] starting screenresolution argv=screenresolution get 14:42:15 INFO - 2016-09-02 14:42:15.245 screenresolution[1645:7426] Display 0: 1600x1200x32@60 14:42:15 INFO - 2016-09-02 14:42:15.250 screenresolution[1646:7428] starting screenresolution argv=screenresolution list 14:42:15 INFO - Available Modes on Display 0 14:42:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:15 INFO - Intel Iris: 14:42:15 INFO - Chipset Model: Intel Iris 14:42:15 INFO - Type: GPU 14:42:15 INFO - Bus: Built-In 14:42:15 INFO - VRAM (Dynamic, Max): 1536 MB 14:42:15 INFO - Vendor: Intel (0x8086) 14:42:15 INFO - Device ID: 0x0a2e 14:42:15 INFO - Revision ID: 0x0009 14:42:15 INFO - Displays: 14:42:15 INFO - Display: 14:42:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:15 INFO - Display Serial Number: 1600x1200 60 14:42:15 INFO - Main Display: Yes 14:42:15 INFO - Mirror: Off 14:42:15 INFO - Online: Yes 14:42:15 INFO - Rotation: Supported 14:42:15 INFO - Return code: 0 14:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:42:15 INFO - Python 2.7.3 14:42:15 INFO - Return code: 0 14:42:15 INFO - grabbing minidump binary from tooltool 14:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x1039e9d30>, '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 0x10374edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:42:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:42:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:42:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:42:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:42:15 INFO - Return code: 0 14:42:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:42:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:42:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:42:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:42:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--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 14:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --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 14:42:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2PVjFQe8Bg/Render', 14:42:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:42:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:42:15 INFO - 'HOME': '/Users/cltbld', 14:42:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:42:15 INFO - 'LOGNAME': 'cltbld', 14:42:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:42:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:15 INFO - 'MOZ_NO_REMOTE': '1', 14:42:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:42:15 INFO - 'NO_EM_RESTART': '1', 14:42:15 INFO - 'PAGER': '/bin/cat', 14:42:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:15 INFO - 'PWD': '/builds/slave/test', 14:42:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:42:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:42:15 INFO - 'SHELL': '/bin/bash', 14:42:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2zD4Oi7vD9/Listeners', 14:42:15 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:42:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:42:15 INFO - 'USER': 'cltbld', 14:42:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:42:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:15 INFO - 'XPC_FLAGS': '0x0', 14:42:15 INFO - 'XPC_SERVICE_NAME': '0', 14:42:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:42:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--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 14:42:15 INFO - mozversion application_buildid: 20160902132549 14:42:15 INFO - mozversion application_changeset: b462b3ebc32cdd8a54b35e52773191d3081f17a7 14:42:15 INFO - mozversion application_display_name: Nightly 14:42:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:42:15 INFO - mozversion application_name: Firefox 14:42:15 INFO - mozversion application_remotingname: firefox 14:42:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:42:15 INFO - mozversion application_vendor: Mozilla 14:42:15 INFO - mozversion application_version: 51.0a1 14:42:15 INFO - mozversion platform_buildid: 20160902132549 14:42:15 INFO - mozversion platform_changeset: b462b3ebc32cdd8a54b35e52773191d3081f17a7 14:42:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:42:15 INFO - mozversion platform_version: 51.0a1 14:42:15 INFO - using testdate: 1472852535 14:42:15 INFO - actual date: 1472852535 14:42:15 INFO - starting webserver on 'localhost:49266' 14:42:15 INFO - SUITE-START | Running 2 tests 14:42:15 INFO - TEST-START | dromaeo_css 14:42:15 INFO - operating with platform_type : mac_ 14:42:15 INFO - Initialising browser for dromaeo_css test... 14:42:15 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp3e01QG/profile http://localhost:49266/getInfo.html) 14:42:18 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:42:18 INFO - PROCESS | 1656 | colorDepth:24 14:42:18 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:42:18 INFO - PROCESS | 1656 | __metrics 14:42:18 INFO - PROCESS | 1656 | 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" 14:42:18 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:19 INFO - TEST-INFO | 1656: exit 0 14:42:19 INFO - Browser initialized. 14:42:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:42:19 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp3e01QG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:31 INFO - PROCESS | 1658 | RSS: Main: 233930752 14:42:31 INFO - PROCESS | 1658 | 14:43:22 INFO - PROCESS | 1658 | 1472852602386 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] 14:45:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 14:45:35 INFO - PROCESS | 1658 | RSS: Main: 364425216 14:45:35 INFO - PROCESS | 1658 | 14:48:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 14:48:39 INFO - PROCESS | 1658 | RSS: Main: 368951296 14:48:39 INFO - PROCESS | 1658 | 14:51:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 14:51:42 INFO - PROCESS | 1658 | RSS: Main: 350502912 14:51:42 INFO - PROCESS | 1658 | 14:54:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 14:54:45 INFO - PROCESS | 1658 | RSS: Main: 336162816 14:54:45 INFO - PROCESS | 1658 | 14:57:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 14:57:49 INFO - PROCESS | 1658 | RSS: Main: 326168576 14:57:49 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 15:00:52 INFO - PROCESS | 1658 | RSS: Main: 469364736 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | __start_tp_report 15:00:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 15:00:52 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 15:00:52 INFO - PROCESS | 1658 | |i|pagename|runs| 15:00:52 INFO - PROCESS | 1658 | |0;dojo.html;3309.172706823295;3324.7838890472117;3345.5483509726196;3368.2926585417063;3392.898213053609;4757;5516.558675305976;5603.299587551556;5655.802046928358;5661.773529058838;5621.128725047624;5635.295588051494;5666.376698563155;5672.149177623359;5685.744141513632;5179.663321884075;5228.92156617651;5254.789808407659;5254.789808407659;5259.579233661317;5194.71429071401;5215.217717342391;5264.578833693296;5264.631475796696;5273.683578985273;5093.923591146117;5324.600654950875;5334.51989320961;5338.199270109495;5345.866353341178;5184.481551844785;5191.558717508998;5202.375714914235;5220.765065572058;5227.8170264040955;5091.338126043628;5104.106781313255;5128.410232823198;5139.331886854685;5154.896902061975;5342.358916929955;5562.916556251659;5610.971945140289;5749.942500574983;5756.338021127582;5178.378594568676;6185.16500272462;6203.472704820096;6204.720787564571;6234.501239900797;6075.270152776053;6213.5339849511465;6272.3100458949475;6279.466245369149;6304.558680892339;5638.013347664142;5666.376698563155;5723.742431590588;5748.6838223898085;5758.3090029196765;6335.493160547145;6357.841053973688;6365.96817015912;6373.362663733682;6381.776637817654;5902.2032025676845;6069.211002569726;6083.543734219951;6086.817395478142;6094.268687757409;6109.34393638171;6141.877162456815;6164.537659675542;6181.690915454209;6234.750609975641;6094.512439004869;6096.786612468542;6159.353267906805;6164.753409863645;6165.660888651078;6176.413240742212;6187.133801267826;6199.411055949768;6203.937960620427;6209.379062093845;4845.345878306454;4889.877753056202;4893.094777466109;4907.141250281186;4958.281049247839;4400.603945644843;4417.2269852775635;4423.933640995388;4450.3991961085485;4482.462104547475;5701.686407247558;5705.74324155414;5707.6290041147195;5710.971445142748;5718.1136923776885;6119.350229749377;6119.479844213202;6158.599691020069;6197.442230199214;6273.96863015682;5664.773409063591;5666.575006874501;5668.716564171775;5668.858278543069;5725.685087320154;5370.4629537045985;5372.597055220874;5374.946250537523;5384.326959130109;5392.218128371364;5320.414754376938;6251.374862513712;6261.96869015652;6332.556721029668;6332.683365831782;5107.361579802525;6005.878219908704;6148.016317389196;6182.227221597301;6185.103160041679;6284.808648691501;6331.430171284606;6349.809505714836;6352.841178970562;6353.459955903615;5912.113183022581;6014.158017877413;6091.7258723358445;6092.939070609415;6129.816105516842;6130.386961303834;6151;6165.982612868826;6186.350433204629;6217.875642487215;5981.641101533922;6024.529942723462;6032.426919442646;6040.36576159497;6097.085437184281;5874.324452687995;5890.6760128191645;5896.764129434775;6029.487493563096;6033.939660603338;5788.102844059177;5804.883902321845;5811.593188476766;5833.066709326487;5849.415058494286;5949;5959.73181206838;5970.850728731816;5974.641521508724;5976.043832986701;5731.312242530923;5772.740226689725;5775.7400916957995;5797.768089276382;5801.82594522165 15:00:52 INFO - PROCESS | 1658 | |1;ext.html;500.17471172565286;511.7850502788828;528.6061883896498;531.2111514401114;545.2502808638123;31423.371532569334;32154.839225803866;33268.16829579262;42102.78948605261;43562.782186089105;44137;44417.33373999393;44472.77763611185;44480.77759611198;44561;9661.4203147811;9838.262130340254;9844.163246124088;9856.35933664313;9858.556364963559;9760;9813.460259685715;9841.950790246074;9857.852132218022;9859.507024648774;9812.803743925117;9884.85172722406;9893.25800564957;9896.50517474127;9904.158146557551;9780.070893265129;9846.852297215548;9847.359921605073;9861.359011664255;9867.40795552269;9728.270379721549;9780.168685661727;9787.168090712297;9790.657326993593;9801.460919649417;41792.582074179176;42234.57765422337;42239.15521689549;42257.78871105625;42267.154656907;3307.4873394623633;3433.9313213735836;3492.6507349265125;3642.981785091084;3849.40334248192;31272;31411;31426;31600.36799264002;32517.837410812794;3043.4978228592254;3181.5704879841155;3185.8088514689193;3252.7235185009304;3258.9571337172115;508654;515463;515529;517860;518760.4061979704;63864.36135638677;64148.67925660342;64299;64370.24112468123;64513;66309.66845165839;66390;66431;66763;67105.66447167733;16202;16873.240704168344;16932.40736574214;17463.38878139259;17497;12936.830476533309;13103;13111.082224244212;13153.53962611304;13179.209247445184;19007.239710411704;19109.331173408864;19238.941858197653;19393.8060619392;19446.611067778565;6796.694148763318;7991.640376183086;8011.078725946591;8076.55578943152;8193.385496087698;781.3397678961269;911.6080085563138;966.9468179250068;1004.8342023566175;1005.3867141043958;30078.24804379908;30957.535636965462;31429;31581.526277105862;31849.363012739614;843.4306842881031;996.1980605612551;1031.1802117316752;1083.9620613278655;1114.3815182573587;15856.920715396349;16004;16133.677326453406;16184.786141039469;16391.754123688155;674358;674981;676044;677308;677690;59996.700016499635;60042.79914401775;60149;60170.69914650486;60282.39717602856;1244.9377531123407;1345.1122259309004;1369.431685850361;1389.5275606293908;1392.9512467063807;30829.69170308358;31727.04818855438;31856.840715796272;32005.039848804572;32612.34775304528;52089.218661720864;52552.21171682504;52699.20951185812;52746.68133296698;52929;521492;529372;529683;529698;530146;27046.72953270442;27797.58303625407;27824.887004520402;28671.996480123096;28723.712762872103;48804.755976219894;49165.2625210615;49638.50361496339;50194.749026254634;50499.69753175863;40049.79850604486;40130.598694013854;40348.394774077824;41405;41786.1642767149;33475.83262083674;39989.80005099956;40521.594784051784;41742.79128604338;41941.161176775684;38609.80695096507;38610.80694596509;39319;39587.2082558353;40123.398149027205;34357.656423435445;34762.13094672653;35755.46366804552;35770.463443048895;36112;25628.743712562635;25749.742502574736;26082;26173.73826261713;26633 15:00:52 INFO - PROCESS | 1658 | |2;jquery.html;350.61432424333253;371.93119272934507;376.3601876809423;383.1035377217312;408.2365975625579;14430.927845360771;15069.020513666605;20740.859252741095;20802.791972080275;20828.791712082875;19703.704444433344;20254.898725506388;20505.589888202227;20644.89677551614;20726.963651817423;5036.471170527097;5218.8695282617855;5482.725863706799;5483.862903427426;5486.643368181076;5865.442782935615;6061.333253342129;6068.241469816273;6070.696465176746;6076.878462430749;5180.844574662766;5663.348714897777;5860.941390586082;6009.188759517475;6023.548233882477;5908.940910590882;5915.9704201478935;5939.613925094855;5944;5960.165576819227;5042.647014708972;5192.221166824968;5249.265102885599;5258.368995720538;5260.237265596467;24954.5009099817;25365.61951570728;25535.48929021428;25731.871340643364;25763.71181440939;2356.5640356534095;2451.8406303590386;2745.9038933637225;2893.652761668592;2966.7984466291186;9945.552450139761;10039.89960100397;10433.9478302608;10434.95650434958;10470.47647617616;1804.6661367646896;1865.1979648751033;1911.44568075258;1931.5460866696314;1932.9806701932941;110863.33704994431;116695;119913;126015;128673;9367.953160234292;11094.667159985212;11388.658340249805;11525.250858694159;11705.063594912386;14553.490627828187;14564;14571.708565828623;14582.927085364505;14588.708225835424;8270.462419942805;8566.400351975302;8583.699570515002;8678.913210867937;8714.607842647096;8438.059246373246;8462.746117616482;8465.957670211732;8630.525321107274;8642.95678521616;3942.7580312201567;4423.336499525097;4474.239379305526;4486.259767138451;4578.336141259499;1406.2054938959454;1536.8386319436522;1637.8198398176191;1712.3664244229465;1778.2406603791849;784.6939693519532;856.6659002988839;878.2139984713646;932.6595792535676;960.5677445149711;20197.091130899145;21286.148554057665;21315.68026479604;21374.358769236947;21401.892990534947;916.2212119698337;923.6674797073048;928.4846909964899;946.2146418472652;1001.8797744270735;10117.241206909512;10519.579216831395;10613.394087420334;10961.451927403597;11130.833037504444;283049;283076;283288;283329;283874;81925.59037204777;132243;139165.30417348052;148043.704266464;149390.25304873622;973.3332667123043;1012.5241136665755;1040.2146379483443;1041.094248004241;1043.9247574997764;16426.342946282493;18905.527361816065;19346.70979935274;19444.125014374105;19677.31129410464;40274.194516108924;56579.86840263089;56799.14801277901;57065.71467142638;57421;84656.73014904658;85891.57054214689;86932.56533717545;87534.68697969409;88769.55615221882;6822.795316140524;7908.288254057163;8164.959175204086;8244.30991646699;8268.545230012167;9868.407895526292;12801.231926084465;12984.220946743226;13230.603081907559;13235.3382330885;9547.663327134345;10991.890081099087;11234.269772464764;11277.23280341543;11403.828942566033;10399.688009359732;10433.843492347773;10542.367457952547;10646.89353106459;10860.185486088732;11452.427378631202;11479.483423245807;11535.711607209887;11766.58816941403;11866.288022718665;7762.7671169865;7983.920160798318;8014.659018483082;8155.673773049249;8444.915550844413;8039.397045221749;9608.279379046739;11123.27698699582;11135;11625.360605166798 15:00:52 INFO - PROCESS | 1658 | |3;mootools.html;1456.8397476277612;1478.4899209772627;1657.8839481236312;1783.652187823375;1853.6570734414133;8309.916900830998;8769.649214031448;8772.385932984693;8781.209691127797;8796;7647.694092236304;7889.960550197241;8135.837283254346;8498.1501849815;8556.572171391437;2317.4785673223514;2353.341064501942;2359.634256690216;2366.1600131953082;2370.4073981504625;2356.1046802215133;2364.1725396111397;2400.2679182849224;2402.939926501843;2405.542946840095;2368.336865677613;2377.405648587853;2388.7133543974746;2396.9640455393182;2397.8441401308946;2347.4248809041724;2348.518553696488;2353.6234202527685;2356.3402247370764;2386.2841147655636;2351.753065928087;2363.102021231921;2365.6924599802087;2371.1345358944036;2371.67982322386;8450.957745211295;8592.785180370478;8597.957010214972;8612.82774344516;8649.048604653482;5158.226266060084;5297.973510132463;5299.5230429261555;5308.362996440414;5310;3556.3598552260582;3567.714582833367;3637.381645120336;3658.2500587379523;3665.21197942441;934.173256667847;971.5579411367811;1765.699831028728;1815.8365747082694;1865.692160793481;11023.007929286323;11185.49665265065;11187.776244475064;11203.551857925591;11366.545338186545;3919.8236079376497;4745.928811067837;4803.375561177095;4813.3983252093485;4813.470518242991;9894.55474503649;9910;9910.653127140515;9938.155256803107;9941.801163976825;5143.305653736773;5196.58427325813;5280.867978300574;5292.9735351323;5300.522952934254;4372.147431250875;4521.660875434355;4685.4143232095985;4830.95169048305;4847.079054979543;3873.6320049595242;3904.2191561687778;4001.2597669431248;4065.0853557949818;4086.3666131749033;1286;1301.7852054411105;1304.1588175626669;1304.2044352944697;1316.9868301317056;747.517850986111;856.5545916123706;872.5157537566712;894.608883186638;918.875951746519;5154.768035438415;5629.549636029108;5872.647641141545;5879.147523609053;5923.17075609415;435.43611023724355;442.8937055106751;443.4877716237751;444.9587964163872;454.07822121094233;3780.3762379207124;3935.5080614923136;3956.8615098471414;3967.80160991955;4189.476315460567;10437.32157409766;10468.47657617116;10591.894081059245;10594.735131621772;10649.73375665599;10546.789064218672;10568.313059651098;10572.52423640938;10582.470876456146;10600.363978161335;6369.490440764727;7863.685452581833;7985.600719963979;8005.319547838499;8046.597670116588;5792.797252096157;5831.79588714393;5904.675242861684;5932.6737029462065;6010.459058684739;8026.83946321082;9590.08894155054;9736.075072868067;9804.55879485439;9817.950910245403;9555.61777528891;9875.209983201183;9902.158316543175;9906.851397229191;9939;6809.387155155861;7050.647467626701;7208.819779505554;7317.560946343024;7519.473636845369;8047.195280471906;8226.547539885363;8238.382121340803;8241.83516329682;8252.669893204205;7220.3140701633265;7306.634668266459;7311;7368.226336234618;7453.664585093792;6976.825579360557;7111.82220444493;7168.068151140318;7201.891971620535;7255.2019277878335;6786.117804685359;6840.657967101724;6942.132233470817;6942.51402401827;6944.201416837129;4040.292948733901;4768.094062128184;4919.704817710949;5017.54842064216;5060;4757.215059515142;4881.609471242363;4950.603951683928;5055.570276526537;5124.231365295235 15:00:52 INFO - PROCESS | 1658 | |4;prototype.html;297.71568152414443;305.1349424381876;311.4736095997764;316.8764181969033;317.7362788885226;4817.47007829139;5339.492748188916;5362.597805164609;5392.865178370543;5403.432639572848;4886.434621823544;4911.926321105187;4958.281049247866;5236.303303798547;5274.314339135916;4033.818478168482;4042.684998301394;4051.5948405159397;4074.6129117733767;4128.649064829493;4036.919261614766;4070.613291737295;4078.7348822326603;4084.4077608746716;4105.7331273467125;3322.468405055192;3775.660190582847;4020.5979402059706;4022.859199928003;4053.9391909121387;3998.9200215995515;4015.072765072752;4032.1129351542613;4037.899052523681;4054.493188351456;3438.7420943429092;3449.844756985917;3456.343294773985;3469.826508674556;3472.2013936794424;4504.346869703907;4937.333459982892;5110.368160397398;5118.539331460149;5167.457416971201;3693.8522459101605;4378.759168245745;4548.272276435788;4566.657500687462;4577.862664120082;4867.732274724889;5511.58663100265;5536.557075433956;5571.637843540157;5586.072804882309;3049.8627561759554;3775.0184951912424;3800;3803.7147213959065;3823.178016726389;4936.234883593013;5074.441811400743;5660.716964151817;5831.708414579297;5919.6152250103605;3248.431524483206;3812.218495208476;3817.7900215488417;3845.9038524036564;3849.40334248192;3483.0247530691445;3826.8469261229798;3927.2341893330527;3971.860984865516;3977.54258260298;4307.310830267204;4556.88607784808;4577.299393357935;4620.422447194101;4624.745638989888;4389.231884420214;4643.628509719214;5598.732513332107;5614.887702245932;5616.887662246732;1195.6114262864603;1261.148724610884;1261.3251910227984;1291.606060151644;1328.5350127455506;834.929031032369;861.2291998661289;886.0563499872615;893.4148132972913;899.5007770687331;5053.646244762905;5064.620153488429;5069.695818250917;5104.213525266127;5138.563222126087;4535.9546404536195;5072.492750724898;5656.179853921159;5699.173619825102;5752.395998420189;4543.000539881221;4876.926846097312;4995.875103122378;5061.6962982221185;5080.110980578384;2426.3691440225316;2726.768224700883;2993.1020693791775;2996.2509372656837;3002.993997010982;5466.671999680032;5592.608517403743;5835.840738926539;5851.824445266649;5881.558883083786;4810.302506136591;4928.630352723489;5972.96824643364;5982.48735531078;6004.819855404345;5121.308623335951;5997.821154787969;6020.638761674313;6070.605410648293;6074.444166874844;5180.19706945409;5542.204716557939;5716.571257155647;5760.494185029525;5854.4730974212525;5665.640246340931;5716.42835716425;5747.39073059544;5754.165645981393;5754.56840736938;5396.676199428047;5944.9405505946115;5947.1079338099635;5952.761889524544;5999.640021598718;3589.264200838874;3805.477808876361;3849.730518863653;3854.4411060396646;3862.4592557042597;5733.168690539765;5790.449907258803;5815.6219845711585;5825.533957283323;5836.482514546164;5164.715940623302;5236.842894713165;5667.234923285304;5679.630823996592;5725.799597014085;4948.826791062295;5542.667439953616;5572.554195664256;5577.414371491097;5595.873568044117;5136.332276803992;5344.11822049373;5484.149956756709;5487.341519017744;5499.972500137474;4621.560951709582;4776.379070720784;4937.1113199624415;4950.900981980412;5497.147942068986;5201.713905735221;5369.27514785499;5385.3268341457315;5389.622726409114;5482.671039737628 15:00:52 INFO - PROCESS | 1658 | |5;yui.html;671.9193696756389;789.4000559574725;794.2414993681035;816.3591580609223;818.7871153500092;15124.546263612096;15222.314995825187;15891.84108158918;16008.599785005366;16059.919700401497;11651.825222621668;12119.575814846483;14320.355583998718;14322.212278324714;14792.260386980663;710.8009757267973;871.3073106880046;896.2426749396782;902.1249388093571;903.5708038681606;733.0506993443504;860.6901515454431;894.4454438248263;903.0157128729684;907.7412937312868;943.7074506902882;945.2249155692335;945.2438049560359;946.6402766948585;947.0576776107782;745.1319213116712;944.4286206844897;947.87677601912;949.6059135458777;951.7668171298042;567.1917517537534;570.2586637371401;574.1387918122816;678.1421501800227;698.4691634357873;14496.492622758153;14594.489192878304;14600.561983140522;14631.41474341025;14687.926560367237;13571.796423053662;13919.164850108924;14077.296135193303;14102;14297.428102875872;12652.936735316356;12733.426995785212;12792;13111.60665180046;13404.128731632412;4614.492638714782;4621.445426548802;4651.418572678415;4837.9032419351415;4846.539578740014;97952;118802;120027;121384;123525.38237308936;10306.227032972558;10423.94788026055;10482.790344193074;10626.14990800734;10868.45657717111;21021.894890525757;21421.143154273967;21424;21459;21536.246231381825;7729.458937874408;7729.768106956801;7982.1618730032515;7995.600219988977;8089.595520223966;4466.665000124939;4529.614982726439;4559.202139625552;4706.599939005223;4748.928766068511;3549.911252218715;3709.7588656737225;3714.3499887519574;3717.20080182762;3726.2920045191327;576.9394213607595;681.3935597318391;694.482610455204;701.7052837808133;708.6988030087192;554.3597145297189;617.6448542088317;656.9652796844988;677.6510097299895;682.5836239893661;9330.393524421026;9341.346105772667;9404.623815047458;9440.716778496657;9541.427514349161;634.9111124442582;650.8568115014689;680.3604611665019;682.5938566552893;683.6479213205204;4296.398504209413;4581.266997280419;4585.518520555361;4671.719696818202;4760.404949381327;156270.43729562787;160341.19829400777;161931.19034404753;162312.18843905706;165469;133783;137869;140528.2973585146;142334;144789;119688.40155799339;121866;122628.38685806513;122663;122859.78551608487;8579.356548259031;9017.594208260512;9026.142516460926;9076.137766912132;9148.954255228682;64270.714585708956;65193.22734909999;65848.67075664591;67306.66346668235;68354.3164568348;93425.5328723352;97782;97966.51016745156;99475;100389;11366.772664546828;11627.53489860396;11762.882371176178;11895.286282823059;12381.442835072263;13000.674983125498;13707.451701931812;14488.749304285551;15495.14776687293;15497;10985.670429887115;13702.45190192381;13905.51330703461;14197;14226.644333891736;12108.152429329863;13727.45090196381;13921.095128816594;14030.929845350707;14446.205458699873;13443.731125377633;13774.311284435938;13981.440742370598;14435.78346324827;14455.421783128977;9486.85769713441;11088.33469991803;11227.49476273586;11318.434078296217;11767.293962362286;9781.141583099188;11421.714457138638;11439.828402573801;11549.711257218636;11597.687218105017 15:00:52 INFO - PROCESS | 1658 | __end_tp_report 15:00:52 INFO - PROCESS | 1658 | __start_cc_report 15:00:52 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1158 15:00:52 INFO - PROCESS | 1658 | __end_cc_report 15:00:52 INFO - PROCESS | 1658 | __startTimestamp1472853652894__endTimestamp 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | ------- Summary: start ------- 15:00:52 INFO - PROCESS | 1658 | Number of tests: 6 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5678.17 Median:5797.77 stddev:625.38 (10.8%) stddev-sans-first:599.05 15:00:52 INFO - PROCESS | 1658 | Values: 3309.2 3324.8 3345.5 3368.3 3392.9 4757.0 5516.6 5603.3 5655.8 5661.8 5621.1 5635.3 5666.4 5672.1 5685.7 5179.7 5228.9 5254.8 5254.8 5259.6 5194.7 5215.2 5264.6 5264.6 5273.7 5093.9 5324.6 5334.5 5338.2 5345.9 5184.5 5191.6 5202.4 5220.8 5227.8 5091.3 5104.1 5128.4 5139.3 5154.9 5342.4 5562.9 5611.0 5749.9 5756.3 5178.4 6185.2 6203.5 6204.7 6234.5 6075.3 6213.5 6272.3 6279.5 6304.6 5638.0 5666.4 5723.7 5748.7 5758.3 6335.5 6357.8 6366.0 6373.4 6381.8 5902.2 6069.2 6083.5 6086.8 6094.3 6109.3 6141.9 6164.5 6181.7 6234.8 6094.5 6096.8 6159.4 6164.8 6165.7 6176.4 6187.1 6199.4 6203.9 6209.4 4845.3 4889.9 4893.1 4907.1 4958.3 4400.6 4417.2 4423.9 4450.4 4482.5 5701.7 5705.7 5707.6 5711.0 5718.1 6119.4 6119.5 6158.6 6197.4 6274.0 5664.8 5666.6 5668.7 5668.9 5725.7 5370.5 5372.6 5374.9 5384.3 5392.2 5320.4 6251.4 6262.0 6332.6 6332.7 5107.4 6005.9 6148.0 6182.2 6185.1 6284.8 6331.4 6349.8 6352.8 6353.5 5912.1 6014.2 6091.7 6092.9 6129.8 6130.4 6151.0 6166.0 6186.4 6217.9 5981.6 6024.5 6032.4 6040.4 6097.1 5874.3 5890.7 5896.8 6029.5 6033.9 5788.1 5804.9 5811.6 5833.1 5849.4 5949.0 5959.7 5970.9 5974.6 5976.0 5731.3 5772.7 5775.7 5797.8 5801.8 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:71450.89 Median:42236.87 stddev:154298.32 (365.3%) stddev-sans-first:154639.21 15:00:52 INFO - PROCESS | 1658 | Values: 500.2 511.8 528.6 531.2 545.3 31423.4 32154.8 33268.2 42102.8 43562.8 44137.0 44417.3 44472.8 44480.8 44561.0 9661.4 9838.3 9844.2 9856.4 9858.6 9760.0 9813.5 9842.0 9857.9 9859.5 9812.8 9884.9 9893.3 9896.5 9904.2 9780.1 9846.9 9847.4 9861.4 9867.4 9728.3 9780.2 9787.2 9790.7 9801.5 41792.6 42234.6 42239.2 42257.8 42267.2 3307.5 3433.9 3492.7 3643.0 3849.4 31272.0 31411.0 31426.0 31600.4 32517.8 3043.5 3181.6 3185.8 3252.7 3259.0 508654.0 515463.0 515529.0 517860.0 518760.4 63864.4 64148.7 64299.0 64370.2 64513.0 66309.7 66390.0 66431.0 66763.0 67105.7 16202.0 16873.2 16932.4 17463.4 17497.0 12936.8 13103.0 13111.1 13153.5 13179.2 19007.2 19109.3 19238.9 19393.8 19446.6 6796.7 7991.6 8011.1 8076.6 8193.4 781.3 911.6 966.9 1004.8 1005.4 30078.2 30957.5 31429.0 31581.5 31849.4 843.4 996.2 1031.2 1084.0 1114.4 15856.9 16004.0 16133.7 16184.8 16391.8 674358.0 674981.0 676044.0 677308.0 677690.0 59996.7 60042.8 60149.0 60170.7 60282.4 1244.9 1345.1 1369.4 1389.5 1393.0 30829.7 31727.0 31856.8 32005.0 32612.3 52089.2 52552.2 52699.2 52746.7 52929.0 521492.0 529372.0 529683.0 529698.0 530146.0 27046.7 27797.6 27824.9 28672.0 28723.7 48804.8 49165.3 49638.5 50194.7 50499.7 40049.8 40130.6 40348.4 41405.0 41786.2 33475.8 39989.8 40521.6 41742.8 41941.2 38609.8 38610.8 39319.0 39587.2 40123.4 34357.7 34762.1 35755.5 35770.5 36112.0 25628.7 25749.7 26082.0 26173.7 26633.0 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:26550.31 Median:142897.45 stddev:53197.35 (37.2%) stddev-sans-first:53310.21 15:00:52 INFO - PROCESS | 1658 | Values: 350.6 371.9 376.4 383.1 408.2 14430.9 15069.0 20740.9 20802.8 20828.8 19703.7 20254.9 20505.6 20644.9 20727.0 5036.5 5218.9 5482.7 5483.9 5486.6 5865.4 6061.3 6068.2 6070.7 6076.9 5180.8 5663.3 5860.9 6009.2 6023.5 5908.9 5916.0 5939.6 5944.0 5960.2 5042.6 5192.2 5249.3 5258.4 5260.2 24954.5 25365.6 25535.5 25731.9 25763.7 2356.6 2451.8 2745.9 2893.7 2966.8 9945.6 10039.9 10433.9 10435.0 10470.5 1804.7 1865.2 1911.4 1931.5 1933.0 110863.3 116695.0 119913.0 126015.0 128673.0 9368.0 11094.7 11388.7 11525.3 11705.1 14553.5 14564.0 14571.7 14582.9 14588.7 8270.5 8566.4 8583.7 8678.9 8714.6 8438.1 8462.7 8466.0 8630.5 8643.0 3942.8 4423.3 4474.2 4486.3 4578.3 1406.2 1536.8 1637.8 1712.4 1778.2 784.7 856.7 878.2 932.7 960.6 20197.1 21286.1 21315.7 21374.4 21401.9 916.2 923.7 928.5 946.2 1001.9 10117.2 10519.6 10613.4 10961.5 11130.8 283049.0 283076.0 283288.0 283329.0 283874.0 81925.6 132243.0 139165.3 148043.7 149390.3 973.3 1012.5 1040.2 1041.1 1043.9 16426.3 18905.5 19346.7 19444.1 19677.3 40274.2 56579.9 56799.1 57065.7 57421.0 84656.7 85891.6 86932.6 87534.7 88769.6 6822.8 7908.3 8165.0 8244.3 8268.5 9868.4 12801.2 12984.2 13230.6 13235.3 9547.7 10991.9 11234.3 11277.2 11403.8 10399.7 10433.8 10542.4 10646.9 10860.2 11452.4 11479.5 11535.7 11766.6 11866.3 7762.8 7983.9 8014.7 8155.7 8444.9 8039.4 9608.3 11123.3 11135.0 11625.4 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5597.47 Median:5057.79 stddev:3098.34 (61.3%) stddev-sans-first:3091.40 15:00:52 INFO - PROCESS | 1658 | Values: 1456.8 1478.5 1657.9 1783.7 1853.7 8309.9 8769.6 8772.4 8781.2 8796.0 7647.7 7890.0 8135.8 8498.2 8556.6 2317.5 2353.3 2359.6 2366.2 2370.4 2356.1 2364.2 2400.3 2402.9 2405.5 2368.3 2377.4 2388.7 2397.0 2397.8 2347.4 2348.5 2353.6 2356.3 2386.3 2351.8 2363.1 2365.7 2371.1 2371.7 8451.0 8592.8 8598.0 8612.8 8649.0 5158.2 5298.0 5299.5 5308.4 5310.0 3556.4 3567.7 3637.4 3658.3 3665.2 934.2 971.6 1765.7 1815.8 1865.7 11023.0 11185.5 11187.8 11203.6 11366.5 3919.8 4745.9 4803.4 4813.4 4813.5 9894.6 9910.0 9910.7 9938.2 9941.8 5143.3 5196.6 5280.9 5293.0 5300.5 4372.1 4521.7 4685.4 4831.0 4847.1 3873.6 3904.2 4001.3 4065.1 4086.4 1286.0 1301.8 1304.2 1304.2 1317.0 747.5 856.6 872.5 894.6 918.9 5154.8 5629.5 5872.6 5879.1 5923.2 435.4 442.9 443.5 445.0 454.1 3780.4 3935.5 3956.9 3967.8 4189.5 10437.3 10468.5 10591.9 10594.7 10649.7 10546.8 10568.3 10572.5 10582.5 10600.4 6369.5 7863.7 7985.6 8005.3 8046.6 5792.8 5831.8 5904.7 5932.7 6010.5 8026.8 9590.1 9736.1 9804.6 9818.0 9555.6 9875.2 9902.2 9906.9 9939.0 6809.4 7050.6 7208.8 7317.6 7519.5 8047.2 8226.5 8238.4 8241.8 8252.7 7220.3 7306.6 7311.0 7368.2 7453.7 6976.8 7111.8 7168.1 7201.9 7255.2 6786.1 6840.7 6942.1 6942.5 6944.2 4040.3 4768.1 4919.7 5017.5 5060.0 4757.2 4881.6 4950.6 5055.6 5124.2 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4502.61 Median:5024.76 stddev:1392.84 (27.7%) stddev-sans-first:1360.52 15:00:52 INFO - PROCESS | 1658 | Values: 297.7 305.1 311.5 316.9 317.7 4817.5 5339.5 5362.6 5392.9 5403.4 4886.4 4911.9 4958.3 5236.3 5274.3 4033.8 4042.7 4051.6 4074.6 4128.6 4036.9 4070.6 4078.7 4084.4 4105.7 3322.5 3775.7 4020.6 4022.9 4053.9 3998.9 4015.1 4032.1 4037.9 4054.5 3438.7 3449.8 3456.3 3469.8 3472.2 4504.3 4937.3 5110.4 5118.5 5167.5 3693.9 4378.8 4548.3 4566.7 4577.9 4867.7 5511.6 5536.6 5571.6 5586.1 3049.9 3775.0 3800.0 3803.7 3823.2 4936.2 5074.4 5660.7 5831.7 5919.6 3248.4 3812.2 3817.8 3845.9 3849.4 3483.0 3826.8 3927.2 3971.9 3977.5 4307.3 4556.9 4577.3 4620.4 4624.7 4389.2 4643.6 5598.7 5614.9 5616.9 1195.6 1261.1 1261.3 1291.6 1328.5 834.9 861.2 886.1 893.4 899.5 5053.6 5064.6 5069.7 5104.2 5138.6 4536.0 5072.5 5656.2 5699.2 5752.4 4543.0 4876.9 4995.9 5061.7 5080.1 2426.4 2726.8 2993.1 2996.3 3003.0 5466.7 5592.6 5835.8 5851.8 5881.6 4810.3 4928.6 5973.0 5982.5 6004.8 5121.3 5997.8 6020.6 6070.6 6074.4 5180.2 5542.2 5716.6 5760.5 5854.5 5665.6 5716.4 5747.4 5754.2 5754.6 5396.7 5944.9 5947.1 5952.8 5999.6 3589.3 3805.5 3849.7 3854.4 3862.5 5733.2 5790.4 5815.6 5825.5 5836.5 5164.7 5236.8 5667.2 5679.6 5725.8 4948.8 5542.7 5572.6 5577.4 5595.9 5136.3 5344.1 5484.1 5487.3 5500.0 4621.6 4776.4 4937.1 4950.9 5497.1 5201.7 5369.3 5385.3 5389.6 5482.7 15:00:52 INFO - PROCESS | 1658 | 15:00:52 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:26283.76 Median:3715.78 stddev:43007.16 (1157.4%) stddev-sans-first:43084.82 15:00:52 INFO - PROCESS | 1658 | Values: 671.9 789.4 794.2 816.4 818.8 15124.5 15222.3 15891.8 16008.6 16059.9 11651.8 12119.6 14320.4 14322.2 14792.3 710.8 871.3 896.2 902.1 903.6 733.1 860.7 894.4 903.0 907.7 943.7 945.2 945.2 946.6 947.1 745.1 944.4 947.9 949.6 951.8 567.2 570.3 574.1 678.1 698.5 14496.5 14594.5 14600.6 14631.4 14687.9 13571.8 13919.2 14077.3 14102.0 14297.4 12652.9 12733.4 12792.0 13111.6 13404.1 4614.5 4621.4 4651.4 4837.9 4846.5 97952.0 118802.0 120027.0 121384.0 123525.4 10306.2 10423.9 10482.8 10626.1 10868.5 21021.9 21421.1 21424.0 21459.0 21536.2 7729.5 7729.8 7982.2 7995.6 8089.6 4466.7 4529.6 4559.2 4706.6 4748.9 3549.9 3709.8 3714.3 3717.2 3726.3 576.9 681.4 694.5 701.7 708.7 554.4 617.6 657.0 677.7 682.6 9330.4 9341.3 9404.6 9440.7 9541.4 634.9 650.9 680.4 682.6 683.6 4296.4 4581.3 4585.5 4671.7 4760.4 156270.4 160341.2 161931.2 162312.2 165469.0 133783.0 137869.0 140528.3 142334.0 144789.0 119688.4 121866.0 122628.4 122663.0 122859.8 8579.4 9017.6 9026.1 9076.1 9149.0 64270.7 65193.2 65848.7 67306.7 68354.3 93425.5 97782.0 97966.5 99475.0 100389.0 11366.8 11627.5 11762.9 11895.3 12381.4 13000.7 13707.5 14488.7 15495.1 15497.0 10985.7 13702.5 13905.5 14197.0 14226.6 12108.2 13727.5 13921.1 14030.9 14446.2 13443.7 13774.3 13981.4 14435.8 14455.4 9486.9 11088.3 11227.5 11318.4 11767.3 9781.1 11421.7 11439.8 11549.7 11597.7 15:00:52 INFO - PROCESS | 1658 | -------- Summary: end -------- 15:00:52 INFO - PROCESS | 1658 | 15:00:53 INFO - TEST-INFO | 1658: exit 0 15:00:53 INFO - TEST-OK | dromaeo_css | took 1117705ms 15:00:53 INFO - TEST-START | kraken 15:00:53 INFO - operating with platform_type : mac_ 15:00:53 INFO - Initialising browser for kraken test... 15:00:53 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpKPHUTO/profile http://localhost:49266/getInfo.html) 15:00:55 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 15:00:55 INFO - PROCESS | 1667 | colorDepth:24 15:00:55 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 15:00:55 INFO - PROCESS | 1667 | __metrics 15:00:56 INFO - PROCESS | 1667 | 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" 15:00:56 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:00:56 INFO - TEST-INFO | 1667: exit 0 15:00:56 INFO - Browser initialized. 15:00:56 INFO - Running cycle 1/1 for kraken test... 15:00:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpKPHUTO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:08 INFO - PROCESS | 1668 | RSS: Main: 234041344 15:01:08 INFO - PROCESS | 1668 | 15:01:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:12 INFO - PROCESS | 1668 | RSS: Main: 293081088 15:01:12 INFO - PROCESS | 1668 | 15:01:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 15:01:15 INFO - PROCESS | 1668 | RSS: Main: 288964608 15:01:15 INFO - PROCESS | 1668 | 15:01:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 15:01:19 INFO - PROCESS | 1668 | RSS: Main: 379965440 15:01:19 INFO - PROCESS | 1668 | 15:01:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 15:01:22 INFO - PROCESS | 1668 | RSS: Main: 282611712 15:01:22 INFO - PROCESS | 1668 | 15:01:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:01:25 INFO - PROCESS | 1668 | RSS: Main: 284225536 15:01:25 INFO - PROCESS | 1668 | 15:01:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 15:01:28 INFO - PROCESS | 1668 | RSS: Main: 322514944 15:01:28 INFO - PROCESS | 1668 | 15:01:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 15:01:31 INFO - PROCESS | 1668 | RSS: Main: 322875392 15:01:31 INFO - PROCESS | 1668 | 15:01:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 15:01:35 INFO - PROCESS | 1668 | RSS: Main: 323014656 15:01:35 INFO - PROCESS | 1668 | 15:01:36 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:01:37 INFO - PROCESS | 1668 | RSS: Main: 298467328 15:01:37 INFO - PROCESS | 1668 | 15:01:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:01:40 INFO - PROCESS | 1668 | RSS: Main: 303538176 15:01:40 INFO - PROCESS | 1668 | 15:01:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:01:43 INFO - PROCESS | 1668 | RSS: Main: 301432832 15:01:43 INFO - PROCESS | 1668 | 15:01:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:01:46 INFO - PROCESS | 1668 | RSS: Main: 322473984 15:01:46 INFO - PROCESS | 1668 | 15:01:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:01:50 INFO - PROCESS | 1668 | RSS: Main: 318525440 15:01:50 INFO - PROCESS | 1668 | 15:01:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 15:01:52 INFO - PROCESS | 1668 | RSS: Main: 361996288 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | __start_tp_report 15:01:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 15:01:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 15:01:52 INFO - PROCESS | 1668 | |i|pagename|runs| 15:01:52 INFO - PROCESS | 1668 | |0;ai-astar;114;116;163;154;114;112;114;115;113;122 15:01:52 INFO - PROCESS | 1668 | |1;audio-beat-detection;146;121;159;197;107;133;129;101;158;106 15:01:52 INFO - PROCESS | 1668 | |2;audio-dft;182;184;182;184;187;179;185;182;181;183 15:01:52 INFO - PROCESS | 1668 | |3;audio-fft;77;75;76;157;59;57;57;67;145;56 15:01:52 INFO - PROCESS | 1668 | |4;audio-oscillator;84;85;130;69;79;89;118;67;69;116 15:01:52 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;87;85;89;86;88;85;88;85;88;85 15:01:52 INFO - PROCESS | 1668 | |6;imaging-darkroom;98;95;93;97;94;95;95;94;93;99 15:01:52 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;85;84;86;85;85;84;87;84;84 15:01:52 INFO - PROCESS | 1668 | |8;json-parse-financial;55;55;58;53;52;52;54;53;53;52 15:01:52 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;68;66;68;77;75;71;70;71;69;72 15:01:52 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;85;86;75;99;95;104;103;106;89;82 15:01:52 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;138;148;127;145;137;164;146;132;187;153 15:01:52 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;173;172;170;173;172;173;172;171;170;163 15:01:52 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;68;68;69;69;68;69;72;84;75;66 15:01:52 INFO - PROCESS | 1668 | __end_tp_report 15:01:52 INFO - PROCESS | 1668 | __start_cc_report 15:01:52 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2003 15:01:52 INFO - PROCESS | 1668 | __end_cc_report 15:01:52 INFO - PROCESS | 1668 | __startTimestamp1472853712118__endTimestamp 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | ------- Summary: start ------- 15:01:52 INFO - PROCESS | 1668 | Number of tests: 14 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:123.70 Median:115.50 stddev:18.66 (16.2%) stddev-sans-first:19.46 15:01:52 INFO - PROCESS | 1668 | Values: 114.0 116.0 163.0 154.0 114.0 112.0 114.0 115.0 113.0 122.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:139.50 stddev:29.97 (21.5%) stddev-sans-first:31.55 15:01:52 INFO - PROCESS | 1668 | Values: 146.0 121.0 159.0 197.0 107.0 133.0 129.0 101.0 158.0 106.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:2.23 (1.2%) stddev-sans-first:2.35 15:01:52 INFO - PROCESS | 1668 | Values: 182.0 184.0 182.0 184.0 187.0 179.0 185.0 182.0 181.0 183.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:82.60 Median:63.00 stddev:37.09 (58.9%) stddev-sans-first:39.28 15:01:52 INFO - PROCESS | 1668 | Values: 77.0 75.0 76.0 157.0 59.0 57.0 57.0 67.0 145.0 56.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:74.00 stddev:22.73 (30.7%) stddev-sans-first:23.98 15:01:52 INFO - PROCESS | 1668 | Values: 84.0 85.0 130.0 69.0 79.0 89.0 118.0 67.0 69.0 116.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.50 stddev:1.58 (1.8%) stddev-sans-first:1.67 15:01:52 INFO - PROCESS | 1668 | Values: 87.0 85.0 89.0 86.0 88.0 85.0 88.0 85.0 88.0 85.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:2.06 (2.2%) stddev-sans-first:1.94 15:01:52 INFO - PROCESS | 1668 | Values: 98.0 95.0 93.0 97.0 94.0 95.0 95.0 94.0 93.0 99.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 15:01:52 INFO - PROCESS | 1668 | Values: 84.0 85.0 84.0 86.0 85.0 85.0 84.0 87.0 84.0 84.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.89 (3.5%) stddev-sans-first:1.94 15:01:52 INFO - PROCESS | 1668 | Values: 55.0 55.0 58.0 53.0 52.0 52.0 54.0 53.0 53.0 52.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:3.33 (4.7%) stddev-sans-first:3.39 15:01:52 INFO - PROCESS | 1668 | Values: 68.0 66.0 68.0 77.0 75.0 71.0 70.0 71.0 69.0 72.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:85.50 stddev:10.54 (12.3%) stddev-sans-first:10.84 15:01:52 INFO - PROCESS | 1668 | Values: 85.0 86.0 75.0 99.0 95.0 104.0 103.0 106.0 89.0 82.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:147.00 stddev:17.42 (11.9%) stddev-sans-first:18.12 15:01:52 INFO - PROCESS | 1668 | Values: 138.0 148.0 127.0 145.0 137.0 164.0 146.0 132.0 187.0 153.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:3.00 (1.7%) stddev-sans-first:3.08 15:01:52 INFO - PROCESS | 1668 | Values: 173.0 172.0 170.0 173.0 172.0 173.0 172.0 171.0 170.0 163.0 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.00 stddev:5.27 (7.6%) stddev-sans-first:5.49 15:01:52 INFO - PROCESS | 1668 | Values: 68.0 68.0 69.0 69.0 68.0 69.0 72.0 84.0 75.0 66.0 15:01:52 INFO - PROCESS | 1668 | -------- Summary: end -------- 15:01:52 INFO - PROCESS | 1668 | 15:01:52 INFO - TEST-INFO | 1668: exit 0 15:01:52 INFO - TEST-OK | kraken | took 59424ms 15:01:52 INFO - SUITE-END | took 1177s 15:01:53 INFO - Completed test suite (00:19:37) 15:01:53 INFO - javascript benchmark 15:01:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.172706823295, 3324.7838890472117, 3345.5483509726196, 3368.2926585417063, 3392.898213053609, 4757.0, 5516.558675305976, 5603.299587551556, 5655.802046928358, 5661.773529058838, 5621.128725047624, 5635.295588051494, 5666.376698563155, 5672.149177623359, 5685.744141513632, 5179.663321884075, 5228.92156617651, 5254.789808407659, 5254.789808407659, 5259.579233661317, 5194.71429071401, 5215.217717342391, 5264.578833693296, 5264.631475796696, 5273.683578985273, 5093.923591146117, 5324.600654950875, 5334.51989320961, 5338.199270109495, 5345.866353341178, 5184.481551844785, 5191.558717508998, 5202.375714914235, 5220.765065572058, 5227.8170264040955, 5091.338126043628, 5104.106781313255, 5128.410232823198, 5139.331886854685, 5154.896902061975, 5342.358916929955, 5562.916556251659, 5610.971945140289, 5749.942500574983, 5756.338021127582, 5178.378594568676, 6185.16500272462, 6203.472704820096, 6204.720787564571, 6234.501239900797, 6075.270152776053, 6213.5339849511465, 6272.3100458949475, 6279.466245369149, 6304.558680892339, 5638.013347664142, 5666.376698563155, 5723.742431590588, 5748.6838223898085, 5758.3090029196765, 6335.493160547145, 6357.841053973688, 6365.96817015912, 6373.362663733682, 6381.776637817654, 5902.2032025676845, 6069.211002569726, 6083.543734219951, 6086.817395478142, 6094.268687757409, 6109.34393638171, 6141.877162456815, 6164.537659675542, 6181.690915454209, 6234.750609975641, 6094.512439004869, 6096.786612468542, 6159.353267906805, 6164.753409863645, 6165.660888651078, 6176.413240742212, 6187.133801267826, 6199.411055949768, 6203.937960620427, 6209.379062093845, 4845.345878306454, 4889.877753056202, 4893.094777466109, 4907.141250281186, 4958.281049247839, 4400.603945644843, 4417.2269852775635, 4423.933640995388, 4450.3991961085485, 4482.462104547475, 5701.686407247558, 5705.74324155414, 5707.6290041147195, 5710.971445142748, 5718.1136923776885, 6119.350229749377, 6119.479844213202, 6158.599691020069, 6197.442230199214, 6273.96863015682, 5664.773409063591, 5666.575006874501, 5668.716564171775, 5668.858278543069, 5725.685087320154, 5370.4629537045985, 5372.597055220874, 5374.946250537523, 5384.326959130109, 5392.218128371364, 5320.414754376938, 6251.374862513712, 6261.96869015652, 6332.556721029668, 6332.683365831782, 5107.361579802525, 6005.878219908704, 6148.016317389196, 6182.227221597301, 6185.103160041679, 6284.808648691501, 6331.430171284606, 6349.809505714836, 6352.841178970562, 6353.459955903615, 5912.113183022581, 6014.158017877413, 6091.7258723358445, 6092.939070609415, 6129.816105516842, 6130.386961303834, 6151.0, 6165.982612868826, 6186.350433204629, 6217.875642487215, 5981.641101533922, 6024.529942723462, 6032.426919442646, 6040.36576159497, 6097.085437184281, 5874.324452687995, 5890.6760128191645, 5896.764129434775, 6029.487493563096, 6033.939660603338, 5788.102844059177, 5804.883902321845, 5811.593188476766, 5833.066709326487, 5849.415058494286, 5949.0, 5959.73181206838, 5970.850728731816, 5974.641521508724, 5976.043832986701, 5731.312242530923, 5772.740226689725, 5775.7400916957995, 5797.768089276382, 5801.82594522165], "value": 5639.545659154325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.17471172565286, 511.7850502788828, 528.6061883896498, 531.2111514401114, 545.2502808638123, 31423.371532569334, 32154.839225803866, 33268.16829579262, 42102.78948605261, 43562.782186089105, 44137.0, 44417.33373999393, 44472.77763611185, 44480.77759611198, 44561.0, 9661.4203147811, 9838.262130340254, 9844.163246124088, 9856.35933664313, 9858.556364963559, 9760.0, 9813.460259685715, 9841.950790246074, 9857.852132218022, 9859.507024648774, 9812.803743925117, 9884.85172722406, 9893.25800564957, 9896.50517474127, 9904.158146557551, 9780.070893265129, 9846.852297215548, 9847.359921605073, 9861.359011664255, 9867.40795552269, 9728.270379721549, 9780.168685661727, 9787.168090712297, 9790.657326993593, 9801.460919649417, 41792.582074179176, 42234.57765422337, 42239.15521689549, 42257.78871105625, 42267.154656907, 3307.4873394623633, 3433.9313213735836, 3492.6507349265125, 3642.981785091084, 3849.40334248192, 31272.0, 31411.0, 31426.0, 31600.36799264002, 32517.837410812794, 3043.4978228592254, 3181.5704879841155, 3185.8088514689193, 3252.7235185009304, 3258.9571337172115, 508654.0, 515463.0, 515529.0, 517860.0, 518760.4061979704, 63864.36135638677, 64148.67925660342, 64299.0, 64370.24112468123, 64513.0, 66309.66845165839, 66390.0, 66431.0, 66763.0, 67105.66447167733, 16202.0, 16873.240704168344, 16932.40736574214, 17463.38878139259, 17497.0, 12936.830476533309, 13103.0, 13111.082224244212, 13153.53962611304, 13179.209247445184, 19007.239710411704, 19109.331173408864, 19238.941858197653, 19393.8060619392, 19446.611067778565, 6796.694148763318, 7991.640376183086, 8011.078725946591, 8076.55578943152, 8193.385496087698, 781.3397678961269, 911.6080085563138, 966.9468179250068, 1004.8342023566175, 1005.3867141043958, 30078.24804379908, 30957.535636965462, 31429.0, 31581.526277105862, 31849.363012739614, 843.4306842881031, 996.1980605612551, 1031.1802117316752, 1083.9620613278655, 1114.3815182573587, 15856.920715396349, 16004.0, 16133.677326453406, 16184.786141039469, 16391.754123688155, 674358.0, 674981.0, 676044.0, 677308.0, 677690.0, 59996.700016499635, 60042.79914401775, 60149.0, 60170.69914650486, 60282.39717602856, 1244.9377531123407, 1345.1122259309004, 1369.431685850361, 1389.5275606293908, 1392.9512467063807, 30829.69170308358, 31727.04818855438, 31856.840715796272, 32005.039848804572, 32612.34775304528, 52089.218661720864, 52552.21171682504, 52699.20951185812, 52746.68133296698, 52929.0, 521492.0, 529372.0, 529683.0, 529698.0, 530146.0, 27046.72953270442, 27797.58303625407, 27824.887004520402, 28671.996480123096, 28723.712762872103, 48804.755976219894, 49165.2625210615, 49638.50361496339, 50194.749026254634, 50499.69753175863, 40049.79850604486, 40130.598694013854, 40348.394774077824, 41405.0, 41786.1642767149, 33475.83262083674, 39989.80005099956, 40521.594784051784, 41742.79128604338, 41941.161176775684, 38609.80695096507, 38610.80694596509, 39319.0, 39587.2082558353, 40123.398149027205, 34357.656423435445, 34762.13094672653, 35755.46366804552, 35770.463443048895, 36112.0, 25628.743712562635, 25749.742502574736, 26082.0, 26173.73826261713, 26633.0], "value": 20482.241416390123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.61432424333253, 371.93119272934507, 376.3601876809423, 383.1035377217312, 408.2365975625579, 14430.927845360771, 15069.020513666605, 20740.859252741095, 20802.791972080275, 20828.791712082875, 19703.704444433344, 20254.898725506388, 20505.589888202227, 20644.89677551614, 20726.963651817423, 5036.471170527097, 5218.8695282617855, 5482.725863706799, 5483.862903427426, 5486.643368181076, 5865.442782935615, 6061.333253342129, 6068.241469816273, 6070.696465176746, 6076.878462430749, 5180.844574662766, 5663.348714897777, 5860.941390586082, 6009.188759517475, 6023.548233882477, 5908.940910590882, 5915.9704201478935, 5939.613925094855, 5944.0, 5960.165576819227, 5042.647014708972, 5192.221166824968, 5249.265102885599, 5258.368995720538, 5260.237265596467, 24954.5009099817, 25365.61951570728, 25535.48929021428, 25731.871340643364, 25763.71181440939, 2356.5640356534095, 2451.8406303590386, 2745.9038933637225, 2893.652761668592, 2966.7984466291186, 9945.552450139761, 10039.89960100397, 10433.9478302608, 10434.95650434958, 10470.47647617616, 1804.6661367646896, 1865.1979648751033, 1911.44568075258, 1931.5460866696314, 1932.9806701932941, 110863.33704994431, 116695.0, 119913.0, 126015.0, 128673.0, 9367.953160234292, 11094.667159985212, 11388.658340249805, 11525.250858694159, 11705.063594912386, 14553.490627828187, 14564.0, 14571.708565828623, 14582.927085364505, 14588.708225835424, 8270.462419942805, 8566.400351975302, 8583.699570515002, 8678.913210867937, 8714.607842647096, 8438.059246373246, 8462.746117616482, 8465.957670211732, 8630.525321107274, 8642.95678521616, 3942.7580312201567, 4423.336499525097, 4474.239379305526, 4486.259767138451, 4578.336141259499, 1406.2054938959454, 1536.8386319436522, 1637.8198398176191, 1712.3664244229465, 1778.2406603791849, 784.6939693519532, 856.6659002988839, 878.2139984713646, 932.6595792535676, 960.5677445149711, 20197.091130899145, 21286.148554057665, 21315.68026479604, 21374.358769236947, 21401.892990534947, 916.2212119698337, 923.6674797073048, 928.4846909964899, 946.2146418472652, 1001.8797744270735, 10117.241206909512, 10519.579216831395, 10613.394087420334, 10961.451927403597, 11130.833037504444, 283049.0, 283076.0, 283288.0, 283329.0, 283874.0, 81925.59037204777, 132243.0, 139165.30417348052, 148043.704266464, 149390.25304873622, 973.3332667123043, 1012.5241136665755, 1040.2146379483443, 1041.094248004241, 1043.9247574997764, 16426.342946282493, 18905.527361816065, 19346.70979935274, 19444.125014374105, 19677.31129410464, 40274.194516108924, 56579.86840263089, 56799.14801277901, 57065.71467142638, 57421.0, 84656.73014904658, 85891.57054214689, 86932.56533717545, 87534.68697969409, 88769.55615221882, 6822.795316140524, 7908.288254057163, 8164.959175204086, 8244.30991646699, 8268.545230012167, 9868.407895526292, 12801.231926084465, 12984.220946743226, 13230.603081907559, 13235.3382330885, 9547.663327134345, 10991.890081099087, 11234.269772464764, 11277.23280341543, 11403.828942566033, 10399.688009359732, 10433.843492347773, 10542.367457952547, 10646.89353106459, 10860.185486088732, 11452.427378631202, 11479.483423245807, 11535.711607209887, 11766.58816941403, 11866.288022718665, 7762.7671169865, 7983.920160798318, 8014.659018483082, 8155.673773049249, 8444.915550844413, 8039.397045221749, 9608.279379046739, 11123.27698699582, 11135.0, 11625.360605166798], "value": 9296.573917149151, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.8397476277612, 1478.4899209772627, 1657.8839481236312, 1783.652187823375, 1853.6570734414133, 8309.916900830998, 8769.649214031448, 8772.385932984693, 8781.209691127797, 8796.0, 7647.694092236304, 7889.960550197241, 8135.837283254346, 8498.1501849815, 8556.572171391437, 2317.4785673223514, 2353.341064501942, 2359.634256690216, 2366.1600131953082, 2370.4073981504625, 2356.1046802215133, 2364.1725396111397, 2400.2679182849224, 2402.939926501843, 2405.542946840095, 2368.336865677613, 2377.405648587853, 2388.7133543974746, 2396.9640455393182, 2397.8441401308946, 2347.4248809041724, 2348.518553696488, 2353.6234202527685, 2356.3402247370764, 2386.2841147655636, 2351.753065928087, 2363.102021231921, 2365.6924599802087, 2371.1345358944036, 2371.67982322386, 8450.957745211295, 8592.785180370478, 8597.957010214972, 8612.82774344516, 8649.048604653482, 5158.226266060084, 5297.973510132463, 5299.5230429261555, 5308.362996440414, 5310.0, 3556.3598552260582, 3567.714582833367, 3637.381645120336, 3658.2500587379523, 3665.21197942441, 934.173256667847, 971.5579411367811, 1765.699831028728, 1815.8365747082694, 1865.692160793481, 11023.007929286323, 11185.49665265065, 11187.776244475064, 11203.551857925591, 11366.545338186545, 3919.8236079376497, 4745.928811067837, 4803.375561177095, 4813.3983252093485, 4813.470518242991, 9894.55474503649, 9910.0, 9910.653127140515, 9938.155256803107, 9941.801163976825, 5143.305653736773, 5196.58427325813, 5280.867978300574, 5292.9735351323, 5300.522952934254, 4372.147431250875, 4521.660875434355, 4685.4143232095985, 4830.95169048305, 4847.079054979543, 3873.6320049595242, 3904.2191561687778, 4001.2597669431248, 4065.0853557949818, 4086.3666131749033, 1286.0, 1301.7852054411105, 1304.1588175626669, 1304.2044352944697, 1316.9868301317056, 747.517850986111, 856.5545916123706, 872.5157537566712, 894.608883186638, 918.875951746519, 5154.768035438415, 5629.549636029108, 5872.647641141545, 5879.147523609053, 5923.17075609415, 435.43611023724355, 442.8937055106751, 443.4877716237751, 444.9587964163872, 454.07822121094233, 3780.3762379207124, 3935.5080614923136, 3956.8615098471414, 3967.80160991955, 4189.476315460567, 10437.32157409766, 10468.47657617116, 10591.894081059245, 10594.735131621772, 10649.73375665599, 10546.789064218672, 10568.313059651098, 10572.52423640938, 10582.470876456146, 10600.363978161335, 6369.490440764727, 7863.685452581833, 7985.600719963979, 8005.319547838499, 8046.597670116588, 5792.797252096157, 5831.79588714393, 5904.675242861684, 5932.6737029462065, 6010.459058684739, 8026.83946321082, 9590.08894155054, 9736.075072868067, 9804.55879485439, 9817.950910245403, 9555.61777528891, 9875.209983201183, 9902.158316543175, 9906.851397229191, 9939.0, 6809.387155155861, 7050.647467626701, 7208.819779505554, 7317.560946343024, 7519.473636845369, 8047.195280471906, 8226.547539885363, 8238.382121340803, 8241.83516329682, 8252.669893204205, 7220.3140701633265, 7306.634668266459, 7311.0, 7368.226336234618, 7453.664585093792, 6976.825579360557, 7111.82220444493, 7168.068151140318, 7201.891971620535, 7255.2019277878335, 6786.117804685359, 6840.657967101724, 6942.132233470817, 6942.51402401827, 6944.201416837129, 4040.292948733901, 4768.094062128184, 4919.704817710949, 5017.54842064216, 5060.0, 4757.215059515142, 4881.609471242363, 4950.603951683928, 5055.570276526537, 5124.231365295235], "value": 4477.55651773993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.71568152414443, 305.1349424381876, 311.4736095997764, 316.8764181969033, 317.7362788885226, 4817.47007829139, 5339.492748188916, 5362.597805164609, 5392.865178370543, 5403.432639572848, 4886.434621823544, 4911.926321105187, 4958.281049247866, 5236.303303798547, 5274.314339135916, 4033.818478168482, 4042.684998301394, 4051.5948405159397, 4074.6129117733767, 4128.649064829493, 4036.919261614766, 4070.613291737295, 4078.7348822326603, 4084.4077608746716, 4105.7331273467125, 3322.468405055192, 3775.660190582847, 4020.5979402059706, 4022.859199928003, 4053.9391909121387, 3998.9200215995515, 4015.072765072752, 4032.1129351542613, 4037.899052523681, 4054.493188351456, 3438.7420943429092, 3449.844756985917, 3456.343294773985, 3469.826508674556, 3472.2013936794424, 4504.346869703907, 4937.333459982892, 5110.368160397398, 5118.539331460149, 5167.457416971201, 3693.8522459101605, 4378.759168245745, 4548.272276435788, 4566.657500687462, 4577.862664120082, 4867.732274724889, 5511.58663100265, 5536.557075433956, 5571.637843540157, 5586.072804882309, 3049.8627561759554, 3775.0184951912424, 3800.0, 3803.7147213959065, 3823.178016726389, 4936.234883593013, 5074.441811400743, 5660.716964151817, 5831.708414579297, 5919.6152250103605, 3248.431524483206, 3812.218495208476, 3817.7900215488417, 3845.9038524036564, 3849.40334248192, 3483.0247530691445, 3826.8469261229798, 3927.2341893330527, 3971.860984865516, 3977.54258260298, 4307.310830267204, 4556.88607784808, 4577.299393357935, 4620.422447194101, 4624.745638989888, 4389.231884420214, 4643.628509719214, 5598.732513332107, 5614.887702245932, 5616.887662246732, 1195.6114262864603, 1261.148724610884, 1261.3251910227984, 1291.606060151644, 1328.5350127455506, 834.929031032369, 861.2291998661289, 886.0563499872615, 893.4148132972913, 899.5007770687331, 5053.646244762905, 5064.620153488429, 5069.695818250917, 5104.213525266127, 5138.563222126087, 4535.9546404536195, 5072.492750724898, 5656.179853921159, 5699.173619825102, 5752.395998420189, 4543.000539881221, 4876.926846097312, 4995.875103122378, 5061.6962982221185, 5080.110980578384, 2426.3691440225316, 2726.768224700883, 2993.1020693791775, 2996.2509372656837, 3002.993997010982, 5466.671999680032, 5592.608517403743, 5835.840738926539, 5851.824445266649, 5881.558883083786, 4810.302506136591, 4928.630352723489, 5972.96824643364, 5982.48735531078, 6004.819855404345, 5121.308623335951, 5997.821154787969, 6020.638761674313, 6070.605410648293, 6074.444166874844, 5180.19706945409, 5542.204716557939, 5716.571257155647, 5760.494185029525, 5854.4730974212525, 5665.640246340931, 5716.42835716425, 5747.39073059544, 5754.165645981393, 5754.56840736938, 5396.676199428047, 5944.9405505946115, 5947.1079338099635, 5952.761889524544, 5999.640021598718, 3589.264200838874, 3805.477808876361, 3849.730518863653, 3854.4411060396646, 3862.4592557042597, 5733.168690539765, 5790.449907258803, 5815.6219845711585, 5825.533957283323, 5836.482514546164, 5164.715940623302, 5236.842894713165, 5667.234923285304, 5679.630823996592, 5725.799597014085, 4948.826791062295, 5542.667439953616, 5572.554195664256, 5577.414371491097, 5595.873568044117, 5136.332276803992, 5344.11822049373, 5484.149956756709, 5487.341519017744, 5499.972500137474, 4621.560951709582, 4776.379070720784, 4937.1113199624415, 4950.900981980412, 5497.147942068986, 5201.713905735221, 5369.27514785499, 5385.3268341457315, 5389.622726409114, 5482.671039737628], "value": 4058.0004308085904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.9193696756389, 789.4000559574725, 794.2414993681035, 816.3591580609223, 818.7871153500092, 15124.546263612096, 15222.314995825187, 15891.84108158918, 16008.599785005366, 16059.919700401497, 11651.825222621668, 12119.575814846483, 14320.355583998718, 14322.212278324714, 14792.260386980663, 710.8009757267973, 871.3073106880046, 896.2426749396782, 902.1249388093571, 903.5708038681606, 733.0506993443504, 860.6901515454431, 894.4454438248263, 903.0157128729684, 907.7412937312868, 943.7074506902882, 945.2249155692335, 945.2438049560359, 946.6402766948585, 947.0576776107782, 745.1319213116712, 944.4286206844897, 947.87677601912, 949.6059135458777, 951.7668171298042, 567.1917517537534, 570.2586637371401, 574.1387918122816, 678.1421501800227, 698.4691634357873, 14496.492622758153, 14594.489192878304, 14600.561983140522, 14631.41474341025, 14687.926560367237, 13571.796423053662, 13919.164850108924, 14077.296135193303, 14102.0, 14297.428102875872, 12652.936735316356, 12733.426995785212, 12792.0, 13111.60665180046, 13404.128731632412, 4614.492638714782, 4621.445426548802, 4651.418572678415, 4837.9032419351415, 4846.539578740014, 97952.0, 118802.0, 120027.0, 121384.0, 123525.38237308936, 10306.227032972558, 10423.94788026055, 10482.790344193074, 10626.14990800734, 10868.45657717111, 21021.894890525757, 21421.143154273967, 21424.0, 21459.0, 21536.246231381825, 7729.458937874408, 7729.768106956801, 7982.1618730032515, 7995.600219988977, 8089.595520223966, 4466.665000124939, 4529.614982726439, 4559.202139625552, 4706.599939005223, 4748.928766068511, 3549.911252218715, 3709.7588656737225, 3714.3499887519574, 3717.20080182762, 3726.2920045191327, 576.9394213607595, 681.3935597318391, 694.482610455204, 701.7052837808133, 708.6988030087192, 554.3597145297189, 617.6448542088317, 656.9652796844988, 677.6510097299895, 682.5836239893661, 9330.393524421026, 9341.346105772667, 9404.623815047458, 9440.716778496657, 9541.427514349161, 634.9111124442582, 650.8568115014689, 680.3604611665019, 682.5938566552893, 683.6479213205204, 4296.398504209413, 4581.266997280419, 4585.518520555361, 4671.719696818202, 4760.404949381327, 156270.43729562787, 160341.19829400777, 161931.19034404753, 162312.18843905706, 165469.0, 133783.0, 137869.0, 140528.2973585146, 142334.0, 144789.0, 119688.40155799339, 121866.0, 122628.38685806513, 122663.0, 122859.78551608487, 8579.356548259031, 9017.594208260512, 9026.142516460926, 9076.137766912132, 9148.954255228682, 64270.714585708956, 65193.22734909999, 65848.67075664591, 67306.66346668235, 68354.3164568348, 93425.5328723352, 97782.0, 97966.51016745156, 99475.0, 100389.0, 11366.772664546828, 11627.53489860396, 11762.882371176178, 11895.286282823059, 12381.442835072263, 13000.674983125498, 13707.451701931812, 14488.749304285551, 15495.14776687293, 15497.0, 10985.670429887115, 13702.45190192381, 13905.51330703461, 14197.0, 14226.644333891736, 12108.152429329863, 13727.45090196381, 13921.095128816594, 14030.929845350707, 14446.205458699873, 13443.731125377633, 13774.311284435938, 13981.440742370598, 14435.78346324827, 14455.421783128977, 9486.85769713441, 11088.33469991803, 11227.49476273586, 11318.434078296217, 11767.293962362286, 9781.141583099188, 11421.714457138638, 11439.828402573801, 11549.711257218636, 11597.687218105017], "value": 7981.121894044707, "unit": "score"}], "name": "dromaeo_css", "value": 7335.025390407468, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 163.0, 154.0, 114.0, 112.0, 114.0, 115.0, 113.0, 122.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 159.0, 197.0, 107.0, 133.0, 129.0, 101.0, 158.0, 106.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 184.0, 187.0, 179.0, 185.0, 182.0, 181.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 157.0, 59.0, 57.0, 57.0, 67.0, 145.0, 56.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 130.0, 69.0, 79.0, 89.0, 118.0, 67.0, 69.0, 116.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 86.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 93.0, 97.0, 94.0, 95.0, 95.0, 94.0, 93.0, 99.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 86.0, 85.0, 85.0, 84.0, 87.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 53.0, 52.0, 52.0, 54.0, 53.0, 53.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 77.0, 75.0, 71.0, 70.0, 71.0, 69.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 75.0, 99.0, 95.0, 104.0, 103.0, 106.0, 89.0, 82.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 148.0, 127.0, 145.0, 137.0, 164.0, 146.0, 132.0, 187.0, 153.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 170.0, 173.0, 172.0, 173.0, 172.0, 171.0, 170.0, 163.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 72.0, 84.0, 75.0, 66.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1488.4, "alertThreshold": 2.0}]} 15:01:53 INFO - Return code: 0 15:01:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:01:53 INFO - # TBPL SUCCESS # 15:01:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:01:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:01:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:01:53 INFO - 2016-09-02 15:01:53.472 screenresolution[1672:9781] starting screenresolution argv=screenresolution get 15:01:53 INFO - 2016-09-02 15:01:53.474 screenresolution[1672:9781] Display 0: 1600x1200x32@60 15:01:53 INFO - 2016-09-02 15:01:53.480 screenresolution[1673:9784] starting screenresolution argv=screenresolution list 15:01:53 INFO - Available Modes on Display 0 15:01:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:01:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:01:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:01:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:01:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:01:53 INFO - Intel Iris: 15:01:53 INFO - Chipset Model: Intel Iris 15:01:53 INFO - Type: GPU 15:01:53 INFO - Bus: Built-In 15:01:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:01:53 INFO - Vendor: Intel (0x8086) 15:01:53 INFO - Device ID: 0x0a2e 15:01:53 INFO - Revision ID: 0x0009 15:01:53 INFO - Displays: 15:01:53 INFO - Display: 15:01:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:01:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:01:53 INFO - Display Serial Number: 1600x1200 60 15:01:53 INFO - Main Display: Yes 15:01:53 INFO - Mirror: Off 15:01:53 INFO - Online: Yes 15:01:53 INFO - Rotation: Supported 15:01:53 INFO - Return code: 0 15:01:53 INFO - Running post-action listener: _resource_record_post_action 15:01:53 INFO - [mozharness: 2016-09-02 22:01:53.714305Z] Finished run-tests step (success) 15:01:53 INFO - Running post-run listener: _resource_record_post_run 15:01:53 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37389312; Write bytes: 704821760; Read time: 237; Write time: 1960 15:01:53 INFO - TinderboxPrint: CPU usage
53.9% 15:01:53 INFO - TinderboxPrint: I/O read bytes / time
37,389,312 / 237 15:01:53 INFO - TinderboxPrint: I/O write bytes / time
704,821,760 / 1,960 15:01:53 INFO - TinderboxPrint: CPU idle
2,236.1 (46.1%) 15:01:53 INFO - TinderboxPrint: CPU system
977.0 (20.1%) 15:01:53 INFO - TinderboxPrint: CPU user
1,636.6 (33.7%) 15:01:53 INFO - TinderboxPrint: Swap in / out
443,408,384 / 0 15:01:53 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398885376; Write bytes: 393586688; Read time: 29664; Write time: 809 15:01:53 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35308544; Write bytes: 294437376; Read time: 218; Write time: 1107 15:01:54 INFO - Running post-run listener: _upload_blobber_files 15:01:54 INFO - Blob upload gear active. 15:01:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:01:54 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 15:01:54 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:01:54 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:01:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:55 INFO - (blobuploader) - INFO - Done attempting. 15:01:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:01:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:01:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:56 INFO - (blobuploader) - INFO - Done attempting. 15:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:58 INFO - (blobuploader) - INFO - Done attempting. 15:01:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:01:58 INFO - Return code: 0 15:01:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:01:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:01:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47b6f23d7d149adcfa5e8c3b4fe96f24d5b53d64d6e7903a2bbe683e198a2cd2be699d8f72edcb3bc3d6cd3a8e7f95c8cfc4142c2b51671ee9cd7fb31d4d1266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/108148a95bd3ca62993e784465ab9ba851efea848005bb11ddd6ff120f6411e574d4c26703c7cacbb2584fda5fd47f5c2dce912699456121f2c70cc9e7a9192a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff69f0ae4c5969c6cb4d10394d84a90ff346acbaa861475e10bd40f48ded3835448d70eb72bf5d0e8c7a3c2c7e3e2b5acf9dd2ffd2ea13bf8d9bdb208ae3fefd"} 15:01:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:01:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:01:58 INFO - Contents: 15:01:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47b6f23d7d149adcfa5e8c3b4fe96f24d5b53d64d6e7903a2bbe683e198a2cd2be699d8f72edcb3bc3d6cd3a8e7f95c8cfc4142c2b51671ee9cd7fb31d4d1266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/108148a95bd3ca62993e784465ab9ba851efea848005bb11ddd6ff120f6411e574d4c26703c7cacbb2584fda5fd47f5c2dce912699456121f2c70cc9e7a9192a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff69f0ae4c5969c6cb4d10394d84a90ff346acbaa861475e10bd40f48ded3835448d70eb72bf5d0e8c7a3c2c7e3e2b5acf9dd2ffd2ea13bf8d9bdb208ae3fefd"} 15:01:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:01:58 INFO - Copying logs to upload dir... 15:01:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:01:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.123053 ========= master_lag: 2.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-02 15:02:01.232450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 15:02:01.239346) ========= 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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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/Autoland/sha512/47b6f23d7d149adcfa5e8c3b4fe96f24d5b53d64d6e7903a2bbe683e198a2cd2be699d8f72edcb3bc3d6cd3a8e7f95c8cfc4142c2b51671ee9cd7fb31d4d1266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/108148a95bd3ca62993e784465ab9ba851efea848005bb11ddd6ff120f6411e574d4c26703c7cacbb2584fda5fd47f5c2dce912699456121f2c70cc9e7a9192a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff69f0ae4c5969c6cb4d10394d84a90ff346acbaa861475e10bd40f48ded3835448d70eb72bf5d0e8c7a3c2c7e3e2b5acf9dd2ffd2ea13bf8d9bdb208ae3fefd"} build_url:https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010432 build_url: 'https://queue.taskcluster.net/v1/task/TbVZGy4vSVq_w9ARZXuSEg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47b6f23d7d149adcfa5e8c3b4fe96f24d5b53d64d6e7903a2bbe683e198a2cd2be699d8f72edcb3bc3d6cd3a8e7f95c8cfc4142c2b51671ee9cd7fb31d4d1266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/108148a95bd3ca62993e784465ab9ba851efea848005bb11ddd6ff120f6411e574d4c26703c7cacbb2584fda5fd47f5c2dce912699456121f2c70cc9e7a9192a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ff69f0ae4c5969c6cb4d10394d84a90ff346acbaa861475e10bd40f48ded3835448d70eb72bf5d0e8c7a3c2c7e3e2b5acf9dd2ffd2ea13bf8d9bdb208ae3fefd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 15:02:01.274305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:02:01.274624) ========= 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.2PVjFQe8Bg/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.2zD4Oi7vD9/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005120 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:02:01.322861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 15:02:01.323166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 15:02:01.323476) ========= ========= Total master_lag: 2.65 =========