builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0320 starttime: 1473403688.08 results: success (0) buildid: 20160908220819 builduid: 7de97141eabb44bea6d8ed27180df885 revision: 52a630b9ed23a9ca199837644a616dfa8407339a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.083982) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.084383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.084663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.125434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.125717) ========= 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.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-08 23:48:08-- 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% 18.7M=0.001s 2016-09-08 23:48:08 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.618593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.767800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.768097) ========= 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.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.034915 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:08.824562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 23:48:08.824886) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 52a630b9ed23a9ca199837644a616dfa8407339a --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 52a630b9ed23a9ca199837644a616dfa8407339a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-08 23:48:08,877 truncating revision to first 12 chars 2016-09-08 23:48:08,877 Setting DEBUG logging. 2016-09-08 23:48:08,877 attempt 1/10 2016-09-08 23:48:08,877 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/52a630b9ed23?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 23:48:10,029 unpacking tar archive at: autoland-52a630b9ed23/testing/mozharness/ program finished with exit code 0 elapsedTime=1.783618 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 23:48:10.633955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:10.634441) ========= script_repo_revision: 52a630b9ed23a9ca199837644a616dfa8407339a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:10.634906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:10.635195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 23:48:10.654473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-08 23:48:10.654753) ========= /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.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:10 INFO - MultiFileLogger online at 20160908 23:48:10 in /builds/slave/test 23:48:10 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 23:48:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:48:10 INFO - {'append_to_log': False, 23:48:10 INFO - 'base_work_dir': '/builds/slave/test', 23:48:10 INFO - 'blob_upload_branch': 'Autoland', 23:48:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:48:10 INFO - 'branch': 'Autoland', 23:48:10 INFO - 'buildbot_json_path': 'buildprops.json', 23:48:10 INFO - 'config_files': ('talos/mac_config.py',), 23:48:10 INFO - 'default_actions': ('clobber', 23:48:10 INFO - 'read-buildbot-config', 23:48:10 INFO - 'download-and-extract', 23:48:10 INFO - 'populate-webroot', 23:48:10 INFO - 'create-virtualenv', 23:48:10 INFO - 'install', 23:48:10 INFO - 'run-tests'), 23:48:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:48:10 INFO - 'download_minidump_stackwalk': True, 23:48:10 INFO - 'download_symbols': 'ondemand', 23:48:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:48:10 INFO - 'tooltool.py': '/tools/tooltool.py', 23:48:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:48:10 INFO - '/tools/misc-python/virtualenv.py')}, 23:48:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:48:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:48:10 INFO - 'installer_path': 'installer.exe', 23:48:10 INFO - 'log_level': 'info', 23:48:10 INFO - 'log_name': 'talos', 23:48:10 INFO - 'log_to_console': True, 23:48:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:48:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:48:10 INFO - 'opt_config_files': (), 23:48:10 INFO - 'pip_index': False, 23:48:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:48:10 INFO - 'cmd': ('bash', 23:48:10 INFO - '-c', 23:48:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:48:10 INFO - 'enabled': True, 23:48:10 INFO - 'halt_on_failure': False, 23:48:10 INFO - 'name': 'check_screen_resolution'},), 23:48:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:48:10 INFO - 'cmd': ('bash', 23:48:10 INFO - '-c', 23:48:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:48:10 INFO - 'enabled': True, 23:48:10 INFO - 'halt_on_failure': False, 23:48:10 INFO - 'name': 'check_screen_resolution'},), 23:48:10 INFO - 'run_cmd_checks_enabled': True, 23:48:10 INFO - 'sps_profile': False, 23:48:10 INFO - 'sps_profile_interval': 0, 23:48:10 INFO - 'suite': 'dromaeojs', 23:48:10 INFO - 'system_bits': '32', 23:48:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:48:10 INFO - 'title': 't-yosemite-r7-0320', 23:48:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:48:10 INFO - 'use_talos_json': True, 23:48:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:48:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:48:10 INFO - 'work_dir': 'build'} 23:48:10 INFO - [mozharness: 2016-09-09 06:48:10.819406Z] Running clobber step. 23:48:10 INFO - Running pre-action listener: _resource_record_pre_action 23:48:10 INFO - Running main action method: clobber 23:48:10 INFO - rmtree: /builds/slave/test/build 23:48:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:48:12 INFO - Running post-action listener: _resource_record_post_action 23:48:12 INFO - [mozharness: 2016-09-09 06:48:12.846225Z] Finished clobber step (success) 23:48:12 INFO - [mozharness: 2016-09-09 06:48:12.846298Z] Running read-buildbot-config step. 23:48:12 INFO - Running pre-action listener: _resource_record_pre_action 23:48:12 INFO - Running main action method: read_buildbot_config 23:48:12 INFO - Using buildbot properties: 23:48:12 INFO - { 23:48:12 INFO - "project": "", 23:48:12 INFO - "product": "firefox", 23:48:12 INFO - "script_repo_revision": "production", 23:48:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 23:48:12 INFO - "repository": "", 23:48:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 23:48:12 INFO - "buildid": "20160908220819", 23:48:12 INFO - "pgo_build": "False", 23:48:12 INFO - "basedir": "/builds/slave/test", 23:48:12 INFO - "buildnumber": 182, 23:48:12 INFO - "slavename": "t-yosemite-r7-0320", 23:48:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 23:48:12 INFO - "platform": "yosemite_r7", 23:48:12 INFO - "scheduler": "tests-autoland-macosx64-talos", 23:48:12 INFO - "branch": "autoland", 23:48:12 INFO - "repo_path": "integration/autoland", 23:48:12 INFO - "revision": "52a630b9ed23a9ca199837644a616dfa8407339a", 23:48:12 INFO - "stage_platform": "macosx64", 23:48:12 INFO - "builduid": "7de97141eabb44bea6d8ed27180df885", 23:48:12 INFO - "slavebuilddir": "test" 23:48:12 INFO - } 23:48:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 23:48:12 INFO - Running post-action listener: _resource_record_post_action 23:48:12 INFO - [mozharness: 2016-09-09 06:48:12.849606Z] Finished read-buildbot-config step (success) 23:48:12 INFO - [mozharness: 2016-09-09 06:48:12.849733Z] Running download-and-extract step. 23:48:12 INFO - Running pre-action listener: _resource_record_pre_action 23:48:12 INFO - Running main action method: download_and_extract 23:48:12 INFO - mkdir: /builds/slave/test/build/tests 23:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:12 INFO - trying https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 23:48:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/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 23:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/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 23:48:13 INFO - Downloaded 1199 bytes. 23:48:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 23:48:13 INFO - Using the following test package requirements: 23:48:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:48:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 23:48:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 23:48:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'jsshell-mac.zip'], 23:48:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 23:48:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:48:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 23:48:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 23:48:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 23:48:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:48:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 23:48:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:48:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:48:14 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:48:21 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 23:48:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:48:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:48:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 23:48:28 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:48: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')]} 23:48:29 INFO - trying https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:48:29 INFO - Downloading https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 23:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/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 23:48:32 INFO - Downloaded 111544072 bytes. 23:48:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:48:32 INFO - mkdir: /builds/slave/test/properties 23:48:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:48:32 INFO - Writing to file /builds/slave/test/properties/build_url 23:48:32 INFO - Contents: 23:48:32 INFO - build_url:https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:48:32 INFO - Running post-action listener: _resource_record_post_action 23:48:32 INFO - Running post-action listener: set_extra_try_arguments 23:48:32 INFO - [mozharness: 2016-09-09 06:48:32.817920Z] Finished download-and-extract step (success) 23:48:32 INFO - [mozharness: 2016-09-09 06:48:32.818046Z] Running populate-webroot step. 23:48:32 INFO - Running pre-action listener: _resource_record_pre_action 23:48:32 INFO - Running main action method: populate_webroot 23:48:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:48:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:48:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:48:32 INFO - '--tppagecycles', 23:48:32 INFO - '7'], 23:48:32 INFO - 'tests': ['tsvgm']}}, 23:48:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:48:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:48:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:48:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['damp', 'tps']}, 23:48:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'tests': ['damp', 'tps']}, 23:48:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['dromaeo_dom']}, 23:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:48:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['basic_compositor_video']}, 23:48:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:48:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['a11yr', 23:48:32 INFO - 'ts_paint', 23:48:32 INFO - 'tpaint', 23:48:32 INFO - 'sessionrestore', 23:48:32 INFO - 'sessionrestore_no_auto_restore', 23:48:32 INFO - 'tabpaint']}, 23:48:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['tsvgx', 23:48:32 INFO - 'tsvgr_opacity', 23:48:32 INFO - 'tart', 23:48:32 INFO - 'tscrollx', 23:48:32 INFO - 'cart']}, 23:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:48:32 INFO - 'tsvgr_opacity', 23:48:32 INFO - 'tart', 23:48:32 INFO - 'tscrollx', 23:48:32 INFO - 'cart']}, 23:48:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'talos_options': ['--disable-e10s'], 23:48:32 INFO - 'tests': ['tp5o']}, 23:48:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'tests': ['tp5o']}, 23:48:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'talos_options': ['--disable-e10s', 23:48:32 INFO - '--xperf_path', 23:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:32 INFO - 'tests': ['tp5n']}, 23:48:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:32 INFO - 'talos_options': ['--xperf_path', 23:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:32 INFO - 'tests': ['tp5n']}}, 23:48:32 INFO - 'talos.zip': {'path': '', 23:48:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:48:32 INFO - Running post-action listener: _resource_record_post_action 23:48:32 INFO - [mozharness: 2016-09-09 06:48:32.836599Z] Finished populate-webroot step (success) 23:48:32 INFO - [mozharness: 2016-09-09 06:48:32.836736Z] Running create-virtualenv step. 23:48:32 INFO - Running pre-action listener: _resource_record_pre_action 23:48:32 INFO - Running main action method: create_virtualenv 23:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 23:48:32 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 23:48:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:48:32 INFO - Using real prefix '/tools/python27' 23:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 23:48:36 INFO - Installing pip.................done. 23:48:36 INFO - Return code: 0 23:48:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:36 INFO - 'HOME': '/Users/cltbld', 23:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:36 INFO - 'LOGNAME': 'cltbld', 23:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:36 INFO - 'MOZ_NO_REMOTE': '1', 23:48:36 INFO - 'NO_EM_RESTART': '1', 23:48:36 INFO - 'PAGER': '/bin/cat', 23:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:36 INFO - 'PWD': '/builds/slave/test', 23:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:36 INFO - 'SHELL': '/bin/bash', 23:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:36 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:36 INFO - 'USER': 'cltbld', 23:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:36 INFO - 'XPC_FLAGS': '0x0', 23:48:36 INFO - 'XPC_SERVICE_NAME': '0', 23:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:36 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 23:48:36 INFO - Cleaning up... 23:48:36 INFO - Return code: 0 23:48:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:36 INFO - 'HOME': '/Users/cltbld', 23:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:36 INFO - 'LOGNAME': 'cltbld', 23:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:36 INFO - 'MOZ_NO_REMOTE': '1', 23:48:36 INFO - 'NO_EM_RESTART': '1', 23:48:36 INFO - 'PAGER': '/bin/cat', 23:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:36 INFO - 'PWD': '/builds/slave/test', 23:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:36 INFO - 'SHELL': '/bin/bash', 23:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:36 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:36 INFO - 'USER': 'cltbld', 23:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:36 INFO - 'XPC_FLAGS': '0x0', 23:48:36 INFO - 'XPC_SERVICE_NAME': '0', 23:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:37 INFO - Downloading/unpacking psutil>=3.1.1 23:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:40 INFO - Installing collected packages: psutil 23:48:40 INFO - Running setup.py install for psutil 23:48:40 INFO - building 'psutil._psutil_osx' extension 23:48:40 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 23:48:41 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 23:48:41 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 23:48:41 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 23:48:41 INFO - building 'psutil._psutil_posix' extension 23:48:41 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 23:48:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:48:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:48:41 INFO - ^ 23:48:41 INFO - 1 warning generated. 23:48:41 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 23:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:41 INFO - Successfully installed psutil 23:48:41 INFO - Cleaning up... 23:48:42 INFO - Return code: 0 23:48:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:42 INFO - 'HOME': '/Users/cltbld', 23:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:42 INFO - 'LOGNAME': 'cltbld', 23:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:42 INFO - 'MOZ_NO_REMOTE': '1', 23:48:42 INFO - 'NO_EM_RESTART': '1', 23:48:42 INFO - 'PAGER': '/bin/cat', 23:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:42 INFO - 'PWD': '/builds/slave/test', 23:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:42 INFO - 'SHELL': '/bin/bash', 23:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:42 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:42 INFO - 'USER': 'cltbld', 23:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:42 INFO - 'XPC_FLAGS': '0x0', 23:48:42 INFO - 'XPC_SERVICE_NAME': '0', 23:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:48:44 INFO - Installing collected packages: mozsystemmonitor 23:48:44 INFO - Running setup.py install for mozsystemmonitor 23:48:44 INFO - Successfully installed mozsystemmonitor 23:48:44 INFO - Cleaning up... 23:48:45 INFO - Return code: 0 23:48:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:45 INFO - 'HOME': '/Users/cltbld', 23:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:45 INFO - 'LOGNAME': 'cltbld', 23:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:45 INFO - 'MOZ_NO_REMOTE': '1', 23:48:45 INFO - 'NO_EM_RESTART': '1', 23:48:45 INFO - 'PAGER': '/bin/cat', 23:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:45 INFO - 'PWD': '/builds/slave/test', 23:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:45 INFO - 'SHELL': '/bin/bash', 23:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:45 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:45 INFO - 'USER': 'cltbld', 23:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:45 INFO - 'XPC_FLAGS': '0x0', 23:48:45 INFO - 'XPC_SERVICE_NAME': '0', 23:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:45 INFO - Downloading/unpacking jsonschema==2.5.1 23:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:48:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:48 INFO - Downloading functools32-3.2.3-2.tar.gz 23:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:48:48 INFO - warning: no files found matching '*.txt' 23:48:48 INFO - no previously-included directories found matching 'build' 23:48:48 INFO - no previously-included directories found matching 'dist' 23:48:48 INFO - no previously-included directories found matching '.git*' 23:48:48 INFO - Installing collected packages: jsonschema, functools32 23:48:48 INFO - Running setup.py install for functools32 23:48:48 INFO - warning: no files found matching '*.txt' 23:48:48 INFO - no previously-included directories found matching 'build' 23:48:48 INFO - no previously-included directories found matching 'dist' 23:48:48 INFO - no previously-included directories found matching '.git*' 23:48:48 INFO - Successfully installed jsonschema functools32 23:48:48 INFO - Cleaning up... 23:48:48 INFO - Return code: 0 23:48:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:48 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:48 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 23:48:48 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 23:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:48 INFO - 'HOME': '/Users/cltbld', 23:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:48 INFO - 'LOGNAME': 'cltbld', 23:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:48 INFO - 'MOZ_NO_REMOTE': '1', 23:48:48 INFO - 'NO_EM_RESTART': '1', 23:48:48 INFO - 'PAGER': '/bin/cat', 23:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:48 INFO - 'PWD': '/builds/slave/test', 23:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:48 INFO - 'SHELL': '/bin/bash', 23:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:48 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:48 INFO - 'USER': 'cltbld', 23:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:48 INFO - 'XPC_FLAGS': '0x0', 23:48:48 INFO - 'XPC_SERVICE_NAME': '0', 23:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:48:48 INFO - Cleaning up... 23:48:48 INFO - Return code: 0 23:48:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:48 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:48 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 23:48:48 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 23:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:48 INFO - 'HOME': '/Users/cltbld', 23:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:48 INFO - 'LOGNAME': 'cltbld', 23:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:48 INFO - 'MOZ_NO_REMOTE': '1', 23:48:48 INFO - 'NO_EM_RESTART': '1', 23:48:48 INFO - 'PAGER': '/bin/cat', 23:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:48 INFO - 'PWD': '/builds/slave/test', 23:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:48 INFO - 'SHELL': '/bin/bash', 23:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:48 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:48 INFO - 'USER': 'cltbld', 23:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:48 INFO - 'XPC_FLAGS': '0x0', 23:48:48 INFO - 'XPC_SERVICE_NAME': '0', 23:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:49 INFO - Downloading/unpacking blobuploader==1.2.4 23:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:51 INFO - Downloading blobuploader-1.2.4.tar.gz 23:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:48:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:48:51 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 23:48:51 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 23:48:51 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 23:48:51 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 23:48:51 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 23:48:51 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 23:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:48:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:52 INFO - Downloading docopt-0.6.1.tar.gz 23:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 23:48:52 INFO - Running setup.py install for blobuploader 23:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:48:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:48:53 INFO - Running setup.py install for requests 23:48:53 INFO - Running setup.py install for docopt 23:48:53 INFO - Successfully installed blobuploader requests docopt 23:48:53 INFO - Cleaning up... 23:48:53 INFO - Return code: 0 23:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:53 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:53 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 23:48:53 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 23:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:53 INFO - 'HOME': '/Users/cltbld', 23:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:53 INFO - 'LOGNAME': 'cltbld', 23:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:53 INFO - 'MOZ_NO_REMOTE': '1', 23:48:53 INFO - 'NO_EM_RESTART': '1', 23:48:53 INFO - 'PAGER': '/bin/cat', 23:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:53 INFO - 'PWD': '/builds/slave/test', 23:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:53 INFO - 'SHELL': '/bin/bash', 23:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:53 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:53 INFO - 'USER': 'cltbld', 23:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:53 INFO - 'XPC_FLAGS': '0x0', 23:48:53 INFO - 'XPC_SERVICE_NAME': '0', 23:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-gMmKzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZvAX8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zQiPr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1QnuvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ItaWuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-le3Ot0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-5KBYYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-wSgjLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-sftABR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-7dadvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4uu809-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_cUjSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-c55ObP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-VtAH2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6hlHdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1yU6bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:48:55 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-iLs3hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:48:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:48:55 INFO - Running setup.py install for manifestparser 23:48:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:48:55 INFO - Running setup.py install for mozcrash 23:48:56 INFO - Running setup.py install for mozdebug 23:48:56 INFO - Running setup.py install for mozdevice 23:48:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Running setup.py install for mozfile 23:48:56 INFO - Running setup.py install for mozhttpd 23:48:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Running setup.py install for mozinfo 23:48:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Running setup.py install for mozInstall 23:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:48:56 INFO - Running setup.py install for mozleak 23:48:57 INFO - Running setup.py install for mozlog 23:48:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Running setup.py install for moznetwork 23:48:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Running setup.py install for mozprocess 23:48:57 INFO - Running setup.py install for mozprofile 23:48:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Running setup.py install for mozrunner 23:48:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:48:57 INFO - Running setup.py install for mozscreenshot 23:48:58 INFO - Running setup.py install for moztest 23:48:58 INFO - Running setup.py install for mozversion 23:48:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:48:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:48:58 INFO - Cleaning up... 23:48:58 INFO - Return code: 0 23:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:58 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:48:58 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 23:48:58 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 23:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:48:58 INFO - 'HOME': '/Users/cltbld', 23:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:48:58 INFO - 'LOGNAME': 'cltbld', 23:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:58 INFO - 'MOZ_NO_REMOTE': '1', 23:48:58 INFO - 'NO_EM_RESTART': '1', 23:48:58 INFO - 'PAGER': '/bin/cat', 23:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:58 INFO - 'PWD': '/builds/slave/test', 23:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:48:58 INFO - 'SHELL': '/bin/bash', 23:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:48:58 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:48:58 INFO - 'USER': 'cltbld', 23:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:58 INFO - 'XPC_FLAGS': '0x0', 23:48:58 INFO - 'XPC_SERVICE_NAME': '0', 23:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-OuqoDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:58 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)) 23:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jGhjVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:58 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)) 23:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-XSwtM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:58 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)) 23:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:58 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZX9ot5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-PzVart-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-H08ZLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DnnMLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-r6Rw0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Dcjq3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-fjBWuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vqehF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-P0Pv6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:59 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4Hwt0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:59 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)) 23:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:49:00 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-6UumL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:49:00 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)) 23:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:00 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8BKvEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:00 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)) 23:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:49:00 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1lHN_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:49:00 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)) 23:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:49:00 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-zpDtVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:49:00 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)) 23:49:00 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)) 23:49:00 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)) 23:49:00 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)) 23:49:00 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)) 23:49:00 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)) 23:49:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:02 INFO - Downloading blessings-1.6.tar.gz 23:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:49:03 INFO - Installing collected packages: blessings 23:49:03 INFO - Running setup.py install for blessings 23:49:03 INFO - Successfully installed blessings 23:49:03 INFO - Cleaning up... 23:49:03 INFO - Return code: 0 23:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:49:03 INFO - Reading from file tmpfile_stdout 23:49:03 INFO - Current package versions: 23:49:03 INFO - blessings == 1.6 23:49:03 INFO - blobuploader == 1.2.4 23:49:03 INFO - docopt == 0.6.1 23:49:03 INFO - functools32 == 3.2.3-2 23:49:03 INFO - jsonschema == 2.5.1 23:49:03 INFO - manifestparser == 1.1 23:49:03 INFO - mozInstall == 1.12 23:49:03 INFO - mozcrash == 0.17 23:49:03 INFO - mozdebug == 0.1 23:49:03 INFO - mozdevice == 0.48 23:49:03 INFO - mozfile == 1.2 23:49:03 INFO - mozhttpd == 0.7 23:49:03 INFO - mozinfo == 0.9 23:49:03 INFO - mozleak == 0.1 23:49:03 INFO - mozlog == 3.3 23:49:03 INFO - moznetwork == 0.27 23:49:03 INFO - mozprocess == 0.23 23:49:03 INFO - mozprofile == 0.28 23:49:03 INFO - mozrunner == 6.12 23:49:03 INFO - mozscreenshot == 0.1 23:49:03 INFO - mozsystemmonitor == 0.3 23:49:03 INFO - moztest == 0.7 23:49:03 INFO - mozversion == 1.4 23:49:03 INFO - psutil == 3.1.1 23:49:03 INFO - requests == 1.2.3 23:49:03 INFO - wsgiref == 0.1.2 23:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:03 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:49:03 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 23:49:03 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 23:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:49:03 INFO - 'HOME': '/Users/cltbld', 23:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:49:03 INFO - 'LOGNAME': 'cltbld', 23:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:03 INFO - 'MOZ_NO_REMOTE': '1', 23:49:03 INFO - 'NO_EM_RESTART': '1', 23:49:03 INFO - 'PAGER': '/bin/cat', 23:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:03 INFO - 'PWD': '/builds/slave/test', 23:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:49:03 INFO - 'SHELL': '/bin/bash', 23:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:49:03 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:49:03 INFO - 'USER': 'cltbld', 23:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:03 INFO - 'XPC_FLAGS': '0x0', 23:49:03 INFO - 'XPC_SERVICE_NAME': '0', 23:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 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)) 23:49:03 INFO - Cleaning up... 23:49:03 INFO - Return code: 0 23:49:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:03 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 0x10b7aaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5c34b4bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, '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.4JcJW1lJfS/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.lS7o0dieae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 23:49:03 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 23:49:03 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 23:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:49:03 INFO - 'HOME': '/Users/cltbld', 23:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:49:03 INFO - 'LOGNAME': 'cltbld', 23:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:03 INFO - 'MOZ_NO_REMOTE': '1', 23:49:03 INFO - 'NO_EM_RESTART': '1', 23:49:03 INFO - 'PAGER': '/bin/cat', 23:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:03 INFO - 'PWD': '/builds/slave/test', 23:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:49:03 INFO - 'SHELL': '/bin/bash', 23:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:49:03 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:49:03 INFO - 'USER': 'cltbld', 23:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:03 INFO - 'XPC_FLAGS': '0x0', 23:49:03 INFO - 'XPC_SERVICE_NAME': '0', 23:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:49:04 INFO - Cleaning up... 23:49:04 INFO - Return code: 0 23:49:04 INFO - Running post-action listener: _resource_record_post_action 23:49:04 INFO - Running post-action listener: _start_resource_monitoring 23:49:04 INFO - Starting resource monitoring. 23:49:04 INFO - [mozharness: 2016-09-09 06:49:04.127688Z] Finished create-virtualenv step (success) 23:49:04 INFO - [mozharness: 2016-09-09 06:49:04.128743Z] Running install step. 23:49:04 INFO - Running pre-action listener: _resource_record_pre_action 23:49:04 INFO - Running main action method: install 23:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:49:04 INFO - Reading from file tmpfile_stdout 23:49:04 INFO - Detecting whether we're running mozinstall >=1.0... 23:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:49:04 INFO - Reading from file tmpfile_stdout 23:49:04 INFO - Output received: 23:49:04 INFO - Usage: mozinstall [options] installer 23:49:04 INFO - Options: 23:49:04 INFO - -h, --help show this help message and exit 23:49:04 INFO - -d DEST, --destination=DEST 23:49:04 INFO - Directory to install application into. [default: 23:49:04 INFO - "/builds/slave/test"] 23:49:04 INFO - --app=APP Application being installed. [default: firefox] 23:49:04 INFO - mkdir: /builds/slave/test/build/application 23:49:04 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'] 23:49:04 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 23:49:38 INFO - Reading from file tmpfile_stdout 23:49:38 INFO - Output received: 23:49:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:49:38 INFO - Running post-action listener: _resource_record_post_action 23:49:38 INFO - [mozharness: 2016-09-09 06:49:38.559854Z] Finished install step (success) 23:49:38 INFO - [mozharness: 2016-09-09 06:49:38.560021Z] Running run-tests step. 23:49:38 INFO - Running pre-action listener: _resource_record_pre_action 23:49:38 INFO - Running main action method: run_tests 23:49:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:49:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:49:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:49:38 INFO - 2016-09-08 23:49:38.574 screenresolution[1652:9572] starting screenresolution argv=screenresolution get 23:49:38 INFO - 2016-09-08 23:49:38.577 screenresolution[1652:9572] Display 0: 1600x1200x32@60 23:49:38 INFO - 2016-09-08 23:49:38.583 screenresolution[1653:9574] starting screenresolution argv=screenresolution list 23:49:38 INFO - Available Modes on Display 0 23:49:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:49:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:49:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:49:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:49:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:49:38 INFO - Intel Iris: 23:49:38 INFO - Chipset Model: Intel Iris 23:49:38 INFO - Type: GPU 23:49:38 INFO - Bus: Built-In 23:49:38 INFO - VRAM (Dynamic, Max): 1536 MB 23:49:38 INFO - Vendor: Intel (0x8086) 23:49:38 INFO - Device ID: 0x0a2e 23:49:38 INFO - Revision ID: 0x0009 23:49:38 INFO - Displays: 23:49:38 INFO - Display: 23:49:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:49:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:49:38 INFO - Display Serial Number: 1600x1200 60 23:49:38 INFO - Main Display: Yes 23:49:38 INFO - Mirror: Off 23:49:38 INFO - Online: Yes 23:49:38 INFO - Rotation: Supported 23:49:38 INFO - Return code: 0 23:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:49:38 INFO - Python 2.7.3 23:49:38 INFO - Return code: 0 23:49:38 INFO - grabbing minidump binary from tooltool 23:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:49:38 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 0x10b70ed30>, '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 0x10b473db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b706b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:49:38 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 23:49:38 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 23:49:38 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 23:49:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:49:38 INFO - Return code: 0 23:49:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:49:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:49:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:49:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:49:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:49:38 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/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 23:49:38 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/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 23:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4JcJW1lJfS/Render', 23:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:49:38 INFO - 'HOME': '/Users/cltbld', 23:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:49:38 INFO - 'LOGNAME': 'cltbld', 23:49:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:49:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:38 INFO - 'MOZ_NO_REMOTE': '1', 23:49:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:49:38 INFO - 'NO_EM_RESTART': '1', 23:49:38 INFO - 'PAGER': '/bin/cat', 23:49:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:38 INFO - 'PWD': '/builds/slave/test', 23:49:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:49:38 INFO - 'SHELL': '/bin/bash', 23:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lS7o0dieae/Listeners', 23:49:38 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 23:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:49:38 INFO - 'USER': 'cltbld', 23:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:38 INFO - 'XPC_FLAGS': '0x0', 23:49:38 INFO - 'XPC_SERVICE_NAME': '0', 23:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:49:38 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/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 23:49:39 INFO - mozversion application_buildid: 20160908220819 23:49:39 INFO - mozversion application_changeset: 52a630b9ed23a9ca199837644a616dfa8407339a 23:49:39 INFO - mozversion application_display_name: Nightly 23:49:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:49:39 INFO - mozversion application_name: Firefox 23:49:39 INFO - mozversion application_remotingname: firefox 23:49:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:49:39 INFO - mozversion application_vendor: Mozilla 23:49:39 INFO - mozversion application_version: 51.0a1 23:49:39 INFO - mozversion platform_buildid: 20160908220819 23:49:39 INFO - mozversion platform_changeset: 52a630b9ed23a9ca199837644a616dfa8407339a 23:49:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:49:39 INFO - mozversion platform_version: 51.0a1 23:49:39 INFO - using testdate: 1473403779 23:49:39 INFO - actual date: 1473403779 23:49:39 INFO - starting webserver on 'localhost:49271' 23:49:39 INFO - SUITE-START | Running 2 tests 23:49:39 INFO - TEST-START | dromaeo_css 23:49:39 INFO - operating with platform_type : mac_ 23:49:39 INFO - Initialising browser for dromaeo_css test... 23:49:39 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp9eWmaz/profile http://localhost:49271/getInfo.html) 23:49:41 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 23:49:41 INFO - PROCESS | 1663 | colorDepth:24 23:49:41 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 23:49:41 INFO - PROCESS | 1663 | __metrics 23:49:41 INFO - PROCESS | 1663 | 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" 23:49:41 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:49:42 INFO - TEST-INFO | 1663: exit 0 23:49:42 INFO - Browser initialized. 23:49:42 INFO - Running cycle 1/1 for dromaeo_css test... 23:49:42 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp9eWmaz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:54 INFO - PROCESS | 1666 | RSS: Main: 252215296 23:49:54 INFO - PROCESS | 1666 | 23:50:45 INFO - PROCESS | 1666 | 1473403845468 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] 23:52:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 23:52:58 INFO - PROCESS | 1666 | RSS: Main: 431722496 23:52:58 INFO - PROCESS | 1666 | 23:56:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 23:56:02 INFO - PROCESS | 1666 | RSS: Main: 393519104 23:56:02 INFO - PROCESS | 1666 | 23:59:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 23:59:05 INFO - PROCESS | 1666 | RSS: Main: 376774656 23:59:05 INFO - PROCESS | 1666 | 00:02:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 00:02:08 INFO - PROCESS | 1666 | RSS: Main: 350711808 00:02:08 INFO - PROCESS | 1666 | 00:05:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 00:05:12 INFO - PROCESS | 1666 | RSS: Main: 346460160 00:05:12 INFO - PROCESS | 1666 | 00:08:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 00:08:16 INFO - PROCESS | 1666 | RSS: Main: 564273152 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | __start_tp_report 00:08:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 00:08:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 00:08:16 INFO - PROCESS | 1666 | |i|pagename|runs| 00:08:16 INFO - PROCESS | 1666 | |0;dojo.html;3291.621463531694;3300.587426571678;3349.715274201693;3358.5633867597207;3406.301708149828;5562.221289019541;5680.943190568093;5687.8578035549135;5755.366909639942;5757.827265182046;5683.005474042046;5710.457506536873;5758.078707406805;5784.074548072309;5811.331696854863;5146.485351464861;5146.485351464861;5226.634135610509;5260.210968354758;5357.678539287635;5308.654937429074;5361.51746342829;5380.677159370431;5385.730713464331;5401;5166.535011848914;5207.166853303491;5218.660787048868;5275.366955965309;5283.154695248781;4271.97864010681;5223.112070947948;5239.764210610493;5242.685438873642;5352.732363381815;5217.373915130209;5221.216817477371;5238.083335416287;5253.605979551511;5263.578913686896;5568.387477377485;5623.465770751772;5693.943060569382;5703.458171473703;5727.312722473288;6161.137440758297;6218.844528886769;6219.502439804804;6236.407541283571;6251.437370636619;6202.286737025254;6266.655333956631;6269.811905642838;6296.024116261941;6305.558610897239;5592.049351610195;5731.226284451545;5771.826845194651;5773.538116950634;5785.247917770663;6257.061440783918;6259.061140828912;6263.655498947602;6272.059191121369;6281.497480201573;6148.047052706837;6160.8767824643255;6166.105914642441;6175.814725558241;6176.7838125665385;6139.4781443577795;6164.568480206342;6213.565050446516;6222.533310001678;6275.717592708339;6178.165947597106;6222.875542489125;6228.159198508234;6239.500839932794;6243.594166379171;6220.315765265817;6235.96882015587;6266;6276.152719382825;6296.024116261987;4856.295837103671;4887.584555312838;4895.926561101586;4939.75301234944;4993.300937868701;4319.287317592562;4381.101874115799;4423.579759922803;4452.577005184502;4479.059397526491;5609.551235901118;5610.915836262459;5619.887602247933;5622;5661.34894487131;6204.286507051656;6211.068339749074;6211.440970312694;6213.596116252519;6213.627182369072;5537.418571050062;5599.132134519156;5635.295588051494;5641.887162256814;5665.348484924287;4604.700694454849;5395.974764794676;5400.594955378362;5414.052540805344;5465.890682186334;6261;6268.216472940882;6269.059641053787;6281.371862813682;6282.623042617458;6111.530965355488;6189.442950134509;6209.937900621117;6249.406306400884;6258.655773932477;5359.812406565751;6279.748810047547;6310.6213627182515;6315.55791094619;6323.525735569759;6161.106639537153;6172.2979372501395;6221.06683997404;6222.719977600928;6223.751049957951;6019.488343490677;6114.57197996136;6140.815775526741;6258.374162583706;6295.653739044396;6090.817275481742;6092.238470191226;6096.908546371897;6097.603655762361;6100.23747031621;6034.939650603614;6078.848028799315;6114.205153330038;6127.525510585499;6135.845176233341;5935.198748168942;5983.55123365758;5996.400359963969;5998.25021872266;6027.939720602738;5906.438888305604;6123.877522449615;6135.631862088289;6138.815835524942;6144.508439324753;5851;5900.11498275245;5929.199558059607;5968.850778730566;5988.461038506555 00:08:16 INFO - PROCESS | 1666 | |1;ext.html;493.9110960027195;501.0755156735821;512.9407772948862;532.1565318969433;556.2490637639185;30354.696453035463;30829.920952766657;31669;40742.59257407425;40959.795201024026;42356.57643423565;42716.78641606795;42743;42763.78618106905;42787.57212427875;9559.474228917425;9725.854112188323;9749.07383798538;9755.804883902318;9762.463064531448;9602.327837051409;9731.805363892718;9733.464659443727;9740.220782337432;9747.756306092333;8336.541490218036;9683.903160968406;9717.805643887117;9751.21990240779;9778.608855645765;8245.83508329833;9728.027197280286;9741.561629726679;9748.90251097487;9752.366096203725;9614.75963100921;9664.323497355188;9677.177439917616;9679.322447428684;9708.466034368106;39683.60316396828;40062.198756025005;40118.99702507431;40136.39795403071;40160.196796063916;3140.2149462634343;3256.934861302784;3384.4754063120254;3664.725145614063;3884.1066554692297;30504.08487745371;31023.22441938947;31254.687453125403;31738.206544836332;31781.364372712647;3215.099772063826;3231.5314279429585;3276.3774882772436;3302.8183449910243;3371.9831400843086;495477;498503;498767;498899.5055024738;499135;32633.51049734256;33486.832565837016;33515.49726754101;55496;55993.440065599636;34754.478682819776;34843.477347839806;34853.477197842054;34869;34925.1268718279;14565.708685826436;14706.55880323592;14719.411223550938;14724;14728.926355368154;12403.875961240452;12473.93763031179;12518.248905065726;12518.937405312916;12529.812052819216;7574.091109066947;7594.354479869163;7667.693292268358;7678;7680.423968202407;3186.394585028837;3242.610886693612;3249.8375081245845;3251.3172233830687;3272.7381809455187;876.4960147914846;908.4685459006423;1009.9244304815348;1043.8225501664735;1047.4762618690654;28591.714082859322;29872.402551949275;30107.548386774215;30443.934462294157;30734.53898191484;821.4291067707885;1009.4296722351847;1086.2939089591828;1122.854028976228;1167.9357635329968;15488.767668484756;15734.527964161094;16311.755323670155;16622.919510231797;17003.23485443158;704533;713301;717343;719190;719258;53831;54143.6464088401;54149.187762183596;54275.18587221195;54276.64308392322;1211.8182272659171;1252.7181384188666;1334.93325333731;1357.7895426208954;1388.6597783543098;28347.291317717223;29798.553021704258;30631.387372251986;30699.044148843066;30971.69028309778;47388.7630561845;48012;48082.27876581784;48099.75950120227;48125.75937120292;555063;556918;559260;560571;561525;24690.382740430916;25027;25178;25816.096436624626;25900.22299331023;44675.608002578796;44745.10509789851;45359.77320113379;45995.540044599125;46325;36578.63421365859;36772.63227367692;37883;38043.61956380401;39213.41179882361;37843.05392365213;38208;38514.53369196786;38639.22721545609;39493.80253098716;33774.81788137403;38297.61702382941;38379.42430863595;38685.6131438682;38910.4163437543;27477.862610686818;31632.525512116878;32331.51502727508;32961.67038329586;33750.324993500486;24415;24909.626355605043;25008.749562522164;25788.871055644602;25877.835497402284 00:08:16 INFO - PROCESS | 1666 | |2;jquery.html;371.1445119000704;373.190177315226;383.61638361638364;391.40506430226077;404.70860980094324;15105.848941510581;15118;18569.071546422674;20471.283505077325;20758.584828303425;17651.470455886312;20038.499037524034;20173.09221085051;20486;20733.896330518364;5668.093105103184;5971.37300583439;5987.28152621686;6017.157597936271;6047.455728984391;5656.575756818234;5961.850953726148;6053.485453736438;6065.150878876961;6072.332043475214;5910.320313163977;5996.940030599703;6005.729742161591;6006.9399306007035;6019.939800602004;5823.82528524145;5993.520518358521;6043.576949613529;6124;6186.19579454668;5999.730012149464;6002.249718785152;6011.849703757397;6013.51891848651;6016.518678505753;12203.47456567929;12532.185407948455;12795.744085118245;13063.542776002889;13104;1809.936652217166;2046.334941144134;2056.1466991198786;2119.4807272218404;2142.967855482169;9823.90176098237;10103.797924041479;10328.741781455448;12562.874371256263;12856.228626282453;1645.3089702324933;1754.657841720865;1842.0973722875694;1896.706010568364;1930.1603802346024;112981;115359.65521896293;122469;124190.37904810508;126123.73876261212;11105.944470277758;11194.944025279985;11289;11322.716932076764;11775.705607359712;12056.51773929033;14003;14015.719685606231;14029.719405611831;14056.945729070156;7212.891806622905;7312.561246325237;7584.772456826304;8199.22107399796;8506.234438900528;6696.5647232929705;6976.616286104313;8380.455270407405;8423.241908228289;8588.914110858812;3116.174213833336;4170.416141740159;4223.711767910817;4376.124775045004;4378.16814805186;1831.587892724153;1875.990620046891;1881.5390229393886;1887.3865993552151;1891.6122194950278;803.3292201012104;853.6756032707656;919.2560207779773;921.0559176843789;999.6051559633904;20256.392308230483;20776.58446831055;20822.58354832895;20962.685559716618;21027.78972210289;869.8434281829205;877.1535468273147;878.9912100879037;937.5124935033881;976.4190306767462;8069.394795390369;10177.592896284214;10456.424896630606;10897.455127243606;11168.106551475863;509726;510250;517319;557664;562343;115624.42187789176;116813;116867.41566292114;118888.21667674991;134873;953.7472569769017;994.4729293474614;1007.6271779441507;1008.037324355239;1020.4132623741378;18437.80154289967;18688.34590789316;19536.413907582795;19586.216551338355;19620.215191392184;41387;46756.36352727638;55128.44871551233;56773.58066048382;57077.42922570721;78228.43543128992;78660.426791465;79962.10704758963;81207.59396202982;81444;7498.887516687145;7806.88289675644;7975.880361794461;8069.919300806917;8136.877946830684;10437.895621043692;11963.282203067844;12227.26636401783;12810.55163069288;12884.935575322439;10671.733206669895;10998.74525722209;11019.530996793712;11224.989750922456;11251.887481125412;10850.348979061282;10881.183911206534;11067.446627668423;11146.442677866236;11245.100391968786;11181.720456988314;11223;11263.605773797877;11287.548498059985;11464.821683880036;7793.532388056735;7819.530828150329;7904;8025.959870200845;8119.066307374491;8165.469244499089;10359.844602331123;11044.613438529614;11274.436278186222;11363.261388009752 00:08:16 INFO - PROCESS | 1666 | |3;mootools.html;1337.2949489401005;1481.7184734900372;1537.054711352518;1726.5769886377839;1900.3728769506065;7653.272939070786;8445.831083378329;8774.64901403943;8806.38355315129;8850.77873053174;8637.654493820255;8733;8738;8741.125887411255;8753.343499237551;2371.7272513660932;2400.12395475651;2403.5913894637865;2411.119941221459;2411.5538625354366;2341.695579574653;2373.786359227669;2386.725526564441;2387;2391.1989483522952;2347.7065366829147;2377.2036367816804;2388.9283321500297;2391;2391.8325717199805;2326.988365058181;2352.5294941011693;2352.7059117610297;2354.6703461515485;2361.433256018543;2314.67594536765;2339.7426283108844;2340.953180936389;2344.80069194117;2345.3315804995664;8597.742067737978;8677.956610216908;8720.040795512488;8766.298696104297;8811.911880881173;5198.038362902875;5384.273123128367;5389.029974604569;5390.6226564140525;5392.73036348181;3400.9627063745547;3610.4764809102535;3660.3045421369857;3679.4848721179055;3681.1901381695984;1078.099786678117;1084.6637542361893;1086.8858769829133;1099.3674393525607;1111.5942680921487;11510.964013238765;11590.94204528972;11664.533418663243;11680.415979201007;11692.532298708042;4356.825726970949;4425.867223983286;4599.103174880933;4608.377868987711;4615.3999980003055;9120.543972801333;9137.81724365509;9143.588538515784;9148.63405463774;9150.679726209684;5203.687778733288;5209.47905209476;5213.322268105122;5215.087359712111;5215.269862219292;4165.625093741517;4303.385156468581;4339.674524410681;4492.9550704493195;4886.267059940967;3731.9626803731617;3773.415120656303;3829.5021647185686;3864.652181303696;3871.903202419962;1125.2629527659396;1130.0789856267115;1154.18629865946;1162.151629310591;1171.3967306836985;844.5566077809076;845.3617518773286;869.9434536755091;904.7378906425499;905.9954700226589;4290.528041915387;4337.50118736343;5771.88456230873;5840.88318233633;6020.157177995085;794.586814856283;853.8719192121107;880.335346813152;893.5978809535735;923.6074668266094;3741.6258374162367;3759.473673685686;3762.680172185395;3821.560520540118;3863.806809659562;10356.792864142675;10712.678619641423;10779.245452818384;10780.730481738019;10784.975427334391;10750.462476876124;10752.516136773864;10753.247272690836;10766.246362754531;10768.892311076946;8066.798330041796;8160.6327715252955;8176.223258790405;8176.345892328481;8183.79540511492;5349.812756553502;5425.936513460408;5451.264079349237;5668.858278543069;5730.283714535683;9704.85442718374;10001.049900259464;10019.699409017741;10165.491725413553;10177.847332289874;9225.261979041794;9656.71029869077;9965.501724913871;10186.490675466346;10290;6209.627422354673;6750.898736518858;7459.067616547932;7584.810379740551;7601.315881570686;8187.672493100209;8189.877151842608;8209.507429554245;8298.626561804613;8298.917010830057;7421.703131874665;7438.6652600632015;7484.663190156347;7503;7521.285477879593;7312.049433573601;7361.631918404166;7404.222556631476;7486.101667799899;7503.5497870127965;6808.421284190701;6830.112085428863;6901.1718593769065;6914;6917.342852429011;4802.687825291345;4815.518448155157;4840.88659608285;4895.241237608177;4924.433690125538;3955.6044395560216;4866.124097662313;4887.706737595756;4991.575716064175;5062.746862656779 00:08:16 INFO - PROCESS | 1666 | |4;prototype.html;299.31307648945665;305.43494535110045;307.1308197800227;313.8540578630936;318.15688425671965;5074.467180945998;5410.729463526823;5485.396606373296;5497.532709719673;5504.119340905456;4049.878503644888;4054.6756259499243;5174.379074511055;5265.236540701596;5311.787528498855;3413.43678293082;4091.5499295077516;4113.4858142732155;4117.3206420940505;4147.854825081123;4082.7958602069925;4091.8772436826944;4106.1992911382295;4131.194417088669;4144.880882161815;3383.2387712764553;3523.8061906595126;3951.6245956634075;3965.8611948581806;4006.2588421142036;3857.691384689218;3866.8839934802;4024.1750441159493;4026.7986600669997;4066.268071747099;3504.5093686883856;3508.333416650828;3510.490978808084;3519.3107308491813;3551.5971191379517;5170.431252562215;5171.870703232412;5173.456787037345;5214.348206474191;5239.21411788231;4234.534201237861;4494.550544945512;4527.569880861313;4542.182407166709;4556.840510582114;4554.63562914966;4817.975910120462;5530.944690553083;5543.392416199297;5599.468050535193;3787.5644300905196;3789.8863034108745;3800.106974860933;3811.599782022903;3835.117922877726;5458.372287186985;5801.82594522165;5847.532197424196;5867.559933005042;5934.080217566284;3229.838508074587;3797.9240415191543;3810.7141964352786;3871.664275824836;3885.6685988407294;3444.9827750861587;3854;3926.5484469285825;3941.7832019239218;3952.8616498422416;4479.776011199427;4535.705179163344;4587.38070360497;4676.789544470507;4690.390249267573;4964.304997300381;5530.391656917735;5577;5594.384617692051;5602.243697100921;1147.649966760146;1306.9934650326688;1331.933403329849;1335.5392389625563;1338.5276196184313;757.814335487798;831.4720152703077;860.5912191708888;864.8486514859875;901;4565.288016993627;5115.693058416507;5131.640785145079;5154.731917956162;5178.8964220716125;4784.177335372077;5081.8475445736685;5708.743106560131;5767.826965191051;5799.449052340021;4100.692448066347;4217.34631132175;4626.629869610423;4832.8791780205775;5165.896682066337;2964.7399855061512;2976.4195981783346;2985.8656360463833;2992.1747733882316;2993.536001919706;5530.917036244459;5858.5898987070495;5869.911951320733;5883.323417807007;5885.705144868208;4627.537246275346;4776.567029891019;5650.491455769001;5656.462636049569;5710.00224881932;4856.037816931739;5036.370453693288;5218.112920803473;5795.797147099831;5890.587658863838;4594.701344412602;5127.743612819419;5568.49883510486;5641.971790141023;5648.700798816213;4615.630749540096;4835.564799168092;5315.309009828852;5542.503524048565;5559.8888022240135;5327.3074500314715;5801.3908539602735;5809.833640665932;5874.794382196603;5893.292804863444;3529.488224207527;3738.7569807962395;3752.831122599544;3829.157585331223;3927.7643341399607;5427.674339539641;5655.406182350958;5665.745041473061;5667.489925906688;5684.431556844283;5051.888584511402;5216.217567364925;5508.834734957958;5596.244506991504;5610.663360198401;5044.520770526794;5211.296474975981;5262.684238945675;5578.5454400063845;5611.446791709844;4430.82276708928;5220.927676412404;5511.751971161388;5527.806526771705;5530.944690553043;4556.20266453376;4984.42679091909;5516.386766667839;5521.907731670278;5565.666060036411;4378.693491455568;5537.612367134423;5546.306711661043;5553.333599967868;5594.832155035356 00:08:16 INFO - PROCESS | 1666 | |5;yui.html;699.3496048674732;737.4690223039413;756.5536333563197;803.6704950970103;809.9230573095554;15041.097534147944;15922.203889805493;15934;15951.601209969756;15956.36174553018;14253.07355021923;14432;14470.493532726357;14471.92764036181;14472.276386180674;670.7887015590073;685.3386482044825;839.5676226743232;848.8641817309232;862.4221771413169;737.7712908998201;826.962786674601;837.3970741066453;840.4285086141422;841.0538144587339;895.8880139982502;898.8651702244683;900.954952252388;902.3052249767675;903.7785742493065;697.7836870570139;721.1598487761752;721.3760097515664;894.5661354243186;895.3508706187994;542.2625229687621;664.5813137723203;673.5016088094824;682.1575354437266;684.8390628202368;14465.987380883342;14478.638034049127;14489.275536223147;14501.709965800625;14510.709785804225;13434.798478022838;13608.65978350549;13868.306584670827;13882.722345553033;14025.5091071812;11306.886931130748;11520.135989800798;11800.350980696057;12157.331346775924;12789.872101279054;4543.863684089482;4545.749983750892;4601.309803529464;4716.198246298138;4755;110669.89330106677;111735.88264117336;111760.88239117587;112320.4383978083;112930.43534782356;10567.577296908037;10615.256932014685;10729.409882456539;10735.731606709738;10803.13574914005;20411.4897127573;20415.693764593543;20448.591028179355;20464.59070818605;20478.795212047688;7501.062367204099;7578.393728501706;7634.580098094547;7874.645640946172;7886.921130788619;4181.184668989578;4238.321868501025;4263;4266.210751011073;4281.593248641374;3427.7943323400177;3566.7503274770515;3568.1258091767163;3570.321638888603;3578.1054736315923;643.832603523078;651.26407159909;659.6306068601599;668.1848145262869;670.0485310858593;513.9203423469369;544.8474427160402;574.844791906183;621.4655396359127;646.6249575246346;9253.861192082124;10033.77230670843;10179.083882450615;10256.846147307797;10510.474476276155;667.9379786139964;671.6708812681849;678.2437582096026;694.7672529702505;699.9815268783907;4084.4281800547947;4560.429946256718;4631.328457373729;4645.326427667969;4692.155412025868;136015.31992339974;144103;144457;151286.48713512943;152281;111358;125015.99936002458;132258.11289814432;134672.32663836813;137102.31448842693;96404;111633;115054.4247278775;115089;116668.41665791787;9094.681686140953;9111.681091161778;9118.22495087925;9246.861297080684;9294.390136241856;61570.69214653898;61803.07295390662;62597;62669;63177.36822631715;87974.56012719896;95688.52155739177;96238.03761962571;98023.52964705678;98923.62378326585;11421.37182454973;11690.70773230676;11959.701007474883;12119.576084783255;12440.066994975232;11700.70748231301;12924.353782311035;12985.610431687064;13337.799933000819;13736.587902362946;12160.148789584999;12171.75656486883;12423;12464.5014199431;12705;12032.338221397908;12032.879671203526;12280.447379867748;12300.630981070582;12437.431828708906;12040.939795300967;12130.878691213327;12143.33211673331;12252.87747122553;12554.661448453198;10174.338667986853;10376.533056012648;10484.947575262075;10573.9471302643;10964.671059868217;8945.172973648057;9964.302498825013;10238.33450825694;10496.842547361643;10590.258681892194 00:08:16 INFO - PROCESS | 1666 | __end_tp_report 00:08:16 INFO - PROCESS | 1666 | __start_cc_report 00:08:16 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1741 00:08:16 INFO - PROCESS | 1666 | __end_cc_report 00:08:16 INFO - PROCESS | 1666 | __startTimestamp1473404896133__endTimestamp 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | ------- Summary: start ------- 00:08:16 INFO - PROCESS | 1666 | Number of tests: 6 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5730.27 Median:5983.55 stddev:646.89 (10.8%) stddev-sans-first:619.94 00:08:16 INFO - PROCESS | 1666 | Values: 3291.6 3300.6 3349.7 3358.6 3406.3 5562.2 5680.9 5687.9 5755.4 5757.8 5683.0 5710.5 5758.1 5784.1 5811.3 5146.5 5146.5 5226.6 5260.2 5357.7 5308.7 5361.5 5380.7 5385.7 5401.0 5166.5 5207.2 5218.7 5275.4 5283.2 4272.0 5223.1 5239.8 5242.7 5352.7 5217.4 5221.2 5238.1 5253.6 5263.6 5568.4 5623.5 5693.9 5703.5 5727.3 6161.1 6218.8 6219.5 6236.4 6251.4 6202.3 6266.7 6269.8 6296.0 6305.6 5592.0 5731.2 5771.8 5773.5 5785.2 6257.1 6259.1 6263.7 6272.1 6281.5 6148.0 6160.9 6166.1 6175.8 6176.8 6139.5 6164.6 6213.6 6222.5 6275.7 6178.2 6222.9 6228.2 6239.5 6243.6 6220.3 6236.0 6266.0 6276.2 6296.0 4856.3 4887.6 4895.9 4939.8 4993.3 4319.3 4381.1 4423.6 4452.6 4479.1 5609.6 5610.9 5619.9 5622.0 5661.3 6204.3 6211.1 6211.4 6213.6 6213.6 5537.4 5599.1 5635.3 5641.9 5665.3 4604.7 5396.0 5400.6 5414.1 5465.9 6261.0 6268.2 6269.1 6281.4 6282.6 6111.5 6189.4 6209.9 6249.4 6258.7 5359.8 6279.7 6310.6 6315.6 6323.5 6161.1 6172.3 6221.1 6222.7 6223.8 6019.5 6114.6 6140.8 6258.4 6295.7 6090.8 6092.2 6096.9 6097.6 6100.2 6034.9 6078.8 6114.2 6127.5 6135.8 5935.2 5983.6 5996.4 5998.3 6027.9 5906.4 6123.9 6135.6 6138.8 6144.5 5851.0 5900.1 5929.2 5968.9 5988.5 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:69830.76 Median:38446.98 stddev:160415.91 (417.2%) stddev-sans-first:160781.44 00:08:16 INFO - PROCESS | 1666 | Values: 493.9 501.1 512.9 532.2 556.2 30354.7 30829.9 31669.0 40742.6 40959.8 42356.6 42716.8 42743.0 42763.8 42787.6 9559.5 9725.9 9749.1 9755.8 9762.5 9602.3 9731.8 9733.5 9740.2 9747.8 8336.5 9683.9 9717.8 9751.2 9778.6 8245.8 9728.0 9741.6 9748.9 9752.4 9614.8 9664.3 9677.2 9679.3 9708.5 39683.6 40062.2 40119.0 40136.4 40160.2 3140.2 3256.9 3384.5 3664.7 3884.1 30504.1 31023.2 31254.7 31738.2 31781.4 3215.1 3231.5 3276.4 3302.8 3372.0 495477.0 498503.0 498767.0 498899.5 499135.0 32633.5 33486.8 33515.5 55496.0 55993.4 34754.5 34843.5 34853.5 34869.0 34925.1 14565.7 14706.6 14719.4 14724.0 14728.9 12403.9 12473.9 12518.2 12518.9 12529.8 7574.1 7594.4 7667.7 7678.0 7680.4 3186.4 3242.6 3249.8 3251.3 3272.7 876.5 908.5 1009.9 1043.8 1047.5 28591.7 29872.4 30107.5 30443.9 30734.5 821.4 1009.4 1086.3 1122.9 1167.9 15488.8 15734.5 16311.8 16622.9 17003.2 704533.0 713301.0 717343.0 719190.0 719258.0 53831.0 54143.6 54149.2 54275.2 54276.6 1211.8 1252.7 1334.9 1357.8 1388.7 28347.3 29798.6 30631.4 30699.0 30971.7 47388.8 48012.0 48082.3 48099.8 48125.8 555063.0 556918.0 559260.0 560571.0 561525.0 24690.4 25027.0 25178.0 25816.1 25900.2 44675.6 44745.1 45359.8 45995.5 46325.0 36578.6 36772.6 37883.0 38043.6 39213.4 37843.1 38208.0 38514.5 38639.2 39493.8 33774.8 38297.6 38379.4 38685.6 38910.4 27477.9 31632.5 32331.5 32961.7 33750.3 24415.0 24909.6 25008.7 25788.9 25877.8 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:32515.28 Median:20892.63 stddev:89443.87 (428.1%) stddev-sans-first:89662.22 00:08:16 INFO - PROCESS | 1666 | Values: 371.1 373.2 383.6 391.4 404.7 15105.8 15118.0 18569.1 20471.3 20758.6 17651.5 20038.5 20173.1 20486.0 20733.9 5668.1 5971.4 5987.3 6017.2 6047.5 5656.6 5961.9 6053.5 6065.2 6072.3 5910.3 5996.9 6005.7 6006.9 6019.9 5823.8 5993.5 6043.6 6124.0 6186.2 5999.7 6002.2 6011.8 6013.5 6016.5 12203.5 12532.2 12795.7 13063.5 13104.0 1809.9 2046.3 2056.1 2119.5 2143.0 9823.9 10103.8 10328.7 12562.9 12856.2 1645.3 1754.7 1842.1 1896.7 1930.2 112981.0 115359.7 122469.0 124190.4 126123.7 11105.9 11194.9 11289.0 11322.7 11775.7 12056.5 14003.0 14015.7 14029.7 14056.9 7212.9 7312.6 7584.8 8199.2 8506.2 6696.6 6976.6 8380.5 8423.2 8588.9 3116.2 4170.4 4223.7 4376.1 4378.2 1831.6 1876.0 1881.5 1887.4 1891.6 803.3 853.7 919.3 921.1 999.6 20256.4 20776.6 20822.6 20962.7 21027.8 869.8 877.2 879.0 937.5 976.4 8069.4 10177.6 10456.4 10897.5 11168.1 509726.0 510250.0 517319.0 557664.0 562343.0 115624.4 116813.0 116867.4 118888.2 134873.0 953.7 994.5 1007.6 1008.0 1020.4 18437.8 18688.3 19536.4 19586.2 19620.2 41387.0 46756.4 55128.4 56773.6 57077.4 78228.4 78660.4 79962.1 81207.6 81444.0 7498.9 7806.9 7975.9 8069.9 8136.9 10437.9 11963.3 12227.3 12810.6 12884.9 10671.7 10998.7 11019.5 11225.0 11251.9 10850.3 10881.2 11067.4 11146.4 11245.1 11181.7 11223.0 11263.6 11287.5 11464.8 7793.5 7819.5 7904.0 8026.0 8119.1 8165.5 10359.8 11044.6 11274.4 11363.3 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5606.72 Median:4853.51 stddev:3172.84 (65.4%) stddev-sans-first:3165.52 00:08:16 INFO - PROCESS | 1666 | Values: 1337.3 1481.7 1537.1 1726.6 1900.4 7653.3 8445.8 8774.6 8806.4 8850.8 8637.7 8733.0 8738.0 8741.1 8753.3 2371.7 2400.1 2403.6 2411.1 2411.6 2341.7 2373.8 2386.7 2387.0 2391.2 2347.7 2377.2 2388.9 2391.0 2391.8 2327.0 2352.5 2352.7 2354.7 2361.4 2314.7 2339.7 2341.0 2344.8 2345.3 8597.7 8678.0 8720.0 8766.3 8811.9 5198.0 5384.3 5389.0 5390.6 5392.7 3401.0 3610.5 3660.3 3679.5 3681.2 1078.1 1084.7 1086.9 1099.4 1111.6 11511.0 11590.9 11664.5 11680.4 11692.5 4356.8 4425.9 4599.1 4608.4 4615.4 9120.5 9137.8 9143.6 9148.6 9150.7 5203.7 5209.5 5213.3 5215.1 5215.3 4165.6 4303.4 4339.7 4493.0 4886.3 3732.0 3773.4 3829.5 3864.7 3871.9 1125.3 1130.1 1154.2 1162.2 1171.4 844.6 845.4 869.9 904.7 906.0 4290.5 4337.5 5771.9 5840.9 6020.2 794.6 853.9 880.3 893.6 923.6 3741.6 3759.5 3762.7 3821.6 3863.8 10356.8 10712.7 10779.2 10780.7 10785.0 10750.5 10752.5 10753.2 10766.2 10768.9 8066.8 8160.6 8176.2 8176.3 8183.8 5349.8 5425.9 5451.3 5668.9 5730.3 9704.9 10001.0 10019.7 10165.5 10177.8 9225.3 9656.7 9965.5 10186.5 10290.0 6209.6 6750.9 7459.1 7584.8 7601.3 8187.7 8189.9 8209.5 8298.6 8298.9 7421.7 7438.7 7484.7 7503.0 7521.3 7312.0 7361.6 7404.2 7486.1 7503.5 6808.4 6830.1 6901.2 6914.0 6917.3 4802.7 4815.5 4840.9 4895.2 4924.4 3955.6 4866.1 4887.7 4991.6 5062.7 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4461.73 Median:5010.40 stddev:1361.77 (27.2%) stddev-sans-first:1329.27 00:08:16 INFO - PROCESS | 1666 | Values: 299.3 305.4 307.1 313.9 318.2 5074.5 5410.7 5485.4 5497.5 5504.1 4049.9 4054.7 5174.4 5265.2 5311.8 3413.4 4091.5 4113.5 4117.3 4147.9 4082.8 4091.9 4106.2 4131.2 4144.9 3383.2 3523.8 3951.6 3965.9 4006.3 3857.7 3866.9 4024.2 4026.8 4066.3 3504.5 3508.3 3510.5 3519.3 3551.6 5170.4 5171.9 5173.5 5214.3 5239.2 4234.5 4494.6 4527.6 4542.2 4556.8 4554.6 4818.0 5530.9 5543.4 5599.5 3787.6 3789.9 3800.1 3811.6 3835.1 5458.4 5801.8 5847.5 5867.6 5934.1 3229.8 3797.9 3810.7 3871.7 3885.7 3445.0 3854.0 3926.5 3941.8 3952.9 4479.8 4535.7 4587.4 4676.8 4690.4 4964.3 5530.4 5577.0 5594.4 5602.2 1147.6 1307.0 1331.9 1335.5 1338.5 757.8 831.5 860.6 864.8 901.0 4565.3 5115.7 5131.6 5154.7 5178.9 4784.2 5081.8 5708.7 5767.8 5799.4 4100.7 4217.3 4626.6 4832.9 5165.9 2964.7 2976.4 2985.9 2992.2 2993.5 5530.9 5858.6 5869.9 5883.3 5885.7 4627.5 4776.6 5650.5 5656.5 5710.0 4856.0 5036.4 5218.1 5795.8 5890.6 4594.7 5127.7 5568.5 5642.0 5648.7 4615.6 4835.6 5315.3 5542.5 5559.9 5327.3 5801.4 5809.8 5874.8 5893.3 3529.5 3738.8 3752.8 3829.2 3927.8 5427.7 5655.4 5665.7 5667.5 5684.4 5051.9 5216.2 5508.8 5596.2 5610.7 5044.5 5211.3 5262.7 5578.5 5611.4 4430.8 5220.9 5511.8 5527.8 5530.9 4556.2 4984.4 5516.4 5521.9 5565.7 4378.7 5537.6 5546.3 5553.3 5594.8 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:24680.73 Median:11953.29 stddev:39733.56 (332.4%) stddev-sans-first:39804.22 00:08:16 INFO - PROCESS | 1666 | Values: 699.3 737.5 756.6 803.7 809.9 15041.1 15922.2 15934.0 15951.6 15956.4 14253.1 14432.0 14470.5 14471.9 14472.3 670.8 685.3 839.6 848.9 862.4 737.8 827.0 837.4 840.4 841.1 895.9 898.9 901.0 902.3 903.8 697.8 721.2 721.4 894.6 895.4 542.3 664.6 673.5 682.2 684.8 14466.0 14478.6 14489.3 14501.7 14510.7 13434.8 13608.7 13868.3 13882.7 14025.5 11306.9 11520.1 11800.4 12157.3 12789.9 4543.9 4545.7 4601.3 4716.2 4755.0 110669.9 111735.9 111760.9 112320.4 112930.4 10567.6 10615.3 10729.4 10735.7 10803.1 20411.5 20415.7 20448.6 20464.6 20478.8 7501.1 7578.4 7634.6 7874.6 7886.9 4181.2 4238.3 4263.0 4266.2 4281.6 3427.8 3566.8 3568.1 3570.3 3578.1 643.8 651.3 659.6 668.2 670.0 513.9 544.8 574.8 621.5 646.6 9253.9 10033.8 10179.1 10256.8 10510.5 667.9 671.7 678.2 694.8 700.0 4084.4 4560.4 4631.3 4645.3 4692.2 136015.3 144103.0 144457.0 151286.5 152281.0 111358.0 125016.0 132258.1 134672.3 137102.3 96404.0 111633.0 115054.4 115089.0 116668.4 9094.7 9111.7 9118.2 9246.9 9294.4 61570.7 61803.1 62597.0 62669.0 63177.4 87974.6 95688.5 96238.0 98023.5 98923.6 11421.4 11690.7 11959.7 12119.6 12440.1 11700.7 12924.4 12985.6 13337.8 13736.6 12160.1 12171.8 12423.0 12464.5 12705.0 12032.3 12032.9 12280.4 12300.6 12437.4 12040.9 12130.9 12143.3 12252.9 12554.7 10174.3 10376.5 10484.9 10573.9 10964.7 8945.2 9964.3 10238.3 10496.8 10590.3 00:08:16 INFO - PROCESS | 1666 | -------- Summary: end -------- 00:08:16 INFO - PROCESS | 1666 | 00:08:16 INFO - TEST-INFO | 1666: exit 0 00:08:16 INFO - TEST-OK | dromaeo_css | took 1117579ms 00:08:16 INFO - TEST-START | kraken 00:08:16 INFO - operating with platform_type : mac_ 00:08:16 INFO - Initialising browser for kraken test... 00:08:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpL6QQHw/profile http://localhost:49271/getInfo.html) 00:08:18 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 00:08:18 INFO - PROCESS | 1673 | colorDepth:24 00:08:18 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 00:08:18 INFO - PROCESS | 1673 | __metrics 00:08:18 INFO - PROCESS | 1673 | 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" 00:08:18 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:08:19 INFO - TEST-INFO | 1673: exit 0 00:08:19 INFO - Browser initialized. 00:08:19 INFO - Running cycle 1/1 for kraken test... 00:08:19 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpL6QQHw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:08:31 INFO - PROCESS | 1674 | RSS: Main: 252862464 00:08:31 INFO - PROCESS | 1674 | 00:08:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 00:08:35 INFO - PROCESS | 1674 | RSS: Main: 309583872 00:08:35 INFO - PROCESS | 1674 | 00:08:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 00:08:38 INFO - PROCESS | 1674 | RSS: Main: 305876992 00:08:38 INFO - PROCESS | 1674 | 00:08:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 00:08:42 INFO - PROCESS | 1674 | RSS: Main: 390057984 00:08:42 INFO - PROCESS | 1674 | 00:08:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 00:08:44 INFO - PROCESS | 1674 | RSS: Main: 292724736 00:08:44 INFO - PROCESS | 1674 | 00:08:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:08:47 INFO - PROCESS | 1674 | RSS: Main: 296628224 00:08:47 INFO - PROCESS | 1674 | 00:08:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 00:08:50 INFO - PROCESS | 1674 | RSS: Main: 335253504 00:08:50 INFO - PROCESS | 1674 | 00:08:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 00:08:54 INFO - PROCESS | 1674 | RSS: Main: 335872000 00:08:54 INFO - PROCESS | 1674 | 00:08:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 00:08:57 INFO - PROCESS | 1674 | RSS: Main: 335839232 00:08:57 INFO - PROCESS | 1674 | 00:08:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:09:00 INFO - PROCESS | 1674 | RSS: Main: 310644736 00:09:00 INFO - PROCESS | 1674 | 00:09:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:09:02 INFO - PROCESS | 1674 | RSS: Main: 315244544 00:09:02 INFO - PROCESS | 1674 | 00:09:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:09:05 INFO - PROCESS | 1674 | RSS: Main: 311701504 00:09:05 INFO - PROCESS | 1674 | 00:09:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:09:09 INFO - PROCESS | 1674 | RSS: Main: 332414976 00:09:09 INFO - PROCESS | 1674 | 00:09:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:09:12 INFO - PROCESS | 1674 | RSS: Main: 328634368 00:09:12 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 00:09:14 INFO - PROCESS | 1674 | RSS: Main: 371744768 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | __start_tp_report 00:09:14 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 00:09:14 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 00:09:14 INFO - PROCESS | 1674 | |i|pagename|runs| 00:09:14 INFO - PROCESS | 1674 | |0;ai-astar;114;112;117;114;112;112;114;112;112;123 00:09:14 INFO - PROCESS | 1674 | |1;audio-beat-detection;146;114;130;170;136;145;129;109;159;107 00:09:14 INFO - PROCESS | 1674 | |2;audio-dft;184;183;182;181;182;180;181;182;179;178 00:09:14 INFO - PROCESS | 1674 | |3;audio-fft;71;82;75;155;57;57;57;64;139;55 00:09:14 INFO - PROCESS | 1674 | |4;audio-oscillator;82;82;130;71;81;78;117;70;69;118 00:09:14 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;83;86;83;86;84;86;83;86;84 00:09:14 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;91;92;92;92;96;92;92;93;92 00:09:14 INFO - PROCESS | 1674 | |7;imaging-desaturate;86;85;86;86;84;84;84;96;144;83 00:09:14 INFO - PROCESS | 1674 | |8;json-parse-financial;55;52;51;52;53;55;52;54;53;52 00:09:14 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;65;65;69;75;77;72;68;67;68;68 00:09:14 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;88;99;104;106;79;84;84;85;83;85 00:09:14 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;139;138;138;139;137;138;156;152;187;139 00:09:14 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;167;167;167;166;166;164;167;167;165;168 00:09:14 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;68;67;70;73;86;86;86;73;66 00:09:14 INFO - PROCESS | 1674 | __end_tp_report 00:09:14 INFO - PROCESS | 1674 | __start_cc_report 00:09:14 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1970 00:09:14 INFO - PROCESS | 1674 | __end_cc_report 00:09:14 INFO - PROCESS | 1674 | __startTimestamp1473404954582__endTimestamp 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | ------- Summary: start ------- 00:09:14 INFO - PROCESS | 1674 | Number of tests: 14 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:3.49 (3.1%) stddev-sans-first:3.70 00:09:14 INFO - PROCESS | 1674 | Values: 114.0 112.0 117.0 114.0 112.0 112.0 114.0 112.0 112.0 123.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:140.50 stddev:21.04 (15.0%) stddev-sans-first:21.90 00:09:14 INFO - PROCESS | 1674 | Values: 146.0 114.0 130.0 170.0 136.0 145.0 129.0 109.0 159.0 107.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:181.20 Median:182.00 stddev:1.81 (1.0%) stddev-sans-first:1.62 00:09:14 INFO - PROCESS | 1674 | Values: 184.0 183.0 182.0 181.0 182.0 180.0 181.0 182.0 179.0 178.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:81.20 Median:60.50 stddev:36.01 (59.5%) stddev-sans-first:38.00 00:09:14 INFO - PROCESS | 1674 | Values: 71.0 82.0 75.0 155.0 57.0 57.0 57.0 64.0 139.0 55.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:74.50 stddev:22.77 (30.6%) stddev-sans-first:23.98 00:09:14 INFO - PROCESS | 1674 | Values: 82.0 82.0 130.0 71.0 81.0 78.0 117.0 70.0 69.0 118.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.42 00:09:14 INFO - PROCESS | 1674 | Values: 87.0 83.0 86.0 83.0 86.0 84.0 86.0 83.0 86.0 84.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:92.00 stddev:1.35 (1.5%) stddev-sans-first:1.42 00:09:14 INFO - PROCESS | 1674 | Values: 93.0 91.0 92.0 92.0 92.0 96.0 92.0 92.0 93.0 92.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:85.50 stddev:18.71 (21.9%) stddev-sans-first:19.72 00:09:14 INFO - PROCESS | 1674 | Values: 86.0 85.0 86.0 86.0 84.0 84.0 84.0 96.0 144.0 83.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.37 (2.6%) stddev-sans-first:1.22 00:09:14 INFO - PROCESS | 1674 | Values: 55.0 52.0 51.0 52.0 53.0 55.0 52.0 54.0 53.0 52.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:68.50 stddev:4.03 (5.9%) stddev-sans-first:3.95 00:09:14 INFO - PROCESS | 1674 | Values: 65.0 65.0 69.0 75.0 77.0 72.0 68.0 67.0 68.0 68.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:84.50 stddev:9.59 (11.4%) stddev-sans-first:10.15 00:09:14 INFO - PROCESS | 1674 | Values: 88.0 99.0 104.0 106.0 79.0 84.0 84.0 85.0 83.0 85.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:139.00 stddev:15.76 (11.3%) stddev-sans-first:16.50 00:09:14 INFO - PROCESS | 1674 | Values: 139.0 138.0 138.0 139.0 137.0 138.0 156.0 152.0 187.0 139.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 00:09:14 INFO - PROCESS | 1674 | Values: 167.0 167.0 167.0 166.0 166.0 164.0 167.0 167.0 165.0 168.0 00:09:14 INFO - PROCESS | 1674 | 00:09:14 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:73.00 stddev:8.48 (11.6%) stddev-sans-first:8.59 00:09:14 INFO - PROCESS | 1674 | Values: 67.0 68.0 67.0 70.0 73.0 86.0 86.0 86.0 73.0 66.0 00:09:14 INFO - PROCESS | 1674 | -------- Summary: end -------- 00:09:14 INFO - PROCESS | 1674 | 00:09:15 INFO - TEST-INFO | 1674: exit 0 00:09:15 INFO - TEST-OK | kraken | took 58638ms 00:09:15 INFO - SUITE-END | took 1176s 00:09:15 INFO - Completed test suite (00:19:36) 00:09:15 INFO - javascript benchmark 00:09:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.621463531694, 3300.587426571678, 3349.715274201693, 3358.5633867597207, 3406.301708149828, 5562.221289019541, 5680.943190568093, 5687.8578035549135, 5755.366909639942, 5757.827265182046, 5683.005474042046, 5710.457506536873, 5758.078707406805, 5784.074548072309, 5811.331696854863, 5146.485351464861, 5146.485351464861, 5226.634135610509, 5260.210968354758, 5357.678539287635, 5308.654937429074, 5361.51746342829, 5380.677159370431, 5385.730713464331, 5401.0, 5166.535011848914, 5207.166853303491, 5218.660787048868, 5275.366955965309, 5283.154695248781, 4271.97864010681, 5223.112070947948, 5239.764210610493, 5242.685438873642, 5352.732363381815, 5217.373915130209, 5221.216817477371, 5238.083335416287, 5253.605979551511, 5263.578913686896, 5568.387477377485, 5623.465770751772, 5693.943060569382, 5703.458171473703, 5727.312722473288, 6161.137440758297, 6218.844528886769, 6219.502439804804, 6236.407541283571, 6251.437370636619, 6202.286737025254, 6266.655333956631, 6269.811905642838, 6296.024116261941, 6305.558610897239, 5592.049351610195, 5731.226284451545, 5771.826845194651, 5773.538116950634, 5785.247917770663, 6257.061440783918, 6259.061140828912, 6263.655498947602, 6272.059191121369, 6281.497480201573, 6148.047052706837, 6160.8767824643255, 6166.105914642441, 6175.814725558241, 6176.7838125665385, 6139.4781443577795, 6164.568480206342, 6213.565050446516, 6222.533310001678, 6275.717592708339, 6178.165947597106, 6222.875542489125, 6228.159198508234, 6239.500839932794, 6243.594166379171, 6220.315765265817, 6235.96882015587, 6266.0, 6276.152719382825, 6296.024116261987, 4856.295837103671, 4887.584555312838, 4895.926561101586, 4939.75301234944, 4993.300937868701, 4319.287317592562, 4381.101874115799, 4423.579759922803, 4452.577005184502, 4479.059397526491, 5609.551235901118, 5610.915836262459, 5619.887602247933, 5622.0, 5661.34894487131, 6204.286507051656, 6211.068339749074, 6211.440970312694, 6213.596116252519, 6213.627182369072, 5537.418571050062, 5599.132134519156, 5635.295588051494, 5641.887162256814, 5665.348484924287, 4604.700694454849, 5395.974764794676, 5400.594955378362, 5414.052540805344, 5465.890682186334, 6261.0, 6268.216472940882, 6269.059641053787, 6281.371862813682, 6282.623042617458, 6111.530965355488, 6189.442950134509, 6209.937900621117, 6249.406306400884, 6258.655773932477, 5359.812406565751, 6279.748810047547, 6310.6213627182515, 6315.55791094619, 6323.525735569759, 6161.106639537153, 6172.2979372501395, 6221.06683997404, 6222.719977600928, 6223.751049957951, 6019.488343490677, 6114.57197996136, 6140.815775526741, 6258.374162583706, 6295.653739044396, 6090.817275481742, 6092.238470191226, 6096.908546371897, 6097.603655762361, 6100.23747031621, 6034.939650603614, 6078.848028799315, 6114.205153330038, 6127.525510585499, 6135.845176233341, 5935.198748168942, 5983.55123365758, 5996.400359963969, 5998.25021872266, 6027.939720602738, 5906.438888305604, 6123.877522449615, 6135.631862088289, 6138.815835524942, 6144.508439324753, 5851.0, 5900.11498275245, 5929.199558059607, 5968.850778730566, 5988.461038506555], "value": 5688.389673505047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.9110960027195, 501.0755156735821, 512.9407772948862, 532.1565318969433, 556.2490637639185, 30354.696453035463, 30829.920952766657, 31669.0, 40742.59257407425, 40959.795201024026, 42356.57643423565, 42716.78641606795, 42743.0, 42763.78618106905, 42787.57212427875, 9559.474228917425, 9725.854112188323, 9749.07383798538, 9755.804883902318, 9762.463064531448, 9602.327837051409, 9731.805363892718, 9733.464659443727, 9740.220782337432, 9747.756306092333, 8336.541490218036, 9683.903160968406, 9717.805643887117, 9751.21990240779, 9778.608855645765, 8245.83508329833, 9728.027197280286, 9741.561629726679, 9748.90251097487, 9752.366096203725, 9614.75963100921, 9664.323497355188, 9677.177439917616, 9679.322447428684, 9708.466034368106, 39683.60316396828, 40062.198756025005, 40118.99702507431, 40136.39795403071, 40160.196796063916, 3140.2149462634343, 3256.934861302784, 3384.4754063120254, 3664.725145614063, 3884.1066554692297, 30504.08487745371, 31023.22441938947, 31254.687453125403, 31738.206544836332, 31781.364372712647, 3215.099772063826, 3231.5314279429585, 3276.3774882772436, 3302.8183449910243, 3371.9831400843086, 495477.0, 498503.0, 498767.0, 498899.5055024738, 499135.0, 32633.51049734256, 33486.832565837016, 33515.49726754101, 55496.0, 55993.440065599636, 34754.478682819776, 34843.477347839806, 34853.477197842054, 34869.0, 34925.1268718279, 14565.708685826436, 14706.55880323592, 14719.411223550938, 14724.0, 14728.926355368154, 12403.875961240452, 12473.93763031179, 12518.248905065726, 12518.937405312916, 12529.812052819216, 7574.091109066947, 7594.354479869163, 7667.693292268358, 7678.0, 7680.423968202407, 3186.394585028837, 3242.610886693612, 3249.8375081245845, 3251.3172233830687, 3272.7381809455187, 876.4960147914846, 908.4685459006423, 1009.9244304815348, 1043.8225501664735, 1047.4762618690654, 28591.714082859322, 29872.402551949275, 30107.548386774215, 30443.934462294157, 30734.53898191484, 821.4291067707885, 1009.4296722351847, 1086.2939089591828, 1122.854028976228, 1167.9357635329968, 15488.767668484756, 15734.527964161094, 16311.755323670155, 16622.919510231797, 17003.23485443158, 704533.0, 713301.0, 717343.0, 719190.0, 719258.0, 53831.0, 54143.6464088401, 54149.187762183596, 54275.18587221195, 54276.64308392322, 1211.8182272659171, 1252.7181384188666, 1334.93325333731, 1357.7895426208954, 1388.6597783543098, 28347.291317717223, 29798.553021704258, 30631.387372251986, 30699.044148843066, 30971.69028309778, 47388.7630561845, 48012.0, 48082.27876581784, 48099.75950120227, 48125.75937120292, 555063.0, 556918.0, 559260.0, 560571.0, 561525.0, 24690.382740430916, 25027.0, 25178.0, 25816.096436624626, 25900.22299331023, 44675.608002578796, 44745.10509789851, 45359.77320113379, 45995.540044599125, 46325.0, 36578.63421365859, 36772.63227367692, 37883.0, 38043.61956380401, 39213.41179882361, 37843.05392365213, 38208.0, 38514.53369196786, 38639.22721545609, 39493.80253098716, 33774.81788137403, 38297.61702382941, 38379.42430863595, 38685.6131438682, 38910.4163437543, 27477.862610686818, 31632.525512116878, 32331.51502727508, 32961.67038329586, 33750.324993500486, 24415.0, 24909.626355605043, 25008.749562522164, 25788.871055644602, 25877.835497402284], "value": 18339.32223086521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1445119000704, 373.190177315226, 383.61638361638364, 391.40506430226077, 404.70860980094324, 15105.848941510581, 15118.0, 18569.071546422674, 20471.283505077325, 20758.584828303425, 17651.470455886312, 20038.499037524034, 20173.09221085051, 20486.0, 20733.896330518364, 5668.093105103184, 5971.37300583439, 5987.28152621686, 6017.157597936271, 6047.455728984391, 5656.575756818234, 5961.850953726148, 6053.485453736438, 6065.150878876961, 6072.332043475214, 5910.320313163977, 5996.940030599703, 6005.729742161591, 6006.9399306007035, 6019.939800602004, 5823.82528524145, 5993.520518358521, 6043.576949613529, 6124.0, 6186.19579454668, 5999.730012149464, 6002.249718785152, 6011.849703757397, 6013.51891848651, 6016.518678505753, 12203.47456567929, 12532.185407948455, 12795.744085118245, 13063.542776002889, 13104.0, 1809.936652217166, 2046.334941144134, 2056.1466991198786, 2119.4807272218404, 2142.967855482169, 9823.90176098237, 10103.797924041479, 10328.741781455448, 12562.874371256263, 12856.228626282453, 1645.3089702324933, 1754.657841720865, 1842.0973722875694, 1896.706010568364, 1930.1603802346024, 112981.0, 115359.65521896293, 122469.0, 124190.37904810508, 126123.73876261212, 11105.944470277758, 11194.944025279985, 11289.0, 11322.716932076764, 11775.705607359712, 12056.51773929033, 14003.0, 14015.719685606231, 14029.719405611831, 14056.945729070156, 7212.891806622905, 7312.561246325237, 7584.772456826304, 8199.22107399796, 8506.234438900528, 6696.5647232929705, 6976.616286104313, 8380.455270407405, 8423.241908228289, 8588.914110858812, 3116.174213833336, 4170.416141740159, 4223.711767910817, 4376.124775045004, 4378.16814805186, 1831.587892724153, 1875.990620046891, 1881.5390229393886, 1887.3865993552151, 1891.6122194950278, 803.3292201012104, 853.6756032707656, 919.2560207779773, 921.0559176843789, 999.6051559633904, 20256.392308230483, 20776.58446831055, 20822.58354832895, 20962.685559716618, 21027.78972210289, 869.8434281829205, 877.1535468273147, 878.9912100879037, 937.5124935033881, 976.4190306767462, 8069.394795390369, 10177.592896284214, 10456.424896630606, 10897.455127243606, 11168.106551475863, 509726.0, 510250.0, 517319.0, 557664.0, 562343.0, 115624.42187789176, 116813.0, 116867.41566292114, 118888.21667674991, 134873.0, 953.7472569769017, 994.4729293474614, 1007.6271779441507, 1008.037324355239, 1020.4132623741378, 18437.80154289967, 18688.34590789316, 19536.413907582795, 19586.216551338355, 19620.215191392184, 41387.0, 46756.36352727638, 55128.44871551233, 56773.58066048382, 57077.42922570721, 78228.43543128992, 78660.426791465, 79962.10704758963, 81207.59396202982, 81444.0, 7498.887516687145, 7806.88289675644, 7975.880361794461, 8069.919300806917, 8136.877946830684, 10437.895621043692, 11963.282203067844, 12227.26636401783, 12810.55163069288, 12884.935575322439, 10671.733206669895, 10998.74525722209, 11019.530996793712, 11224.989750922456, 11251.887481125412, 10850.348979061282, 10881.183911206534, 11067.446627668423, 11146.442677866236, 11245.100391968786, 11181.720456988314, 11223.0, 11263.605773797877, 11287.548498059985, 11464.821683880036, 7793.532388056735, 7819.530828150329, 7904.0, 8025.959870200845, 8119.066307374491, 8165.469244499089, 10359.844602331123, 11044.613438529614, 11274.436278186222, 11363.261388009752], "value": 9173.195603539061, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.2949489401005, 1481.7184734900372, 1537.054711352518, 1726.5769886377839, 1900.3728769506065, 7653.272939070786, 8445.831083378329, 8774.64901403943, 8806.38355315129, 8850.77873053174, 8637.654493820255, 8733.0, 8738.0, 8741.125887411255, 8753.343499237551, 2371.7272513660932, 2400.12395475651, 2403.5913894637865, 2411.119941221459, 2411.5538625354366, 2341.695579574653, 2373.786359227669, 2386.725526564441, 2387.0, 2391.1989483522952, 2347.7065366829147, 2377.2036367816804, 2388.9283321500297, 2391.0, 2391.8325717199805, 2326.988365058181, 2352.5294941011693, 2352.7059117610297, 2354.6703461515485, 2361.433256018543, 2314.67594536765, 2339.7426283108844, 2340.953180936389, 2344.80069194117, 2345.3315804995664, 8597.742067737978, 8677.956610216908, 8720.040795512488, 8766.298696104297, 8811.911880881173, 5198.038362902875, 5384.273123128367, 5389.029974604569, 5390.6226564140525, 5392.73036348181, 3400.9627063745547, 3610.4764809102535, 3660.3045421369857, 3679.4848721179055, 3681.1901381695984, 1078.099786678117, 1084.6637542361893, 1086.8858769829133, 1099.3674393525607, 1111.5942680921487, 11510.964013238765, 11590.94204528972, 11664.533418663243, 11680.415979201007, 11692.532298708042, 4356.825726970949, 4425.867223983286, 4599.103174880933, 4608.377868987711, 4615.3999980003055, 9120.543972801333, 9137.81724365509, 9143.588538515784, 9148.63405463774, 9150.679726209684, 5203.687778733288, 5209.47905209476, 5213.322268105122, 5215.087359712111, 5215.269862219292, 4165.625093741517, 4303.385156468581, 4339.674524410681, 4492.9550704493195, 4886.267059940967, 3731.9626803731617, 3773.415120656303, 3829.5021647185686, 3864.652181303696, 3871.903202419962, 1125.2629527659396, 1130.0789856267115, 1154.18629865946, 1162.151629310591, 1171.3967306836985, 844.5566077809076, 845.3617518773286, 869.9434536755091, 904.7378906425499, 905.9954700226589, 4290.528041915387, 4337.50118736343, 5771.88456230873, 5840.88318233633, 6020.157177995085, 794.586814856283, 853.8719192121107, 880.335346813152, 893.5978809535735, 923.6074668266094, 3741.6258374162367, 3759.473673685686, 3762.680172185395, 3821.560520540118, 3863.806809659562, 10356.792864142675, 10712.678619641423, 10779.245452818384, 10780.730481738019, 10784.975427334391, 10750.462476876124, 10752.516136773864, 10753.247272690836, 10766.246362754531, 10768.892311076946, 8066.798330041796, 8160.6327715252955, 8176.223258790405, 8176.345892328481, 8183.79540511492, 5349.812756553502, 5425.936513460408, 5451.264079349237, 5668.858278543069, 5730.283714535683, 9704.85442718374, 10001.049900259464, 10019.699409017741, 10165.491725413553, 10177.847332289874, 9225.261979041794, 9656.71029869077, 9965.501724913871, 10186.490675466346, 10290.0, 6209.627422354673, 6750.898736518858, 7459.067616547932, 7584.810379740551, 7601.315881570686, 8187.672493100209, 8189.877151842608, 8209.507429554245, 8298.626561804613, 8298.917010830057, 7421.703131874665, 7438.6652600632015, 7484.663190156347, 7503.0, 7521.285477879593, 7312.049433573601, 7361.631918404166, 7404.222556631476, 7486.101667799899, 7503.5497870127965, 6808.421284190701, 6830.112085428863, 6901.1718593769065, 6914.0, 6917.342852429011, 4802.687825291345, 4815.518448155157, 4840.88659608285, 4895.241237608177, 4924.433690125538, 3955.6044395560216, 4866.124097662313, 4887.706737595756, 4991.575716064175, 5062.746862656779], "value": 4495.229936985207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.31307648945665, 305.43494535110045, 307.1308197800227, 313.8540578630936, 318.15688425671965, 5074.467180945998, 5410.729463526823, 5485.396606373296, 5497.532709719673, 5504.119340905456, 4049.878503644888, 4054.6756259499243, 5174.379074511055, 5265.236540701596, 5311.787528498855, 3413.43678293082, 4091.5499295077516, 4113.4858142732155, 4117.3206420940505, 4147.854825081123, 4082.7958602069925, 4091.8772436826944, 4106.1992911382295, 4131.194417088669, 4144.880882161815, 3383.2387712764553, 3523.8061906595126, 3951.6245956634075, 3965.8611948581806, 4006.2588421142036, 3857.691384689218, 3866.8839934802, 4024.1750441159493, 4026.7986600669997, 4066.268071747099, 3504.5093686883856, 3508.333416650828, 3510.490978808084, 3519.3107308491813, 3551.5971191379517, 5170.431252562215, 5171.870703232412, 5173.456787037345, 5214.348206474191, 5239.21411788231, 4234.534201237861, 4494.550544945512, 4527.569880861313, 4542.182407166709, 4556.840510582114, 4554.63562914966, 4817.975910120462, 5530.944690553083, 5543.392416199297, 5599.468050535193, 3787.5644300905196, 3789.8863034108745, 3800.106974860933, 3811.599782022903, 3835.117922877726, 5458.372287186985, 5801.82594522165, 5847.532197424196, 5867.559933005042, 5934.080217566284, 3229.838508074587, 3797.9240415191543, 3810.7141964352786, 3871.664275824836, 3885.6685988407294, 3444.9827750861587, 3854.0, 3926.5484469285825, 3941.7832019239218, 3952.8616498422416, 4479.776011199427, 4535.705179163344, 4587.38070360497, 4676.789544470507, 4690.390249267573, 4964.304997300381, 5530.391656917735, 5577.0, 5594.384617692051, 5602.243697100921, 1147.649966760146, 1306.9934650326688, 1331.933403329849, 1335.5392389625563, 1338.5276196184313, 757.814335487798, 831.4720152703077, 860.5912191708888, 864.8486514859875, 901.0, 4565.288016993627, 5115.693058416507, 5131.640785145079, 5154.731917956162, 5178.8964220716125, 4784.177335372077, 5081.8475445736685, 5708.743106560131, 5767.826965191051, 5799.449052340021, 4100.692448066347, 4217.34631132175, 4626.629869610423, 4832.8791780205775, 5165.896682066337, 2964.7399855061512, 2976.4195981783346, 2985.8656360463833, 2992.1747733882316, 2993.536001919706, 5530.917036244459, 5858.5898987070495, 5869.911951320733, 5883.323417807007, 5885.705144868208, 4627.537246275346, 4776.567029891019, 5650.491455769001, 5656.462636049569, 5710.00224881932, 4856.037816931739, 5036.370453693288, 5218.112920803473, 5795.797147099831, 5890.587658863838, 4594.701344412602, 5127.743612819419, 5568.49883510486, 5641.971790141023, 5648.700798816213, 4615.630749540096, 4835.564799168092, 5315.309009828852, 5542.503524048565, 5559.8888022240135, 5327.3074500314715, 5801.3908539602735, 5809.833640665932, 5874.794382196603, 5893.292804863444, 3529.488224207527, 3738.7569807962395, 3752.831122599544, 3829.157585331223, 3927.7643341399607, 5427.674339539641, 5655.406182350958, 5665.745041473061, 5667.489925906688, 5684.431556844283, 5051.888584511402, 5216.217567364925, 5508.834734957958, 5596.244506991504, 5610.663360198401, 5044.520770526794, 5211.296474975981, 5262.684238945675, 5578.5454400063845, 5611.446791709844, 4430.82276708928, 5220.927676412404, 5511.751971161388, 5527.806526771705, 5530.944690553043, 4556.20266453376, 4984.42679091909, 5516.386766667839, 5521.907731670278, 5565.666060036411, 4378.693491455568, 5537.612367134423, 5546.306711661043, 5553.333599967868, 5594.832155035356], "value": 4028.5925105610518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3496048674732, 737.4690223039413, 756.5536333563197, 803.6704950970103, 809.9230573095554, 15041.097534147944, 15922.203889805493, 15934.0, 15951.601209969756, 15956.36174553018, 14253.07355021923, 14432.0, 14470.493532726357, 14471.92764036181, 14472.276386180674, 670.7887015590073, 685.3386482044825, 839.5676226743232, 848.8641817309232, 862.4221771413169, 737.7712908998201, 826.962786674601, 837.3970741066453, 840.4285086141422, 841.0538144587339, 895.8880139982502, 898.8651702244683, 900.954952252388, 902.3052249767675, 903.7785742493065, 697.7836870570139, 721.1598487761752, 721.3760097515664, 894.5661354243186, 895.3508706187994, 542.2625229687621, 664.5813137723203, 673.5016088094824, 682.1575354437266, 684.8390628202368, 14465.987380883342, 14478.638034049127, 14489.275536223147, 14501.709965800625, 14510.709785804225, 13434.798478022838, 13608.65978350549, 13868.306584670827, 13882.722345553033, 14025.5091071812, 11306.886931130748, 11520.135989800798, 11800.350980696057, 12157.331346775924, 12789.872101279054, 4543.863684089482, 4545.749983750892, 4601.309803529464, 4716.198246298138, 4755.0, 110669.89330106677, 111735.88264117336, 111760.88239117587, 112320.4383978083, 112930.43534782356, 10567.577296908037, 10615.256932014685, 10729.409882456539, 10735.731606709738, 10803.13574914005, 20411.4897127573, 20415.693764593543, 20448.591028179355, 20464.59070818605, 20478.795212047688, 7501.062367204099, 7578.393728501706, 7634.580098094547, 7874.645640946172, 7886.921130788619, 4181.184668989578, 4238.321868501025, 4263.0, 4266.210751011073, 4281.593248641374, 3427.7943323400177, 3566.7503274770515, 3568.1258091767163, 3570.321638888603, 3578.1054736315923, 643.832603523078, 651.26407159909, 659.6306068601599, 668.1848145262869, 670.0485310858593, 513.9203423469369, 544.8474427160402, 574.844791906183, 621.4655396359127, 646.6249575246346, 9253.861192082124, 10033.77230670843, 10179.083882450615, 10256.846147307797, 10510.474476276155, 667.9379786139964, 671.6708812681849, 678.2437582096026, 694.7672529702505, 699.9815268783907, 4084.4281800547947, 4560.429946256718, 4631.328457373729, 4645.326427667969, 4692.155412025868, 136015.31992339974, 144103.0, 144457.0, 151286.48713512943, 152281.0, 111358.0, 125015.99936002458, 132258.11289814432, 134672.32663836813, 137102.31448842693, 96404.0, 111633.0, 115054.4247278775, 115089.0, 116668.41665791787, 9094.681686140953, 9111.681091161778, 9118.22495087925, 9246.861297080684, 9294.390136241856, 61570.69214653898, 61803.07295390662, 62597.0, 62669.0, 63177.36822631715, 87974.56012719896, 95688.52155739177, 96238.03761962571, 98023.52964705678, 98923.62378326585, 11421.37182454973, 11690.70773230676, 11959.701007474883, 12119.576084783255, 12440.066994975232, 11700.70748231301, 12924.353782311035, 12985.610431687064, 13337.799933000819, 13736.587902362946, 12160.148789584999, 12171.75656486883, 12423.0, 12464.5014199431, 12705.0, 12032.338221397908, 12032.879671203526, 12280.447379867748, 12300.630981070582, 12437.431828708906, 12040.939795300967, 12130.878691213327, 12143.33211673331, 12252.87747122553, 12554.661448453198, 10174.338667986853, 10376.533056012648, 10484.947575262075, 10573.9471302643, 10964.671059868217, 8945.172973648057, 9964.302498825013, 10238.33450825694, 10496.842547361643, 10590.258681892194], "value": 7648.786876282676, "unit": "score"}], "name": "dromaeo_css", "value": 7140.672591029969, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 117.0, 114.0, 112.0, 112.0, 114.0, 112.0, 112.0, 123.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 130.0, 170.0, 136.0, 145.0, 129.0, 109.0, 159.0, 107.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 182.0, 181.0, 182.0, 180.0, 181.0, 182.0, 179.0, 178.0], "value": 181.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 82.0, 75.0, 155.0, 57.0, 57.0, 57.0, 64.0, 139.0, 55.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 130.0, 71.0, 81.0, 78.0, 117.0, 70.0, 69.0, 118.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 83.0, 86.0, 84.0, 86.0, 83.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 92.0, 92.0, 92.0, 96.0, 92.0, 92.0, 93.0, 92.0], "value": 92.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 84.0, 84.0, 84.0, 96.0, 144.0, 83.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 52.0, 53.0, 55.0, 52.0, 54.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 75.0, 77.0, 72.0, 68.0, 67.0, 68.0, 68.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 99.0, 104.0, 106.0, 79.0, 84.0, 84.0, 85.0, 83.0, 85.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 138.0, 139.0, 137.0, 138.0, 156.0, 152.0, 187.0, 139.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 166.0, 166.0, 164.0, 167.0, 167.0, 165.0, 168.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 70.0, 73.0, 86.0, 86.0, 86.0, 73.0, 66.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1468.8999999999999, "alertThreshold": 2.0}]} 00:09:15 INFO - Return code: 0 00:09:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:09:15 INFO - # TBPL SUCCESS # 00:09:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:09:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:09:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:09:15 INFO - 2016-09-09 00:09:15.880 screenresolution[1678:12157] starting screenresolution argv=screenresolution get 00:09:15 INFO - 2016-09-09 00:09:15.882 screenresolution[1678:12157] Display 0: 1600x1200x32@60 00:09:15 INFO - 2016-09-09 00:09:15.888 screenresolution[1679:12160] starting screenresolution argv=screenresolution list 00:09:15 INFO - Available Modes on Display 0 00:09:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:09:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:09:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:09:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:09:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:09:16 INFO - Intel Iris: 00:09:16 INFO - Chipset Model: Intel Iris 00:09:16 INFO - Type: GPU 00:09:16 INFO - Bus: Built-In 00:09:16 INFO - VRAM (Dynamic, Max): 1536 MB 00:09:16 INFO - Vendor: Intel (0x8086) 00:09:16 INFO - Device ID: 0x0a2e 00:09:16 INFO - Revision ID: 0x0009 00:09:16 INFO - Displays: 00:09:16 INFO - Display: 00:09:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:09:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:09:16 INFO - Display Serial Number: 1600x1200 60 00:09:16 INFO - Main Display: Yes 00:09:16 INFO - Mirror: Off 00:09:16 INFO - Online: Yes 00:09:16 INFO - Rotation: Supported 00:09:16 INFO - Return code: 0 00:09:16 INFO - Running post-action listener: _resource_record_post_action 00:09:16 INFO - [mozharness: 2016-09-09 07:09:16.128803Z] Finished run-tests step (success) 00:09:16 INFO - Running post-run listener: _resource_record_post_run 00:09:16 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38218752; Write bytes: 713568768; Read time: 453; Write time: 1988 00:09:16 INFO - TinderboxPrint: CPU usage
53.5% 00:09:16 INFO - TinderboxPrint: I/O read bytes / time
38,218,752 / 453 00:09:16 INFO - TinderboxPrint: I/O write bytes / time
713,568,768 / 1,988 00:09:16 INFO - TinderboxPrint: CPU idle
2,254.8 (46.5%) 00:09:16 INFO - TinderboxPrint: CPU system
964.4 (19.9%) 00:09:16 INFO - TinderboxPrint: CPU user
1,626.4 (33.6%) 00:09:16 INFO - TinderboxPrint: Swap in / out
439,017,472 / 0 00:09:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398514688; Write bytes: 393836544; Read time: 29642; Write time: 796 00:09:16 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36178944; Write bytes: 303028736; Read time: 434; Write time: 1147 00:09:16 INFO - Running post-run listener: _upload_blobber_files 00:09:16 INFO - Blob upload gear active. 00:09:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:09:16 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 00:09:16 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'] 00:09:16 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 00:09:17 INFO - (blobuploader) - INFO - Open directory for files ... 00:09:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:09:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:19 INFO - (blobuploader) - INFO - Done attempting. 00:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:20 INFO - (blobuploader) - INFO - Done attempting. 00:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:09:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:23 INFO - (blobuploader) - INFO - Done attempting. 00:09:23 INFO - (blobuploader) - INFO - Iteration through files over. 00:09:23 INFO - Return code: 0 00:09:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:09:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:09:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8f9dcea0d445a69b7398f18c546a4be7e31abf6a1c0811edf1a3739ca4b9be7338ba859a32613dbfc1c74b051c4117abe1a31ec6749071d53ee4d557fd4cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7884f97d6008a6ff4f8708fcef1df087c4528b38e51a9c642245d8809f1f53c19c8f891627ecad218bd583f004b9d7f5cedea023eabf8d5000964b1bfb07eb18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/154c9e7f974108ec847cdc93da81498eb1715ae3a7ed54ff86a86bed5511bbd48dc418272bdf764bdbfa9739ddb6dcbb99f625932f57a5624f82f6e2e9b8328a"} 00:09:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:09:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:09:23 INFO - Contents: 00:09:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa8f9dcea0d445a69b7398f18c546a4be7e31abf6a1c0811edf1a3739ca4b9be7338ba859a32613dbfc1c74b051c4117abe1a31ec6749071d53ee4d557fd4cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7884f97d6008a6ff4f8708fcef1df087c4528b38e51a9c642245d8809f1f53c19c8f891627ecad218bd583f004b9d7f5cedea023eabf8d5000964b1bfb07eb18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/154c9e7f974108ec847cdc93da81498eb1715ae3a7ed54ff86a86bed5511bbd48dc418272bdf764bdbfa9739ddb6dcbb99f625932f57a5624f82f6e2e9b8328a"} 00:09:23 INFO - Running post-run listener: copy_logs_to_upload_dir 00:09:23 INFO - Copying logs to upload dir... 00:09:23 INFO - mkdir: /builds/slave/test/build/upload/logs 00:09:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.564700 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-09 00:09:23.247447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 00:09:23.251336) ========= 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.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/aa8f9dcea0d445a69b7398f18c546a4be7e31abf6a1c0811edf1a3739ca4b9be7338ba859a32613dbfc1c74b051c4117abe1a31ec6749071d53ee4d557fd4cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7884f97d6008a6ff4f8708fcef1df087c4528b38e51a9c642245d8809f1f53c19c8f891627ecad218bd583f004b9d7f5cedea023eabf8d5000964b1bfb07eb18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/154c9e7f974108ec847cdc93da81498eb1715ae3a7ed54ff86a86bed5511bbd48dc418272bdf764bdbfa9739ddb6dcbb99f625932f57a5624f82f6e2e9b8328a"} build_url:https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011101 build_url: 'https://queue.taskcluster.net/v1/task/fFVnN6dgSLe4ZaKb8PwJxQ/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/aa8f9dcea0d445a69b7398f18c546a4be7e31abf6a1c0811edf1a3739ca4b9be7338ba859a32613dbfc1c74b051c4117abe1a31ec6749071d53ee4d557fd4cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7884f97d6008a6ff4f8708fcef1df087c4528b38e51a9c642245d8809f1f53c19c8f891627ecad218bd583f004b9d7f5cedea023eabf8d5000964b1bfb07eb18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/154c9e7f974108ec847cdc93da81498eb1715ae3a7ed54ff86a86bed5511bbd48dc418272bdf764bdbfa9739ddb6dcbb99f625932f57a5624f82f6e2e9b8328a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 00:09:23.292480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 00:09:23.293160) ========= 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.4JcJW1lJfS/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.lS7o0dieae/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005205 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 00:09:23.346842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 00:09:23.347545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 00:09:23.348344) ========= ========= Total master_lag: 0.18 =========