builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1484949982.32 results: success (0) buildid: 20170120121625 builduid: d10d8617587d402a814433fb50cb7cad revision: d4698098ca0d9e2f29bc5407edd968b73bc0ebfa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.320848) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.321339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.321623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.351482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.351941) ========= 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.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 --2017-01-20 14:06:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2017-01-20 14:06:22 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.475528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.475873) ========= 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.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.030832 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:22.529451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 14:06:22.529828) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d4698098ca0d9e2f29bc5407edd968b73bc0ebfa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev d4698098ca0d9e2f29bc5407edd968b73bc0ebfa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 2017-01-20 14:06:22,643 truncating revision to first 12 chars 2017-01-20 14:06:22,643 Setting DEBUG logging. 2017-01-20 14:06:22,643 attempt 1/10 2017-01-20 14:06:22,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d4698098ca0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 14:06:23,629 unpacking tar archive at: graphics-d4698098ca0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 14:06:23.806102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:23.806433) ========= script_repo_revision: d4698098ca0d9e2f29bc5407edd968b73bc0ebfa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:23.806864) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:23.807155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 14:06:23.827331) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-20 14:06:23.827759) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:06:24 INFO - MultiFileLogger online at 20170120 14:06:24 in /builds/slave/test 14:06:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 14:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:24 INFO - {'append_to_log': False, 14:06:24 INFO - 'base_work_dir': '/builds/slave/test', 14:06:24 INFO - 'blob_upload_branch': 'Graphics', 14:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:24 INFO - 'branch': 'Graphics', 14:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:24 INFO - 'config_files': ('talos/mac_config.py',), 14:06:24 INFO - 'default_actions': ('clobber', 14:06:24 INFO - 'read-buildbot-config', 14:06:24 INFO - 'download-and-extract', 14:06:24 INFO - 'populate-webroot', 14:06:24 INFO - 'create-virtualenv', 14:06:24 INFO - 'install', 14:06:24 INFO - 'run-tests'), 14:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:24 INFO - 'download_minidump_stackwalk': True, 14:06:24 INFO - 'download_symbols': 'ondemand', 14:06:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:24 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:24 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:24 INFO - 'installer_path': 'installer.exe', 14:06:24 INFO - 'log_level': 'info', 14:06:24 INFO - 'log_name': 'talos', 14:06:24 INFO - 'log_to_console': True, 14:06:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:06:24 INFO - 'opt_config_files': (), 14:06:24 INFO - 'pip_index': False, 14:06:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:06:24 INFO - 'cmd': ('bash', 14:06:24 INFO - '-c', 14:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:06:24 INFO - 'enabled': True, 14:06:24 INFO - 'halt_on_failure': False, 14:06:24 INFO - 'name': 'check_screen_resolution'},), 14:06:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:06:24 INFO - 'cmd': ('bash', 14:06:24 INFO - '-c', 14:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:06:24 INFO - 'enabled': True, 14:06:24 INFO - 'halt_on_failure': False, 14:06:24 INFO - 'name': 'check_screen_resolution'},), 14:06:24 INFO - 'run_cmd_checks_enabled': True, 14:06:24 INFO - 'sps_profile': False, 14:06:24 INFO - 'sps_profile_interval': 0, 14:06:24 INFO - 'suite': 'dromaeojs', 14:06:24 INFO - 'system_bits': '32', 14:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:24 INFO - 'title': 't-yosemite-r7-0060', 14:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:24 INFO - 'use_talos_json': True, 14:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:24 INFO - 'work_dir': 'build'} 14:06:24 INFO - [mozharness: 2017-01-20 22:06:24.045071Z] Running clobber step. 14:06:24 INFO - Running pre-action listener: _resource_record_pre_action 14:06:24 INFO - Running main action method: clobber 14:06:24 INFO - rmtree: /builds/slave/test/build 14:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - [mozharness: 2017-01-20 22:06:26.454809Z] Finished clobber step (success) 14:06:26 INFO - [mozharness: 2017-01-20 22:06:26.454955Z] Running read-buildbot-config step. 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: read_buildbot_config 14:06:26 INFO - Using buildbot properties: 14:06:26 INFO - { 14:06:26 INFO - "project": "", 14:06:26 INFO - "product": "firefox", 14:06:26 INFO - "script_repo_revision": "default", 14:06:26 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 14:06:26 INFO - "repository": "", 14:06:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 14:06:26 INFO - "buildid": "20170120121625", 14:06:26 INFO - "pgo_build": "False", 14:06:26 INFO - "basedir": "/builds/slave/test", 14:06:26 INFO - "buildnumber": 29, 14:06:26 INFO - "slavename": "t-yosemite-r7-0060", 14:06:26 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:06:26 INFO - "platform": "yosemite_r7", 14:06:26 INFO - "scheduler": "tests-graphics-macosx64-talos", 14:06:26 INFO - "branch": "graphics", 14:06:26 INFO - "repo_path": "projects/graphics", 14:06:26 INFO - "revision": "d4698098ca0d9e2f29bc5407edd968b73bc0ebfa", 14:06:26 INFO - "stage_platform": "macosx64", 14:06:26 INFO - "builduid": "d10d8617587d402a814433fb50cb7cad", 14:06:26 INFO - "slavebuilddir": "test" 14:06:26 INFO - } 14:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - [mozharness: 2017-01-20 22:06:26.458384Z] Finished read-buildbot-config step (success) 14:06:26 INFO - [mozharness: 2017-01-20 22:06:26.458510Z] Running download-and-extract step. 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: download_and_extract 14:06:26 INFO - mkdir: /builds/slave/test/build/tests 14:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:26 INFO - trying https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:06:27 INFO - Downloaded 1199 bytes. 14:06:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:06:27 INFO - Using the following test package requirements: 14:06:27 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:06:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:06:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:06:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'jsshell-mac.zip'], 14:06:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:06:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:06:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:06:27 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:06:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:06:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:06:27 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:06:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:06:28 INFO - Expected file size: 16345380 14:06:28 INFO - Obtained file size: 16345380 14:06:35 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:06:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:06:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:06:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:06:35 INFO - Expected file size: 16345380 14:06:35 INFO - Obtained file size: 16345380 14:06:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:06:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:06:42 INFO - Fetch https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:06:43 INFO - Expected file size: 14403476 14:06:43 INFO - Obtained file size: 14403476 14:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:43 INFO - trying https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:06:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:06:45 INFO - Downloaded 69993942 bytes. 14:06:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:06:45 INFO - mkdir: /builds/slave/test/properties 14:06:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:45 INFO - Contents: 14:06:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:06:46 INFO - Running post-action listener: _resource_record_post_action 14:06:46 INFO - Running post-action listener: set_extra_try_arguments 14:06:46 INFO - [mozharness: 2017-01-20 22:06:46.621642Z] Finished download-and-extract step (success) 14:06:46 INFO - [mozharness: 2017-01-20 22:06:46.621768Z] Running populate-webroot step. 14:06:46 INFO - Running pre-action listener: _resource_record_pre_action 14:06:46 INFO - Running main action method: populate_webroot 14:06:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:46 INFO - '--tppagecycles', 14:06:46 INFO - '7'], 14:06:46 INFO - 'tests': ['tsvgm']}}, 14:06:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['damp', 'tps']}, 14:06:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'tests': ['damp', 'tps']}, 14:06:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['dromaeo_dom']}, 14:06:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['basic_compositor_video']}, 14:06:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:06:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['a11yr', 14:06:46 INFO - 'ts_paint', 14:06:46 INFO - 'tpaint', 14:06:46 INFO - 'sessionrestore', 14:06:46 INFO - 'sessionrestore_no_auto_restore', 14:06:46 INFO - 'tabpaint']}, 14:06:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['tsvgx', 14:06:46 INFO - 'tsvgr_opacity', 14:06:46 INFO - 'tart', 14:06:46 INFO - 'tscrollx', 14:06:46 INFO - 'cart', 14:06:46 INFO - 'tsvg_static']}, 14:06:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:46 INFO - 'tsvgr_opacity', 14:06:46 INFO - 'tart', 14:06:46 INFO - 'tscrollx', 14:06:46 INFO - 'cart', 14:06:46 INFO - 'tsvg_static']}, 14:06:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'talos_options': ['--disable-e10s'], 14:06:46 INFO - 'tests': ['tp5o']}, 14:06:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:06:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'talos_options': ['--disable-e10s', 14:06:46 INFO - '--xperf_path', 14:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:46 INFO - 'tests': ['tp5n']}, 14:06:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:06:46 INFO - 'talos_options': ['--xperf_path', 14:06:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:46 INFO - 'tests': ['tp5n']}}, 14:06:46 INFO - 'talos.zip': {'path': '', 14:06:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:46 INFO - Running post-action listener: _resource_record_post_action 14:06:46 INFO - [mozharness: 2017-01-20 22:06:46.640144Z] Finished populate-webroot step (success) 14:06:46 INFO - [mozharness: 2017-01-20 22:06:46.640258Z] Running create-virtualenv step. 14:06:46 INFO - Running pre-action listener: _resource_record_pre_action 14:06:46 INFO - Running main action method: create_virtualenv 14:06:46 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:06:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:46 INFO - Using real prefix '/tools/python27' 14:06:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:50 INFO - Installing pip.................done. 14:06:50 INFO - Return code: 0 14:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:06:50 INFO - Reading from file tmpfile_stdout 14:06:50 INFO - Output received: 14:06:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:50 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:06:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:06:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:50 INFO - 'HOME': '/Users/cltbld', 14:06:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:50 INFO - 'LOGNAME': 'cltbld', 14:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:50 INFO - 'MOZ_NO_REMOTE': '1', 14:06:50 INFO - 'NO_EM_RESTART': '1', 14:06:50 INFO - 'PAGER': '/bin/cat', 14:06:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:50 INFO - 'PWD': '/builds/slave/test', 14:06:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:50 INFO - 'SHELL': '/bin/bash', 14:06:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:06:50 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:06:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:50 INFO - 'USER': 'cltbld', 14:06:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:50 INFO - 'XPC_FLAGS': '0x0', 14:06:50 INFO - 'XPC_SERVICE_NAME': '0', 14:06:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:06:51 INFO - Cleaning up... 14:06:51 INFO - Return code: 0 14:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:51 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:51 INFO - 'HOME': '/Users/cltbld', 14:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:51 INFO - 'LOGNAME': 'cltbld', 14:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:51 INFO - 'MOZ_NO_REMOTE': '1', 14:06:51 INFO - 'NO_EM_RESTART': '1', 14:06:51 INFO - 'PAGER': '/bin/cat', 14:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:51 INFO - 'PWD': '/builds/slave/test', 14:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:51 INFO - 'SHELL': '/bin/bash', 14:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:06:51 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:51 INFO - 'USER': 'cltbld', 14:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:51 INFO - 'XPC_FLAGS': '0x0', 14:06:51 INFO - 'XPC_SERVICE_NAME': '0', 14:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:51 INFO - Downloading/unpacking psutil>=3.1.1 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:55 INFO - Installing collected packages: psutil 14:06:55 INFO - Running setup.py install for psutil 14:06:55 INFO - building 'psutil._psutil_osx' extension 14:06:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:06:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:06:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:06:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:06:56 INFO - building 'psutil._psutil_posix' extension 14:06:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:06:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:06:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:06:56 INFO - ^ 14:06:56 INFO - 1 warning generated. 14:06:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:06:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:56 INFO - Successfully installed psutil 14:06:56 INFO - Cleaning up... 14:06:56 INFO - Return code: 0 14:06:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:56 INFO - 'HOME': '/Users/cltbld', 14:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:56 INFO - 'LOGNAME': 'cltbld', 14:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:56 INFO - 'MOZ_NO_REMOTE': '1', 14:06:56 INFO - 'NO_EM_RESTART': '1', 14:06:56 INFO - 'PAGER': '/bin/cat', 14:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:56 INFO - 'PWD': '/builds/slave/test', 14:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:56 INFO - 'SHELL': '/bin/bash', 14:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:06:56 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:56 INFO - 'USER': 'cltbld', 14:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:56 INFO - 'XPC_FLAGS': '0x0', 14:06:56 INFO - 'XPC_SERVICE_NAME': '0', 14:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:59 INFO - Installing collected packages: mozsystemmonitor 14:06:59 INFO - Running setup.py install for mozsystemmonitor 14:06:59 INFO - Successfully installed mozsystemmonitor 14:06:59 INFO - Cleaning up... 14:06:59 INFO - Return code: 0 14:06:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:59 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:59 INFO - 'HOME': '/Users/cltbld', 14:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:59 INFO - 'LOGNAME': 'cltbld', 14:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:59 INFO - 'MOZ_NO_REMOTE': '1', 14:06:59 INFO - 'NO_EM_RESTART': '1', 14:06:59 INFO - 'PAGER': '/bin/cat', 14:06:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:59 INFO - 'PWD': '/builds/slave/test', 14:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:59 INFO - 'SHELL': '/bin/bash', 14:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:06:59 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:59 INFO - 'USER': 'cltbld', 14:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:59 INFO - 'XPC_FLAGS': '0x0', 14:06:59 INFO - 'XPC_SERVICE_NAME': '0', 14:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:59 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:03 INFO - warning: no files found matching '*.txt' 14:07:03 INFO - no previously-included directories found matching 'build' 14:07:03 INFO - no previously-included directories found matching 'dist' 14:07:03 INFO - no previously-included directories found matching '.git*' 14:07:03 INFO - Installing collected packages: jsonschema, functools32 14:07:03 INFO - Running setup.py install for functools32 14:07:03 INFO - warning: no files found matching '*.txt' 14:07:03 INFO - no previously-included directories found matching 'build' 14:07:03 INFO - no previously-included directories found matching 'dist' 14:07:03 INFO - no previously-included directories found matching '.git*' 14:07:03 INFO - Successfully installed jsonschema functools32 14:07:03 INFO - Cleaning up... 14:07:03 INFO - Return code: 0 14:07:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', '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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:07: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 functools32==3.2.3-2 14:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:03 INFO - 'HOME': '/Users/cltbld', 14:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:03 INFO - 'LOGNAME': 'cltbld', 14:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:03 INFO - 'MOZ_NO_REMOTE': '1', 14:07:03 INFO - 'NO_EM_RESTART': '1', 14:07:03 INFO - 'PAGER': '/bin/cat', 14:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:03 INFO - 'PWD': '/builds/slave/test', 14:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:03 INFO - 'SHELL': '/bin/bash', 14:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:03 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:03 INFO - 'USER': 'cltbld', 14:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:03 INFO - 'XPC_FLAGS': '0x0', 14:07:03 INFO - 'XPC_SERVICE_NAME': '0', 14:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:07:03 INFO - Cleaning up... 14:07:03 INFO - Return code: 0 14:07:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', '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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07: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 blobuploader==1.2.4 14:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:03 INFO - 'HOME': '/Users/cltbld', 14:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:03 INFO - 'LOGNAME': 'cltbld', 14:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:03 INFO - 'MOZ_NO_REMOTE': '1', 14:07:03 INFO - 'NO_EM_RESTART': '1', 14:07:03 INFO - 'PAGER': '/bin/cat', 14:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:03 INFO - 'PWD': '/builds/slave/test', 14:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:03 INFO - 'SHELL': '/bin/bash', 14:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:03 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:03 INFO - 'USER': 'cltbld', 14:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:03 INFO - 'XPC_FLAGS': '0x0', 14:07:03 INFO - 'XPC_SERVICE_NAME': '0', 14:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:07 INFO - Downloading docopt-0.6.1.tar.gz 14:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:07 INFO - Running setup.py install for blobuploader 14:07:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:08 INFO - Running setup.py install for requests 14:07:08 INFO - Running setup.py install for docopt 14:07:08 INFO - Successfully installed blobuploader requests docopt 14:07:08 INFO - Cleaning up... 14:07:08 INFO - Return code: 0 14:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:08 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:08 INFO - 'HOME': '/Users/cltbld', 14:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:08 INFO - 'LOGNAME': 'cltbld', 14:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:08 INFO - 'MOZ_NO_REMOTE': '1', 14:07:08 INFO - 'NO_EM_RESTART': '1', 14:07:08 INFO - 'PAGER': '/bin/cat', 14:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:08 INFO - 'PWD': '/builds/slave/test', 14:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:08 INFO - 'SHELL': '/bin/bash', 14:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:08 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:08 INFO - 'USER': 'cltbld', 14:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:08 INFO - 'XPC_FLAGS': '0x0', 14:07:08 INFO - 'XPC_SERVICE_NAME': '0', 14:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-nsV7hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-QkVTpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ImJEBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-t5krEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-9bC8gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-GfAj6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-OQ3OiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-dyZ9VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:09 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-hzPPfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-VlnWpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ad3fvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-eGNWSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-atZzFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Srmsnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-igBp06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-192iSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:10 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-D7lHxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:10 INFO - Running setup.py install for manifestparser 14:07:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:11 INFO - Running setup.py install for mozcrash 14:07:11 INFO - Running setup.py install for mozdebug 14:07:11 INFO - Running setup.py install for mozdevice 14:07:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:11 INFO - Running setup.py install for mozfile 14:07:11 INFO - Running setup.py install for mozhttpd 14:07:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:11 INFO - Running setup.py install for mozinfo 14:07:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:11 INFO - Running setup.py install for mozInstall 14:07:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Running setup.py install for mozleak 14:07:12 INFO - Running setup.py install for mozlog 14:07:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Running setup.py install for moznetwork 14:07:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Running setup.py install for mozprocess 14:07:12 INFO - Running setup.py install for mozprofile 14:07:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:12 INFO - Running setup.py install for mozrunner 14:07:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:13 INFO - Running setup.py install for mozscreenshot 14:07:13 INFO - Running setup.py install for moztest 14:07:13 INFO - Running setup.py install for mozversion 14:07:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:13 INFO - Cleaning up... 14:07:13 INFO - Return code: 0 14:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:13 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:13 INFO - 'HOME': '/Users/cltbld', 14:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:13 INFO - 'LOGNAME': 'cltbld', 14:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:13 INFO - 'MOZ_NO_REMOTE': '1', 14:07:13 INFO - 'NO_EM_RESTART': '1', 14:07:13 INFO - 'PAGER': '/bin/cat', 14:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:13 INFO - 'PWD': '/builds/slave/test', 14:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:13 INFO - 'SHELL': '/bin/bash', 14:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:13 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:13 INFO - 'USER': 'cltbld', 14:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:13 INFO - 'XPC_FLAGS': '0x0', 14:07:13 INFO - 'XPC_SERVICE_NAME': '0', 14:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:13 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-8yri1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:13 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-JUJs6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:13 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-O06FuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-fuEYUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-hgBZCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-hIjvXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-OKs_sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-LlnlTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-TG_Rv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-QgEaFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-rbzRJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:14 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-_x3jl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:15 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-XPGYu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:15 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-CggxdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:15 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-pWmtVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:15 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-gwGJiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:15 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-PNgipo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:07:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:07:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:18 INFO - Downloading blessings-1.6.tar.gz 14:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:18 INFO - Installing collected packages: blessings 14:07:18 INFO - Running setup.py install for blessings 14:07:18 INFO - Successfully installed blessings 14:07:18 INFO - Cleaning up... 14:07:18 INFO - Return code: 0 14:07:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:18 INFO - Reading from file tmpfile_stdout 14:07:18 INFO - Current package versions: 14:07:18 INFO - blessings == 1.6 14:07:18 INFO - blobuploader == 1.2.4 14:07:18 INFO - docopt == 0.6.1 14:07:18 INFO - functools32 == 3.2.3-2 14:07:18 INFO - jsonschema == 2.5.1 14:07:18 INFO - manifestparser == 1.1 14:07:18 INFO - mozInstall == 1.12 14:07:18 INFO - mozcrash == 1.0 14:07:18 INFO - mozdebug == 0.1 14:07:18 INFO - mozdevice == 0.49 14:07:18 INFO - mozfile == 1.2 14:07:18 INFO - mozhttpd == 0.7 14:07:18 INFO - mozinfo == 0.9 14:07:18 INFO - mozleak == 0.1 14:07:18 INFO - mozlog == 3.4 14:07:18 INFO - moznetwork == 0.27 14:07:18 INFO - mozprocess == 0.24 14:07:18 INFO - mozprofile == 0.28 14:07:18 INFO - mozrunner == 6.13 14:07:18 INFO - mozscreenshot == 0.1 14:07:18 INFO - mozsystemmonitor == 0.3 14:07:18 INFO - moztest == 0.8 14:07:18 INFO - mozversion == 1.4 14:07:18 INFO - psutil == 3.1.1 14:07:18 INFO - requests == 1.2.3 14:07:18 INFO - wsgiref == 0.1.2 14:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:19 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:19 INFO - 'HOME': '/Users/cltbld', 14:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:19 INFO - 'LOGNAME': 'cltbld', 14:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:19 INFO - 'MOZ_NO_REMOTE': '1', 14:07:19 INFO - 'NO_EM_RESTART': '1', 14:07:19 INFO - 'PAGER': '/bin/cat', 14:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:19 INFO - 'PWD': '/builds/slave/test', 14:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:19 INFO - 'SHELL': '/bin/bash', 14:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:19 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:19 INFO - 'USER': 'cltbld', 14:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:19 INFO - 'XPC_FLAGS': '0x0', 14:07:19 INFO - 'XPC_SERVICE_NAME': '0', 14:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:19 INFO - Cleaning up... 14:07:19 INFO - Return code: 0 14:07:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:20 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 0x110576b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110579768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f0595820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, '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.IO3U0AxpzI/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.2I68NiultD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:20 INFO - 'HOME': '/Users/cltbld', 14:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:20 INFO - 'LOGNAME': 'cltbld', 14:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:20 INFO - 'MOZ_NO_REMOTE': '1', 14:07:20 INFO - 'NO_EM_RESTART': '1', 14:07:20 INFO - 'PAGER': '/bin/cat', 14:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:20 INFO - 'PWD': '/builds/slave/test', 14:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:20 INFO - 'SHELL': '/bin/bash', 14:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:20 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:20 INFO - 'USER': 'cltbld', 14:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:20 INFO - 'XPC_FLAGS': '0x0', 14:07:20 INFO - 'XPC_SERVICE_NAME': '0', 14:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:20 INFO - Cleaning up... 14:07:20 INFO - Return code: 0 14:07:20 INFO - Running post-action listener: _resource_record_post_action 14:07:20 INFO - Running post-action listener: _start_resource_monitoring 14:07:20 INFO - Starting resource monitoring. 14:07:20 INFO - [mozharness: 2017-01-20 22:07:20.665988Z] Finished create-virtualenv step (success) 14:07:20 INFO - [mozharness: 2017-01-20 22:07:20.667000Z] Running install step. 14:07:20 INFO - Running pre-action listener: _resource_record_pre_action 14:07:20 INFO - Running main action method: install 14:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:20 INFO - Reading from file tmpfile_stdout 14:07:20 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:21 INFO - Reading from file tmpfile_stdout 14:07:21 INFO - Output received: 14:07:21 INFO - Usage: mozinstall [options] installer 14:07:21 INFO - Options: 14:07:21 INFO - -h, --help show this help message and exit 14:07:21 INFO - -d DEST, --destination=DEST 14:07:21 INFO - Directory to install application into. [default: 14:07:21 INFO - "/builds/slave/test"] 14:07:21 INFO - --app=APP Application being installed. [default: firefox] 14:07:21 INFO - mkdir: /builds/slave/test/build/application 14:07:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:07:43 INFO - Reading from file tmpfile_stdout 14:07:43 INFO - Output received: 14:07:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:07:43 INFO - Running post-action listener: _resource_record_post_action 14:07:43 INFO - [mozharness: 2017-01-20 22:07:43.158327Z] Finished install step (success) 14:07:43 INFO - [mozharness: 2017-01-20 22:07:43.158454Z] Running run-tests step. 14:07:43 INFO - Running pre-action listener: _resource_record_pre_action 14:07:43 INFO - Running main action method: run_tests 14:07:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:07:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:07:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:07:43 INFO - 2017-01-20 14:07:43.172 screenresolution[1628:7342] starting screenresolution argv=screenresolution get 14:07:43 INFO - 2017-01-20 14:07:43.175 screenresolution[1628:7342] Display 0: 1600x1200x32@60 14:07:43 INFO - 2017-01-20 14:07:43.181 screenresolution[1629:7344] starting screenresolution argv=screenresolution list 14:07:43 INFO - Available Modes on Display 0 14:07:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:07:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:07:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:07:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:07:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:07:43 INFO - Intel Iris: 14:07:43 INFO - Chipset Model: Intel Iris 14:07:43 INFO - Type: GPU 14:07:43 INFO - Bus: Built-In 14:07:43 INFO - VRAM (Dynamic, Max): 1536 MB 14:07:43 INFO - Vendor: Intel (0x8086) 14:07:43 INFO - Device ID: 0x0a2e 14:07:43 INFO - Revision ID: 0x0009 14:07:43 INFO - Displays: 14:07:43 INFO - Display: 14:07:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:07:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:07:43 INFO - Display Serial Number: 1600x1200 60 14:07:43 INFO - Main Display: Yes 14:07:43 INFO - Mirror: Off 14:07:43 INFO - Online: Yes 14:07:43 INFO - Rotation: Supported 14:07:43 INFO - Return code: 0 14:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:43 INFO - Python 2.7.3 14:07:43 INFO - Return code: 0 14:07:43 INFO - grabbing minidump binary from tooltool 14:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:43 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 0x110354d30>, '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 0x11027bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110349be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:07:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:07:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:07:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:43 INFO - Return code: 0 14:07:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:07:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:07:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:07:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IO3U0AxpzI/Render', 14:07:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:43 INFO - 'HOME': '/Users/cltbld', 14:07:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:43 INFO - 'LOGNAME': 'cltbld', 14:07:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:43 INFO - 'MOZ_NO_REMOTE': '1', 14:07:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:43 INFO - 'NO_EM_RESTART': '1', 14:07:43 INFO - 'PAGER': '/bin/cat', 14:07:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:43 INFO - 'PWD': '/builds/slave/test', 14:07:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:43 INFO - 'SHELL': '/bin/bash', 14:07:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2I68NiultD/Listeners', 14:07:43 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 14:07:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:43 INFO - 'USER': 'cltbld', 14:07:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:43 INFO - 'XPC_FLAGS': '0x0', 14:07:43 INFO - 'XPC_SERVICE_NAME': '0', 14:07:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:07:43 INFO - mozversion application_buildid: 20170120121625 14:07:43 INFO - mozversion application_changeset: d4698098ca0d9e2f29bc5407edd968b73bc0ebfa 14:07:43 INFO - mozversion application_display_name: Nightly 14:07:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:43 INFO - mozversion application_name: Firefox 14:07:43 INFO - mozversion application_remotingname: firefox 14:07:43 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:07:43 INFO - mozversion application_vendor: Mozilla 14:07:43 INFO - mozversion application_version: 53.0a1 14:07:43 INFO - mozversion platform_buildid: 20170120121625 14:07:43 INFO - mozversion platform_changeset: d4698098ca0d9e2f29bc5407edd968b73bc0ebfa 14:07:43 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:07:43 INFO - mozversion platform_version: 53.0a1 14:07:43 INFO - using testdate: 1484950063 14:07:43 INFO - actual date: 1484950063 14:07:43 INFO - starting webserver on 'localhost:49235' 14:07:43 INFO - SUITE-START | Running 2 tests 14:07:43 INFO - TEST-START | dromaeo_css 14:07:43 INFO - operating with platform_type : mac_ 14:07:43 INFO - Initialising browser for dromaeo_css test... 14:07:43 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpxsCse4/profile http://localhost:49235/getInfo.html) 14:07:46 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:07:46 INFO - PROCESS | 1639 | colorDepth:24 14:07:46 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:07:46 INFO - PROCESS | 1639 | __metrics 14:07:46 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 14:07:46 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:07:46 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:07:47 INFO - TEST-INFO | 1639: exit 0 14:07:47 INFO - Browser initialized. 14:07:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:47 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpxsCse4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:59 INFO - PROCESS | 1641 | RSS: Main: 227221504 14:07:59 INFO - PROCESS | 1641 | 14:11:02 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 14:11:04 INFO - PROCESS | 1641 | RSS: Main: 367476736 14:11:04 INFO - PROCESS | 1641 | 14:12:48 INFO - PROCESS | 1641 | ************************* 14:12:48 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 14:12:48 INFO - PROCESS | 1641 | 14:12:48 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:12:48 INFO - PROCESS | 1641 | Full stack: 14:12:48 INFO - PROCESS | 1641 | ************************* 14:14:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 14:14:07 INFO - PROCESS | 1641 | RSS: Main: 368709632 14:14:07 INFO - PROCESS | 1641 | 14:17:10 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 14:17:10 INFO - PROCESS | 1641 | RSS: Main: 342360064 14:17:10 INFO - PROCESS | 1641 | 14:20:13 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 14:20:13 INFO - PROCESS | 1641 | RSS: Main: 338464768 14:20:13 INFO - PROCESS | 1641 | 14:23:17 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 14:23:17 INFO - PROCESS | 1641 | RSS: Main: 335974400 14:23:17 INFO - PROCESS | 1641 | 14:26:20 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 14:26:21 INFO - PROCESS | 1641 | RSS: Main: 476471296 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | __start_tp_report 14:26:21 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 14:26:21 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 14:26:21 INFO - PROCESS | 1641 | |i|pagename|runs| 14:26:21 INFO - PROCESS | 1641 | |0;dojo.html;2697.5683890577507;3307.520409540615;3330.5337252784607;3334.4831551109573;3394.71144952679;5616.719164041802;5668.801591944282;5681.573881958854;5724.169995350677;5744.7127643617805;4625.5836974672275;5653.406392328798;5672.914906276409;5696.829095127143;5725.4847063764255;5203.843884683465;5246.134387826014;5260.316158899357;5277.762500687479;5299.019681358942;5153.587712982952;5272.99813035522;5283.8150664726745;5313.309269794921;5314.574834013289;4673.415823022122;5303.257543943851;5321.680699158043;5330.200469929503;5336.519713225809;3804.220134872372;5234.398044224925;5280.735963201824;5294.52349288564;5374.113271310268;4675.392199014106;5142.768575414116;5224.138017227191;5227.451117632631;5229.712365819878;5654.519365853907;5702.65784052954;5725.112607545795;5728.598998070137;5745.569082318801;6177.351378105279;6184.659843708594;6203.131561581382;6205;6206.224221972254;5786.253547447593;6241.531885108589;6265;6319.557630965788;6349.682515874188;5772.422757724194;5876.265466816648;5878.118282257696;5904.61619994699;5927.229460170193;6178.907316390258;6239.96880015597;6244.2819075805955;6319.399657032574;6335.968320158369;6164.3835616438;6242.906356404657;6250.15622890913;6250.718717657716;6252.749890004349;6293.37066293367;6296.433321001132;6297.779577714758;6302.432781049728;6308.053791931247;6091.5735898487565;6110.5587591967305;6277.497800175975;6290.528210384239;6292;6180.7527698891545;6191.535634827406;6201.596896201732;6202.34875338092;6209.813705588839;5019.071471777733;5021.422536408287;5037.219231019198;5052.671576347526;5053.620978426633;4386.320120381346;4414.359917811964;4414.646828253732;4420.734755914656;4451.998300382388;5593.860153496195;5731.971340143273;5801.731860256726;5819.127130930395;5863.853403664943;6257.092721555349;6257.2804127525005;6261.217347831521;6291.874162516724;6296.370362963667;5826.242588463472;5836.387179346192;5862.413758624103;5869.090291004901;5874.412558744177;5467.097928841776;5503.944960550343;5510.090835012178;5523.364813046551;5526.613137080366;6238.594491358047;6242.469390101892;6317.273513545817;6323.272823625342;6341.651209183539;6279.403456671609;6345.587536810092;6348.555601107878;6367.745290188526;6375.968120159369;6324.557280990287;6330.366963303817;6350.936490635035;6378.1070650108095;6387.840303992437;6102.186302349;6152.169457123231;6226.40849119333;6251.124842522141;6257.374262573706;5251;6235.937640623717;6261.092141639528;6305.085762564494;6358.046293056079;5122.410922743932;5864.706764661664;6192.225971753531;6193.349698281616;6208.1308616792785;5966.075258334965;6130.019196928649;6174.506039516738;6192.535559832941;6193.473554747897;5904.3210030845285;5981.880362392815;6022.879542409215;6048.939510604838;6060.666663333559;6136.6011209271255;6165.255079724711;6189.442950134509;6221.3156552778255;6228.314885362516;5854.356020837789;5900.822975310747;5918.319393269657;6068.027890935376;6103.792276408585 14:26:21 INFO - PROCESS | 1641 | |1;ext.html;456.4043922680902;487.05754365303164;502.9974850125749;509.40908546086524;520.1365732883414;30589.54115688264;39508.604913950854;41264.79367603165;41335;41390;42649.36025959613;42900.3564946526;42904.785476072655;42968.140637187236;43064.56935430645;9265.629374825015;9472.100150485692;9479.95260023699;9492.620295188184;9499.620015199383;8427.199416055464;8642.611082501271;11119.833202501968;11447.942760286187;11458.942705286461;11382.260153090065;11428.657140285804;11438.084953203765;11442.199046066778;11447.08423326132;11281.210315277935;11363.090952723804;11365.659030229106;11371.204015718902;11372.203945723802;8260.8347833043;8494.108118647577;8505.064442911274;8609.655613775503;10899.455027248607;38767.418488722695;40694.982625434306;40716.98207544805;40878.38682419736;40880.79559602183;4040.878773636796;4069.1658210066867;4074;4098.672106231525;4179.143275628519;29649.555256671167;30564.54153187704;30600.08199754011;30811.537826932614;30878.382432351227;3141.858616362269;3243.3189030303665;3268.983655081733;3277.213468767479;3332.5501057357187;337584;339445;339880;339996.99999999756;340865;50320.49679503231;58837;60644.39355606387;61029.38970610326;61162.69418652878;63715.36284637187;63858.36141638617;63935;63944;63965.04052439217;15730.213489325488;15960.36158553668;15991.600209994844;15992.76010859838;16010.199490025685;11222.831657525143;11862.406879655982;11933.224340417844;12352.44414001372;12429.627111186679;14538.909581781198;14946.92526537382;16422.917885410498;16638.417655382003;16860.662786744197;6249.78125765596;7251.891221631679;7282.672279747424;7401.851962960711;7446.393762183193;879.5162660536679;880.8678698195322;894.5348418822176;917.8393781088283;922.5479515037583;29438.705612944024;29443.411131777244;29607.25981850471;29865;30080.69919300779;954.7298910016669;1000.8140353680911;1067.813132701774;1100.8844071372391;1119.5186069989982;13791.241481718602;15387.230638468032;15428.691426171414;15652.982556133815;15727.528174154793;570872;573064;574249;575185;576425;59526;59837.40162598405;59895.401045989856;59960.10059849106;60006;1292.8642492538336;1411.4636438153436;1460.8466111058399;1472.1461552299854;1473.049882825593;28218.43563128767;28982.56526152067;29050;29855;29946.25134371658;50244.95590793692;50377.49622503728;50387.496125038284;50451;50501.49498504968;490562;492680.2685718091;492716;492993;493144;36715.44926826046;38915.6108438912;39448.40827387534;39716.2056758869;39778;40470.79764601158;45802;46066;46184.84336409739;46223.53776462192;30305;34391.82804085963;34744.652553474145;35383.29233415369;37916.24167516579;37011;37303.81348093242;38356.041098972746;38442.80778596089;38507.80746096364;36166.457503136946;36311.09222269464;36823;37173;37653.246935061696;25169.748302516742;31543.053708388787;33312.00063998084;33655;33701.66298336985;24430.87784561066;24475.877620611784;24930.626040609044;25094.874525627256;25120 14:26:21 INFO - PROCESS | 1641 | |2;jquery.html;370.8739028730231;391.54189598170143;395.3141299844767;397.8150160175519;425.4596662238957;14647.853521464796;17961.910190449045;20654.586908261826;21778.564428711416;21977.23079692211;19982.900085499554;20967.580648387062;21048.052837622305;21077.894610526964;21333.57332853342;5183.807724223431;5883.176355310249;6140.815775526741;6148.292946311164;6159.784407545737;6031.3413811201835;6064.3026052003925;6092.147099406086;6092.6953652317425;6138.47822935051;5767.711614419283;5904.645721256738;6036.366181550918;6038.909416358758;6048.969755151218;5905.232319798421;5979.910301345483;5987.790427335044;5990.73041713124;5993.071073983496;5091.592672586185;5117.667351622133;5232.241325007891;5233.293505376763;5242.449542798027;25241.495170096496;25274;25294.1147059852;25449.92801151807;25493.745062549508;2408.205292253552;2791.2742686901347;2820;2823.435312937421;2899.376634023695;14743.852561474356;14834.777478337834;15738.527844164693;15739.213039348102;15904.602384940354;1821.799602043774;1882.181251155738;1890.810918908112;1891.2718603337814;1892.1201641236892;123933.14100288502;125267.12099318518;127771;129763.35118324442;130623;11124.777504450027;11235.438228088726;11362.48868800906;11373;11484.081273498101;14224.28878556068;14274.643133921734;14290.356933937997;14292.213928234047;14292.428302867977;8346.958265208636;8502.234798868132;8552.562728926221;8623.611937462829;8646.870296945552;8464.195901389357;8468.364872634576;8644.740657780276;8646.351523635627;8685.218330350299;5660.518855897295;6971.8605627887155;7006.544574602634;7015.9298407016295;7025.92974070263;1887.3960332693407;1918.2998205654835;1919.9856225725755;1923.7210604462555;1924.4130540185097;913.8219287496619;1049.7218237167158;1055.4406164732704;1077.256692881909;1104.2049724198564;22337.218197363338;22354.32937011892;22414.43963900883;22564.66153007706;22608.869556522437;1064.6327017179215;1072.2976450424985;1093.868735751699;1099.1591432554103;1101.9063379612824;10588.417637029883;11737.550631403397;11818.468168932246;11836.230645008047;11957.043436525057;690760;700370;701744;706715;715943.6811263745;90190;94111.58832617379;113122.2123990501;128835;131048.3447582756;1015.6648306058983;1015.664830605913;1041.2086814021397;1042.6298663974333;1043.2801367056707;18913.959732214862;19161.61676766429;19171.61656766829;19310.517237069187;19360.70958935589;48041;49363.753181233864;55821.720891395285;57306.713466432404;57546.7122664384;76182.4763504738;77900.66298011069;78216.82674759997;78884;79022.56616375115;5738.512226460798;8038.503251085796;8073.71741989051;8290.046644635944;8379.45533540318;12696.936515317733;13184.736305274033;13583.32083395846;13703.862961370658;13821.378037988516;10330.638427654996;11101.222914395914;11192.776144477228;11623.883761162619;11939;9419.340646154704;9632.855507167538;10115.7471063224;11223.38271395081;11675.532978681098;11317.547298107984;11636.41817909118;11640.301581905112;11674.70813229676;11779.293242405483;8277.213664701843;8330.166983301622;8571.485710857369;8586.957065214634;8739.694110706349;11145.721356965816;11282.661520154408;11397.373144477133;11770.76458470843;11820.0543956485 14:26:21 INFO - PROCESS | 1641 | |3;mootools.html;1443.2062365698862;1446.9204193769338;1458.445790599572;1467.7431449496335;1472.801171841801;7957.283844453998;8351.4989100654;8387.370947178955;8392.580370981457;8396.992360916684;7407.25927407259;7618.73334433295;7647.426443016768;7953.681852725898;8164.469309494879;2256.7743225677423;2313.2135074074813;2314.5486630107134;2316.5714342846545;2321.059970711856;2309.099451214028;2338.38032921276;2339.9181028664;2341.988290058547;2344.589696803061;2302.412884714404;2317.756635553268;2327.8836058197107;2335.0309621507054;2338.672585837984;2286.6798648189183;2312.190733243368;2313.595120853844;2314.837961342707;2317.80298674612;2251.6172250717254;2321.68657231275;2330.300909727092;2331.9300420987397;2332.661764044221;7639.388848892076;7661.272179142972;8183.631736571869;8261.669533218665;8284.420090593661;4980.551750342486;5120.334356533627;5140.820071297524;5145.07388670043;5145.794168233266;2879.9136025919256;3176.888808891678;3254.332861763333;3440.6559344065645;3446.293509830479;1195.4799662146906;1195.7429152732204;1231.0828432817518;1245.103525461666;1249.375312343828;10543.209259305506;10645.733856653645;10689.091427228695;10692.625758098508;10709.839352409643;4365.3670217818235;4573.268277075652;4640.8375706850775;4647.790849411785;4658.697184683053;9372.06279372071;9389.953050234704;9399.24806015517;9405.952970235105;9410.623575056921;5185.118529849935;5192.909489007276;5194.220866869924;5204.479552044841;5213.895722085613;4186.351115577029;4441.666874984389;4642.373279607277;4712.2224832902875;4748.667593268438;3763.7553559018575;3771.2268984858038;3842.9615703842605;3877.2439374322303;3897.512810898638;1074.8925107489345;1272.8790764877508;1283.2428866968532;1283.332667013148;1287.523616261989;871.4335681806876;879.6921077622909;881.1981097201644;887.2990337633327;906.225177473264;5731.656100633975;5802.158686990447;5806.129080637854;5976.266882603996;6090.086487026892;980.8528720691811;1018.7453136715822;1019.4444028004755;1019.7756493571402;1064.2816099133054;3445.4831775233915;3800.9049773755323;3897.922041559153;4084.101497670508;4109.3425051991535;9750.561224744763;9760.609575616896;9781.266405019653;9845.75385615351;10059;9723.222142228604;9814.7805981552;9877.506124693737;9989.750256243651;10018.849717254247;6537.901931471032;6660.000999850061;7616.428767842434;7676.616169191518;7790.610469476617;4879.316895634543;5573.749181286933;5696.259486266758;5883.735231914488;5923.851903702442;7607.657655405409;9022.413543119676;9027.375072487015;9317.86023209666;9336.253099752139;8817.382783205114;9075.319351048565;9076.636934522809;9223.677171299241;9240.768980775534;5825.184474173534;6193.287771906288;6592.505562082959;6833.214180369122;7124.109486314211;7537.962310188634;7579.621018949141;7580.0145981022115;7604.353629941295;7648.311651951351;6941.0629565010095;7221.566705997657;7226.74706385274;7297.270272972661;7341.559506429631;7083.327083927019;7117.252688467636;7142.9285707144345;7156.355927966508;7265.4550908681;5772.422757724194;5880.029795083763;6394.808155755335;6471.288158302677;6474.838129046811;4774.140654682191;4992.8751781205765;5074.391073071255;5104.642675012714;5156.510131537498;4915.18899381598;4945.578771748526;5117.948820511747;5230.529252367305;5239 14:26:21 INFO - PROCESS | 1641 | |4;prototype.html;352.24619314666614;362.226646110554;365.2986266368572;369.83911998280735;371.3408699558282;4896.894335435762;5257.7402010753385;5301.814436494724;5338.3327084114435;5348.679079255247;4551.749653769041;4743.675598956513;5180.6632568883;5270;5288.5504732097725;3371.7808342457784;3847.2497862916744;3975.0658595230097;4049.8380064797375;4073.6130067643676;3573.767050367632;3612.8735494257708;4053.736507127042;4080.4491393661774;4080.7551546907134;4060.593940605945;4062.878113656595;4069.8168582413864;4071.9185616287805;4072.1855628874346;3562.6615471530163;3650.689691376236;3933.370660694275;3997.8200980955926;4089.666921459016;3137.294108825519;3574.4272520091336;3579.8031108289033;3620.8913732588067;3655.6161603031564;4315.410753547846;5116.386033675945;5131.769070391804;5153.510416510426;5206.817761378334;4124.90689967159;4170.77060761658;4314.460692413449;4650.395448591661;4730.95269047312;5543.944560554423;5577.713137613599;5588.580856435784;5590.91613625796;5601.523870471015;3816.694664426867;3819.7135214858718;3827.3302172119766;3828;3831.770093794353;4332.631726303236;5541.168824676331;5578.609497335188;5808.535317174658;5825.825225243249;3039.6656367799524;3803.7937995962275;3820.3887378019385;3823.5220597425323;3832.3329351732086;3688.381249312964;3860.575336712959;3872.806359682061;3876.127871228951;3888.319544079775;4283.565005723055;4491.955080449219;4503.909921801545;4540.160070386989;4548.431446069241;4684.765761711901;5317.813876514381;5595.720213989365;5621.8194179222;5626.409227031185;1086.6142519405498;1094.861344202021;1234.6110975042832;1248.0701877101617;1252.7369252456904;806.8184658451802;843.6667516331015;849.6176720475811;862.6800994478458;877.6621000914566;4065.89835254121;4286.592773686495;4411.558844115627;4730.408698912636;4947.950520494821;5266.368035835724;5452.454754524516;5472.415567803096;5476.7535460904355;5491.945080549223;4401.493828209796;4528.682992190581;4590.96703241768;4928;5000.3249561309485;2608.752168543985;2654.9380247900995;2759.6274502941847;2820.9407132792767;2836.9219696515192;5253.185756207794;5356.705381204071;5608.439156084441;5632.633878797865;5660.462256085665;4814.325994360793;5108.952664703726;5402.163863971368;5570.470805273492;5696.0031994400815;4649.930515981343;4687.367205427224;4902.823322402598;5101.811367895066;5597.860053498695;4934.570473520868;5271.4464981176425;5383.973080134574;5493.061212251427;5499.642523235977;4840.564349208588;5029.471905450021;5046.460829447054;5379.4082650907585;5400.567954563704;5425.419223312595;5574.749136288796;5604.747786349542;5778.913316300175;5798.173575323928;3494.982525087358;4024.657904078186;4084.8570300039355;4122.031322639117;4131.318332475108;5637.746301416364;5666.46168613981;5667.838093190969;5671.631343962629;5681.346645135697;4960.677555958851;5182.486494050458;5235.65968212065;5257.89484210306;5573.860653483695;4837.750446042607;5076.7207803571155;5254.054270231242;5499.450054994469;5505.229267902577;4764.78558464863;5401.783928642967;5412.404635490014;5412.972935135299;5434.809781657623;5192.429747275123;5234.842954711365;5476;5477.726113694379;5490.533304669148;4560.977195114003;4862.763128960718;5356.812511562077;5385.246065550904;5410.567154627699 14:26:21 INFO - PROCESS | 1641 | |5;yui.html;714.8570285942812;751.526538280883;772.239344245918;813.7355359508159;814.2712272516098;15044.548663540085;15370.615734606641;15556.222188890539;15584.922075389635;15596.610084747872;14369.712605747878;14518.34667439965;14537.345819438124;14539.709205815903;14545.490907818228;670.3932940688685;692.2350802363392;693.9167299924017;841.877927700483;865.8138500222451;855.1832999485507;855.2730179347567;873.5806812729893;874.8906386701663;875.8729984152294;923.4090182283344;923.5059243304834;924.1959495239151;925.8287216864868;926.6988228825625;712.1276436365437;737.5832654550215;740.3078121955988;914.6478605736839;922.064104933493;681.3118750062423;681.4105798484325;681.8431760695019;682.5529278322707;683.1801837794617;15007.549773506813;15125.394984200619;15163.696726065527;15169.924150379287;15177.696446071128;10735.62425315118;13281.535146269835;13793.931030344884;14092.929535352258;14259.07316024455;10397.636082737068;12933.224006559543;13136.605901822864;13446.86553134466;13723;4525.660575456854;4570.771461426949;4574.382458368111;4740.620750339965;4759.214729569617;99693.91045516558;101794;103875.48062259716;105730.94269057288;108286.45856770745;10744.247902646739;10914.56341746337;10932.360325644757;11008.779824403468;11079.72300692473;21129.943502824797;21308.36074917755;21325.146994120372;21334.253301134388;21372.78627213739;7563.394928405714;7650.120236172911;7650.4644674872225;7740.109887363025;7807.297343239135;4244.702870799015;4311.784410779511;4316.417283666728;4318.935215971763;4442.777861106932;3385.9492107618407;3400.438927576922;3440.8451619677176;3467.1678797088516;3473.8263086845554;550.2901257377938;626.332955402504;639.3574457670012;647.543481845298;655.1515787055774;498.17054604083796;524.4755244755245;529.8172130614931;532.2229544864541;538.5072658517491;8606.44058136219;9477.6731257624;9499.810003799885;9643.373180743369;9844.458554779556;620.3486339343671;627.9529035322278;644.8226737647091;653.2498182651092;667.2393471442559;4676.766161691902;4694.422937635778;4702.976485117552;4749.667523273338;4812.422509298906;95750.52124739472;98947.50526247322;100088;100176;100757.98484030279;89303.55348223218;89604.6559301611;92116.61825072629;92206;93641;66948.66525667341;67679.32320676927;68033;69713.95429068568;70444.64777676079;10673.41296228715;11161.609343672932;11186.496607652512;11460.426978651201;11474.655760327203;43190.13619727525;46003.61989140331;50083.49916500934;51161.23258151205;53505;60222;65132;65544.67227663832;66206.75864826958;66472.66763666151;13083.803742943674;13419.472174755641;13473;13517.459301627825;13892.583222503341;14733.778993315324;15033.022853514487;15054.849451505344;15082.773758393414;15189.31648075817;14073.859261407255;14148.646283842987;14229.64425889361;14232.644183895485;14730.26348682583;13991.860081399056;14012.789808152682;14078.370854815086;14413;14447.422103115758;12639.304838233986;13097.214167150001;13736.793948090586;13963.650908727363;14512.854871451573;11376.089912807121;11432.599859004895;11587.942060289644;11678.299302041565;11923.284602923852;7976;9672.02954956736;9937.652182173879;9995.950425205248;11145.832812507657 14:26:21 INFO - PROCESS | 1641 | __end_tp_report 14:26:21 INFO - PROCESS | 1641 | __start_cc_report 14:26:21 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1433 14:26:21 INFO - PROCESS | 1641 | __end_cc_report 14:26:21 INFO - PROCESS | 1641 | __startTimestamp1484951181190__endTimestamp 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | ------- Summary: start ------- 14:26:21 INFO - PROCESS | 1641 | Number of tests: 6 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5748.32 Median:5927.23 stddev:687.76 (11.6%) stddev-sans-first:646.89 14:26:21 INFO - PROCESS | 1641 | Values: 2697.6 3307.5 3330.5 3334.5 3394.7 5616.7 5668.8 5681.6 5724.2 5744.7 4625.6 5653.4 5672.9 5696.8 5725.5 5203.8 5246.1 5260.3 5277.8 5299.0 5153.6 5273.0 5283.8 5313.3 5314.6 4673.4 5303.3 5321.7 5330.2 5336.5 3804.2 5234.4 5280.7 5294.5 5374.1 4675.4 5142.8 5224.1 5227.5 5229.7 5654.5 5702.7 5725.1 5728.6 5745.6 6177.4 6184.7 6203.1 6205.0 6206.2 5786.3 6241.5 6265.0 6319.6 6349.7 5772.4 5876.3 5878.1 5904.6 5927.2 6178.9 6240.0 6244.3 6319.4 6336.0 6164.4 6242.9 6250.2 6250.7 6252.7 6293.4 6296.4 6297.8 6302.4 6308.1 6091.6 6110.6 6277.5 6290.5 6292.0 6180.8 6191.5 6201.6 6202.3 6209.8 5019.1 5021.4 5037.2 5052.7 5053.6 4386.3 4414.4 4414.6 4420.7 4452.0 5593.9 5732.0 5801.7 5819.1 5863.9 6257.1 6257.3 6261.2 6291.9 6296.4 5826.2 5836.4 5862.4 5869.1 5874.4 5467.1 5503.9 5510.1 5523.4 5526.6 6238.6 6242.5 6317.3 6323.3 6341.7 6279.4 6345.6 6348.6 6367.7 6376.0 6324.6 6330.4 6350.9 6378.1 6387.8 6102.2 6152.2 6226.4 6251.1 6257.4 5251.0 6235.9 6261.1 6305.1 6358.0 5122.4 5864.7 6192.2 6193.3 6208.1 5966.1 6130.0 6174.5 6192.5 6193.5 5904.3 5981.9 6022.9 6048.9 6060.7 6136.6 6165.3 6189.4 6221.3 6228.3 5854.4 5900.8 5918.3 6068.0 6103.8 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:61891.90 Median:37784.74 stddev:127420.77 (337.2%) stddev-sans-first:127694.73 14:26:21 INFO - PROCESS | 1641 | Values: 456.4 487.1 503.0 509.4 520.1 30589.5 39508.6 41264.8 41335.0 41390.0 42649.4 42900.4 42904.8 42968.1 43064.6 9265.6 9472.1 9480.0 9492.6 9499.6 8427.2 8642.6 11119.8 11447.9 11458.9 11382.3 11428.7 11438.1 11442.2 11447.1 11281.2 11363.1 11365.7 11371.2 11372.2 8260.8 8494.1 8505.1 8609.7 10899.5 38767.4 40695.0 40717.0 40878.4 40880.8 4040.9 4069.2 4074.0 4098.7 4179.1 29649.6 30564.5 30600.1 30811.5 30878.4 3141.9 3243.3 3269.0 3277.2 3332.6 337584.0 339445.0 339880.0 339997.0 340865.0 50320.5 58837.0 60644.4 61029.4 61162.7 63715.4 63858.4 63935.0 63944.0 63965.0 15730.2 15960.4 15991.6 15992.8 16010.2 11222.8 11862.4 11933.2 12352.4 12429.6 14538.9 14946.9 16422.9 16638.4 16860.7 6249.8 7251.9 7282.7 7401.9 7446.4 879.5 880.9 894.5 917.8 922.5 29438.7 29443.4 29607.3 29865.0 30080.7 954.7 1000.8 1067.8 1100.9 1119.5 13791.2 15387.2 15428.7 15653.0 15727.5 570872.0 573064.0 574249.0 575185.0 576425.0 59526.0 59837.4 59895.4 59960.1 60006.0 1292.9 1411.5 1460.8 1472.1 1473.0 28218.4 28982.6 29050.0 29855.0 29946.3 50245.0 50377.5 50387.5 50451.0 50501.5 490562.0 492680.3 492716.0 492993.0 493144.0 36715.4 38915.6 39448.4 39716.2 39778.0 40470.8 45802.0 46066.0 46184.8 46223.5 30305.0 34391.8 34744.7 35383.3 37916.2 37011.0 37303.8 38356.0 38442.8 38507.8 36166.5 36311.1 36823.0 37173.0 37653.2 25169.7 31543.1 33312.0 33655.0 33701.7 24430.9 24475.9 24930.6 25094.9 25120.0 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:38081.59 Median:22345.77 stddev:116322.12 (520.6%) stddev-sans-first:116613.97 14:26:21 INFO - PROCESS | 1641 | Values: 370.9 391.5 395.3 397.8 425.5 14647.9 17961.9 20654.6 21778.6 21977.2 19982.9 20967.6 21048.1 21077.9 21333.6 5183.8 5883.2 6140.8 6148.3 6159.8 6031.3 6064.3 6092.1 6092.7 6138.5 5767.7 5904.6 6036.4 6038.9 6049.0 5905.2 5979.9 5987.8 5990.7 5993.1 5091.6 5117.7 5232.2 5233.3 5242.4 25241.5 25274.0 25294.1 25449.9 25493.7 2408.2 2791.3 2820.0 2823.4 2899.4 14743.9 14834.8 15738.5 15739.2 15904.6 1821.8 1882.2 1890.8 1891.3 1892.1 123933.1 125267.1 127771.0 129763.4 130623.0 11124.8 11235.4 11362.5 11373.0 11484.1 14224.3 14274.6 14290.4 14292.2 14292.4 8347.0 8502.2 8552.6 8623.6 8646.9 8464.2 8468.4 8644.7 8646.4 8685.2 5660.5 6971.9 7006.5 7015.9 7025.9 1887.4 1918.3 1920.0 1923.7 1924.4 913.8 1049.7 1055.4 1077.3 1104.2 22337.2 22354.3 22414.4 22564.7 22608.9 1064.6 1072.3 1093.9 1099.2 1101.9 10588.4 11737.6 11818.5 11836.2 11957.0 690760.0 700370.0 701744.0 706715.0 715943.7 90190.0 94111.6 113122.2 128835.0 131048.3 1015.7 1015.7 1041.2 1042.6 1043.3 18914.0 19161.6 19171.6 19310.5 19360.7 48041.0 49363.8 55821.7 57306.7 57546.7 76182.5 77900.7 78216.8 78884.0 79022.6 5738.5 8038.5 8073.7 8290.0 8379.5 12696.9 13184.7 13583.3 13703.9 13821.4 10330.6 11101.2 11192.8 11623.9 11939.0 9419.3 9632.9 10115.7 11223.4 11675.5 11317.5 11636.4 11640.3 11674.7 11779.3 8277.2 8330.2 8571.5 8587.0 8739.7 11145.7 11282.7 11397.4 11770.8 11820.1 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5362.95 Median:5189.01 stddev:2878.73 (55.5%) stddev-sans-first:2871.73 14:26:21 INFO - PROCESS | 1641 | Values: 1443.2 1446.9 1458.4 1467.7 1472.8 7957.3 8351.5 8387.4 8392.6 8397.0 7407.3 7618.7 7647.4 7953.7 8164.5 2256.8 2313.2 2314.5 2316.6 2321.1 2309.1 2338.4 2339.9 2342.0 2344.6 2302.4 2317.8 2327.9 2335.0 2338.7 2286.7 2312.2 2313.6 2314.8 2317.8 2251.6 2321.7 2330.3 2331.9 2332.7 7639.4 7661.3 8183.6 8261.7 8284.4 4980.6 5120.3 5140.8 5145.1 5145.8 2879.9 3176.9 3254.3 3440.7 3446.3 1195.5 1195.7 1231.1 1245.1 1249.4 10543.2 10645.7 10689.1 10692.6 10709.8 4365.4 4573.3 4640.8 4647.8 4658.7 9372.1 9390.0 9399.2 9406.0 9410.6 5185.1 5192.9 5194.2 5204.5 5213.9 4186.4 4441.7 4642.4 4712.2 4748.7 3763.8 3771.2 3843.0 3877.2 3897.5 1074.9 1272.9 1283.2 1283.3 1287.5 871.4 879.7 881.2 887.3 906.2 5731.7 5802.2 5806.1 5976.3 6090.1 980.9 1018.7 1019.4 1019.8 1064.3 3445.5 3800.9 3897.9 4084.1 4109.3 9750.6 9760.6 9781.3 9845.8 10059.0 9723.2 9814.8 9877.5 9989.8 10018.8 6537.9 6660.0 7616.4 7676.6 7790.6 4879.3 5573.7 5696.3 5883.7 5923.9 7607.7 9022.4 9027.4 9317.9 9336.3 8817.4 9075.3 9076.6 9223.7 9240.8 5825.2 6193.3 6592.5 6833.2 7124.1 7538.0 7579.6 7580.0 7604.4 7648.3 6941.1 7221.6 7226.7 7297.3 7341.6 7083.3 7117.3 7142.9 7156.4 7265.5 5772.4 5880.0 6394.8 6471.3 6474.8 4774.1 4992.9 5074.4 5104.6 5156.5 4915.2 4945.6 5117.9 5230.5 5239.0 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4402.46 Median:4899.86 stddev:1332.80 (27.2%) stddev-sans-first:1301.40 14:26:21 INFO - PROCESS | 1641 | Values: 352.2 362.2 365.3 369.8 371.3 4896.9 5257.7 5301.8 5338.3 5348.7 4551.7 4743.7 5180.7 5270.0 5288.6 3371.8 3847.2 3975.1 4049.8 4073.6 3573.8 3612.9 4053.7 4080.4 4080.8 4060.6 4062.9 4069.8 4071.9 4072.2 3562.7 3650.7 3933.4 3997.8 4089.7 3137.3 3574.4 3579.8 3620.9 3655.6 4315.4 5116.4 5131.8 5153.5 5206.8 4124.9 4170.8 4314.5 4650.4 4731.0 5543.9 5577.7 5588.6 5590.9 5601.5 3816.7 3819.7 3827.3 3828.0 3831.8 4332.6 5541.2 5578.6 5808.5 5825.8 3039.7 3803.8 3820.4 3823.5 3832.3 3688.4 3860.6 3872.8 3876.1 3888.3 4283.6 4492.0 4503.9 4540.2 4548.4 4684.8 5317.8 5595.7 5621.8 5626.4 1086.6 1094.9 1234.6 1248.1 1252.7 806.8 843.7 849.6 862.7 877.7 4065.9 4286.6 4411.6 4730.4 4948.0 5266.4 5452.5 5472.4 5476.8 5491.9 4401.5 4528.7 4591.0 4928.0 5000.3 2608.8 2654.9 2759.6 2820.9 2836.9 5253.2 5356.7 5608.4 5632.6 5660.5 4814.3 5109.0 5402.2 5570.5 5696.0 4649.9 4687.4 4902.8 5101.8 5597.9 4934.6 5271.4 5384.0 5493.1 5499.6 4840.6 5029.5 5046.5 5379.4 5400.6 5425.4 5574.7 5604.7 5778.9 5798.2 3495.0 4024.7 4084.9 4122.0 4131.3 5637.7 5666.5 5667.8 5671.6 5681.3 4960.7 5182.5 5235.7 5257.9 5573.9 4837.8 5076.7 5254.1 5499.5 5505.2 4764.8 5401.8 5412.4 5413.0 5434.8 5192.4 5234.8 5476.0 5477.7 5490.5 4561.0 4862.8 5356.8 5385.2 5410.6 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20100.65 Median:4572.58 stddev:28412.55 (621.4%) stddev-sans-first:28454.97 14:26:21 INFO - PROCESS | 1641 | Values: 714.9 751.5 772.2 813.7 814.3 15044.5 15370.6 15556.2 15584.9 15596.6 14369.7 14518.3 14537.3 14539.7 14545.5 670.4 692.2 693.9 841.9 865.8 855.2 855.3 873.6 874.9 875.9 923.4 923.5 924.2 925.8 926.7 712.1 737.6 740.3 914.6 922.1 681.3 681.4 681.8 682.6 683.2 15007.5 15125.4 15163.7 15169.9 15177.7 10735.6 13281.5 13793.9 14092.9 14259.1 10397.6 12933.2 13136.6 13446.9 13723.0 4525.7 4570.8 4574.4 4740.6 4759.2 99693.9 101794.0 103875.5 105730.9 108286.5 10744.2 10914.6 10932.4 11008.8 11079.7 21129.9 21308.4 21325.1 21334.3 21372.8 7563.4 7650.1 7650.5 7740.1 7807.3 4244.7 4311.8 4316.4 4318.9 4442.8 3385.9 3400.4 3440.8 3467.2 3473.8 550.3 626.3 639.4 647.5 655.2 498.2 524.5 529.8 532.2 538.5 8606.4 9477.7 9499.8 9643.4 9844.5 620.3 628.0 644.8 653.2 667.2 4676.8 4694.4 4703.0 4749.7 4812.4 95750.5 98947.5 100088.0 100176.0 100758.0 89303.6 89604.7 92116.6 92206.0 93641.0 66948.7 67679.3 68033.0 69714.0 70444.6 10673.4 11161.6 11186.5 11460.4 11474.7 43190.1 46003.6 50083.5 51161.2 53505.0 60222.0 65132.0 65544.7 66206.8 66472.7 13083.8 13419.5 13473.0 13517.5 13892.6 14733.8 15033.0 15054.8 15082.8 15189.3 14073.9 14148.6 14229.6 14232.6 14730.3 13991.9 14012.8 14078.4 14413.0 14447.4 12639.3 13097.2 13736.8 13963.7 14512.9 11376.1 11432.6 11587.9 11678.3 11923.3 7976.0 9672.0 9937.7 9996.0 11145.8 14:26:21 INFO - PROCESS | 1641 | -------- Summary: end -------- 14:26:21 INFO - PROCESS | 1641 | 14:26:21 INFO - TEST-INFO | 1641: exit 0 14:26:21 INFO - TEST-OK | dromaeo_css | took 1118051ms 14:26:21 INFO - TEST-START | kraken 14:26:21 INFO - operating with platform_type : mac_ 14:26:21 INFO - Initialising browser for kraken test... 14:26:21 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpS6KGrH/profile http://localhost:49235/getInfo.html) 14:26:24 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 14:26:24 INFO - PROCESS | 1651 | colorDepth:24 14:26:24 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 14:26:24 INFO - PROCESS | 1651 | __metrics 14:26:24 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 14:26:24 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:26:24 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:25 INFO - TEST-INFO | 1651: exit 0 14:26:25 INFO - Browser initialized. 14:26:25 INFO - Running cycle 1/1 for kraken test... 14:26:25 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpS6KGrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:37 INFO - PROCESS | 1652 | RSS: Main: 236060672 14:26:37 INFO - PROCESS | 1652 | 14:26:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:40 INFO - PROCESS | 1652 | RSS: Main: 287682560 14:26:40 INFO - PROCESS | 1652 | 14:26:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 14:26:43 INFO - PROCESS | 1652 | RSS: Main: 287244288 14:26:43 INFO - PROCESS | 1652 | 14:26:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 14:26:47 INFO - PROCESS | 1652 | RSS: Main: 379822080 14:26:47 INFO - PROCESS | 1652 | 14:26:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 14:26:50 INFO - PROCESS | 1652 | RSS: Main: 283406336 14:26:50 INFO - PROCESS | 1652 | 14:26:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:53 INFO - PROCESS | 1652 | RSS: Main: 287457280 14:26:53 INFO - PROCESS | 1652 | 14:26:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:56 INFO - PROCESS | 1652 | RSS: Main: 330354688 14:26:56 INFO - PROCESS | 1652 | 14:26:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:59 INFO - PROCESS | 1652 | RSS: Main: 331223040 14:26:59 INFO - PROCESS | 1652 | 14:27:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 14:27:03 INFO - PROCESS | 1652 | RSS: Main: 328306688 14:27:03 INFO - PROCESS | 1652 | 14:27:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:05 INFO - PROCESS | 1652 | RSS: Main: 303247360 14:27:05 INFO - PROCESS | 1652 | 14:27:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:08 INFO - PROCESS | 1652 | RSS: Main: 308101120 14:27:08 INFO - PROCESS | 1652 | 14:27:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:11 INFO - PROCESS | 1652 | RSS: Main: 310448128 14:27:11 INFO - PROCESS | 1652 | 14:27:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:14 INFO - PROCESS | 1652 | RSS: Main: 329183232 14:27:14 INFO - PROCESS | 1652 | 14:27:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:18 INFO - PROCESS | 1652 | RSS: Main: 322441216 14:27:18 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 14:27:20 INFO - PROCESS | 1652 | RSS: Main: 366522368 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | __start_tp_report 14:27:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 14:27:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 14:27:20 INFO - PROCESS | 1652 | |i|pagename|runs| 14:27:20 INFO - PROCESS | 1652 | |0;ai-astar;113;114;114;112;113;114;114;114;114;114 14:27:20 INFO - PROCESS | 1652 | |1;audio-beat-detection;140;109;109;146;110;110;114;93;146;134 14:27:20 INFO - PROCESS | 1652 | |2;audio-dft;182;183;181;184;183;184;182;180;185;185 14:27:20 INFO - PROCESS | 1652 | |3;audio-fft;82;58;58;87;61;59;58;58;75;78 14:27:20 INFO - PROCESS | 1652 | |4;audio-oscillator;89;70;85;70;68;69;81;68;69;84 14:27:20 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;89;84;90;119;88;84;89;85;88;84 14:27:20 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;93;103;131;93;94;93;94;94;93 14:27:20 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;85;89;135;85;85;87;84;87;87 14:27:20 INFO - PROCESS | 1652 | |8;json-parse-financial;57;57;56;56;55;57;55;56;55;57 14:27:20 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;98;110;107;104;68;69;70;69;69 14:27:20 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;87;87;88;86;85;85;87;87;88 14:27:20 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;139;138;162;144;148;150;146;139;179;151 14:27:20 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;216;173;173;173;174;172;173;174;173;173 14:27:20 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;68;68;68;67;69;70;68;66;67 14:27:20 INFO - PROCESS | 1652 | __end_tp_report 14:27:20 INFO - PROCESS | 1652 | __start_cc_report 14:27:20 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1972 14:27:20 INFO - PROCESS | 1652 | __end_cc_report 14:27:20 INFO - PROCESS | 1652 | __startTimestamp1484951240338__endTimestamp 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | ------- Summary: start ------- 14:27:20 INFO - PROCESS | 1652 | Number of tests: 14 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 14:27:20 INFO - PROCESS | 1652 | Values: 113.0 114.0 114.0 112.0 113.0 114.0 114.0 114.0 114.0 114.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:137.00 stddev:18.69 (13.6%) stddev-sans-first:18.53 14:27:20 INFO - PROCESS | 1652 | Values: 140.0 109.0 109.0 146.0 110.0 110.0 114.0 93.0 146.0 134.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.66 (0.9%) stddev-sans-first:1.73 14:27:20 INFO - PROCESS | 1652 | Values: 182.0 183.0 181.0 184.0 183.0 184.0 182.0 180.0 185.0 185.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.40 Median:68.00 stddev:11.70 (17.2%) stddev-sans-first:11.16 14:27:20 INFO - PROCESS | 1652 | Values: 82.0 58.0 58.0 87.0 61.0 59.0 58.0 58.0 75.0 78.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:75.50 stddev:8.38 (11.1%) stddev-sans-first:7.28 14:27:20 INFO - PROCESS | 1652 | Values: 89.0 70.0 85.0 70.0 68.0 69.0 81.0 68.0 69.0 84.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:88.00 stddev:10.46 (11.9%) stddev-sans-first:11.08 14:27:20 INFO - PROCESS | 1652 | Values: 89.0 84.0 90.0 119.0 88.0 84.0 89.0 85.0 88.0 84.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:93.50 stddev:11.91 (12.7%) stddev-sans-first:12.54 14:27:20 INFO - PROCESS | 1652 | Values: 94.0 93.0 103.0 131.0 93.0 94.0 93.0 94.0 94.0 93.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:86.50 stddev:15.53 (18.0%) stddev-sans-first:16.36 14:27:20 INFO - PROCESS | 1652 | Values: 86.0 85.0 89.0 135.0 85.0 85.0 87.0 84.0 87.0 87.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:0.88 (1.5%) stddev-sans-first:0.87 14:27:20 INFO - PROCESS | 1652 | Values: 57.0 57.0 56.0 56.0 55.0 57.0 55.0 56.0 55.0 57.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:82.90 Median:69.00 stddev:19.08 (27.7%) stddev-sans-first:19.11 14:27:20 INFO - PROCESS | 1652 | Values: 65.0 98.0 110.0 107.0 104.0 68.0 69.0 70.0 69.0 69.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 14:27:20 INFO - PROCESS | 1652 | Values: 86.0 87.0 87.0 88.0 86.0 85.0 85.0 87.0 87.0 88.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:149.00 stddev:12.59 (8.4%) stddev-sans-first:12.76 14:27:20 INFO - PROCESS | 1652 | Values: 139.0 138.0 162.0 144.0 148.0 150.0 146.0 139.0 179.0 151.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:173.00 stddev:13.57 (7.8%) stddev-sans-first:0.60 14:27:20 INFO - PROCESS | 1652 | Values: 216.0 173.0 173.0 173.0 174.0 172.0 173.0 174.0 173.0 173.0 14:27:20 INFO - PROCESS | 1652 | 14:27:20 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 14:27:20 INFO - PROCESS | 1652 | Values: 68.0 68.0 68.0 68.0 67.0 69.0 70.0 68.0 66.0 67.0 14:27:20 INFO - PROCESS | 1652 | -------- Summary: end -------- 14:27:20 INFO - PROCESS | 1652 | 14:27:21 INFO - TEST-INFO | 1652: exit 0 14:27:21 INFO - TEST-OK | kraken | took 59424ms 14:27:21 INFO - SUITE-END | took 1177s 14:27:21 INFO - Completed test suite (00:19:37) 14:27:21 INFO - javascript benchmark 14:27:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.5683890577507, 3307.520409540615, 3330.5337252784607, 3334.4831551109573, 3394.71144952679, 5616.719164041802, 5668.801591944282, 5681.573881958854, 5724.169995350677, 5744.7127643617805, 4625.5836974672275, 5653.406392328798, 5672.914906276409, 5696.829095127143, 5725.4847063764255, 5203.843884683465, 5246.134387826014, 5260.316158899357, 5277.762500687479, 5299.019681358942, 5153.587712982952, 5272.99813035522, 5283.8150664726745, 5313.309269794921, 5314.574834013289, 4673.415823022122, 5303.257543943851, 5321.680699158043, 5330.200469929503, 5336.519713225809, 3804.220134872372, 5234.398044224925, 5280.735963201824, 5294.52349288564, 5374.113271310268, 4675.392199014106, 5142.768575414116, 5224.138017227191, 5227.451117632631, 5229.712365819878, 5654.519365853907, 5702.65784052954, 5725.112607545795, 5728.598998070137, 5745.569082318801, 6177.351378105279, 6184.659843708594, 6203.131561581382, 6205.0, 6206.224221972254, 5786.253547447593, 6241.531885108589, 6265.0, 6319.557630965788, 6349.682515874188, 5772.422757724194, 5876.265466816648, 5878.118282257696, 5904.61619994699, 5927.229460170193, 6178.907316390258, 6239.96880015597, 6244.2819075805955, 6319.399657032574, 6335.968320158369, 6164.3835616438, 6242.906356404657, 6250.15622890913, 6250.718717657716, 6252.749890004349, 6293.37066293367, 6296.433321001132, 6297.779577714758, 6302.432781049728, 6308.053791931247, 6091.5735898487565, 6110.5587591967305, 6277.497800175975, 6290.528210384239, 6292.0, 6180.7527698891545, 6191.535634827406, 6201.596896201732, 6202.34875338092, 6209.813705588839, 5019.071471777733, 5021.422536408287, 5037.219231019198, 5052.671576347526, 5053.620978426633, 4386.320120381346, 4414.359917811964, 4414.646828253732, 4420.734755914656, 4451.998300382388, 5593.860153496195, 5731.971340143273, 5801.731860256726, 5819.127130930395, 5863.853403664943, 6257.092721555349, 6257.2804127525005, 6261.217347831521, 6291.874162516724, 6296.370362963667, 5826.242588463472, 5836.387179346192, 5862.413758624103, 5869.090291004901, 5874.412558744177, 5467.097928841776, 5503.944960550343, 5510.090835012178, 5523.364813046551, 5526.613137080366, 6238.594491358047, 6242.469390101892, 6317.273513545817, 6323.272823625342, 6341.651209183539, 6279.403456671609, 6345.587536810092, 6348.555601107878, 6367.745290188526, 6375.968120159369, 6324.557280990287, 6330.366963303817, 6350.936490635035, 6378.1070650108095, 6387.840303992437, 6102.186302349, 6152.169457123231, 6226.40849119333, 6251.124842522141, 6257.374262573706, 5251.0, 6235.937640623717, 6261.092141639528, 6305.085762564494, 6358.046293056079, 5122.410922743932, 5864.706764661664, 6192.225971753531, 6193.349698281616, 6208.1308616792785, 5966.075258334965, 6130.019196928649, 6174.506039516738, 6192.535559832941, 6193.473554747897, 5904.3210030845285, 5981.880362392815, 6022.879542409215, 6048.939510604838, 6060.666663333559, 6136.6011209271255, 6165.255079724711, 6189.442950134509, 6221.3156552778255, 6228.314885362516, 5854.356020837789, 5900.822975310747, 5918.319393269657, 6068.027890935376, 6103.792276408585], "value": 5702.3132979693155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.4043922680902, 487.05754365303164, 502.9974850125749, 509.40908546086524, 520.1365732883414, 30589.54115688264, 39508.604913950854, 41264.79367603165, 41335.0, 41390.0, 42649.36025959613, 42900.3564946526, 42904.785476072655, 42968.140637187236, 43064.56935430645, 9265.629374825015, 9472.100150485692, 9479.95260023699, 9492.620295188184, 9499.620015199383, 8427.199416055464, 8642.611082501271, 11119.833202501968, 11447.942760286187, 11458.942705286461, 11382.260153090065, 11428.657140285804, 11438.084953203765, 11442.199046066778, 11447.08423326132, 11281.210315277935, 11363.090952723804, 11365.659030229106, 11371.204015718902, 11372.203945723802, 8260.8347833043, 8494.108118647577, 8505.064442911274, 8609.655613775503, 10899.455027248607, 38767.418488722695, 40694.982625434306, 40716.98207544805, 40878.38682419736, 40880.79559602183, 4040.878773636796, 4069.1658210066867, 4074.0, 4098.672106231525, 4179.143275628519, 29649.555256671167, 30564.54153187704, 30600.08199754011, 30811.537826932614, 30878.382432351227, 3141.858616362269, 3243.3189030303665, 3268.983655081733, 3277.213468767479, 3332.5501057357187, 337584.0, 339445.0, 339880.0, 339996.99999999756, 340865.0, 50320.49679503231, 58837.0, 60644.39355606387, 61029.38970610326, 61162.69418652878, 63715.36284637187, 63858.36141638617, 63935.0, 63944.0, 63965.04052439217, 15730.213489325488, 15960.36158553668, 15991.600209994844, 15992.76010859838, 16010.199490025685, 11222.831657525143, 11862.406879655982, 11933.224340417844, 12352.44414001372, 12429.627111186679, 14538.909581781198, 14946.92526537382, 16422.917885410498, 16638.417655382003, 16860.662786744197, 6249.78125765596, 7251.891221631679, 7282.672279747424, 7401.851962960711, 7446.393762183193, 879.5162660536679, 880.8678698195322, 894.5348418822176, 917.8393781088283, 922.5479515037583, 29438.705612944024, 29443.411131777244, 29607.25981850471, 29865.0, 30080.69919300779, 954.7298910016669, 1000.8140353680911, 1067.813132701774, 1100.8844071372391, 1119.5186069989982, 13791.241481718602, 15387.230638468032, 15428.691426171414, 15652.982556133815, 15727.528174154793, 570872.0, 573064.0, 574249.0, 575185.0, 576425.0, 59526.0, 59837.40162598405, 59895.401045989856, 59960.10059849106, 60006.0, 1292.8642492538336, 1411.4636438153436, 1460.8466111058399, 1472.1461552299854, 1473.049882825593, 28218.43563128767, 28982.56526152067, 29050.0, 29855.0, 29946.25134371658, 50244.95590793692, 50377.49622503728, 50387.496125038284, 50451.0, 50501.49498504968, 490562.0, 492680.2685718091, 492716.0, 492993.0, 493144.0, 36715.44926826046, 38915.6108438912, 39448.40827387534, 39716.2056758869, 39778.0, 40470.79764601158, 45802.0, 46066.0, 46184.84336409739, 46223.53776462192, 30305.0, 34391.82804085963, 34744.652553474145, 35383.29233415369, 37916.24167516579, 37011.0, 37303.81348093242, 38356.041098972746, 38442.80778596089, 38507.80746096364, 36166.457503136946, 36311.09222269464, 36823.0, 37173.0, 37653.246935061696, 25169.748302516742, 31543.053708388787, 33312.00063998084, 33655.0, 33701.66298336985, 24430.87784561066, 24475.877620611784, 24930.626040609044, 25094.874525627256, 25120.0], "value": 19719.248867104736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8739028730231, 391.54189598170143, 395.3141299844767, 397.8150160175519, 425.4596662238957, 14647.853521464796, 17961.910190449045, 20654.586908261826, 21778.564428711416, 21977.23079692211, 19982.900085499554, 20967.580648387062, 21048.052837622305, 21077.894610526964, 21333.57332853342, 5183.807724223431, 5883.176355310249, 6140.815775526741, 6148.292946311164, 6159.784407545737, 6031.3413811201835, 6064.3026052003925, 6092.147099406086, 6092.6953652317425, 6138.47822935051, 5767.711614419283, 5904.645721256738, 6036.366181550918, 6038.909416358758, 6048.969755151218, 5905.232319798421, 5979.910301345483, 5987.790427335044, 5990.73041713124, 5993.071073983496, 5091.592672586185, 5117.667351622133, 5232.241325007891, 5233.293505376763, 5242.449542798027, 25241.495170096496, 25274.0, 25294.1147059852, 25449.92801151807, 25493.745062549508, 2408.205292253552, 2791.2742686901347, 2820.0, 2823.435312937421, 2899.376634023695, 14743.852561474356, 14834.777478337834, 15738.527844164693, 15739.213039348102, 15904.602384940354, 1821.799602043774, 1882.181251155738, 1890.810918908112, 1891.2718603337814, 1892.1201641236892, 123933.14100288502, 125267.12099318518, 127771.0, 129763.35118324442, 130623.0, 11124.777504450027, 11235.438228088726, 11362.48868800906, 11373.0, 11484.081273498101, 14224.28878556068, 14274.643133921734, 14290.356933937997, 14292.213928234047, 14292.428302867977, 8346.958265208636, 8502.234798868132, 8552.562728926221, 8623.611937462829, 8646.870296945552, 8464.195901389357, 8468.364872634576, 8644.740657780276, 8646.351523635627, 8685.218330350299, 5660.518855897295, 6971.8605627887155, 7006.544574602634, 7015.9298407016295, 7025.92974070263, 1887.3960332693407, 1918.2998205654835, 1919.9856225725755, 1923.7210604462555, 1924.4130540185097, 913.8219287496619, 1049.7218237167158, 1055.4406164732704, 1077.256692881909, 1104.2049724198564, 22337.218197363338, 22354.32937011892, 22414.43963900883, 22564.66153007706, 22608.869556522437, 1064.6327017179215, 1072.2976450424985, 1093.868735751699, 1099.1591432554103, 1101.9063379612824, 10588.417637029883, 11737.550631403397, 11818.468168932246, 11836.230645008047, 11957.043436525057, 690760.0, 700370.0, 701744.0, 706715.0, 715943.6811263745, 90190.0, 94111.58832617379, 113122.2123990501, 128835.0, 131048.3447582756, 1015.6648306058983, 1015.664830605913, 1041.2086814021397, 1042.6298663974333, 1043.2801367056707, 18913.959732214862, 19161.61676766429, 19171.61656766829, 19310.517237069187, 19360.70958935589, 48041.0, 49363.753181233864, 55821.720891395285, 57306.713466432404, 57546.7122664384, 76182.4763504738, 77900.66298011069, 78216.82674759997, 78884.0, 79022.56616375115, 5738.512226460798, 8038.503251085796, 8073.71741989051, 8290.046644635944, 8379.45533540318, 12696.936515317733, 13184.736305274033, 13583.32083395846, 13703.862961370658, 13821.378037988516, 10330.638427654996, 11101.222914395914, 11192.776144477228, 11623.883761162619, 11939.0, 9419.340646154704, 9632.855507167538, 10115.7471063224, 11223.38271395081, 11675.532978681098, 11317.547298107984, 11636.41817909118, 11640.301581905112, 11674.70813229676, 11779.293242405483, 8277.213664701843, 8330.166983301622, 8571.485710857369, 8586.957065214634, 8739.694110706349, 11145.721356965816, 11282.661520154408, 11397.373144477133, 11770.76458470843, 11820.0543956485], "value": 10024.778757075408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.2062365698862, 1446.9204193769338, 1458.445790599572, 1467.7431449496335, 1472.801171841801, 7957.283844453998, 8351.4989100654, 8387.370947178955, 8392.580370981457, 8396.992360916684, 7407.25927407259, 7618.73334433295, 7647.426443016768, 7953.681852725898, 8164.469309494879, 2256.7743225677423, 2313.2135074074813, 2314.5486630107134, 2316.5714342846545, 2321.059970711856, 2309.099451214028, 2338.38032921276, 2339.9181028664, 2341.988290058547, 2344.589696803061, 2302.412884714404, 2317.756635553268, 2327.8836058197107, 2335.0309621507054, 2338.672585837984, 2286.6798648189183, 2312.190733243368, 2313.595120853844, 2314.837961342707, 2317.80298674612, 2251.6172250717254, 2321.68657231275, 2330.300909727092, 2331.9300420987397, 2332.661764044221, 7639.388848892076, 7661.272179142972, 8183.631736571869, 8261.669533218665, 8284.420090593661, 4980.551750342486, 5120.334356533627, 5140.820071297524, 5145.07388670043, 5145.794168233266, 2879.9136025919256, 3176.888808891678, 3254.332861763333, 3440.6559344065645, 3446.293509830479, 1195.4799662146906, 1195.7429152732204, 1231.0828432817518, 1245.103525461666, 1249.375312343828, 10543.209259305506, 10645.733856653645, 10689.091427228695, 10692.625758098508, 10709.839352409643, 4365.3670217818235, 4573.268277075652, 4640.8375706850775, 4647.790849411785, 4658.697184683053, 9372.06279372071, 9389.953050234704, 9399.24806015517, 9405.952970235105, 9410.623575056921, 5185.118529849935, 5192.909489007276, 5194.220866869924, 5204.479552044841, 5213.895722085613, 4186.351115577029, 4441.666874984389, 4642.373279607277, 4712.2224832902875, 4748.667593268438, 3763.7553559018575, 3771.2268984858038, 3842.9615703842605, 3877.2439374322303, 3897.512810898638, 1074.8925107489345, 1272.8790764877508, 1283.2428866968532, 1283.332667013148, 1287.523616261989, 871.4335681806876, 879.6921077622909, 881.1981097201644, 887.2990337633327, 906.225177473264, 5731.656100633975, 5802.158686990447, 5806.129080637854, 5976.266882603996, 6090.086487026892, 980.8528720691811, 1018.7453136715822, 1019.4444028004755, 1019.7756493571402, 1064.2816099133054, 3445.4831775233915, 3800.9049773755323, 3897.922041559153, 4084.101497670508, 4109.3425051991535, 9750.561224744763, 9760.609575616896, 9781.266405019653, 9845.75385615351, 10059.0, 9723.222142228604, 9814.7805981552, 9877.506124693737, 9989.750256243651, 10018.849717254247, 6537.901931471032, 6660.000999850061, 7616.428767842434, 7676.616169191518, 7790.610469476617, 4879.316895634543, 5573.749181286933, 5696.259486266758, 5883.735231914488, 5923.851903702442, 7607.657655405409, 9022.413543119676, 9027.375072487015, 9317.86023209666, 9336.253099752139, 8817.382783205114, 9075.319351048565, 9076.636934522809, 9223.677171299241, 9240.768980775534, 5825.184474173534, 6193.287771906288, 6592.505562082959, 6833.214180369122, 7124.109486314211, 7537.962310188634, 7579.621018949141, 7580.0145981022115, 7604.353629941295, 7648.311651951351, 6941.0629565010095, 7221.566705997657, 7226.74706385274, 7297.270272972661, 7341.559506429631, 7083.327083927019, 7117.252688467636, 7142.9285707144345, 7156.355927966508, 7265.4550908681, 5772.422757724194, 5880.029795083763, 6394.808155755335, 6471.288158302677, 6474.838129046811, 4774.140654682191, 4992.8751781205765, 5074.391073071255, 5104.642675012714, 5156.510131537498, 4915.18899381598, 4945.578771748526, 5117.948820511747, 5230.529252367305, 5239.0], "value": 4393.254472045711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.24619314666614, 362.226646110554, 365.2986266368572, 369.83911998280735, 371.3408699558282, 4896.894335435762, 5257.7402010753385, 5301.814436494724, 5338.3327084114435, 5348.679079255247, 4551.749653769041, 4743.675598956513, 5180.6632568883, 5270.0, 5288.5504732097725, 3371.7808342457784, 3847.2497862916744, 3975.0658595230097, 4049.8380064797375, 4073.6130067643676, 3573.767050367632, 3612.8735494257708, 4053.736507127042, 4080.4491393661774, 4080.7551546907134, 4060.593940605945, 4062.878113656595, 4069.8168582413864, 4071.9185616287805, 4072.1855628874346, 3562.6615471530163, 3650.689691376236, 3933.370660694275, 3997.8200980955926, 4089.666921459016, 3137.294108825519, 3574.4272520091336, 3579.8031108289033, 3620.8913732588067, 3655.6161603031564, 4315.410753547846, 5116.386033675945, 5131.769070391804, 5153.510416510426, 5206.817761378334, 4124.90689967159, 4170.77060761658, 4314.460692413449, 4650.395448591661, 4730.95269047312, 5543.944560554423, 5577.713137613599, 5588.580856435784, 5590.91613625796, 5601.523870471015, 3816.694664426867, 3819.7135214858718, 3827.3302172119766, 3828.0, 3831.770093794353, 4332.631726303236, 5541.168824676331, 5578.609497335188, 5808.535317174658, 5825.825225243249, 3039.6656367799524, 3803.7937995962275, 3820.3887378019385, 3823.5220597425323, 3832.3329351732086, 3688.381249312964, 3860.575336712959, 3872.806359682061, 3876.127871228951, 3888.319544079775, 4283.565005723055, 4491.955080449219, 4503.909921801545, 4540.160070386989, 4548.431446069241, 4684.765761711901, 5317.813876514381, 5595.720213989365, 5621.8194179222, 5626.409227031185, 1086.6142519405498, 1094.861344202021, 1234.6110975042832, 1248.0701877101617, 1252.7369252456904, 806.8184658451802, 843.6667516331015, 849.6176720475811, 862.6800994478458, 877.6621000914566, 4065.89835254121, 4286.592773686495, 4411.558844115627, 4730.408698912636, 4947.950520494821, 5266.368035835724, 5452.454754524516, 5472.415567803096, 5476.7535460904355, 5491.945080549223, 4401.493828209796, 4528.682992190581, 4590.96703241768, 4928.0, 5000.3249561309485, 2608.752168543985, 2654.9380247900995, 2759.6274502941847, 2820.9407132792767, 2836.9219696515192, 5253.185756207794, 5356.705381204071, 5608.439156084441, 5632.633878797865, 5660.462256085665, 4814.325994360793, 5108.952664703726, 5402.163863971368, 5570.470805273492, 5696.0031994400815, 4649.930515981343, 4687.367205427224, 4902.823322402598, 5101.811367895066, 5597.860053498695, 4934.570473520868, 5271.4464981176425, 5383.973080134574, 5493.061212251427, 5499.642523235977, 4840.564349208588, 5029.471905450021, 5046.460829447054, 5379.4082650907585, 5400.567954563704, 5425.419223312595, 5574.749136288796, 5604.747786349542, 5778.913316300175, 5798.173575323928, 3494.982525087358, 4024.657904078186, 4084.8570300039355, 4122.031322639117, 4131.318332475108, 5637.746301416364, 5666.46168613981, 5667.838093190969, 5671.631343962629, 5681.346645135697, 4960.677555958851, 5182.486494050458, 5235.65968212065, 5257.89484210306, 5573.860653483695, 4837.750446042607, 5076.7207803571155, 5254.054270231242, 5499.450054994469, 5505.229267902577, 4764.78558464863, 5401.783928642967, 5412.404635490014, 5412.972935135299, 5434.809781657623, 5192.429747275123, 5234.842954711365, 5476.0, 5477.726113694379, 5490.533304669148, 4560.977195114003, 4862.763128960718, 5356.812511562077, 5385.246065550904, 5410.567154627699], "value": 3988.889775447688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8570285942812, 751.526538280883, 772.239344245918, 813.7355359508159, 814.2712272516098, 15044.548663540085, 15370.615734606641, 15556.222188890539, 15584.922075389635, 15596.610084747872, 14369.712605747878, 14518.34667439965, 14537.345819438124, 14539.709205815903, 14545.490907818228, 670.3932940688685, 692.2350802363392, 693.9167299924017, 841.877927700483, 865.8138500222451, 855.1832999485507, 855.2730179347567, 873.5806812729893, 874.8906386701663, 875.8729984152294, 923.4090182283344, 923.5059243304834, 924.1959495239151, 925.8287216864868, 926.6988228825625, 712.1276436365437, 737.5832654550215, 740.3078121955988, 914.6478605736839, 922.064104933493, 681.3118750062423, 681.4105798484325, 681.8431760695019, 682.5529278322707, 683.1801837794617, 15007.549773506813, 15125.394984200619, 15163.696726065527, 15169.924150379287, 15177.696446071128, 10735.62425315118, 13281.535146269835, 13793.931030344884, 14092.929535352258, 14259.07316024455, 10397.636082737068, 12933.224006559543, 13136.605901822864, 13446.86553134466, 13723.0, 4525.660575456854, 4570.771461426949, 4574.382458368111, 4740.620750339965, 4759.214729569617, 99693.91045516558, 101794.0, 103875.48062259716, 105730.94269057288, 108286.45856770745, 10744.247902646739, 10914.56341746337, 10932.360325644757, 11008.779824403468, 11079.72300692473, 21129.943502824797, 21308.36074917755, 21325.146994120372, 21334.253301134388, 21372.78627213739, 7563.394928405714, 7650.120236172911, 7650.4644674872225, 7740.109887363025, 7807.297343239135, 4244.702870799015, 4311.784410779511, 4316.417283666728, 4318.935215971763, 4442.777861106932, 3385.9492107618407, 3400.438927576922, 3440.8451619677176, 3467.1678797088516, 3473.8263086845554, 550.2901257377938, 626.332955402504, 639.3574457670012, 647.543481845298, 655.1515787055774, 498.17054604083796, 524.4755244755245, 529.8172130614931, 532.2229544864541, 538.5072658517491, 8606.44058136219, 9477.6731257624, 9499.810003799885, 9643.373180743369, 9844.458554779556, 620.3486339343671, 627.9529035322278, 644.8226737647091, 653.2498182651092, 667.2393471442559, 4676.766161691902, 4694.422937635778, 4702.976485117552, 4749.667523273338, 4812.422509298906, 95750.52124739472, 98947.50526247322, 100088.0, 100176.0, 100757.98484030279, 89303.55348223218, 89604.6559301611, 92116.61825072629, 92206.0, 93641.0, 66948.66525667341, 67679.32320676927, 68033.0, 69713.95429068568, 70444.64777676079, 10673.41296228715, 11161.609343672932, 11186.496607652512, 11460.426978651201, 11474.655760327203, 43190.13619727525, 46003.61989140331, 50083.49916500934, 51161.23258151205, 53505.0, 60222.0, 65132.0, 65544.67227663832, 66206.75864826958, 66472.66763666151, 13083.803742943674, 13419.472174755641, 13473.0, 13517.459301627825, 13892.583222503341, 14733.778993315324, 15033.022853514487, 15054.849451505344, 15082.773758393414, 15189.31648075817, 14073.859261407255, 14148.646283842987, 14229.64425889361, 14232.644183895485, 14730.26348682583, 13991.860081399056, 14012.789808152682, 14078.370854815086, 14413.0, 14447.422103115758, 12639.304838233986, 13097.214167150001, 13736.793948090586, 13963.650908727363, 14512.854871451573, 11376.089912807121, 11432.599859004895, 11587.942060289644, 11678.299302041565, 11923.284602923852, 7976.0, 9672.02954956736, 9937.652182173879, 9995.950425205248, 11145.832812507657], "value": 7445.644587141325, "unit": "score"}], "name": "dromaeo_css", "value": 7265.53568792087, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 112.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 146.0, 110.0, 110.0, 114.0, 93.0, 146.0, 134.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 181.0, 184.0, 183.0, 184.0, 182.0, 180.0, 185.0, 185.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 87.0, 61.0, 59.0, 58.0, 58.0, 75.0, 78.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 70.0, 68.0, 69.0, 81.0, 68.0, 69.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 90.0, 119.0, 88.0, 84.0, 89.0, 85.0, 88.0, 84.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 103.0, 131.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 89.0, 135.0, 85.0, 85.0, 87.0, 84.0, 87.0, 87.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 98.0, 110.0, 107.0, 104.0, 68.0, 69.0, 70.0, 69.0, 69.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 88.0, 86.0, 85.0, 85.0, 87.0, 87.0, 88.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 162.0, 144.0, 148.0, 150.0, 146.0, 139.0, 179.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 173.0, 173.0, 173.0, 174.0, 172.0, 173.0, 174.0, 173.0, 173.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 69.0, 70.0, 68.0, 66.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1460.0, "alertThreshold": 2.0}]} 14:27:21 INFO - Return code: 0 14:27:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:21 ERROR - # TBPL SUCCESS # 14:27:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:27:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:27:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:27:21 INFO - 2017-01-20 14:27:21.629 screenresolution[1656:9741] starting screenresolution argv=screenresolution get 14:27:21 INFO - 2017-01-20 14:27:21.632 screenresolution[1656:9741] Display 0: 1600x1200x32@60 14:27:21 INFO - 2017-01-20 14:27:21.638 screenresolution[1657:9744] starting screenresolution argv=screenresolution list 14:27:21 INFO - Available Modes on Display 0 14:27:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:27:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:27:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:27:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:27:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:27:21 INFO - Intel Iris: 14:27:21 INFO - Chipset Model: Intel Iris 14:27:21 INFO - Type: GPU 14:27:21 INFO - Bus: Built-In 14:27:21 INFO - VRAM (Dynamic, Max): 1536 MB 14:27:21 INFO - Vendor: Intel (0x8086) 14:27:21 INFO - Device ID: 0x0a2e 14:27:21 INFO - Revision ID: 0x0009 14:27:21 INFO - Displays: 14:27:21 INFO - Display: 14:27:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:27:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:27:21 INFO - Display Serial Number: 1600x1200 60 14:27:21 INFO - Main Display: Yes 14:27:21 INFO - Mirror: Off 14:27:21 INFO - Online: Yes 14:27:21 INFO - Rotation: Supported 14:27:21 INFO - Return code: 0 14:27:21 INFO - Running post-action listener: _resource_record_post_action 14:27:21 INFO - [mozharness: 2017-01-20 22:27:21.883950Z] Finished run-tests step (success) 14:27:21 INFO - Running post-run listener: _resource_record_post_run 14:27:21 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 36656128; Write bytes: 551286784; Read time: 380; Write time: 1743 14:27:21 INFO - TinderboxPrint: CPU usage
53.7% 14:27:21 INFO - TinderboxPrint: I/O read bytes / time
36,656,128 / 380 14:27:21 INFO - TinderboxPrint: I/O write bytes / time
551,286,784 / 1,743 14:27:21 INFO - TinderboxPrint: CPU idle
2,222.7 (46.3%) 14:27:21 INFO - TinderboxPrint: CPU system
957.4 (19.9%) 14:27:21 INFO - TinderboxPrint: CPU user
1,621.4 (33.8%) 14:27:21 INFO - TinderboxPrint: Swap in / out
287,891,456 / 0 14:27:21 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243382784; Write bytes: 235732992; Read time: 17675; Write time: 413 14:27:21 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34694144; Write bytes: 298043392; Read time: 359; Write time: 1286 14:27:22 INFO - Running post-run listener: _upload_blobber_files 14:27:22 INFO - Blob upload gear active. 14:27:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:22 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 14:27:22 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:27:22 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:27:22 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:23 INFO - (blobuploader) - INFO - Done attempting. 14:27:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:27:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:24 INFO - (blobuploader) - INFO - Done attempting. 14:27:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:27:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:25 INFO - (blobuploader) - INFO - Done attempting. 14:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:28 INFO - (blobuploader) - INFO - Done attempting. 14:27:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:28 INFO - Return code: 0 14:27:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f536459f18d0bcc2f5d69a5f4872e771d4956e80245340bce6823e5d43a8d68ab9a6260e8971795ae64074cbd7fbe686957eee94a5e74afb84327dbb9c06eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3a2a5aa79eb689254e87623cec71f9cdd6392a6b067c0bfb6f19b5127b33b3df9d49b600d0c2860a80cd6619daca59e1b9357c1665aed431b099049c807a2aa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e8cec5bce900399725dd9e0535b794e88871ddf1ecbd6d970eb035255002d368c42bb53764074565455963f129be15fb0dbf12fd27afdc56bc549080b423908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bee64db40067910141c6504b40701cb3b40c283cf434c119ea61af440ec30e8a7dff82e051fe6a6de4e8ca0056b412619dea2d723c8c2416dbf3410da8150d7f"} 14:27:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:28 INFO - Contents: 14:27:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f536459f18d0bcc2f5d69a5f4872e771d4956e80245340bce6823e5d43a8d68ab9a6260e8971795ae64074cbd7fbe686957eee94a5e74afb84327dbb9c06eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3a2a5aa79eb689254e87623cec71f9cdd6392a6b067c0bfb6f19b5127b33b3df9d49b600d0c2860a80cd6619daca59e1b9357c1665aed431b099049c807a2aa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e8cec5bce900399725dd9e0535b794e88871ddf1ecbd6d970eb035255002d368c42bb53764074565455963f129be15fb0dbf12fd27afdc56bc549080b423908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bee64db40067910141c6504b40701cb3b40c283cf434c119ea61af440ec30e8a7dff82e051fe6a6de4e8ca0056b412619dea2d723c8c2416dbf3410da8150d7f"} 14:27:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:28 INFO - Copying logs to upload dir... 14:27:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.378801 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-20 14:27:28.247639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 14:27:28.251174) ========= 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.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/Graphics/sha512/9f536459f18d0bcc2f5d69a5f4872e771d4956e80245340bce6823e5d43a8d68ab9a6260e8971795ae64074cbd7fbe686957eee94a5e74afb84327dbb9c06eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3a2a5aa79eb689254e87623cec71f9cdd6392a6b067c0bfb6f19b5127b33b3df9d49b600d0c2860a80cd6619daca59e1b9357c1665aed431b099049c807a2aa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e8cec5bce900399725dd9e0535b794e88871ddf1ecbd6d970eb035255002d368c42bb53764074565455963f129be15fb0dbf12fd27afdc56bc549080b423908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bee64db40067910141c6504b40701cb3b40c283cf434c119ea61af440ec30e8a7dff82e051fe6a6de4e8ca0056b412619dea2d723c8c2416dbf3410da8150d7f"} build_url:https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/ba450oDXQYa0TrMUpU454w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f536459f18d0bcc2f5d69a5f4872e771d4956e80245340bce6823e5d43a8d68ab9a6260e8971795ae64074cbd7fbe686957eee94a5e74afb84327dbb9c06eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3a2a5aa79eb689254e87623cec71f9cdd6392a6b067c0bfb6f19b5127b33b3df9d49b600d0c2860a80cd6619daca59e1b9357c1665aed431b099049c807a2aa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e8cec5bce900399725dd9e0535b794e88871ddf1ecbd6d970eb035255002d368c42bb53764074565455963f129be15fb0dbf12fd27afdc56bc549080b423908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bee64db40067910141c6504b40701cb3b40c283cf434c119ea61af440ec30e8a7dff82e051fe6a6de4e8ca0056b412619dea2d723c8c2416dbf3410da8150d7f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 14:27:28.288619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:27:28.289214) ========= 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.IO3U0AxpzI/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.2I68NiultD/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005286 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 14:27:28.340522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 14:27:28.341294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 14:27:28.342022) ========= ========= Total master_lag: 0.18 =========