builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0237 starttime: 1482289459.23 results: success (0) buildid: 20161220174153 builduid: 06068e8dcc094fa1981d24c4838524df revision: 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.227731) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.228287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.228632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.259608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.259997) ========= 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.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-20 19:04:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2016-12-20 19:04:19 (20.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092670 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.378256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.378689) ========= 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.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.025521 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:19.428866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 19:04:19.429959) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 --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 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-20 19:04:19,525 truncating revision to first 12 chars 2016-12-20 19:04:19,526 Setting DEBUG logging. 2016-12-20 19:04:19,526 attempt 1/10 2016-12-20 19:04:19,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7a4e657e1d42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 19:04:20,539 unpacking tar archive at: graphics-7a4e657e1d42/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285556 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 19:04:20.740956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:20.741400) ========= script_repo_revision: 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:20.742307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:20.742952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 19:04:20.765157) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-20 19:04:20.765839) ========= /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.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:04:20 INFO - MultiFileLogger online at 20161220 19:04:20 in /builds/slave/test 19:04:20 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 19:04:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:20 INFO - {'append_to_log': False, 19:04:20 INFO - 'base_work_dir': '/builds/slave/test', 19:04:20 INFO - 'blob_upload_branch': 'Graphics', 19:04:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:20 INFO - 'branch': 'Graphics', 19:04:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:20 INFO - 'config_files': ('talos/mac_config.py',), 19:04:20 INFO - 'default_actions': ('clobber', 19:04:20 INFO - 'read-buildbot-config', 19:04:20 INFO - 'download-and-extract', 19:04:20 INFO - 'populate-webroot', 19:04:20 INFO - 'create-virtualenv', 19:04:20 INFO - 'install', 19:04:20 INFO - 'run-tests'), 19:04:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:20 INFO - 'download_minidump_stackwalk': True, 19:04:20 INFO - 'download_symbols': 'ondemand', 19:04:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:20 INFO - 'installer_path': 'installer.exe', 19:04:20 INFO - 'log_level': 'info', 19:04:20 INFO - 'log_name': 'talos', 19:04:20 INFO - 'log_to_console': True, 19:04:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:04:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:04:20 INFO - 'opt_config_files': (), 19:04:20 INFO - 'pip_index': False, 19:04:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:04:20 INFO - 'cmd': ('bash', 19:04:20 INFO - '-c', 19:04:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:04:20 INFO - 'enabled': True, 19:04:20 INFO - 'halt_on_failure': False, 19:04:20 INFO - 'name': 'check_screen_resolution'},), 19:04:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:04:20 INFO - 'cmd': ('bash', 19:04:20 INFO - '-c', 19:04:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:04:20 INFO - 'enabled': True, 19:04:20 INFO - 'halt_on_failure': False, 19:04:20 INFO - 'name': 'check_screen_resolution'},), 19:04:20 INFO - 'run_cmd_checks_enabled': True, 19:04:20 INFO - 'sps_profile': False, 19:04:20 INFO - 'sps_profile_interval': 0, 19:04:20 INFO - 'suite': 'dromaeojs', 19:04:20 INFO - 'system_bits': '32', 19:04:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:20 INFO - 'title': 't-yosemite-r7-0237', 19:04:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:20 INFO - 'use_talos_json': True, 19:04:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:20 INFO - 'work_dir': 'build'} 19:04:20 INFO - [mozharness: 2016-12-21 03:04:20.971312Z] Running clobber step. 19:04:20 INFO - Running pre-action listener: _resource_record_pre_action 19:04:20 INFO - Running main action method: clobber 19:04:20 INFO - rmtree: /builds/slave/test/build 19:04:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:23 INFO - Running post-action listener: _resource_record_post_action 19:04:23 INFO - [mozharness: 2016-12-21 03:04:23.282583Z] Finished clobber step (success) 19:04:23 INFO - [mozharness: 2016-12-21 03:04:23.282709Z] Running read-buildbot-config step. 19:04:23 INFO - Running pre-action listener: _resource_record_pre_action 19:04:23 INFO - Running main action method: read_buildbot_config 19:04:23 INFO - Using buildbot properties: 19:04:23 INFO - { 19:04:23 INFO - "project": "", 19:04:23 INFO - "product": "firefox", 19:04:23 INFO - "script_repo_revision": "default", 19:04:23 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 19:04:23 INFO - "repository": "", 19:04:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 19:04:23 INFO - "buildid": "20161220174153", 19:04:23 INFO - "pgo_build": "False", 19:04:23 INFO - "basedir": "/builds/slave/test", 19:04:23 INFO - "buildnumber": 10, 19:04:23 INFO - "slavename": "t-yosemite-r7-0237", 19:04:23 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:04:23 INFO - "platform": "yosemite_r7", 19:04:23 INFO - "scheduler": "tests-graphics-macosx64-talos", 19:04:23 INFO - "branch": "graphics", 19:04:23 INFO - "repo_path": "projects/graphics", 19:04:23 INFO - "revision": "7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262", 19:04:23 INFO - "stage_platform": "macosx64", 19:04:23 INFO - "builduid": "06068e8dcc094fa1981d24c4838524df", 19:04:23 INFO - "slavebuilddir": "test" 19:04:23 INFO - } 19:04:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:04:23 INFO - Running post-action listener: _resource_record_post_action 19:04:23 INFO - [mozharness: 2016-12-21 03:04:23.288241Z] Finished read-buildbot-config step (success) 19:04:23 INFO - [mozharness: 2016-12-21 03:04:23.288378Z] Running download-and-extract step. 19:04:23 INFO - Running pre-action listener: _resource_record_pre_action 19:04:23 INFO - Running main action method: download_and_extract 19:04:23 INFO - mkdir: /builds/slave/test/build/tests 19:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:23 INFO - trying https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:04:23 INFO - Downloading https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/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 19:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/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 19:04:24 INFO - Downloaded 1199 bytes. 19:04:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:04:24 INFO - Using the following test package requirements: 19:04:24 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:04:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:04:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:04:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'jsshell-mac.zip'], 19:04:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:04:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:04:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:04:24 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:04:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:04:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:04:24 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:04:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:04:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:04:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:04:24 INFO - Fetch https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:04:25 INFO - Expected file size: 16276040 19:04:25 INFO - Obtained file size: 16276040 19:04:31 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 19:04:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:04:32 INFO - Expected file size: 16276040 19:04:32 INFO - Obtained file size: 16276040 19:04:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:04:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:04:39 INFO - Fetch https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:04:41 INFO - Expected file size: 14409734 19:04:41 INFO - Obtained file size: 14409734 19:04:41 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')]} 19:04:41 INFO - trying https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:04:41 INFO - Downloading https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/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 19:04:44 INFO - Downloaded 69662968 bytes. 19:04:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:04:44 INFO - mkdir: /builds/slave/test/properties 19:04:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:04:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:04:44 INFO - Contents: 19:04:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:04:45 INFO - Running post-action listener: _resource_record_post_action 19:04:45 INFO - Running post-action listener: set_extra_try_arguments 19:04:45 INFO - [mozharness: 2016-12-21 03:04:45.066890Z] Finished download-and-extract step (success) 19:04:45 INFO - [mozharness: 2016-12-21 03:04:45.067044Z] Running populate-webroot step. 19:04:45 INFO - Running pre-action listener: _resource_record_pre_action 19:04:45 INFO - Running main action method: populate_webroot 19:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:45 INFO - '--tppagecycles', 19:04:45 INFO - '7'], 19:04:45 INFO - 'tests': ['tsvgm']}}, 19:04:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:04:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:04:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:04:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['damp', 'tps']}, 19:04:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'tests': ['damp', 'tps']}, 19:04:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['dromaeo_dom']}, 19:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['basic_compositor_video']}, 19:04:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:04:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore', 19:04:45 INFO - 'tabpaint']}, 19:04:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['tsvgx', 19:04:45 INFO - 'tsvgr_opacity', 19:04:45 INFO - 'tart', 19:04:45 INFO - 'tscrollx', 19:04:45 INFO - 'cart', 19:04:45 INFO - 'tsvg_static']}, 19:04:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:04:45 INFO - 'tsvgr_opacity', 19:04:45 INFO - 'tart', 19:04:45 INFO - 'tscrollx', 19:04:45 INFO - 'cart', 19:04:45 INFO - 'tsvg_static']}, 19:04:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'talos_options': ['--disable-e10s'], 19:04:45 INFO - 'tests': ['tp5o']}, 19:04:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:04:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'talos_options': ['--disable-e10s', 19:04:45 INFO - '--xperf_path', 19:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:45 INFO - 'tests': ['tp5n']}, 19:04:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:04:45 INFO - 'talos_options': ['--xperf_path', 19:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:45 INFO - 'tests': ['tp5n']}}, 19:04:45 INFO - 'talos.zip': {'path': '', 19:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:45 INFO - Running post-action listener: _resource_record_post_action 19:04:45 INFO - [mozharness: 2016-12-21 03:04:45.085338Z] Finished populate-webroot step (success) 19:04:45 INFO - [mozharness: 2016-12-21 03:04:45.085451Z] Running create-virtualenv step. 19:04:45 INFO - Running pre-action listener: _resource_record_pre_action 19:04:45 INFO - Running main action method: create_virtualenv 19:04:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:04:45 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 19:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:04:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:45 INFO - Using real prefix '/tools/python27' 19:04:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:04:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:48 INFO - Installing pip.................done. 19:04:48 INFO - Return code: 0 19:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:04:49 INFO - Reading from file tmpfile_stdout 19:04:49 INFO - Output received: 19:04:49 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) 19:04:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:04:49 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 19:04:49 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 19:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:49 INFO - 'HOME': '/Users/cltbld', 19:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:49 INFO - 'LOGNAME': 'cltbld', 19:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:49 INFO - 'MOZ_NO_REMOTE': '1', 19:04:49 INFO - 'NO_EM_RESTART': '1', 19:04:49 INFO - 'PAGER': '/bin/cat', 19:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:49 INFO - 'PWD': '/builds/slave/test', 19:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:49 INFO - 'SHELL': '/bin/bash', 19:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:04:49 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:49 INFO - 'USER': 'cltbld', 19:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:49 INFO - 'XPC_FLAGS': '0x0', 19:04:49 INFO - 'XPC_SERVICE_NAME': '0', 19:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:49 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 19:04:49 INFO - Cleaning up... 19:04:49 INFO - Return code: 0 19:04:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:04:49 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 19:04:49 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 19:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:49 INFO - 'HOME': '/Users/cltbld', 19:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:49 INFO - 'LOGNAME': 'cltbld', 19:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:49 INFO - 'MOZ_NO_REMOTE': '1', 19:04:49 INFO - 'NO_EM_RESTART': '1', 19:04:49 INFO - 'PAGER': '/bin/cat', 19:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:49 INFO - 'PWD': '/builds/slave/test', 19:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:49 INFO - 'SHELL': '/bin/bash', 19:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:04:49 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:49 INFO - 'USER': 'cltbld', 19:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:49 INFO - 'XPC_FLAGS': '0x0', 19:04:49 INFO - 'XPC_SERVICE_NAME': '0', 19:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:49 INFO - Downloading/unpacking psutil>=3.1.1 19:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:53 INFO - Installing collected packages: psutil 19:04:53 INFO - Running setup.py install for psutil 19:04:53 INFO - building 'psutil._psutil_osx' extension 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 INFO - building 'psutil._psutil_posix' extension 19:04:53 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 19:04:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:04:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:04:54 INFO - ^ 19:04:54 INFO - 1 warning generated. 19:04:54 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 19:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:54 INFO - Successfully installed psutil 19:04:54 INFO - Cleaning up... 19:04:54 INFO - Return code: 0 19:04:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:04:54 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')]} 19:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:54 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')]} 19:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:54 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:04:54 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 19:04:54 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 19:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:54 INFO - 'HOME': '/Users/cltbld', 19:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:54 INFO - 'LOGNAME': 'cltbld', 19:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:54 INFO - 'MOZ_NO_REMOTE': '1', 19:04:54 INFO - 'NO_EM_RESTART': '1', 19:04:54 INFO - 'PAGER': '/bin/cat', 19:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:54 INFO - 'PWD': '/builds/slave/test', 19:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:54 INFO - 'SHELL': '/bin/bash', 19:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:04:54 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:54 INFO - 'USER': 'cltbld', 19:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:54 INFO - 'XPC_FLAGS': '0x0', 19:04:54 INFO - 'XPC_SERVICE_NAME': '0', 19:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:04:57 INFO - Installing collected packages: mozsystemmonitor 19:04:57 INFO - Running setup.py install for mozsystemmonitor 19:04:57 INFO - Successfully installed mozsystemmonitor 19:04:57 INFO - Cleaning up... 19:04:57 INFO - Return code: 0 19:04:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:04:57 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')]} 19:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:57 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')]} 19:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:57 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:04:57 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 19:04:57 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 19:04:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:04:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:57 INFO - 'HOME': '/Users/cltbld', 19:04:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:57 INFO - 'LOGNAME': 'cltbld', 19:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:57 INFO - 'MOZ_NO_REMOTE': '1', 19:04:57 INFO - 'NO_EM_RESTART': '1', 19:04:57 INFO - 'PAGER': '/bin/cat', 19:04:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:57 INFO - 'PWD': '/builds/slave/test', 19:04:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:57 INFO - 'SHELL': '/bin/bash', 19:04:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:04:57 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:04:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:57 INFO - 'USER': 'cltbld', 19:04:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:57 INFO - 'XPC_FLAGS': '0x0', 19:04:57 INFO - 'XPC_SERVICE_NAME': '0', 19:04:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:57 INFO - Downloading/unpacking jsonschema==2.5.1 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:04:57 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 19:05:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:00 INFO - warning: no files found matching '*.txt' 19:05:00 INFO - no previously-included directories found matching 'build' 19:05:00 INFO - no previously-included directories found matching 'dist' 19:05:00 INFO - no previously-included directories found matching '.git*' 19:05:01 INFO - Installing collected packages: jsonschema, functools32 19:05:01 INFO - Running setup.py install for functools32 19:05:01 INFO - warning: no files found matching '*.txt' 19:05:01 INFO - no previously-included directories found matching 'build' 19:05:01 INFO - no previously-included directories found matching 'dist' 19:05:01 INFO - no previously-included directories found matching '.git*' 19:05:01 INFO - Successfully installed jsonschema functools32 19:05:01 INFO - Cleaning up... 19:05:01 INFO - Return code: 0 19:05:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:01 INFO - 'HOME': '/Users/cltbld', 19:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:01 INFO - 'LOGNAME': 'cltbld', 19:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:01 INFO - 'MOZ_NO_REMOTE': '1', 19:05:01 INFO - 'NO_EM_RESTART': '1', 19:05:01 INFO - 'PAGER': '/bin/cat', 19:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:01 INFO - 'PWD': '/builds/slave/test', 19:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:01 INFO - 'SHELL': '/bin/bash', 19:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:01 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:01 INFO - 'USER': 'cltbld', 19:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:01 INFO - 'XPC_FLAGS': '0x0', 19:05:01 INFO - 'XPC_SERVICE_NAME': '0', 19:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:01 INFO - Cleaning up... 19:05:01 INFO - Return code: 0 19:05:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:01 INFO - 'HOME': '/Users/cltbld', 19:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:01 INFO - 'LOGNAME': 'cltbld', 19:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:01 INFO - 'MOZ_NO_REMOTE': '1', 19:05:01 INFO - 'NO_EM_RESTART': '1', 19:05:01 INFO - 'PAGER': '/bin/cat', 19:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:01 INFO - 'PWD': '/builds/slave/test', 19:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:01 INFO - 'SHELL': '/bin/bash', 19:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:01 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:01 INFO - 'USER': 'cltbld', 19:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:01 INFO - 'XPC_FLAGS': '0x0', 19:05:01 INFO - 'XPC_SERVICE_NAME': '0', 19:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:04 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 19:05:04 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 19:05:04 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 19:05:04 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 19:05:04 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 19:05:04 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 19:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:05 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 19:05:05 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 19:05:05 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 19:05:05 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 19:05:05 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 19:05:05 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 19:05:05 INFO - Downloading docopt-0.6.1.tar.gz 19:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:05 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:05 INFO - Running setup.py install for blobuploader 19:05:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:05 INFO - Running setup.py install for requests 19:05:06 INFO - Running setup.py install for docopt 19:05:06 INFO - Successfully installed blobuploader requests docopt 19:05:06 INFO - Cleaning up... 19:05:06 INFO - Return code: 0 19:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:06 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:06 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 19:05:06 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 19:05:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:06 INFO - 'HOME': '/Users/cltbld', 19:05:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:06 INFO - 'LOGNAME': 'cltbld', 19:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:06 INFO - 'MOZ_NO_REMOTE': '1', 19:05:06 INFO - 'NO_EM_RESTART': '1', 19:05:06 INFO - 'PAGER': '/bin/cat', 19:05:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:06 INFO - 'PWD': '/builds/slave/test', 19:05:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:06 INFO - 'SHELL': '/bin/bash', 19:05:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:06 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:06 INFO - 'USER': 'cltbld', 19:05:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:06 INFO - 'XPC_FLAGS': '0x0', 19:05:06 INFO - 'XPC_SERVICE_NAME': '0', 19:05:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:06 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-jX1zaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:06 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-SKQBKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-FpTaDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-wajfiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-cei3be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2uX3B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-pHWZJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-qbftnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-IskyKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-KTV4Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:07 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-C2H4e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-1dW5xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-0edAYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-xzgnFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-8RVmxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-HdvUXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:08 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-H7Pn1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:08 INFO - Running setup.py install for manifestparser 19:05:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:08 INFO - Running setup.py install for mozcrash 19:05:08 INFO - Running setup.py install for mozdebug 19:05:09 INFO - Running setup.py install for mozdevice 19:05:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Running setup.py install for mozfile 19:05:09 INFO - Running setup.py install for mozhttpd 19:05:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Running setup.py install for mozinfo 19:05:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Running setup.py install for mozInstall 19:05:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:09 INFO - Running setup.py install for mozleak 19:05:09 INFO - Running setup.py install for mozlog 19:05:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Running setup.py install for moznetwork 19:05:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Running setup.py install for mozprocess 19:05:10 INFO - Running setup.py install for mozprofile 19:05:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Running setup.py install for mozrunner 19:05:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:10 INFO - Running setup.py install for mozscreenshot 19:05:10 INFO - Running setup.py install for moztest 19:05:11 INFO - Running setup.py install for mozversion 19:05:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:11 INFO - Cleaning up... 19:05:11 INFO - Return code: 0 19:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:11 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:11 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 19:05:11 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 19:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:11 INFO - 'HOME': '/Users/cltbld', 19:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:11 INFO - 'LOGNAME': 'cltbld', 19:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:11 INFO - 'MOZ_NO_REMOTE': '1', 19:05:11 INFO - 'NO_EM_RESTART': '1', 19:05:11 INFO - 'PAGER': '/bin/cat', 19:05:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:11 INFO - 'PWD': '/builds/slave/test', 19:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:11 INFO - 'SHELL': '/bin/bash', 19:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:11 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:11 INFO - 'USER': 'cltbld', 19:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:11 INFO - 'XPC_FLAGS': '0x0', 19:05:11 INFO - 'XPC_SERVICE_NAME': '0', 19:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:11 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Vw7iS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:11 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)) 19:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:11 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-DiHh4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:11 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)) 19:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:11 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-G0SIbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:11 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)) 19:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:11 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-WuHnNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:11 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)) 19:05:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:11 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-8xXndv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-V9K7Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-CjfeP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-CptSL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-LRcRjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-0_YPWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2ynLxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-74BlMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-VnoXC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:12 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)) 19:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:12 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-asWAka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:13 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)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-O4IYf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:13 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)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-bvPirv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:13 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-gQaR3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:13 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)) 19:05:13 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)) 19:05:13 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)) 19:05:13 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)) 19:05:13 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)) 19:05:13 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)) 19:05:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:15 INFO - Downloading blessings-1.6.tar.gz 19:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:16 INFO - Installing collected packages: blessings 19:05:16 INFO - Running setup.py install for blessings 19:05:16 INFO - Successfully installed blessings 19:05:16 INFO - Cleaning up... 19:05:16 INFO - Return code: 0 19:05:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:16 INFO - Reading from file tmpfile_stdout 19:05:16 INFO - Current package versions: 19:05:16 INFO - blessings == 1.6 19:05:16 INFO - blobuploader == 1.2.4 19:05:16 INFO - docopt == 0.6.1 19:05:16 INFO - functools32 == 3.2.3-2 19:05:16 INFO - jsonschema == 2.5.1 19:05:16 INFO - manifestparser == 1.1 19:05:16 INFO - mozInstall == 1.12 19:05:16 INFO - mozcrash == 1.0 19:05:16 INFO - mozdebug == 0.1 19:05:16 INFO - mozdevice == 0.49 19:05:16 INFO - mozfile == 1.2 19:05:16 INFO - mozhttpd == 0.7 19:05:16 INFO - mozinfo == 0.9 19:05:16 INFO - mozleak == 0.1 19:05:16 INFO - mozlog == 3.4 19:05:16 INFO - moznetwork == 0.27 19:05:16 INFO - mozprocess == 0.23 19:05:16 INFO - mozprofile == 0.28 19:05:16 INFO - mozrunner == 6.13 19:05:16 INFO - mozscreenshot == 0.1 19:05:16 INFO - mozsystemmonitor == 0.3 19:05:16 INFO - moztest == 0.7 19:05:16 INFO - mozversion == 1.4 19:05:16 INFO - psutil == 3.1.1 19:05:16 INFO - requests == 1.2.3 19:05:16 INFO - wsgiref == 0.1.2 19:05:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:16 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')]} 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:17 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')]} 19:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:17 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 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:17 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 19:05:17 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 19:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:17 INFO - 'HOME': '/Users/cltbld', 19:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:17 INFO - 'LOGNAME': 'cltbld', 19:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:17 INFO - 'MOZ_NO_REMOTE': '1', 19:05:17 INFO - 'NO_EM_RESTART': '1', 19:05:17 INFO - 'PAGER': '/bin/cat', 19:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:17 INFO - 'PWD': '/builds/slave/test', 19:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:17 INFO - 'SHELL': '/bin/bash', 19:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:17 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:17 INFO - 'USER': 'cltbld', 19:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:17 INFO - 'XPC_FLAGS': '0x0', 19:05:17 INFO - 'XPC_SERVICE_NAME': '0', 19:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 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)) 19:05:17 INFO - Cleaning up... 19:05:17 INFO - Return code: 0 19:05:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:17 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')]} 19:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:17 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')]} 19:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa661470fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, '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.hX7Pmmitps/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.X7l4lePcSj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 19:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:18 INFO - 'HOME': '/Users/cltbld', 19:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:18 INFO - 'LOGNAME': 'cltbld', 19:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:18 INFO - 'MOZ_NO_REMOTE': '1', 19:05:18 INFO - 'NO_EM_RESTART': '1', 19:05:18 INFO - 'PAGER': '/bin/cat', 19:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:18 INFO - 'PWD': '/builds/slave/test', 19:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:18 INFO - 'SHELL': '/bin/bash', 19:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:18 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:18 INFO - 'USER': 'cltbld', 19:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:18 INFO - 'XPC_FLAGS': '0x0', 19:05:18 INFO - 'XPC_SERVICE_NAME': '0', 19:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:18 INFO - Cleaning up... 19:05:18 INFO - Return code: 0 19:05:18 INFO - Running post-action listener: _resource_record_post_action 19:05:18 INFO - Running post-action listener: _start_resource_monitoring 19:05:18 INFO - Starting resource monitoring. 19:05:18 INFO - [mozharness: 2016-12-21 03:05:18.394431Z] Finished create-virtualenv step (success) 19:05:18 INFO - [mozharness: 2016-12-21 03:05:18.395432Z] Running install step. 19:05:18 INFO - Running pre-action listener: _resource_record_pre_action 19:05:18 INFO - Running main action method: install 19:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:18 INFO - Reading from file tmpfile_stdout 19:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:18 INFO - Reading from file tmpfile_stdout 19:05:18 INFO - Output received: 19:05:18 INFO - Usage: mozinstall [options] installer 19:05:18 INFO - Options: 19:05:18 INFO - -h, --help show this help message and exit 19:05:18 INFO - -d DEST, --destination=DEST 19:05:18 INFO - Directory to install application into. [default: 19:05:18 INFO - "/builds/slave/test"] 19:05:18 INFO - --app=APP Application being installed. [default: firefox] 19:05:18 INFO - mkdir: /builds/slave/test/build/application 19:05:18 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'] 19:05:18 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 19:05:41 INFO - Reading from file tmpfile_stdout 19:05:41 INFO - Output received: 19:05:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:05:41 INFO - Running post-action listener: _resource_record_post_action 19:05:41 INFO - [mozharness: 2016-12-21 03:05:41.140143Z] Finished install step (success) 19:05:41 INFO - [mozharness: 2016-12-21 03:05:41.140300Z] Running run-tests step. 19:05:41 INFO - Running pre-action listener: _resource_record_pre_action 19:05:41 INFO - Running main action method: run_tests 19:05:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:05:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:05:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:05:41 INFO - 2016-12-20 19:05:41.154 screenresolution[1620:7407] starting screenresolution argv=screenresolution get 19:05:41 INFO - 2016-12-20 19:05:41.157 screenresolution[1620:7407] Display 0: 1600x1200x32@60 19:05:41 INFO - 2016-12-20 19:05:41.163 screenresolution[1621:7411] starting screenresolution argv=screenresolution list 19:05:41 INFO - Available Modes on Display 0 19:05:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:05:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:05:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:05:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:05:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:05:41 INFO - Intel Iris: 19:05:41 INFO - Chipset Model: Intel Iris 19:05:41 INFO - Type: GPU 19:05:41 INFO - Bus: Built-In 19:05:41 INFO - VRAM (Dynamic, Max): 1536 MB 19:05:41 INFO - Vendor: Intel (0x8086) 19:05:41 INFO - Device ID: 0x0a2e 19:05:41 INFO - Revision ID: 0x0009 19:05:41 INFO - Displays: 19:05:41 INFO - Display: 19:05:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:05:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:05:41 INFO - Display Serial Number: 1600x1200 60 19:05:41 INFO - Main Display: Yes 19:05:41 INFO - Mirror: Off 19:05:41 INFO - Online: Yes 19:05:41 INFO - Rotation: Supported 19:05:41 INFO - Return code: 0 19:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:41 INFO - Python 2.7.3 19:05:41 INFO - Return code: 0 19:05:41 INFO - grabbing minidump binary from tooltool 19:05:41 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')]} 19:05:41 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 0x108e53d30>, '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 0x108d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e48be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:41 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 19:05:41 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 19:05:41 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 19:05:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:41 INFO - Return code: 0 19:05:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:05:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:05:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:41 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/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 19:05:41 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/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0237 --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 19:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hX7Pmmitps/Render', 19:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:41 INFO - 'HOME': '/Users/cltbld', 19:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:41 INFO - 'LOGNAME': 'cltbld', 19:05:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:41 INFO - 'MOZ_NO_REMOTE': '1', 19:05:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:41 INFO - 'NO_EM_RESTART': '1', 19:05:41 INFO - 'PAGER': '/bin/cat', 19:05:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:41 INFO - 'PWD': '/builds/slave/test', 19:05:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:41 INFO - 'SHELL': '/bin/bash', 19:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X7l4lePcSj/Listeners', 19:05:41 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 19:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:41 INFO - 'USER': 'cltbld', 19:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:41 INFO - 'XPC_FLAGS': '0x0', 19:05:41 INFO - 'XPC_SERVICE_NAME': '0', 19:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:41 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/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 19:05:41 INFO - mozversion application_buildid: 20161220174153 19:05:41 INFO - mozversion application_changeset: 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 19:05:41 INFO - mozversion application_display_name: Nightly 19:05:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:41 INFO - mozversion application_name: Firefox 19:05:41 INFO - mozversion application_remotingname: firefox 19:05:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:05:41 INFO - mozversion application_vendor: Mozilla 19:05:41 INFO - mozversion application_version: 53.0a1 19:05:41 INFO - mozversion platform_buildid: 20161220174153 19:05:41 INFO - mozversion platform_changeset: 7a4e657e1d42e43030e6e5f3672e8e8f5a3d8262 19:05:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:05:41 INFO - mozversion platform_version: 53.0a1 19:05:41 INFO - using testdate: 1482289541 19:05:41 INFO - actual date: 1482289541 19:05:41 INFO - starting webserver on 'localhost:49241' 19:05:41 INFO - SUITE-START | Running 2 tests 19:05:41 INFO - TEST-START | dromaeo_css 19:05:41 INFO - operating with platform_type : mac_ 19:05:41 INFO - Initialising browser for dromaeo_css test... 19:05:41 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpA7k0sH/profile http://localhost:49241/getInfo.html) 19:05:44 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 19:05:44 INFO - PROCESS | 1631 | colorDepth:24 19:05:44 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 19:05:44 INFO - PROCESS | 1631 | __metrics 19:05:44 INFO - PROCESS | 1631 | 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" 19:05:44 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:05:45 INFO - TEST-INFO | 1631: exit 0 19:05:45 INFO - Browser initialized. 19:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:45 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpA7k0sH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:57 INFO - PROCESS | 1633 | RSS: Main: 230699008 19:05:57 INFO - PROCESS | 1633 | 19:06:48 INFO - PROCESS | 1633 | 1482289608108 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:08:59 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 19:09:03 INFO - PROCESS | 1633 | RSS: Main: 499023872 19:09:03 INFO - PROCESS | 1633 | 19:12:06 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 19:12:06 INFO - PROCESS | 1633 | RSS: Main: 373936128 19:12:06 INFO - PROCESS | 1633 | 19:15:09 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 19:15:09 INFO - PROCESS | 1633 | RSS: Main: 352382976 19:15:09 INFO - PROCESS | 1633 | 19:18:12 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 19:18:12 INFO - PROCESS | 1633 | RSS: Main: 349421568 19:18:12 INFO - PROCESS | 1633 | 19:21:16 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 19:21:17 INFO - PROCESS | 1633 | RSS: Main: 334843904 19:21:17 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 19:24:20 INFO - PROCESS | 1633 | RSS: Main: 422330368 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | __start_tp_report 19:24:20 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 19:24:20 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 19:24:20 INFO - PROCESS | 1633 | |i|pagename|runs| 19:24:20 INFO - PROCESS | 1633 | |0;dojo.html;3292.604887413511;3327.4509705898527;3327.6672332766725;3354.530365748797;3375.426177549816;5444.727763611819;5567.805126820562;5642.04085305498;5655.095184770437;5735.856603584913;4241.342591898253;5625.296837895263;5657.688827114507;5714.77140914364;5778.248827652399;5110.412302585194;5154.38147422308;5158.0576228722975;5183.533481986639;5232.8691782705355;5220.321358223426;5287.021900948337;5308.177232528964;5330.626856120073;5371.435999220084;5126.359205099363;5266.499682530153;5297.496737809902;5299.49654782795;5371.221172929922;5158.7420628968775;5170.6122040847085;5213.53078222958;5213.895722085575;5227.60792940531;5134.2041983492245;5180.507851754077;5197.116490196676;5200.5059519345605;5243.4232234454175;5693.430656934315;5707.714614269312;5713.257276554022;5730.05454100073;5765.625234359753;6074.726637301332;6116.174316467264;6121.326654068049;6173.9073913891325;6237.6257424554215;6172.691365431755;6205.7517699291975;6234.532410069263;6237.625742455467;6242.594231374991;5803.912941305799;5805.216295800097;5836.766529338822;5854.151148083504;5863.061910094364;6262.718177682015;6297.96851015742;6338.080978258126;6347.460465860361;6354.3963323484195;5957.374475680078;6003.5797494174985;6134.22411175217;6174.876502469925;6182.103594978703;5165.74171291434;6183.598066125687;6198.504119670415;6211.378862113843;6216.098665693539;6180.258368995749;6235.501159907197;6236.781712640036;6243.094751261042;6246.750129994749;6247.5939063960695;6264.404881536247;6266.122742816009;6272.717727702265;6279.152314437584;4873.025394920959;4902.901941961212;4903.607711383081;4938.530839570235;5016.54851063406;4384.342348647729;4390.846320378771;4432.623227025739;4436.7559784211535;4489.753063581535;5797.4782269595935;5812.534997200214;5823.388544202882;5828.388019258002;5873.823785286363;6113.755449781959;6172.506199504029;6197.101420294032;6301.243850737941;6308.116863639094;5737.8565535861935;5783.8554036149435;5810.738516766755;5867.178594996619;5870;5434.619576629598;5443.863903402446;5455.399906010336;5462.945370546323;5466.726663666801;6345.07996340528;6350.714217860115;6353.205849268841;6359.7456101755415;6374.075759014824;5280.947190528199;5964.8807023860145;6044.697765111815;6058.454739073504;6286.968565157145;6298.937010629835;6309.958856788762;6340.080688300263;6344.873102537831;6348.079528468254;6177.444030037318;6203.47270481996;6209.006558950727;6210.410011049124;6210.720517576629;6051.425114614105;6106.278657334014;6168.907466388097;6288.591241569284;6296.33888441707;6062.727177277121;6072.271327440559;6073.48375388097;6078.209832721895;6082;6044.365341639241;6072.514198864169;6076.605020673642;6077.665728384981;6081.847953801191;5860.150278209721;5892.970535147297;5896.64620122794;5919.319278283053;5922.289325280994;6062.818115456544;6072.757089716361;6076.361981991828;6092.116643086816;6096.817095487142;5313.787448502017;5883.117532370007;5923.49650279731;5926.525877929669;5938.990371636918 19:24:20 INFO - PROCESS | 1633 | |1;ext.html;479.7241586087996;496.01045913402754;502.4197052404473;502.52009331088834;530.5622861139561;30092.548611770813;31174.844125779367;31212;31271.843640781823;31303.53044704331;38377.23245535087;38956.61043389565;39162.21675566487;41243.58756412435;41284.58715412845;9036.8644470333;9222.216111630485;9229.446233226028;9237.353385263;9244;8330.50016998982;9084.091590840897;9210.76973075675;9215.262778977665;9234.445933243993;8300.792480188013;10883.782324353508;11151.163662725288;11177.608783692573;11324.03745681618;11045.171612129083;11112.555497780078;11115.944420277927;11117.332960022344;11124.38815865127;8268.875966860502;10917.727056823564;11030.724231894186;11033.062189713884;11036.944815275872;30145.246368840733;36431.4535281971;37118;37136.44295335572;37518.249635007145;3424.845881935294;3424.931501369959;3517.278957813642;3526.2066035142143;3777.3200823851694;28384.4886959126;28640.856795716096;28849.56725649117;29002.854985724935;29282.70717292821;3155.2742869140225;3160.478521044025;3194.8083115013173;3269.75476839238;3283;496499;496511;498955;500156;503134.99999999633;60795.69602151961;61222.081668775005;61266.16201513962;61356.38643613596;61490;64585;64616.67691661511;64658;64715.35284647093;64778.352216478175;15439.459618913508;15974.361025558848;16000;16004.919975400282;16095.839041609433;12466.252024878537;12528.997680185563;12530.498780048878;12533.31066791317;12537.185082969578;14268.500602478864;14610.123392596479;15463.768043479356;16153.838461615469;16156;5584.134459158837;6690.5316627836555;6702.966485167543;6706.26231114577;6761.763338283136;908.6092980018524;962.7304354780673;1004.1113614451264;1004.7136566078633;1049.7008352619466;27629;27780.58329125065;29181.416371672447;29207.853960730485;29871.850640747092;966.8743063401713;1054.6941386997837;1116.843641890136;1139.510010695409;1177.4112943528237;14299.498552651821;14818.629534261514;14958.02772819785;15175.924120379328;15604.712432271122;595545;595616;599442;601073;601102;58074;58199.709001455565;58348.70825645929;58366;58400.415995839496;1346.2864681718704;1379.3654918737493;1398.084254813099;1401.1242973141786;1403.7192561487743;27221.319467013484;27716.30709232285;27861.860690696416;27949.301267468476;28231.57652635171;50765.73085672888;51215.23177152271;51296;51302.486975129774;51418.74290628523;535113;535901;542107;543369;544243;37920;38334.46662133595;38509.614903851725;38699.6130038696;38778.61221387863;42832.57167428286;43106.353404698326;43488.13023739571;43567;43667.34498982581;28485.43029139364;35030.824845875606;35086.64913350936;35527.644723553465;36105.277894442486;27017.864910676108;33858.83070584631;34141.48787768235;34616;34726.65273347234;34753;35186.12034699153;35413.82293088518;35429;35729.64270357263;27151.86424067867;29617.851910740308;30665.693343066283;30707;30790;21372.35882923515;22076.33770986873;23207.535849283257;23655.763442366046;23664.763352366255 19:24:20 INFO - PROCESS | 1633 | |2;jquery.html;357.39243286413074;374.30753106752513;380.853371451991;386.00410939775384;409.6886366361566;14828.703425931475;14890.957632965683;17408.47774566762;20022.799772002312;20221.203666799513;19746.802531974678;19985.800141998574;20414.795852041476;20456.397310605105;21017.579648407023;4419.712718673292;5151.562117220041;5802.361740208574;5812.4768770810615;5812.622179558336;4798.856034318976;5681.857953551153;5731.283589551306;5731.767669950959;5769.394213607574;5364.758585863646;5693.459121383462;5697.8005769798065;5699.914501282484;5703.40114288;4713.811447542094;4877.536634019798;5752.13717942312;5766.135079738052;5770.653760774367;5407.459254074601;5589.80435684749;5594.9720251398885;5764.452377024176;5870.559708021916;13225.801612975813;13435.798463022964;13453.529126480624;13459;23001.424964375856;2101.7477902651626;2223.9332820015425;2327.359976006595;2931.4576803291247;2938.3682508260827;9710.708678739578;9809.754756131082;9865.654702085465;10272.126869216125;10311.896881031169;1782.7415024821328;1829.4511646505996;1832.725091236312;1839.9264029438807;1856.4059500959697;116052;118660;122421.99999999911;123572.38213808874;124315;11112.44437778108;11310.491027903765;11389.145814063979;11436.885631143748;11462.197646164688;14374.053319069566;14386.28068596566;14428.278586070655;14435.989480736247;14475.855241447662;8027.719029833927;8274.338052955749;8314.41799074071;8356.456830306011;8432.072472028072;8125.837483250302;8132.227438393344;8167.95916020428;8359.707410240613;8370.581470926429;3683.5211422514903;4384.539623339503;4513.842015529441;4567.474740404829;4577.359169716243;1544.9304781284868;1865.4963159946738;1923.557581756176;1926.7013612890025;1935.622553602034;860.9311255099577;907.9319051071196;928.3223247029706;997.7677568203263;1039.5374058543875;20372.388828335173;21676.34970950874;21709.13163473475;21725.67411488829;21790;925.3476299209176;951.509972364233;955.3408148377597;982.9901700983041;986.225812736998;10387.584496620051;10939.726506837393;11172.720681983015;11197.720056998478;11264.831027534594;543048;545034;546608;556115.2194239084;564588;116496;116865.8313416855;118001.40999294948;127601;130741.69258307485;994.7766741333114;1029.2897900448665;1043.4417586591137;1043.4574021508772;1060.7136073260176;15138.772918406012;15638.609034774221;19591.902040489706;19835.404937851887;20025.198992040154;36270.81864590766;53479.73260133674;53482;54510.45489545212;56755.86488270129;67868.6606566964;73858;79735;80286;81792;7376.4836461447185;8060.556669383241;8230.917690823015;8298.543580103153;8305.501669899826;9973.849840414321;12244.837319863389;12703.682407939876;13040.804387933998;13092.279924604238;10947.34315941046;11037.889621103686;11255.099592032782;11406.771864562828;11449.370284634426;10900.291481053706;10914.563417463212;11101.278416902875;11297.322160670057;11361.54553817838;10893;11271.323720576791;11474.909883561048;11501.424928753697;11573.826392604286;6952;7204.639768011683;7349.522281051714;7603.809904752426;8453.788655283666;9387.953060234655;10908.945455272673;11055.22613417053;11160.274582152135;11252.099832013582 19:24:20 INFO - PROCESS | 1633 | |3;mootools.html;1362.4413990263993;1506.5329747778187;1540.7611820167879;1765.337998250656;1928.0745242283704;6773.187217533897;7856.685732570698;8119.309858662021;8500.404971651988;8518.23335899769;8204.630791614376;8366.330693544516;8462.830743385144;8470.407071504997;8472.534010629413;2057.989710051455;2294.1396976133906;2337.929862104131;2339.87130707811;2341.625339945609;2139.358192542239;2274.931752047441;2352.494213744045;2353.5528249632603;2368.348704106376;2307.9538409231805;2320.640300753386;2330.592146374386;2333.0900948630047;2336.3458231695154;2270.330252575486;2296.954060918789;2299.9655005174936;2301.3096071178747;2301.401635574746;2310.1798861404127;2338.707661542307;2339.239747082188;2342.5900467418132;2351.541449417364;7035.929640703579;8324.66701331946;8397.748067557983;8436;8523.914760852374;5085.389753229599;5251.947480525184;5257.08001099806;5259.86850328741;5264.657797243167;3135.3102317490343;3165.6071328615567;3296.3901678189613;3339.231976645385;3342.615599206074;825.22428916818;955.804060167671;995.2933417273672;995.775950411159;999.1058003087196;11026.558937642485;11040.723981900517;11057.723556911142;11059.502322395512;11069.557217711283;4593.6095431888;4627.190241707755;4647.651426143053;4687.929681054787;4760.785764640599;9559.283053770994;9623.422594644344;9625.663101791404;9626.47054412;9647.372920760128;5260;5261.263423120766;5267.815626453055;5271.288376069258;5277.182036784305;4608.677392582554;4717.504662010508;4788.569028787426;4831.202851529459;4838.346823178826;3732.328180927459;3757.342465068602;3788.9242215156096;3825.3496905526126;3830.433609481654;1075.9623413180502;1258.358237298984;1266.4807428954084;1273.9745205095846;1275.5025540039392;820.5659315763548;847.8007668197969;876.6055275126091;903.701778413122;923.930705197113;5213.504717051874;5342.439043900412;5508.697021663847;5616.073347897633;5654.491095801398;917.4036876030633;949.9835176361228;950.7480517662825;961.9038096190325;987.0918754745651;3484.0767196692896;3604.4953706481115;3700.2229531798625;3718.6839118674675;3765.548134223911;9980;10263.74340641475;10338.431386273676;10366.637167699246;10467.42429166388;10301.587936482607;10321.84517232242;10338.844917326247;10340.53467593945;10381.792364152674;6390.936090639034;7394.075740532434;7778.416618753616;7787.026621672404;7987.3610111190965;4350.782460877007;5713.457221563945;5860.09168578871;5870.354261031369;5891.204687367151;9192.17270445663;9314.115159059878;9379.249660027317;9426.491503669635;9528.475933823705;9419.764505887133;9541.666041688784;9583.760405989906;9608.423494590346;9652.662156824477;7081.327273908971;7214.242504537158;7277.490575659865;7293.124825021031;7294.525855819355;6503.6097834130105;7822.5697586631;7844.137144914169;7899.565523896241;7909.52542847431;6029.969850150721;7106.538075025107;7193.280671932765;7217.6030318333;7299.708011679473;6831.180258369028;6868.62222577763;7002.439804815501;7077;7177.246389129066;6627.734890604322;6680.3987641112535;6740.966295168493;6758.391744742997;6773.187217533928;4740.336352910526;4866.075445665312;4867.878303042452;4902.4607293197005;5034;4123.9175216496105;4786.593139583175;4926.187179115549;4984.675996060245;5002.9994001199175 19:24:20 INFO - PROCESS | 1633 | |4;prototype.html;327;353.45214916878837;357.4887910288288;364.26782167842634;373.32241980804855;4277.572242775721;5045.445001049886;5128.794733237686;5214.497041420116;5282.947170528294;5049.621278404125;5179.093658609747;5267.367915850094;5374.516293533581;5377.569794416447;3042.574039634453;3477.3045390921916;3932.803359831997;4061.3501839705655;4068.3694027425795;3679.7792132472005;3809.695224382043;3890.7276490645527;3954.307996100685;4031.3191727501176;3554.5023696682356;3667.449882517617;3669.7981611011382;3945.684345252373;3947.2105578884193;3161.462551366273;3505.8597656093725;3969.9603003970024;3980.383040628707;4009.51885773709;2820.63331766869;3263.673632636741;3384.627690953993;3404.553064947412;3466.687998080185;5088.160453525164;5090.847274581768;5110.233464980245;5152.819651312224;5203.9219411708855;4497.797599108016;4500.707454015511;4508.458984921797;4541.250693635546;4553.317002449626;4974.527419895104;5295.735213239323;5538.9169162462595;5572.690417751865;5574.693391863446;3290.8190049547266;3659.9268014639824;3777.8111094445444;3796.0889386547306;3813.408921617126;4895.632827537914;5861.325947516005;5904.527637788967;5910.527157827363;5935.970320148414;2872.6696429910826;3289.901302960915;3440.9827950860085;3800.638939300762;3895.454636350913;3324;3333;3675.8162091895833;3920.2159568086495;3929.899628104078;3887.2225554889137;4252.681048921343;4434.026858048138;4442.644588432918;4444.911101777946;4787.569118779326;5057.367829021372;5625.399744163738;5640.223329651229;5656.680760888098;1191.326900301327;1236.746466974268;1249.5439164704817;1268.7589358021946;1278.3033246880473;753.963300461865;760.9315161635369;774.9573773442514;779.2519181585741;831.7213733399379;4919.163052818807;4995.327499787596;5003.849884503471;5012.974935125301;5038.949610503922;4659.836905708352;4710.715303078005;4823.710577365299;5276.973615131977;5378.11261141915;4186.6859985501205;4262.50981137167;4443.7111587746695;5037.697738135724;5343.7175077981;2486.6394372816203;2670.813043086965;2822.379076603144;2886.5381538953666;2913;5384.78460861569;5647.8040203013325;5720.456556627197;5775.335836378787;5781.4218578141845;4955.554000139932;5607.579431542651;5655.575831812631;5667.858303542444;5691.548655093007;4966.8758281043265;5012.922221722347;5385.084535629031;5531.778728850882;5737.139429085671;5158.3552055993005;5215.574757737671;5291.576673866159;5505.944940550543;5513.889722205453;4861.371440567449;4895.4370247422;5359.392182345358;5469.453054694499;5496.120620700669;4517.025017984153;5136.512031357015;5633.746481408264;5716.999050332351;5730.885382292414;3137.6234851817926;3534.081138903852;3647.3070116677745;3665.837156077927;3679.865677906861;4781.880452988564;5388.73056347189;5640.5769567281795;5799.2750906136735;5819.883602328015;5291.523762861361;5303.6210585247345;5491.892539937896;5552.611317207919;5587.944120558743;4437.001674623184;4680.485146633936;4899.363082799213;5534.4742249486235;5559.916601251065;5321.2816269804625;5437.483439073281;5445.83662490126;5483.945160548344;5487.807926722546;5454.59090568201;5463.754131064191;5483.888702849352;5490.6980116094;5535.501804837584;4659.743714095757;5006.173981293192;5022.598192144693;5161.638685292144;5373.194020896896 19:24:20 INFO - PROCESS | 1633 | |5;yui.html;700.4396482813747;733.7615275035614;738.9815254618634;743.3978477433283;744.6090802328777;15123.924380378097;15688.843111568882;15692.450764223255;15697;15708.764368534466;14234;14410;14412.423503059892;14421.134731916067;14436.350364233609;697.1181455458849;718.3750137380487;725.9981225908239;866.2290561400343;891.4784850862253;856.7044369692446;881.7398867334152;882.2677177942293;892.4422236102404;892.8883889513811;961.0437614573474;964.9179819715332;965.5703212070631;965.9806803863919;967.7145242153547;729.0886392009987;952.9237660987104;953.6376177052675;958.1376760915232;961.6586111930304;557.436988641471;688.1810645332039;708.3341658840674;715.9284071592851;717.0499088707431;14198.432062717582;14258.001939864214;14260.92869535656;14273.429062837475;14281.642958926006;13762.449502019907;13771;13797.24115173665;13874.4450221991;13888.513902013483;12508.562200322946;12521.937390313082;12747.745045099045;12984.545540906118;13075.600343910557;4365.825366985317;4399.802008909607;4466.7766611669285;4488.506264310923;4613.284940834143;97960.51019744856;101677.49161254146;102391;104759;107352;10897.945510272399;11060.723481913017;11200.935911088434;11204.103671706243;11494.13793965456;19875.60248795016;22143.44641383946;22155.113795448324;22156.88921555382;22187.223447179273;7664.425168112414;7745.883811742829;7920.643571039317;7928.3260922821055;7966.6415011324625;4300.204462174508;4336.588024137702;4339.913201736011;4357.3899654048455;4370.759608221579;3378.35811195872;3472.427049536798;3476.8435420406145;3485.4249048907154;3499.492573576817;583.8540364908773;621.7140115546899;623.538581449733;637.4486069549898;644.9355064493607;535.9249705041298;600.7687040489443;611.7308384310978;617.2438762515972;623.2365352443311;8447.915520844714;8680.045195028542;8799.680047992852;8913.343052864948;9279.39683920543;585.3034888482692;589.2487078974257;611.3366996808423;614.4991831657275;621.382278731513;4280.165367753259;4377.562243775661;4401.207782599099;4432.13573353193;4454.844080457168;73764;93878;95828.52085739667;108890.45554772334;113372.86627133623;95640.04359956311;97188;97281.5407768884;97600;99847;83487.16512834794;84453.57773211217;84687.15312846792;85027.5748621253;86107;8318.319812870202;8577.185167409087;8637.827243455222;8706.60820263077;8932.598033088656;45225.32162017506;46651;47444.7627761859;49646;52110.47889521056;60406.697966509884;66848;69020.6548967252;70481.64759176376;72565.27434725585;10085.394876307446;10668.83996740065;13300.667483312995;13374.331283435595;13625.931870340584;14630.926845365704;14716.55850324492;14761.114333140045;14794.852051479347;14881.851181488046;12293.877061229274;12755.553555625509;13499.797503037658;13624;14379;13671.79492307636;13802.447902083804;13864;14070.78893816614;14278.785818212527;11579.8263026053;13241.404136814059;13549.729005420033;13605.86394136046;13656.863431365957;11014.944925275642;11415.543378264776;11457.59898403552;11502.698194418947;11658.76682466329;10852.968967948033;10949.397783122005;11203.241026457817;11495.252808567417;11581.82627260575 19:24:20 INFO - PROCESS | 1633 | __end_tp_report 19:24:20 INFO - PROCESS | 1633 | __start_cc_report 19:24:20 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,3247 19:24:20 INFO - PROCESS | 1633 | __end_cc_report 19:24:20 INFO - PROCESS | 1633 | __startTimestamp1482290660633__endTimestamp 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | ------- Summary: start ------- 19:24:20 INFO - PROCESS | 1633 | Number of tests: 6 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5723.65 Median:5919.32 stddev:645.63 (10.9%) stddev-sans-first:618.80 19:24:20 INFO - PROCESS | 1633 | Values: 3292.6 3327.5 3327.7 3354.5 3375.4 5444.7 5567.8 5642.0 5655.1 5735.9 4241.3 5625.3 5657.7 5714.8 5778.2 5110.4 5154.4 5158.1 5183.5 5232.9 5220.3 5287.0 5308.2 5330.6 5371.4 5126.4 5266.5 5297.5 5299.5 5371.2 5158.7 5170.6 5213.5 5213.9 5227.6 5134.2 5180.5 5197.1 5200.5 5243.4 5693.4 5707.7 5713.3 5730.1 5765.6 6074.7 6116.2 6121.3 6173.9 6237.6 6172.7 6205.8 6234.5 6237.6 6242.6 5803.9 5805.2 5836.8 5854.2 5863.1 6262.7 6298.0 6338.1 6347.5 6354.4 5957.4 6003.6 6134.2 6174.9 6182.1 5165.7 6183.6 6198.5 6211.4 6216.1 6180.3 6235.5 6236.8 6243.1 6246.8 6247.6 6264.4 6266.1 6272.7 6279.2 4873.0 4902.9 4903.6 4938.5 5016.5 4384.3 4390.8 4432.6 4436.8 4489.8 5797.5 5812.5 5823.4 5828.4 5873.8 6113.8 6172.5 6197.1 6301.2 6308.1 5737.9 5783.9 5810.7 5867.2 5870.0 5434.6 5443.9 5455.4 5462.9 5466.7 6345.1 6350.7 6353.2 6359.7 6374.1 5280.9 5964.9 6044.7 6058.5 6287.0 6298.9 6310.0 6340.1 6344.9 6348.1 6177.4 6203.5 6209.0 6210.4 6210.7 6051.4 6106.3 6168.9 6288.6 6296.3 6062.7 6072.3 6073.5 6078.2 6082.0 6044.4 6072.5 6076.6 6077.7 6081.8 5860.2 5893.0 5896.6 5919.3 5922.3 6062.8 6072.8 6076.4 6092.1 6096.8 5313.8 5883.1 5923.5 5926.5 5939.0 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:67439.49 Median:35058.74 stddev:146209.37 (417.0%) stddev-sans-first:146533.09 19:24:20 INFO - PROCESS | 1633 | Values: 479.7 496.0 502.4 502.5 530.6 30092.5 31174.8 31212.0 31271.8 31303.5 38377.2 38956.6 39162.2 41243.6 41284.6 9036.9 9222.2 9229.4 9237.4 9244.0 8330.5 9084.1 9210.8 9215.3 9234.4 8300.8 10883.8 11151.2 11177.6 11324.0 11045.2 11112.6 11115.9 11117.3 11124.4 8268.9 10917.7 11030.7 11033.1 11036.9 30145.2 36431.5 37118.0 37136.4 37518.2 3424.8 3424.9 3517.3 3526.2 3777.3 28384.5 28640.9 28849.6 29002.9 29282.7 3155.3 3160.5 3194.8 3269.8 3283.0 496499.0 496511.0 498955.0 500156.0 503135.0 60795.7 61222.1 61266.2 61356.4 61490.0 64585.0 64616.7 64658.0 64715.4 64778.4 15439.5 15974.4 16000.0 16004.9 16095.8 12466.3 12529.0 12530.5 12533.3 12537.2 14268.5 14610.1 15463.8 16153.8 16156.0 5584.1 6690.5 6703.0 6706.3 6761.8 908.6 962.7 1004.1 1004.7 1049.7 27629.0 27780.6 29181.4 29207.9 29871.9 966.9 1054.7 1116.8 1139.5 1177.4 14299.5 14818.6 14958.0 15175.9 15604.7 595545.0 595616.0 599442.0 601073.0 601102.0 58074.0 58199.7 58348.7 58366.0 58400.4 1346.3 1379.4 1398.1 1401.1 1403.7 27221.3 27716.3 27861.9 27949.3 28231.6 50765.7 51215.2 51296.0 51302.5 51418.7 535113.0 535901.0 542107.0 543369.0 544243.0 37920.0 38334.5 38509.6 38699.6 38778.6 42832.6 43106.4 43488.1 43567.0 43667.3 28485.4 35030.8 35086.6 35527.6 36105.3 27017.9 33858.8 34141.5 34616.0 34726.7 34753.0 35186.1 35413.8 35429.0 35729.6 27151.9 29617.9 30665.7 30707.0 30790.0 21372.4 22076.3 23207.5 23655.8 23664.8 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:33087.56 Median:12612.68 stddev:92432.76 (732.9%) stddev-sans-first:92659.38 19:24:20 INFO - PROCESS | 1633 | Values: 357.4 374.3 380.9 386.0 409.7 14828.7 14891.0 17408.5 20022.8 20221.2 19746.8 19985.8 20414.8 20456.4 21017.6 4419.7 5151.6 5802.4 5812.5 5812.6 4798.9 5681.9 5731.3 5731.8 5769.4 5364.8 5693.5 5697.8 5699.9 5703.4 4713.8 4877.5 5752.1 5766.1 5770.7 5407.5 5589.8 5595.0 5764.5 5870.6 13225.8 13435.8 13453.5 13459.0 23001.4 2101.7 2223.9 2327.4 2931.5 2938.4 9710.7 9809.8 9865.7 10272.1 10311.9 1782.7 1829.5 1832.7 1839.9 1856.4 116052.0 118660.0 122422.0 123572.4 124315.0 11112.4 11310.5 11389.1 11436.9 11462.2 14374.1 14386.3 14428.3 14436.0 14475.9 8027.7 8274.3 8314.4 8356.5 8432.1 8125.8 8132.2 8168.0 8359.7 8370.6 3683.5 4384.5 4513.8 4567.5 4577.4 1544.9 1865.5 1923.6 1926.7 1935.6 860.9 907.9 928.3 997.8 1039.5 20372.4 21676.3 21709.1 21725.7 21790.0 925.3 951.5 955.3 983.0 986.2 10387.6 10939.7 11172.7 11197.7 11264.8 543048.0 545034.0 546608.0 556115.2 564588.0 116496.0 116865.8 118001.4 127601.0 130741.7 994.8 1029.3 1043.4 1043.5 1060.7 15138.8 15638.6 19591.9 19835.4 20025.2 36270.8 53479.7 53482.0 54510.5 56755.9 67868.7 73858.0 79735.0 80286.0 81792.0 7376.5 8060.6 8230.9 8298.5 8305.5 9973.8 12244.8 12703.7 13040.8 13092.3 10947.3 11037.9 11255.1 11406.8 11449.4 10900.3 10914.6 11101.3 11297.3 11361.5 10893.0 11271.3 11474.9 11501.4 11573.8 6952.0 7204.6 7349.5 7603.8 8453.8 9388.0 10908.9 11055.2 11160.3 11252.1 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5447.31 Median:5260.63 stddev:3021.75 (57.4%) stddev-sans-first:3014.63 19:24:20 INFO - PROCESS | 1633 | Values: 1362.4 1506.5 1540.8 1765.3 1928.1 6773.2 7856.7 8119.3 8500.4 8518.2 8204.6 8366.3 8462.8 8470.4 8472.5 2058.0 2294.1 2337.9 2339.9 2341.6 2139.4 2274.9 2352.5 2353.6 2368.3 2308.0 2320.6 2330.6 2333.1 2336.3 2270.3 2297.0 2300.0 2301.3 2301.4 2310.2 2338.7 2339.2 2342.6 2351.5 7035.9 8324.7 8397.7 8436.0 8523.9 5085.4 5251.9 5257.1 5259.9 5264.7 3135.3 3165.6 3296.4 3339.2 3342.6 825.2 955.8 995.3 995.8 999.1 11026.6 11040.7 11057.7 11059.5 11069.6 4593.6 4627.2 4647.7 4687.9 4760.8 9559.3 9623.4 9625.7 9626.5 9647.4 5260.0 5261.3 5267.8 5271.3 5277.2 4608.7 4717.5 4788.6 4831.2 4838.3 3732.3 3757.3 3788.9 3825.3 3830.4 1076.0 1258.4 1266.5 1274.0 1275.5 820.6 847.8 876.6 903.7 923.9 5213.5 5342.4 5508.7 5616.1 5654.5 917.4 950.0 950.7 961.9 987.1 3484.1 3604.5 3700.2 3718.7 3765.5 9980.0 10263.7 10338.4 10366.6 10467.4 10301.6 10321.8 10338.8 10340.5 10381.8 6390.9 7394.1 7778.4 7787.0 7987.4 4350.8 5713.5 5860.1 5870.4 5891.2 9192.2 9314.1 9379.2 9426.5 9528.5 9419.8 9541.7 9583.8 9608.4 9652.7 7081.3 7214.2 7277.5 7293.1 7294.5 6503.6 7822.6 7844.1 7899.6 7909.5 6030.0 7106.5 7193.3 7217.6 7299.7 6831.2 6868.6 7002.4 7077.0 7177.2 6627.7 6680.4 6741.0 6758.4 6773.2 4740.3 4866.1 4867.9 4902.5 5034.0 4123.9 4786.6 4926.2 4984.7 5003.0 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4370.66 Median:4984.93 stddev:1374.39 (27.6%) stddev-sans-first:1344.32 19:24:20 INFO - PROCESS | 1633 | Values: 327.0 353.5 357.5 364.3 373.3 4277.6 5045.4 5128.8 5214.5 5282.9 5049.6 5179.1 5267.4 5374.5 5377.6 3042.6 3477.3 3932.8 4061.4 4068.4 3679.8 3809.7 3890.7 3954.3 4031.3 3554.5 3667.4 3669.8 3945.7 3947.2 3161.5 3505.9 3970.0 3980.4 4009.5 2820.6 3263.7 3384.6 3404.6 3466.7 5088.2 5090.8 5110.2 5152.8 5203.9 4497.8 4500.7 4508.5 4541.3 4553.3 4974.5 5295.7 5538.9 5572.7 5574.7 3290.8 3659.9 3777.8 3796.1 3813.4 4895.6 5861.3 5904.5 5910.5 5936.0 2872.7 3289.9 3441.0 3800.6 3895.5 3324.0 3333.0 3675.8 3920.2 3929.9 3887.2 4252.7 4434.0 4442.6 4444.9 4787.6 5057.4 5625.4 5640.2 5656.7 1191.3 1236.7 1249.5 1268.8 1278.3 754.0 760.9 775.0 779.3 831.7 4919.2 4995.3 5003.8 5013.0 5038.9 4659.8 4710.7 4823.7 5277.0 5378.1 4186.7 4262.5 4443.7 5037.7 5343.7 2486.6 2670.8 2822.4 2886.5 2913.0 5384.8 5647.8 5720.5 5775.3 5781.4 4955.6 5607.6 5655.6 5667.9 5691.5 4966.9 5012.9 5385.1 5531.8 5737.1 5158.4 5215.6 5291.6 5505.9 5513.9 4861.4 4895.4 5359.4 5469.5 5496.1 4517.0 5136.5 5633.7 5717.0 5730.9 3137.6 3534.1 3647.3 3665.8 3679.9 4781.9 5388.7 5640.6 5799.3 5819.9 5291.5 5303.6 5491.9 5552.6 5587.9 4437.0 4680.5 4899.4 5534.5 5559.9 5321.3 5437.5 5445.8 5483.9 5487.8 5454.6 5463.8 5483.9 5490.7 5535.5 4659.7 5006.2 5022.6 5161.6 5373.2 19:24:20 INFO - PROCESS | 1633 | 19:24:20 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20575.10 Median:4416.67 stddev:29749.36 (673.6%) stddev-sans-first:29795.38 19:24:20 INFO - PROCESS | 1633 | Values: 700.4 733.8 739.0 743.4 744.6 15123.9 15688.8 15692.5 15697.0 15708.8 14234.0 14410.0 14412.4 14421.1 14436.4 697.1 718.4 726.0 866.2 891.5 856.7 881.7 882.3 892.4 892.9 961.0 964.9 965.6 966.0 967.7 729.1 952.9 953.6 958.1 961.7 557.4 688.2 708.3 715.9 717.0 14198.4 14258.0 14260.9 14273.4 14281.6 13762.4 13771.0 13797.2 13874.4 13888.5 12508.6 12521.9 12747.7 12984.5 13075.6 4365.8 4399.8 4466.8 4488.5 4613.3 97960.5 101677.5 102391.0 104759.0 107352.0 10897.9 11060.7 11200.9 11204.1 11494.1 19875.6 22143.4 22155.1 22156.9 22187.2 7664.4 7745.9 7920.6 7928.3 7966.6 4300.2 4336.6 4339.9 4357.4 4370.8 3378.4 3472.4 3476.8 3485.4 3499.5 583.9 621.7 623.5 637.4 644.9 535.9 600.8 611.7 617.2 623.2 8447.9 8680.0 8799.7 8913.3 9279.4 585.3 589.2 611.3 614.5 621.4 4280.2 4377.6 4401.2 4432.1 4454.8 73764.0 93878.0 95828.5 108890.5 113372.9 95640.0 97188.0 97281.5 97600.0 99847.0 83487.2 84453.6 84687.2 85027.6 86107.0 8318.3 8577.2 8637.8 8706.6 8932.6 45225.3 46651.0 47444.8 49646.0 52110.5 60406.7 66848.0 69020.7 70481.6 72565.3 10085.4 10668.8 13300.7 13374.3 13625.9 14630.9 14716.6 14761.1 14794.9 14881.9 12293.9 12755.6 13499.8 13624.0 14379.0 13671.8 13802.4 13864.0 14070.8 14278.8 11579.8 13241.4 13549.7 13605.9 13656.9 11014.9 11415.5 11457.6 11502.7 11658.8 10853.0 10949.4 11203.2 11495.3 11581.8 19:24:20 INFO - PROCESS | 1633 | -------- Summary: end -------- 19:24:20 INFO - PROCESS | 1633 | 19:24:21 INFO - TEST-INFO | 1633: exit 0 19:24:21 INFO - TEST-OK | dromaeo_css | took 1119561ms 19:24:21 INFO - TEST-START | kraken 19:24:21 INFO - operating with platform_type : mac_ 19:24:21 INFO - Initialising browser for kraken test... 19:24:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpGmhIdF/profile http://localhost:49241/getInfo.html) 19:24:23 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 19:24:23 INFO - PROCESS | 1642 | colorDepth:24 19:24:23 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 19:24:23 INFO - PROCESS | 1642 | __metrics 19:24:23 INFO - PROCESS | 1642 | 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" 19:24:23 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:24:24 INFO - TEST-INFO | 1642: exit 0 19:24:24 INFO - Browser initialized. 19:24:24 INFO - Running cycle 1/1 for kraken test... 19:24:24 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpGmhIdF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:36 INFO - PROCESS | 1643 | RSS: Main: 237649920 19:24:36 INFO - PROCESS | 1643 | 19:24:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:40 INFO - PROCESS | 1643 | RSS: Main: 289267712 19:24:40 INFO - PROCESS | 1643 | 19:24:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 19:24:43 INFO - PROCESS | 1643 | RSS: Main: 290811904 19:24:43 INFO - PROCESS | 1643 | 19:24:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 19:24:47 INFO - PROCESS | 1643 | RSS: Main: 381734912 19:24:47 INFO - PROCESS | 1643 | 19:24:49 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 19:24:50 INFO - PROCESS | 1643 | RSS: Main: 285863936 19:24:50 INFO - PROCESS | 1643 | 19:24:52 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:52 INFO - PROCESS | 1643 | RSS: Main: 289759232 19:24:52 INFO - PROCESS | 1643 | 19:24:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:56 INFO - PROCESS | 1643 | RSS: Main: 332980224 19:24:56 INFO - PROCESS | 1643 | 19:24:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:59 INFO - PROCESS | 1643 | RSS: Main: 334172160 19:24:59 INFO - PROCESS | 1643 | 19:25:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 19:25:03 INFO - PROCESS | 1643 | RSS: Main: 328814592 19:25:03 INFO - PROCESS | 1643 | 19:25:04 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:05 INFO - PROCESS | 1643 | RSS: Main: 304599040 19:25:05 INFO - PROCESS | 1643 | 19:25:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:08 INFO - PROCESS | 1643 | RSS: Main: 309243904 19:25:08 INFO - PROCESS | 1643 | 19:25:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:10 INFO - PROCESS | 1643 | RSS: Main: 310431744 19:25:10 INFO - PROCESS | 1643 | 19:25:13 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:14 INFO - PROCESS | 1643 | RSS: Main: 327413760 19:25:14 INFO - PROCESS | 1643 | 19:25:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:17 INFO - PROCESS | 1643 | RSS: Main: 321241088 19:25:17 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 19:25:19 INFO - PROCESS | 1643 | RSS: Main: 365445120 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | __start_tp_report 19:25:19 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 19:25:19 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 19:25:19 INFO - PROCESS | 1643 | |i|pagename|runs| 19:25:19 INFO - PROCESS | 1643 | |0;ai-astar;114;114;114;114;113;114;113;113;114;115 19:25:19 INFO - PROCESS | 1643 | |1;audio-beat-detection;144;112;113;148;112;121;149;140;142;114 19:25:19 INFO - PROCESS | 1643 | |2;audio-dft;183;185;182;187;180;182;180;183;182;181 19:25:19 INFO - PROCESS | 1643 | |3;audio-fft;79;59;59;86;61;62;64;84;97;83 19:25:19 INFO - PROCESS | 1643 | |4;audio-oscillator;90;66;85;69;69;69;83;68;68;84 19:25:19 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;109;109;107;109;108;110;109;112;108;109 19:25:19 INFO - PROCESS | 1643 | |6;imaging-darkroom;94;94;95;94;94;95;94;94;94;93 19:25:19 INFO - PROCESS | 1643 | |7;imaging-desaturate;84;84;83;87;95;133;130;88;87;88 19:25:19 INFO - PROCESS | 1643 | |8;json-parse-financial;55;53;54;53;54;55;56;57;54;54 19:25:19 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;70;67;81;74;74;70;70;73;71;71 19:25:19 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;89;87;88;87;90;91;86;86;90;89 19:25:19 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;139;138;131;132;160;166;142;153;169;147 19:25:19 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;168;172;169;171;172;171;172;162;171;174 19:25:19 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;66;67;67;66;66 19:25:19 INFO - PROCESS | 1643 | __end_tp_report 19:25:19 INFO - PROCESS | 1643 | __start_cc_report 19:25:19 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2114 19:25:19 INFO - PROCESS | 1643 | __end_cc_report 19:25:19 INFO - PROCESS | 1643 | __startTimestamp1482290719964__endTimestamp 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | ------- Summary: start ------- 19:25:19 INFO - PROCESS | 1643 | Number of tests: 14 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 19:25:19 INFO - PROCESS | 1643 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 113.0 113.0 114.0 115.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:141.00 stddev:16.32 (11.6%) stddev-sans-first:16.44 19:25:19 INFO - PROCESS | 1643 | Values: 144.0 112.0 113.0 148.0 112.0 121.0 149.0 140.0 142.0 114.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:182.50 Median:182.50 stddev:2.17 (1.2%) stddev-sans-first:2.30 19:25:19 INFO - PROCESS | 1643 | Values: 183.0 185.0 182.0 187.0 180.0 182.0 180.0 183.0 182.0 181.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:73.40 Median:81.00 stddev:13.90 (17.2%) stddev-sans-first:14.59 19:25:19 INFO - PROCESS | 1643 | Values: 79.0 59.0 59.0 86.0 61.0 62.0 64.0 84.0 97.0 83.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:9.17 (12.1%) stddev-sans-first:7.99 19:25:19 INFO - PROCESS | 1643 | Values: 90.0 66.0 85.0 69.0 69.0 69.0 83.0 68.0 68.0 84.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:1.33 (1.2%) stddev-sans-first:1.41 19:25:19 INFO - PROCESS | 1643 | Values: 109.0 109.0 107.0 109.0 108.0 110.0 109.0 112.0 108.0 109.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:25:19 INFO - PROCESS | 1643 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 93.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:87.00 stddev:19.07 (21.9%) stddev-sans-first:19.73 19:25:19 INFO - PROCESS | 1643 | Values: 84.0 84.0 83.0 87.0 95.0 133.0 130.0 88.0 87.0 88.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.27 (2.3%) stddev-sans-first:1.33 19:25:19 INFO - PROCESS | 1643 | Values: 55.0 53.0 54.0 53.0 54.0 55.0 56.0 57.0 54.0 54.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:3.78 (5.3%) stddev-sans-first:3.94 19:25:19 INFO - PROCESS | 1643 | Values: 70.0 67.0 81.0 74.0 74.0 70.0 70.0 73.0 71.0 71.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:1.77 (2.0%) stddev-sans-first:1.86 19:25:19 INFO - PROCESS | 1643 | Values: 89.0 87.0 88.0 87.0 90.0 91.0 86.0 86.0 90.0 89.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:150.00 stddev:13.73 (9.2%) stddev-sans-first:14.20 19:25:19 INFO - PROCESS | 1643 | Values: 139.0 138.0 131.0 132.0 160.0 166.0 142.0 153.0 169.0 147.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.50 stddev:3.33 (1.9%) stddev-sans-first:3.43 19:25:19 INFO - PROCESS | 1643 | Values: 168.0 172.0 169.0 171.0 172.0 171.0 172.0 162.0 171.0 174.0 19:25:19 INFO - PROCESS | 1643 | 19:25:19 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 19:25:19 INFO - PROCESS | 1643 | Values: 67.0 68.0 67.0 68.0 67.0 66.0 67.0 67.0 66.0 66.0 19:25:19 INFO - PROCESS | 1643 | -------- Summary: end -------- 19:25:19 INFO - PROCESS | 1643 | 19:25:20 INFO - TEST-INFO | 1643: exit 0 19:25:20 INFO - TEST-OK | kraken | took 59544ms 19:25:20 INFO - SUITE-END | took 1179s 19:25:21 INFO - Completed test suite (00:19:39) 19:25:21 INFO - javascript benchmark 19:25:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.604887413511, 3327.4509705898527, 3327.6672332766725, 3354.530365748797, 3375.426177549816, 5444.727763611819, 5567.805126820562, 5642.04085305498, 5655.095184770437, 5735.856603584913, 4241.342591898253, 5625.296837895263, 5657.688827114507, 5714.77140914364, 5778.248827652399, 5110.412302585194, 5154.38147422308, 5158.0576228722975, 5183.533481986639, 5232.8691782705355, 5220.321358223426, 5287.021900948337, 5308.177232528964, 5330.626856120073, 5371.435999220084, 5126.359205099363, 5266.499682530153, 5297.496737809902, 5299.49654782795, 5371.221172929922, 5158.7420628968775, 5170.6122040847085, 5213.53078222958, 5213.895722085575, 5227.60792940531, 5134.2041983492245, 5180.507851754077, 5197.116490196676, 5200.5059519345605, 5243.4232234454175, 5693.430656934315, 5707.714614269312, 5713.257276554022, 5730.05454100073, 5765.625234359753, 6074.726637301332, 6116.174316467264, 6121.326654068049, 6173.9073913891325, 6237.6257424554215, 6172.691365431755, 6205.7517699291975, 6234.532410069263, 6237.625742455467, 6242.594231374991, 5803.912941305799, 5805.216295800097, 5836.766529338822, 5854.151148083504, 5863.061910094364, 6262.718177682015, 6297.96851015742, 6338.080978258126, 6347.460465860361, 6354.3963323484195, 5957.374475680078, 6003.5797494174985, 6134.22411175217, 6174.876502469925, 6182.103594978703, 5165.74171291434, 6183.598066125687, 6198.504119670415, 6211.378862113843, 6216.098665693539, 6180.258368995749, 6235.501159907197, 6236.781712640036, 6243.094751261042, 6246.750129994749, 6247.5939063960695, 6264.404881536247, 6266.122742816009, 6272.717727702265, 6279.152314437584, 4873.025394920959, 4902.901941961212, 4903.607711383081, 4938.530839570235, 5016.54851063406, 4384.342348647729, 4390.846320378771, 4432.623227025739, 4436.7559784211535, 4489.753063581535, 5797.4782269595935, 5812.534997200214, 5823.388544202882, 5828.388019258002, 5873.823785286363, 6113.755449781959, 6172.506199504029, 6197.101420294032, 6301.243850737941, 6308.116863639094, 5737.8565535861935, 5783.8554036149435, 5810.738516766755, 5867.178594996619, 5870.0, 5434.619576629598, 5443.863903402446, 5455.399906010336, 5462.945370546323, 5466.726663666801, 6345.07996340528, 6350.714217860115, 6353.205849268841, 6359.7456101755415, 6374.075759014824, 5280.947190528199, 5964.8807023860145, 6044.697765111815, 6058.454739073504, 6286.968565157145, 6298.937010629835, 6309.958856788762, 6340.080688300263, 6344.873102537831, 6348.079528468254, 6177.444030037318, 6203.47270481996, 6209.006558950727, 6210.410011049124, 6210.720517576629, 6051.425114614105, 6106.278657334014, 6168.907466388097, 6288.591241569284, 6296.33888441707, 6062.727177277121, 6072.271327440559, 6073.48375388097, 6078.209832721895, 6082.0, 6044.365341639241, 6072.514198864169, 6076.605020673642, 6077.665728384981, 6081.847953801191, 5860.150278209721, 5892.970535147297, 5896.64620122794, 5919.319278283053, 5922.289325280994, 6062.818115456544, 6072.757089716361, 6076.361981991828, 6092.116643086816, 6096.817095487142, 5313.787448502017, 5883.117532370007, 5923.49650279731, 5926.525877929669, 5938.990371636918], "value": 5682.691215187528, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.7241586087996, 496.01045913402754, 502.4197052404473, 502.52009331088834, 530.5622861139561, 30092.548611770813, 31174.844125779367, 31212.0, 31271.843640781823, 31303.53044704331, 38377.23245535087, 38956.61043389565, 39162.21675566487, 41243.58756412435, 41284.58715412845, 9036.8644470333, 9222.216111630485, 9229.446233226028, 9237.353385263, 9244.0, 8330.50016998982, 9084.091590840897, 9210.76973075675, 9215.262778977665, 9234.445933243993, 8300.792480188013, 10883.782324353508, 11151.163662725288, 11177.608783692573, 11324.03745681618, 11045.171612129083, 11112.555497780078, 11115.944420277927, 11117.332960022344, 11124.38815865127, 8268.875966860502, 10917.727056823564, 11030.724231894186, 11033.062189713884, 11036.944815275872, 30145.246368840733, 36431.4535281971, 37118.0, 37136.44295335572, 37518.249635007145, 3424.845881935294, 3424.931501369959, 3517.278957813642, 3526.2066035142143, 3777.3200823851694, 28384.4886959126, 28640.856795716096, 28849.56725649117, 29002.854985724935, 29282.70717292821, 3155.2742869140225, 3160.478521044025, 3194.8083115013173, 3269.75476839238, 3283.0, 496499.0, 496511.0, 498955.0, 500156.0, 503134.99999999633, 60795.69602151961, 61222.081668775005, 61266.16201513962, 61356.38643613596, 61490.0, 64585.0, 64616.67691661511, 64658.0, 64715.35284647093, 64778.352216478175, 15439.459618913508, 15974.361025558848, 16000.0, 16004.919975400282, 16095.839041609433, 12466.252024878537, 12528.997680185563, 12530.498780048878, 12533.31066791317, 12537.185082969578, 14268.500602478864, 14610.123392596479, 15463.768043479356, 16153.838461615469, 16156.0, 5584.134459158837, 6690.5316627836555, 6702.966485167543, 6706.26231114577, 6761.763338283136, 908.6092980018524, 962.7304354780673, 1004.1113614451264, 1004.7136566078633, 1049.7008352619466, 27629.0, 27780.58329125065, 29181.416371672447, 29207.853960730485, 29871.850640747092, 966.8743063401713, 1054.6941386997837, 1116.843641890136, 1139.510010695409, 1177.4112943528237, 14299.498552651821, 14818.629534261514, 14958.02772819785, 15175.924120379328, 15604.712432271122, 595545.0, 595616.0, 599442.0, 601073.0, 601102.0, 58074.0, 58199.709001455565, 58348.70825645929, 58366.0, 58400.415995839496, 1346.2864681718704, 1379.3654918737493, 1398.084254813099, 1401.1242973141786, 1403.7192561487743, 27221.319467013484, 27716.30709232285, 27861.860690696416, 27949.301267468476, 28231.57652635171, 50765.73085672888, 51215.23177152271, 51296.0, 51302.486975129774, 51418.74290628523, 535113.0, 535901.0, 542107.0, 543369.0, 544243.0, 37920.0, 38334.46662133595, 38509.614903851725, 38699.6130038696, 38778.61221387863, 42832.57167428286, 43106.353404698326, 43488.13023739571, 43567.0, 43667.34498982581, 28485.43029139364, 35030.824845875606, 35086.64913350936, 35527.644723553465, 36105.277894442486, 27017.864910676108, 33858.83070584631, 34141.48787768235, 34616.0, 34726.65273347234, 34753.0, 35186.12034699153, 35413.82293088518, 35429.0, 35729.64270357263, 27151.86424067867, 29617.851910740308, 30665.693343066283, 30707.0, 30790.0, 21372.35882923515, 22076.33770986873, 23207.535849283257, 23655.763442366046, 23664.763352366255], "value": 19383.24708630342, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.39243286413074, 374.30753106752513, 380.853371451991, 386.00410939775384, 409.6886366361566, 14828.703425931475, 14890.957632965683, 17408.47774566762, 20022.799772002312, 20221.203666799513, 19746.802531974678, 19985.800141998574, 20414.795852041476, 20456.397310605105, 21017.579648407023, 4419.712718673292, 5151.562117220041, 5802.361740208574, 5812.4768770810615, 5812.622179558336, 4798.856034318976, 5681.857953551153, 5731.283589551306, 5731.767669950959, 5769.394213607574, 5364.758585863646, 5693.459121383462, 5697.8005769798065, 5699.914501282484, 5703.40114288, 4713.811447542094, 4877.536634019798, 5752.13717942312, 5766.135079738052, 5770.653760774367, 5407.459254074601, 5589.80435684749, 5594.9720251398885, 5764.452377024176, 5870.559708021916, 13225.801612975813, 13435.798463022964, 13453.529126480624, 13459.0, 23001.424964375856, 2101.7477902651626, 2223.9332820015425, 2327.359976006595, 2931.4576803291247, 2938.3682508260827, 9710.708678739578, 9809.754756131082, 9865.654702085465, 10272.126869216125, 10311.896881031169, 1782.7415024821328, 1829.4511646505996, 1832.725091236312, 1839.9264029438807, 1856.4059500959697, 116052.0, 118660.0, 122421.99999999911, 123572.38213808874, 124315.0, 11112.44437778108, 11310.491027903765, 11389.145814063979, 11436.885631143748, 11462.197646164688, 14374.053319069566, 14386.28068596566, 14428.278586070655, 14435.989480736247, 14475.855241447662, 8027.719029833927, 8274.338052955749, 8314.41799074071, 8356.456830306011, 8432.072472028072, 8125.837483250302, 8132.227438393344, 8167.95916020428, 8359.707410240613, 8370.581470926429, 3683.5211422514903, 4384.539623339503, 4513.842015529441, 4567.474740404829, 4577.359169716243, 1544.9304781284868, 1865.4963159946738, 1923.557581756176, 1926.7013612890025, 1935.622553602034, 860.9311255099577, 907.9319051071196, 928.3223247029706, 997.7677568203263, 1039.5374058543875, 20372.388828335173, 21676.34970950874, 21709.13163473475, 21725.67411488829, 21790.0, 925.3476299209176, 951.509972364233, 955.3408148377597, 982.9901700983041, 986.225812736998, 10387.584496620051, 10939.726506837393, 11172.720681983015, 11197.720056998478, 11264.831027534594, 543048.0, 545034.0, 546608.0, 556115.2194239084, 564588.0, 116496.0, 116865.8313416855, 118001.40999294948, 127601.0, 130741.69258307485, 994.7766741333114, 1029.2897900448665, 1043.4417586591137, 1043.4574021508772, 1060.7136073260176, 15138.772918406012, 15638.609034774221, 19591.902040489706, 19835.404937851887, 20025.198992040154, 36270.81864590766, 53479.73260133674, 53482.0, 54510.45489545212, 56755.86488270129, 67868.6606566964, 73858.0, 79735.0, 80286.0, 81792.0, 7376.4836461447185, 8060.556669383241, 8230.917690823015, 8298.543580103153, 8305.501669899826, 9973.849840414321, 12244.837319863389, 12703.682407939876, 13040.804387933998, 13092.279924604238, 10947.34315941046, 11037.889621103686, 11255.099592032782, 11406.771864562828, 11449.370284634426, 10900.291481053706, 10914.563417463212, 11101.278416902875, 11297.322160670057, 11361.54553817838, 10893.0, 11271.323720576791, 11474.909883561048, 11501.424928753697, 11573.826392604286, 6952.0, 7204.639768011683, 7349.522281051714, 7603.809904752426, 8453.788655283666, 9387.953060234655, 10908.945455272673, 11055.22613417053, 11160.274582152135, 11252.099832013582], "value": 9257.584324462003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.4413990263993, 1506.5329747778187, 1540.7611820167879, 1765.337998250656, 1928.0745242283704, 6773.187217533897, 7856.685732570698, 8119.309858662021, 8500.404971651988, 8518.23335899769, 8204.630791614376, 8366.330693544516, 8462.830743385144, 8470.407071504997, 8472.534010629413, 2057.989710051455, 2294.1396976133906, 2337.929862104131, 2339.87130707811, 2341.625339945609, 2139.358192542239, 2274.931752047441, 2352.494213744045, 2353.5528249632603, 2368.348704106376, 2307.9538409231805, 2320.640300753386, 2330.592146374386, 2333.0900948630047, 2336.3458231695154, 2270.330252575486, 2296.954060918789, 2299.9655005174936, 2301.3096071178747, 2301.401635574746, 2310.1798861404127, 2338.707661542307, 2339.239747082188, 2342.5900467418132, 2351.541449417364, 7035.929640703579, 8324.66701331946, 8397.748067557983, 8436.0, 8523.914760852374, 5085.389753229599, 5251.947480525184, 5257.08001099806, 5259.86850328741, 5264.657797243167, 3135.3102317490343, 3165.6071328615567, 3296.3901678189613, 3339.231976645385, 3342.615599206074, 825.22428916818, 955.804060167671, 995.2933417273672, 995.775950411159, 999.1058003087196, 11026.558937642485, 11040.723981900517, 11057.723556911142, 11059.502322395512, 11069.557217711283, 4593.6095431888, 4627.190241707755, 4647.651426143053, 4687.929681054787, 4760.785764640599, 9559.283053770994, 9623.422594644344, 9625.663101791404, 9626.47054412, 9647.372920760128, 5260.0, 5261.263423120766, 5267.815626453055, 5271.288376069258, 5277.182036784305, 4608.677392582554, 4717.504662010508, 4788.569028787426, 4831.202851529459, 4838.346823178826, 3732.328180927459, 3757.342465068602, 3788.9242215156096, 3825.3496905526126, 3830.433609481654, 1075.9623413180502, 1258.358237298984, 1266.4807428954084, 1273.9745205095846, 1275.5025540039392, 820.5659315763548, 847.8007668197969, 876.6055275126091, 903.701778413122, 923.930705197113, 5213.504717051874, 5342.439043900412, 5508.697021663847, 5616.073347897633, 5654.491095801398, 917.4036876030633, 949.9835176361228, 950.7480517662825, 961.9038096190325, 987.0918754745651, 3484.0767196692896, 3604.4953706481115, 3700.2229531798625, 3718.6839118674675, 3765.548134223911, 9980.0, 10263.74340641475, 10338.431386273676, 10366.637167699246, 10467.42429166388, 10301.587936482607, 10321.84517232242, 10338.844917326247, 10340.53467593945, 10381.792364152674, 6390.936090639034, 7394.075740532434, 7778.416618753616, 7787.026621672404, 7987.3610111190965, 4350.782460877007, 5713.457221563945, 5860.09168578871, 5870.354261031369, 5891.204687367151, 9192.17270445663, 9314.115159059878, 9379.249660027317, 9426.491503669635, 9528.475933823705, 9419.764505887133, 9541.666041688784, 9583.760405989906, 9608.423494590346, 9652.662156824477, 7081.327273908971, 7214.242504537158, 7277.490575659865, 7293.124825021031, 7294.525855819355, 6503.6097834130105, 7822.5697586631, 7844.137144914169, 7899.565523896241, 7909.52542847431, 6029.969850150721, 7106.538075025107, 7193.280671932765, 7217.6030318333, 7299.708011679473, 6831.180258369028, 6868.62222577763, 7002.439804815501, 7077.0, 7177.246389129066, 6627.734890604322, 6680.3987641112535, 6740.966295168493, 6758.391744742997, 6773.187217533928, 4740.336352910526, 4866.075445665312, 4867.878303042452, 4902.4607293197005, 5034.0, 4123.9175216496105, 4786.593139583175, 4926.187179115549, 4984.675996060245, 5002.9994001199175], "value": 4401.87463439338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.0, 353.45214916878837, 357.4887910288288, 364.26782167842634, 373.32241980804855, 4277.572242775721, 5045.445001049886, 5128.794733237686, 5214.497041420116, 5282.947170528294, 5049.621278404125, 5179.093658609747, 5267.367915850094, 5374.516293533581, 5377.569794416447, 3042.574039634453, 3477.3045390921916, 3932.803359831997, 4061.3501839705655, 4068.3694027425795, 3679.7792132472005, 3809.695224382043, 3890.7276490645527, 3954.307996100685, 4031.3191727501176, 3554.5023696682356, 3667.449882517617, 3669.7981611011382, 3945.684345252373, 3947.2105578884193, 3161.462551366273, 3505.8597656093725, 3969.9603003970024, 3980.383040628707, 4009.51885773709, 2820.63331766869, 3263.673632636741, 3384.627690953993, 3404.553064947412, 3466.687998080185, 5088.160453525164, 5090.847274581768, 5110.233464980245, 5152.819651312224, 5203.9219411708855, 4497.797599108016, 4500.707454015511, 4508.458984921797, 4541.250693635546, 4553.317002449626, 4974.527419895104, 5295.735213239323, 5538.9169162462595, 5572.690417751865, 5574.693391863446, 3290.8190049547266, 3659.9268014639824, 3777.8111094445444, 3796.0889386547306, 3813.408921617126, 4895.632827537914, 5861.325947516005, 5904.527637788967, 5910.527157827363, 5935.970320148414, 2872.6696429910826, 3289.901302960915, 3440.9827950860085, 3800.638939300762, 3895.454636350913, 3324.0, 3333.0, 3675.8162091895833, 3920.2159568086495, 3929.899628104078, 3887.2225554889137, 4252.681048921343, 4434.026858048138, 4442.644588432918, 4444.911101777946, 4787.569118779326, 5057.367829021372, 5625.399744163738, 5640.223329651229, 5656.680760888098, 1191.326900301327, 1236.746466974268, 1249.5439164704817, 1268.7589358021946, 1278.3033246880473, 753.963300461865, 760.9315161635369, 774.9573773442514, 779.2519181585741, 831.7213733399379, 4919.163052818807, 4995.327499787596, 5003.849884503471, 5012.974935125301, 5038.949610503922, 4659.836905708352, 4710.715303078005, 4823.710577365299, 5276.973615131977, 5378.11261141915, 4186.6859985501205, 4262.50981137167, 4443.7111587746695, 5037.697738135724, 5343.7175077981, 2486.6394372816203, 2670.813043086965, 2822.379076603144, 2886.5381538953666, 2913.0, 5384.78460861569, 5647.8040203013325, 5720.456556627197, 5775.335836378787, 5781.4218578141845, 4955.554000139932, 5607.579431542651, 5655.575831812631, 5667.858303542444, 5691.548655093007, 4966.8758281043265, 5012.922221722347, 5385.084535629031, 5531.778728850882, 5737.139429085671, 5158.3552055993005, 5215.574757737671, 5291.576673866159, 5505.944940550543, 5513.889722205453, 4861.371440567449, 4895.4370247422, 5359.392182345358, 5469.453054694499, 5496.120620700669, 4517.025017984153, 5136.512031357015, 5633.746481408264, 5716.999050332351, 5730.885382292414, 3137.6234851817926, 3534.081138903852, 3647.3070116677745, 3665.837156077927, 3679.865677906861, 4781.880452988564, 5388.73056347189, 5640.5769567281795, 5799.2750906136735, 5819.883602328015, 5291.523762861361, 5303.6210585247345, 5491.892539937896, 5552.611317207919, 5587.944120558743, 4437.001674623184, 4680.485146633936, 4899.363082799213, 5534.4742249486235, 5559.916601251065, 5321.2816269804625, 5437.483439073281, 5445.83662490126, 5483.945160548344, 5487.807926722546, 5454.59090568201, 5463.754131064191, 5483.888702849352, 5490.6980116094, 5535.501804837584, 4659.743714095757, 5006.173981293192, 5022.598192144693, 5161.638685292144, 5373.194020896896], "value": 3943.690569316771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.4396482813747, 733.7615275035614, 738.9815254618634, 743.3978477433283, 744.6090802328777, 15123.924380378097, 15688.843111568882, 15692.450764223255, 15697.0, 15708.764368534466, 14234.0, 14410.0, 14412.423503059892, 14421.134731916067, 14436.350364233609, 697.1181455458849, 718.3750137380487, 725.9981225908239, 866.2290561400343, 891.4784850862253, 856.7044369692446, 881.7398867334152, 882.2677177942293, 892.4422236102404, 892.8883889513811, 961.0437614573474, 964.9179819715332, 965.5703212070631, 965.9806803863919, 967.7145242153547, 729.0886392009987, 952.9237660987104, 953.6376177052675, 958.1376760915232, 961.6586111930304, 557.436988641471, 688.1810645332039, 708.3341658840674, 715.9284071592851, 717.0499088707431, 14198.432062717582, 14258.001939864214, 14260.92869535656, 14273.429062837475, 14281.642958926006, 13762.449502019907, 13771.0, 13797.24115173665, 13874.4450221991, 13888.513902013483, 12508.562200322946, 12521.937390313082, 12747.745045099045, 12984.545540906118, 13075.600343910557, 4365.825366985317, 4399.802008909607, 4466.7766611669285, 4488.506264310923, 4613.284940834143, 97960.51019744856, 101677.49161254146, 102391.0, 104759.0, 107352.0, 10897.945510272399, 11060.723481913017, 11200.935911088434, 11204.103671706243, 11494.13793965456, 19875.60248795016, 22143.44641383946, 22155.113795448324, 22156.88921555382, 22187.223447179273, 7664.425168112414, 7745.883811742829, 7920.643571039317, 7928.3260922821055, 7966.6415011324625, 4300.204462174508, 4336.588024137702, 4339.913201736011, 4357.3899654048455, 4370.759608221579, 3378.35811195872, 3472.427049536798, 3476.8435420406145, 3485.4249048907154, 3499.492573576817, 583.8540364908773, 621.7140115546899, 623.538581449733, 637.4486069549898, 644.9355064493607, 535.9249705041298, 600.7687040489443, 611.7308384310978, 617.2438762515972, 623.2365352443311, 8447.915520844714, 8680.045195028542, 8799.680047992852, 8913.343052864948, 9279.39683920543, 585.3034888482692, 589.2487078974257, 611.3366996808423, 614.4991831657275, 621.382278731513, 4280.165367753259, 4377.562243775661, 4401.207782599099, 4432.13573353193, 4454.844080457168, 73764.0, 93878.0, 95828.52085739667, 108890.45554772334, 113372.86627133623, 95640.04359956311, 97188.0, 97281.5407768884, 97600.0, 99847.0, 83487.16512834794, 84453.57773211217, 84687.15312846792, 85027.5748621253, 86107.0, 8318.319812870202, 8577.185167409087, 8637.827243455222, 8706.60820263077, 8932.598033088656, 45225.32162017506, 46651.0, 47444.7627761859, 49646.0, 52110.47889521056, 60406.697966509884, 66848.0, 69020.6548967252, 70481.64759176376, 72565.27434725585, 10085.394876307446, 10668.83996740065, 13300.667483312995, 13374.331283435595, 13625.931870340584, 14630.926845365704, 14716.55850324492, 14761.114333140045, 14794.852051479347, 14881.851181488046, 12293.877061229274, 12755.553555625509, 13499.797503037658, 13624.0, 14379.0, 13671.79492307636, 13802.447902083804, 13864.0, 14070.78893816614, 14278.785818212527, 11579.8263026053, 13241.404136814059, 13549.729005420033, 13605.86394136046, 13656.863431365957, 11014.944925275642, 11415.543378264776, 11457.59898403552, 11502.698194418947, 11658.76682466329, 10852.968967948033, 10949.397783122005, 11203.241026457817, 11495.252808567417, 11581.82627260575], "value": 7448.91761327755, "unit": "score"}], "name": "dromaeo_css", "value": 7134.440489109051, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 113.0, 148.0, 112.0, 121.0, 149.0, 140.0, 142.0, 114.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 187.0, 180.0, 182.0, 180.0, 183.0, 182.0, 181.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 86.0, 61.0, 62.0, 64.0, 84.0, 97.0, 83.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 66.0, 85.0, 69.0, 69.0, 69.0, 83.0, 68.0, 68.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 107.0, 109.0, 108.0, 110.0, 109.0, 112.0, 108.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 95.0, 133.0, 130.0, 88.0, 87.0, 88.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 54.0, 55.0, 56.0, 57.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 81.0, 74.0, 74.0, 70.0, 70.0, 73.0, 71.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 87.0, 90.0, 91.0, 86.0, 86.0, 90.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 131.0, 132.0, 160.0, 166.0, 142.0, 153.0, 169.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 169.0, 171.0, 172.0, 171.0, 172.0, 162.0, 171.0, 174.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1473.0000000000002, "alertThreshold": 2.0}]} 19:25:21 INFO - Return code: 0 19:25:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:21 INFO - # TBPL SUCCESS # 19:25:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:25:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:25:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:25:21 INFO - 2016-12-20 19:25:21.314 screenresolution[1647:9784] starting screenresolution argv=screenresolution get 19:25:21 INFO - 2016-12-20 19:25:21.317 screenresolution[1647:9784] Display 0: 1600x1200x32@60 19:25:21 INFO - 2016-12-20 19:25:21.323 screenresolution[1648:9787] starting screenresolution argv=screenresolution list 19:25:21 INFO - Available Modes on Display 0 19:25:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:25:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:25:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:25:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:25:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:25:21 INFO - Intel Iris: 19:25:21 INFO - Chipset Model: Intel Iris 19:25:21 INFO - Type: GPU 19:25:21 INFO - Bus: Built-In 19:25:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:25:21 INFO - Vendor: Intel (0x8086) 19:25:21 INFO - Device ID: 0x0a2e 19:25:21 INFO - Revision ID: 0x0009 19:25:21 INFO - Displays: 19:25:21 INFO - Display: 19:25:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:25:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:25:21 INFO - Display Serial Number: 1600x1200 60 19:25:21 INFO - Main Display: Yes 19:25:21 INFO - Mirror: Off 19:25:21 INFO - Online: Yes 19:25:21 INFO - Rotation: Supported 19:25:21 INFO - Return code: 0 19:25:21 INFO - Running post-action listener: _resource_record_post_action 19:25:21 INFO - [mozharness: 2016-12-21 03:25:21.557301Z] Finished run-tests step (success) 19:25:21 INFO - Running post-run listener: _resource_record_post_run 19:25:21 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37704704; Write bytes: 551604224; Read time: 239; Write time: 1702 19:25:21 INFO - TinderboxPrint: CPU usage
53.7% 19:25:21 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 239 19:25:21 INFO - TinderboxPrint: I/O write bytes / time
551,604,224 / 1,702 19:25:21 INFO - TinderboxPrint: CPU idle
2,227.1 (46.3%) 19:25:21 INFO - TinderboxPrint: CPU system
961.9 (20.0%) 19:25:21 INFO - TinderboxPrint: CPU user
1,620.6 (33.7%) 19:25:21 INFO - TinderboxPrint: Swap in / out
287,588,352 / 0 19:25:21 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 233245184; Write bytes: 226887680; Read time: 16923; Write time: 509 19:25:21 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36783104; Write bytes: 298670080; Read time: 228; Write time: 1133 19:25:22 INFO - Running post-run listener: _upload_blobber_files 19:25:22 INFO - Blob upload gear active. 19:25:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25: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 19:25: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'] 19:25: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 19:25:22 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:25:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:25:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:23 INFO - (blobuploader) - INFO - Done attempting. 19:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:24 INFO - (blobuploader) - INFO - Done attempting. 19:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:25 INFO - (blobuploader) - INFO - Done attempting. 19:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:28 INFO - (blobuploader) - INFO - Done attempting. 19:25:28 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:28 INFO - Return code: 0 19:25:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/160089e975d59fbcad477744d2214132909e4e43de4832d7f35a074dd7172b0a3b05fe59de1aba3ee22ee9693791d97bed534d9985ea1d2e571ab82af04acbfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ae2ac6346487475da77e372ca0755f3d1e30365db7a97ab4d433ec6b72147fe6f70f7d41199ef4098024128fa59f1c036a430109c66e50500c21e9fc6f510c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/76da80c0ac3ffdc42dd41dc137d958895c09804aa0957fb341655d8e63722798c8fba7377a7fde998c383609529fde39d5e321b13ea2348de8ab35b264e2abf4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d45d877aa84583f299e61769b601656f297f6e7923688e53d8b788386858d81b25dd0a22cc0710d45f33e5d866e946b2164627b9bbd6754a7f58f9695a97d18"} 19:25:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:28 INFO - Contents: 19:25:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/160089e975d59fbcad477744d2214132909e4e43de4832d7f35a074dd7172b0a3b05fe59de1aba3ee22ee9693791d97bed534d9985ea1d2e571ab82af04acbfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ae2ac6346487475da77e372ca0755f3d1e30365db7a97ab4d433ec6b72147fe6f70f7d41199ef4098024128fa59f1c036a430109c66e50500c21e9fc6f510c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/76da80c0ac3ffdc42dd41dc137d958895c09804aa0957fb341655d8e63722798c8fba7377a7fde998c383609529fde39d5e321b13ea2348de8ab35b264e2abf4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d45d877aa84583f299e61769b601656f297f6e7923688e53d8b788386858d81b25dd0a22cc0710d45f33e5d866e946b2164627b9bbd6754a7f58f9695a97d18"} 19:25:28 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:28 INFO - Copying logs to upload dir... 19:25:28 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.555449 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-20 19:25:28.366025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 19:25:28.374928) ========= 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.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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/160089e975d59fbcad477744d2214132909e4e43de4832d7f35a074dd7172b0a3b05fe59de1aba3ee22ee9693791d97bed534d9985ea1d2e571ab82af04acbfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ae2ac6346487475da77e372ca0755f3d1e30365db7a97ab4d433ec6b72147fe6f70f7d41199ef4098024128fa59f1c036a430109c66e50500c21e9fc6f510c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/76da80c0ac3ffdc42dd41dc137d958895c09804aa0957fb341655d8e63722798c8fba7377a7fde998c383609529fde39d5e321b13ea2348de8ab35b264e2abf4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d45d877aa84583f299e61769b601656f297f6e7923688e53d8b788386858d81b25dd0a22cc0710d45f33e5d866e946b2164627b9bbd6754a7f58f9695a97d18"} build_url:https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/VMU7ESnhQrW-ep7cinC3Gw/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/160089e975d59fbcad477744d2214132909e4e43de4832d7f35a074dd7172b0a3b05fe59de1aba3ee22ee9693791d97bed534d9985ea1d2e571ab82af04acbfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ae2ac6346487475da77e372ca0755f3d1e30365db7a97ab4d433ec6b72147fe6f70f7d41199ef4098024128fa59f1c036a430109c66e50500c21e9fc6f510c57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/76da80c0ac3ffdc42dd41dc137d958895c09804aa0957fb341655d8e63722798c8fba7377a7fde998c383609529fde39d5e321b13ea2348de8ab35b264e2abf4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9d45d877aa84583f299e61769b601656f297f6e7923688e53d8b788386858d81b25dd0a22cc0710d45f33e5d866e946b2164627b9bbd6754a7f58f9695a97d18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 19:25:28.409767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:25:28.410124) ========= 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.hX7Pmmitps/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.X7l4lePcSj/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.005013 ========= master_lag: 0.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 19:25:28.738314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 19:25:28.738749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 19:25:28.739886) ========= ========= Total master_lag: 0.47 =========