builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1485061859.62 results: success (0) buildid: 20170121202625 builduid: 16d080c080a1444cac2ddf829c041d2f revision: d295888faea067587708534300861dcba5a38928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 21:10:59.619855) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 21:10:59.620291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 21:10:59.620600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 21:10:59.656866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:10:59.657218) ========= 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.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-21 21:10:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 78.5M=0s 2017-01-21 21:11:00 (78.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:00.190872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:00.191181) ========= 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.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:00.238934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-21 21:11:00.239253) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d295888faea067587708534300861dcba5a38928 --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 d295888faea067587708534300861dcba5a38928 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-21 21:11:00,331 truncating revision to first 12 chars 2017-01-21 21:11:00,331 Setting DEBUG logging. 2017-01-21 21:11:00,331 attempt 1/10 2017-01-21 21:11:00,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d295888faea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 21:11:01,171 unpacking tar archive at: graphics-d295888faea0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-21 21:11:01.361395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:01.361678) ========= script_repo_revision: d295888faea067587708534300861dcba5a38928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:01.362046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:01.362324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 21:11:01.381719) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-21 21:11:01.381997) ========= /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.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:01 INFO - MultiFileLogger online at 20170121 21:11:01 in /builds/slave/test 21:11:01 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 21:11:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:11:01 INFO - {'append_to_log': False, 21:11:01 INFO - 'base_work_dir': '/builds/slave/test', 21:11:01 INFO - 'blob_upload_branch': 'Graphics', 21:11:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:11:01 INFO - 'branch': 'Graphics', 21:11:01 INFO - 'buildbot_json_path': 'buildprops.json', 21:11:01 INFO - 'config_files': ('talos/mac_config.py',), 21:11:01 INFO - 'default_actions': ('clobber', 21:11:01 INFO - 'read-buildbot-config', 21:11:01 INFO - 'download-and-extract', 21:11:01 INFO - 'populate-webroot', 21:11:01 INFO - 'create-virtualenv', 21:11:01 INFO - 'install', 21:11:01 INFO - 'run-tests'), 21:11:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:11:01 INFO - 'download_minidump_stackwalk': True, 21:11:01 INFO - 'download_symbols': 'ondemand', 21:11:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:11:01 INFO - 'tooltool.py': '/tools/tooltool.py', 21:11:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:11:01 INFO - '/tools/misc-python/virtualenv.py')}, 21:11:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:11:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:11:01 INFO - 'installer_path': 'installer.exe', 21:11:01 INFO - 'log_level': 'info', 21:11:01 INFO - 'log_name': 'talos', 21:11:01 INFO - 'log_to_console': True, 21:11:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:11:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:11:01 INFO - 'opt_config_files': (), 21:11:01 INFO - 'pip_index': False, 21:11:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:11:01 INFO - 'cmd': ('bash', 21:11:01 INFO - '-c', 21:11:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:11:01 INFO - 'enabled': True, 21:11:01 INFO - 'halt_on_failure': False, 21:11:01 INFO - 'name': 'check_screen_resolution'},), 21:11:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:11:01 INFO - 'cmd': ('bash', 21:11:01 INFO - '-c', 21:11:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:11:01 INFO - 'enabled': True, 21:11:01 INFO - 'halt_on_failure': False, 21:11:01 INFO - 'name': 'check_screen_resolution'},), 21:11:01 INFO - 'run_cmd_checks_enabled': True, 21:11:01 INFO - 'sps_profile': False, 21:11:01 INFO - 'sps_profile_interval': 0, 21:11:01 INFO - 'suite': 'dromaeojs', 21:11:01 INFO - 'system_bits': '32', 21:11:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:11:01 INFO - 'title': 't-yosemite-r7-0387', 21:11:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:11:01 INFO - 'use_talos_json': True, 21:11:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:11:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:11:01 INFO - 'work_dir': 'build'} 21:11:01 INFO - [mozharness: 2017-01-22 05:11:01.594824Z] Running clobber step. 21:11:01 INFO - Running pre-action listener: _resource_record_pre_action 21:11:01 INFO - Running main action method: clobber 21:11:01 INFO - rmtree: /builds/slave/test/build 21:11:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:11:02 INFO - Running post-action listener: _resource_record_post_action 21:11:02 INFO - [mozharness: 2017-01-22 05:11:02.492527Z] Finished clobber step (success) 21:11:02 INFO - [mozharness: 2017-01-22 05:11:02.492661Z] Running read-buildbot-config step. 21:11:02 INFO - Running pre-action listener: _resource_record_pre_action 21:11:02 INFO - Running main action method: read_buildbot_config 21:11:02 INFO - Using buildbot properties: 21:11:02 INFO - { 21:11:02 INFO - "project": "", 21:11:02 INFO - "product": "firefox", 21:11:02 INFO - "script_repo_revision": "default", 21:11:02 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 21:11:02 INFO - "repository": "", 21:11:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 21:11:02 INFO - "buildid": "20170121202625", 21:11:02 INFO - "pgo_build": "False", 21:11:02 INFO - "basedir": "/builds/slave/test", 21:11:02 INFO - "buildnumber": 13, 21:11:02 INFO - "slavename": "t-yosemite-r7-0387", 21:11:02 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:11:02 INFO - "platform": "yosemite_r7", 21:11:02 INFO - "scheduler": "tests-graphics-macosx64-talos", 21:11:02 INFO - "branch": "graphics", 21:11:02 INFO - "repo_path": "projects/graphics", 21:11:02 INFO - "revision": "d295888faea067587708534300861dcba5a38928", 21:11:02 INFO - "stage_platform": "macosx64", 21:11:02 INFO - "builduid": "16d080c080a1444cac2ddf829c041d2f", 21:11:02 INFO - "slavebuilddir": "test" 21:11:02 INFO - } 21:11:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:11:02 INFO - Running post-action listener: _resource_record_post_action 21:11:02 INFO - [mozharness: 2017-01-22 05:11:02.495761Z] Finished read-buildbot-config step (success) 21:11:02 INFO - [mozharness: 2017-01-22 05:11:02.495884Z] Running download-and-extract step. 21:11:02 INFO - Running pre-action listener: _resource_record_pre_action 21:11:02 INFO - Running main action method: download_and_extract 21:11:02 INFO - mkdir: /builds/slave/test/build/tests 21:11:02 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')]} 21:11:02 INFO - trying https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:11:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/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 21:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/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 21:11:03 INFO - Downloaded 1199 bytes. 21:11:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:11:03 INFO - Using the following test package requirements: 21:11:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:11:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:11:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:11:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'jsshell-mac.zip'], 21:11:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:11:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:11:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:11:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:11:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:11:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:11:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:11:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:11:04 INFO - Expected file size: 16345258 21:11:04 INFO - Obtained file size: 16345258 21:11:11 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 21:11:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:11:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:11:11 INFO - Fetch https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:11:12 INFO - Expected file size: 16345258 21:11:12 INFO - Obtained file size: 16345258 21:11:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:11:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:11:19 INFO - Fetch https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:11:20 INFO - Expected file size: 14403476 21:11:20 INFO - Obtained file size: 14403476 21:11:20 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')]} 21:11:20 INFO - trying https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:11:20 INFO - Downloading https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/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 21:11:23 INFO - Downloaded 69990939 bytes. 21:11:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:11:23 INFO - mkdir: /builds/slave/test/properties 21:11:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:11:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:11:23 INFO - Contents: 21:11:23 INFO - build_url:https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:11:23 INFO - Running post-action listener: _resource_record_post_action 21:11:23 INFO - Running post-action listener: set_extra_try_arguments 21:11:23 INFO - [mozharness: 2017-01-22 05:11:23.830727Z] Finished download-and-extract step (success) 21:11:23 INFO - [mozharness: 2017-01-22 05:11:23.830858Z] Running populate-webroot step. 21:11:23 INFO - Running pre-action listener: _resource_record_pre_action 21:11:23 INFO - Running main action method: populate_webroot 21:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:11:23 INFO - '--tppagecycles', 21:11:23 INFO - '7'], 21:11:23 INFO - 'tests': ['tsvgm']}}, 21:11:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:11:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:11:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:11:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:11:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:11:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['damp', 'tps']}, 21:11:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'tests': ['damp', 'tps']}, 21:11:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['dromaeo_dom']}, 21:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:11:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['basic_compositor_video']}, 21:11:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:11:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'other-e10s': {'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['a11yr', 21:11:23 INFO - 'ts_paint', 21:11:23 INFO - 'tpaint', 21:11:23 INFO - 'sessionrestore', 21:11:23 INFO - 'sessionrestore_no_auto_restore', 21:11:23 INFO - 'tabpaint']}, 21:11:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['tsvgx', 21:11:23 INFO - 'tsvgr_opacity', 21:11:23 INFO - 'tart', 21:11:23 INFO - 'tscrollx', 21:11:23 INFO - 'cart', 21:11:23 INFO - 'tsvg_static']}, 21:11:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:11:23 INFO - 'tsvgr_opacity', 21:11:23 INFO - 'tart', 21:11:23 INFO - 'tscrollx', 21:11:23 INFO - 'cart', 21:11:23 INFO - 'tsvg_static']}, 21:11:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'talos_options': ['--disable-e10s'], 21:11:23 INFO - 'tests': ['tp5o']}, 21:11:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:11:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'talos_options': ['--disable-e10s', 21:11:23 INFO - '--xperf_path', 21:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:23 INFO - 'tests': ['tp5n']}, 21:11:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:11:23 INFO - 'talos_options': ['--xperf_path', 21:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:11:23 INFO - 'tests': ['tp5n']}}, 21:11:23 INFO - 'talos.zip': {'path': '', 21:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:11:23 INFO - Running post-action listener: _resource_record_post_action 21:11:23 INFO - [mozharness: 2017-01-22 05:11:23.849243Z] Finished populate-webroot step (success) 21:11:23 INFO - [mozharness: 2017-01-22 05:11:23.849380Z] Running create-virtualenv step. 21:11:23 INFO - Running pre-action listener: _resource_record_pre_action 21:11:23 INFO - Running main action method: create_virtualenv 21:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 21:11:23 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 21:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:11:23 INFO - Using real prefix '/tools/python27' 21:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:11:27 INFO - Installing pip.................done. 21:11:27 INFO - Return code: 0 21:11:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:11:27 INFO - Reading from file tmpfile_stdout 21:11:27 INFO - Output received: 21:11:27 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) 21:11:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:11:27 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')]} 21:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:27 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')]} 21:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:27 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 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:27 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 21:11:27 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 21:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:27 INFO - 'HOME': '/Users/cltbld', 21:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:27 INFO - 'LOGNAME': 'cltbld', 21:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:27 INFO - 'MOZ_NO_REMOTE': '1', 21:11:27 INFO - 'NO_EM_RESTART': '1', 21:11:27 INFO - 'PAGER': '/bin/cat', 21:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:27 INFO - 'PWD': '/builds/slave/test', 21:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:27 INFO - 'SHELL': '/bin/bash', 21:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:27 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:27 INFO - 'USER': 'cltbld', 21:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:27 INFO - 'XPC_FLAGS': '0x0', 21:11:27 INFO - 'XPC_SERVICE_NAME': '0', 21:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:11:28 INFO - Cleaning up... 21:11:28 INFO - Return code: 0 21:11:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:28 INFO - 'HOME': '/Users/cltbld', 21:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:28 INFO - 'LOGNAME': 'cltbld', 21:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:28 INFO - 'MOZ_NO_REMOTE': '1', 21:11:28 INFO - 'NO_EM_RESTART': '1', 21:11:28 INFO - 'PAGER': '/bin/cat', 21:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:28 INFO - 'PWD': '/builds/slave/test', 21:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:28 INFO - 'SHELL': '/bin/bash', 21:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:28 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:28 INFO - 'USER': 'cltbld', 21:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:28 INFO - 'XPC_FLAGS': '0x0', 21:11:28 INFO - 'XPC_SERVICE_NAME': '0', 21:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:28 INFO - Downloading/unpacking psutil>=3.1.1 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:11:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:32 INFO - Installing collected packages: psutil 21:11:32 INFO - Running setup.py install for psutil 21:11:32 INFO - building 'psutil._psutil_osx' extension 21:11:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:11:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:11:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:11:32 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 21:11:32 INFO - building 'psutil._psutil_posix' extension 21:11:32 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 21:11:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:11:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:11:32 INFO - ^ 21:11:32 INFO - 1 warning generated. 21:11:32 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 21:11:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:11:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:11:33 INFO - Successfully installed psutil 21:11:33 INFO - Cleaning up... 21:11:33 INFO - Return code: 0 21:11:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:33 INFO - 'HOME': '/Users/cltbld', 21:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:33 INFO - 'LOGNAME': 'cltbld', 21:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:33 INFO - 'MOZ_NO_REMOTE': '1', 21:11:33 INFO - 'NO_EM_RESTART': '1', 21:11:33 INFO - 'PAGER': '/bin/cat', 21:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:33 INFO - 'PWD': '/builds/slave/test', 21:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:33 INFO - 'SHELL': '/bin/bash', 21:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:33 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:33 INFO - 'USER': 'cltbld', 21:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:33 INFO - 'XPC_FLAGS': '0x0', 21:11:33 INFO - 'XPC_SERVICE_NAME': '0', 21:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:11:33 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 21:11:33 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 21:11:33 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 21:11:33 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 21:11:33 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 21:11:33 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 21:11:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:11:36 INFO - Installing collected packages: mozsystemmonitor 21:11:36 INFO - Running setup.py install for mozsystemmonitor 21:11:36 INFO - Successfully installed mozsystemmonitor 21:11:36 INFO - Cleaning up... 21:11:36 INFO - Return code: 0 21:11:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:36 INFO - 'HOME': '/Users/cltbld', 21:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:36 INFO - 'LOGNAME': 'cltbld', 21:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:36 INFO - 'MOZ_NO_REMOTE': '1', 21:11:36 INFO - 'NO_EM_RESTART': '1', 21:11:36 INFO - 'PAGER': '/bin/cat', 21:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:36 INFO - 'PWD': '/builds/slave/test', 21:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:36 INFO - 'SHELL': '/bin/bash', 21:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:36 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:36 INFO - 'USER': 'cltbld', 21:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:36 INFO - 'XPC_FLAGS': '0x0', 21:11:36 INFO - 'XPC_SERVICE_NAME': '0', 21:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:36 INFO - Downloading/unpacking jsonschema==2.5.1 21:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:11:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:11:39 INFO - warning: no files found matching '*.txt' 21:11:39 INFO - no previously-included directories found matching 'build' 21:11:39 INFO - no previously-included directories found matching 'dist' 21:11:39 INFO - no previously-included directories found matching '.git*' 21:11:39 INFO - Installing collected packages: jsonschema, functools32 21:11:39 INFO - Running setup.py install for functools32 21:11:39 INFO - warning: no files found matching '*.txt' 21:11:39 INFO - no previously-included directories found matching 'build' 21:11:39 INFO - no previously-included directories found matching 'dist' 21:11:39 INFO - no previously-included directories found matching '.git*' 21:11:40 INFO - Successfully installed jsonschema functools32 21:11:40 INFO - Cleaning up... 21:11:40 INFO - Return code: 0 21:11:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:40 INFO - 'HOME': '/Users/cltbld', 21:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:40 INFO - 'LOGNAME': 'cltbld', 21:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:40 INFO - 'MOZ_NO_REMOTE': '1', 21:11:40 INFO - 'NO_EM_RESTART': '1', 21:11:40 INFO - 'PAGER': '/bin/cat', 21:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:40 INFO - 'PWD': '/builds/slave/test', 21:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:40 INFO - 'SHELL': '/bin/bash', 21:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:40 INFO - 'USER': 'cltbld', 21:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:40 INFO - 'XPC_FLAGS': '0x0', 21:11:40 INFO - 'XPC_SERVICE_NAME': '0', 21:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:11:40 INFO - Cleaning up... 21:11:40 INFO - Return code: 0 21:11:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:40 INFO - 'HOME': '/Users/cltbld', 21:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:40 INFO - 'LOGNAME': 'cltbld', 21:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:40 INFO - 'MOZ_NO_REMOTE': '1', 21:11:40 INFO - 'NO_EM_RESTART': '1', 21:11:40 INFO - 'PAGER': '/bin/cat', 21:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:40 INFO - 'PWD': '/builds/slave/test', 21:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:40 INFO - 'SHELL': '/bin/bash', 21:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:40 INFO - 'USER': 'cltbld', 21:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:40 INFO - 'XPC_FLAGS': '0x0', 21:11:40 INFO - 'XPC_SERVICE_NAME': '0', 21:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:40 INFO - Downloading/unpacking blobuploader==1.2.4 21:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:43 INFO - Downloading blobuploader-1.2.4.tar.gz 21:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:11:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:11:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:11:44 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 21:11:44 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 21:11:44 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 21:11:44 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 21:11:44 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 21:11:44 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 21:11:44 INFO - Downloading docopt-0.6.1.tar.gz 21:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:11:44 INFO - Installing collected packages: blobuploader, requests, docopt 21:11:44 INFO - Running setup.py install for blobuploader 21:11:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:11:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:11:44 INFO - Running setup.py install for requests 21:11:45 INFO - Running setup.py install for docopt 21:11:45 INFO - Successfully installed blobuploader requests docopt 21:11:45 INFO - Cleaning up... 21:11:45 INFO - Return code: 0 21:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:45 INFO - 'HOME': '/Users/cltbld', 21:11:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:45 INFO - 'LOGNAME': 'cltbld', 21:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:45 INFO - 'MOZ_NO_REMOTE': '1', 21:11:45 INFO - 'NO_EM_RESTART': '1', 21:11:45 INFO - 'PAGER': '/bin/cat', 21:11:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:45 INFO - 'PWD': '/builds/slave/test', 21:11:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:45 INFO - 'SHELL': '/bin/bash', 21:11:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:45 INFO - 'USER': 'cltbld', 21:11:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:45 INFO - 'XPC_FLAGS': '0x0', 21:11:45 INFO - 'XPC_SERVICE_NAME': '0', 21:11:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-KH5UP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-c3Ec9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Yo6nMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GyPTD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-dYYzSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-R312Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-5cRmwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-tumjNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-u_FEdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-cFynpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-jxs0Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sn9fp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-EpGjwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-qUkmg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-S0Nxmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-t7A6V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-1ECpwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:11:47 INFO - Running setup.py install for manifestparser 21:11:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:11:47 INFO - Running setup.py install for mozcrash 21:11:47 INFO - Running setup.py install for mozdebug 21:11:48 INFO - Running setup.py install for mozdevice 21:11:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Running setup.py install for mozfile 21:11:48 INFO - Running setup.py install for mozhttpd 21:11:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Running setup.py install for mozinfo 21:11:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Running setup.py install for mozInstall 21:11:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:11:48 INFO - Running setup.py install for mozleak 21:11:48 INFO - Running setup.py install for mozlog 21:11:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Running setup.py install for moznetwork 21:11:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Running setup.py install for mozprocess 21:11:49 INFO - Running setup.py install for mozprofile 21:11:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Running setup.py install for mozrunner 21:11:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:11:49 INFO - Running setup.py install for mozscreenshot 21:11:49 INFO - Running setup.py install for moztest 21:11:50 INFO - Running setup.py install for mozversion 21:11:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:11:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:11:50 INFO - Cleaning up... 21:11:50 INFO - Return code: 0 21:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:50 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 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:50 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 21:11:50 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 21:11:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:50 INFO - 'HOME': '/Users/cltbld', 21:11:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:50 INFO - 'LOGNAME': 'cltbld', 21:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:50 INFO - 'MOZ_NO_REMOTE': '1', 21:11:50 INFO - 'NO_EM_RESTART': '1', 21:11:50 INFO - 'PAGER': '/bin/cat', 21:11:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:50 INFO - 'PWD': '/builds/slave/test', 21:11:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:50 INFO - 'SHELL': '/bin/bash', 21:11:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:50 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:50 INFO - 'USER': 'cltbld', 21:11:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:50 INFO - 'XPC_FLAGS': '0x0', 21:11:50 INFO - 'XPC_SERVICE_NAME': '0', 21:11:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:11:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sQQUIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:11:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-9RjuDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:11:50 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)) 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:11:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XjlgGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:11:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hVQz27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:11:50 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)) 21:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:11:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-aPzYDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:11:51 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)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RHvYYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:11:51 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)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-10PSSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:11:51 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)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_1r6Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-JMDACA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-lAXqLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:11:51 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)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-2OPmCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sSz1kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-oe350m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CWClOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:11:51 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)) 21:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-wtg3Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:11:52 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)) 21:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:11:52 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-D2mGtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:11:52 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-cgs6_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:54 INFO - Downloading blessings-1.6.tar.gz 21:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:11:55 INFO - Installing collected packages: blessings 21:11:55 INFO - Running setup.py install for blessings 21:11:55 INFO - Successfully installed blessings 21:11:55 INFO - Cleaning up... 21:11:55 INFO - Return code: 0 21:11:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:55 INFO - Reading from file tmpfile_stdout 21:11:55 INFO - Current package versions: 21:11:55 INFO - blessings == 1.6 21:11:55 INFO - blobuploader == 1.2.4 21:11:55 INFO - docopt == 0.6.1 21:11:55 INFO - functools32 == 3.2.3-2 21:11:55 INFO - jsonschema == 2.5.1 21:11:55 INFO - manifestparser == 1.1 21:11:55 INFO - mozInstall == 1.12 21:11:55 INFO - mozcrash == 1.0 21:11:55 INFO - mozdebug == 0.1 21:11:55 INFO - mozdevice == 0.49 21:11:55 INFO - mozfile == 1.2 21:11:55 INFO - mozhttpd == 0.7 21:11:55 INFO - mozinfo == 0.9 21:11:55 INFO - mozleak == 0.1 21:11:55 INFO - mozlog == 3.4 21:11:55 INFO - moznetwork == 0.27 21:11:55 INFO - mozprocess == 0.24 21:11:55 INFO - mozprofile == 0.28 21:11:55 INFO - mozrunner == 6.13 21:11:55 INFO - mozscreenshot == 0.1 21:11:55 INFO - mozsystemmonitor == 0.3 21:11:55 INFO - moztest == 0.8 21:11:55 INFO - mozversion == 1.4 21:11:55 INFO - psutil == 3.1.1 21:11:55 INFO - requests == 1.2.3 21:11:55 INFO - wsgiref == 0.1.2 21:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:55 INFO - 'HOME': '/Users/cltbld', 21:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:55 INFO - 'LOGNAME': 'cltbld', 21:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:55 INFO - 'MOZ_NO_REMOTE': '1', 21:11:55 INFO - 'NO_EM_RESTART': '1', 21:11:55 INFO - 'PAGER': '/bin/cat', 21:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:55 INFO - 'PWD': '/builds/slave/test', 21:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:55 INFO - 'SHELL': '/bin/bash', 21:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:55 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:55 INFO - 'USER': 'cltbld', 21:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:55 INFO - 'XPC_FLAGS': '0x0', 21:11:55 INFO - 'XPC_SERVICE_NAME': '0', 21:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:11:55 INFO - Cleaning up... 21:11:55 INFO - Return code: 0 21:11:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c24bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c24e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a5056c370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, '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.wwVZswkgcN/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.A1NzqLakm3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 21:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:55 INFO - 'HOME': '/Users/cltbld', 21:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:55 INFO - 'LOGNAME': 'cltbld', 21:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:55 INFO - 'MOZ_NO_REMOTE': '1', 21:11:55 INFO - 'NO_EM_RESTART': '1', 21:11:55 INFO - 'PAGER': '/bin/cat', 21:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:55 INFO - 'PWD': '/builds/slave/test', 21:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:55 INFO - 'SHELL': '/bin/bash', 21:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:11:55 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:55 INFO - 'USER': 'cltbld', 21:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:55 INFO - 'XPC_FLAGS': '0x0', 21:11:55 INFO - 'XPC_SERVICE_NAME': '0', 21:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:11:56 INFO - Cleaning up... 21:11:56 INFO - Return code: 0 21:11:56 INFO - Running post-action listener: _resource_record_post_action 21:11:56 INFO - Running post-action listener: _start_resource_monitoring 21:11:56 INFO - Starting resource monitoring. 21:11:56 INFO - [mozharness: 2017-01-22 05:11:56.167086Z] Finished create-virtualenv step (success) 21:11:56 INFO - [mozharness: 2017-01-22 05:11:56.168038Z] Running install step. 21:11:56 INFO - Running pre-action listener: _resource_record_pre_action 21:11:56 INFO - Running main action method: install 21:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:11:56 INFO - Reading from file tmpfile_stdout 21:11:56 INFO - Detecting whether we're running mozinstall >=1.0... 21:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:11:56 INFO - Reading from file tmpfile_stdout 21:11:56 INFO - Output received: 21:11:56 INFO - Usage: mozinstall [options] installer 21:11:56 INFO - Options: 21:11:56 INFO - -h, --help show this help message and exit 21:11:56 INFO - -d DEST, --destination=DEST 21:11:56 INFO - Directory to install application into. [default: 21:11:56 INFO - "/builds/slave/test"] 21:11:56 INFO - --app=APP Application being installed. [default: firefox] 21:11:56 INFO - mkdir: /builds/slave/test/build/application 21:11:56 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'] 21:11:56 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 21:12:18 INFO - Reading from file tmpfile_stdout 21:12:18 INFO - Output received: 21:12:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:12:18 INFO - Running post-action listener: _resource_record_post_action 21:12:18 INFO - [mozharness: 2017-01-22 05:12:18.399556Z] Finished install step (success) 21:12:18 INFO - [mozharness: 2017-01-22 05:12:18.399695Z] Running run-tests step. 21:12:18 INFO - Running pre-action listener: _resource_record_pre_action 21:12:18 INFO - Running main action method: run_tests 21:12:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:12:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:12:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:12:18 INFO - 2017-01-21 21:12:18.414 screenresolution[1977:20275] starting screenresolution argv=screenresolution get 21:12:18 INFO - 2017-01-21 21:12:18.417 screenresolution[1977:20275] Display 0: 1600x1200x32@60 21:12:18 INFO - 2017-01-21 21:12:18.423 screenresolution[1978:20278] starting screenresolution argv=screenresolution list 21:12:18 INFO - Available Modes on Display 0 21:12:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:12:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:12:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:12:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:12:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:12:18 INFO - Intel Iris: 21:12:18 INFO - Chipset Model: Intel Iris 21:12:18 INFO - Type: GPU 21:12:18 INFO - Bus: Built-In 21:12:18 INFO - VRAM (Dynamic, Max): 1536 MB 21:12:18 INFO - Vendor: Intel (0x8086) 21:12:18 INFO - Device ID: 0x0a2e 21:12:18 INFO - Revision ID: 0x0009 21:12:18 INFO - Displays: 21:12:18 INFO - Display: 21:12:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:12:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:12:18 INFO - Display Serial Number: 1600x1200 60 21:12:18 INFO - Main Display: Yes 21:12:18 INFO - Mirror: Off 21:12:18 INFO - Online: Yes 21:12:18 INFO - Rotation: Supported 21:12:18 INFO - Return code: 0 21:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:12:18 INFO - Python 2.7.3 21:12:18 INFO - Return code: 0 21:12:18 INFO - grabbing minidump binary from tooltool 21:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:18 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 0x10c029d30>, '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 0x10bf50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c01ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:12:18 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 21:12:18 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 21:12:18 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 21:12:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:12:18 INFO - Return code: 0 21:12:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:12:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:12:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:12:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:12:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:12:18 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/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 21:12:18 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/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --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 21:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wwVZswkgcN/Render', 21:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:12:18 INFO - 'HOME': '/Users/cltbld', 21:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:12:18 INFO - 'LOGNAME': 'cltbld', 21:12:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:12:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:18 INFO - 'MOZ_NO_REMOTE': '1', 21:12:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:12:18 INFO - 'NO_EM_RESTART': '1', 21:12:18 INFO - 'PAGER': '/bin/cat', 21:12:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:18 INFO - 'PWD': '/builds/slave/test', 21:12:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:12:18 INFO - 'SHELL': '/bin/bash', 21:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A1NzqLakm3/Listeners', 21:12:18 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 21:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:12:18 INFO - 'USER': 'cltbld', 21:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:18 INFO - 'XPC_FLAGS': '0x0', 21:12:18 INFO - 'XPC_SERVICE_NAME': '0', 21:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:12:18 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/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 21:12:19 INFO - mozversion application_buildid: 20170121202625 21:12:19 INFO - mozversion application_changeset: d295888faea067587708534300861dcba5a38928 21:12:19 INFO - mozversion application_display_name: Nightly 21:12:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:12:19 INFO - mozversion application_name: Firefox 21:12:19 INFO - mozversion application_remotingname: firefox 21:12:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 21:12:19 INFO - mozversion application_vendor: Mozilla 21:12:19 INFO - mozversion application_version: 53.0a1 21:12:19 INFO - mozversion platform_buildid: 20170121202625 21:12:19 INFO - mozversion platform_changeset: d295888faea067587708534300861dcba5a38928 21:12:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 21:12:19 INFO - mozversion platform_version: 53.0a1 21:12:19 INFO - using testdate: 1485061939 21:12:19 INFO - actual date: 1485061939 21:12:19 INFO - starting webserver on 'localhost:52696' 21:12:19 INFO - SUITE-START | Running 2 tests 21:12:19 INFO - TEST-START | dromaeo_css 21:12:19 INFO - operating with platform_type : mac_ 21:12:19 INFO - Initialising browser for dromaeo_css test... 21:12:19 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpVupxbo/profile http://localhost:52696/getInfo.html) 21:12:21 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 21:12:21 INFO - PROCESS | 1988 | colorDepth:24 21:12:21 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 21:12:21 INFO - PROCESS | 1988 | __metrics 21:12:21 INFO - PROCESS | 1988 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 21:12:21 INFO - PROCESS | 1988 | 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" 21:12:21 INFO - PROCESS | 1988 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:12:22 INFO - TEST-INFO | 1988: exit 0 21:12:22 INFO - Browser initialized. 21:12:22 INFO - Running cycle 1/1 for dromaeo_css test... 21:12:22 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpVupxbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:12:34 INFO - PROCESS | 1990 | RSS: Main: 227364864 21:12:34 INFO - PROCESS | 1990 | 21:15:38 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52696/tests/dromaeo/cssquery-ext.html) 21:15:40 INFO - PROCESS | 1990 | RSS: Main: 403083264 21:15:40 INFO - PROCESS | 1990 | 21:17:23 INFO - PROCESS | 1990 | ************************* 21:17:23 INFO - PROCESS | 1990 | A coding exception was thrown and uncaught in a Task. 21:17:23 INFO - PROCESS | 1990 | 21:17:23 ERROR - PROCESS | 1990 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:17:23 INFO - PROCESS | 1990 | Full stack: 21:17:23 INFO - PROCESS | 1990 | ************************* 21:18:43 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-ext.html (next: http://localhost:52696/tests/dromaeo/cssquery-jquery.html) 21:18:44 INFO - PROCESS | 1990 | RSS: Main: 370978816 21:18:44 INFO - PROCESS | 1990 | 21:21:46 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52696/tests/dromaeo/cssquery-mootools.html) 21:21:47 INFO - PROCESS | 1990 | RSS: Main: 329363456 21:21:47 INFO - PROCESS | 1990 | 21:24:49 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52696/tests/dromaeo/cssquery-prototype.html) 21:24:50 INFO - PROCESS | 1990 | RSS: Main: 326467584 21:24:50 INFO - PROCESS | 1990 | 21:27:53 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52696/tests/dromaeo/cssquery-yui.html) 21:27:54 INFO - PROCESS | 1990 | RSS: Main: 335863808 21:27:54 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:52696/tests/dromaeo/cssquery-yui.html (next: http://localhost:52696/tests/dromaeo/cssquery-dojo.html) 21:30:57 INFO - PROCESS | 1990 | RSS: Main: 458964992 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | __start_tp_report 21:30:57 INFO - PROCESS | 1990 | _x_x_mozilla_page_load 21:30:57 INFO - PROCESS | 1990 | _x_x_mozilla_page_load_details 21:30:57 INFO - PROCESS | 1990 | |i|pagename|runs| 21:30:57 INFO - PROCESS | 1990 | |0;dojo.html;3281.7210537104347;3282.852271647777;3291.1443024813548;3314.5359649649067;3352.7150192233657;5633.380328163909;5710.600257981938;5739.713014349287;5748.971255143723;5796.536277097833;5735.397783232763;5788.942110578893;5790.160426738131;5791.623544469607;5795.9857025020665;5150.793968241275;5178.611604129686;5189.42916279209;5227.059129356714;5257.684538927677;5338.519533242007;5343.465653434645;5345.037893179227;5351.946480535184;5363.758630861621;5335.146376579748;5343.038253114438;5345.412004679482;5345.572354211654;5349.277847490578;5333.413324534298;5336.573074154077;5336.706481143536;5337.332833395825;5337.866553336159;5108.4125325587665;5179.818706345298;5252.185911183773;5281.102212623863;5282.418933917266;5757.913631295534;5792.68140252286;5832.066869300891;5909.911351329733;5933.406659334032;6151.200343955302;6161.476274516672;6175.3515880832765;6180.072989051633;6194.225721784777;6104.125697713681;6104.368208815878;6133.438468486935;6134.314131579348;6134.742747059152;5977.850553736192;5979.1629171915965;5984.551158663117;5991.880162396727;6013.54898382623;6274.996000639876;6277;6289.842753931097;6297.842553936188;6308.053791931247;6052.515798736091;6125.050617154348;6129.540284478682;6144.846378840475;6162.661053642093;6162.876742465126;6216.7824126155365;6234.096056071935;6234.2830574483605;6236.251649802053;6073.453389194905;6080.513558915364;6154.876902461926;6167.167432396569;6171.629702217791;6130.908036379458;6131.346082861964;6157.199564056644;6157.353477884847;6181.227346581677;4992.550670439605;5000.549950504472;5050.242463630485;5060.139776238048;5078.238264260391;4473.865784026484;4484.798184081724;4487.910241795211;4516.977415112903;4519.0058187198765;5865.970670146622;5867.442592953663;5868.735906884201;5886.6173698709445;5903.439173278532;6127.203463549799;6138.786925362681;6145.846353841101;6159.199304090529;6183.721732522047;5852.765889364463;5881.382454842265;5908.291005079332;5911.054231322968;5945.702714864239;5310.203469479609;5375.19372094189;5377.354717433933;5378;5514.448555144534;6210.347913469202;6236.126942228092;6282.214723159514;6288.905666415099;6303.590266632654;6123.1606109212;6134.35589263121;6147.647517546133;6170.6914654268;6183.319834818257;6137.591499645336;6221.3156552778255;6238.812835614939;6287.245530536365;6292.182016337847;6192.628442293477;6216.689165541795;6220.813375598739;6226.813195604139;6230.190075290183;6120.325235636462;6243.531735119794;6255.843603909939;6261.467775238973;6267.46726528232;5885.646861188342;6103.277060575968;6120.599512025131;6132.967444181115;6204.193454850841;6130.264368275835;6167.969160154171;6179.907301390573;6193.411625895533;6197.380261973766;6044.607100538451;6079.726412311368;6088.6042407243385;6091.385737923878;6118.938810611837;6037.667928263988;6092.75628974836;6108.786192483241;6114.6942652868065;6139.3246742857355;6071;6072;6076.966915624443;6081.756729730938;6086.543509236736 21:30:57 INFO - PROCESS | 1990 | |1;ext.html;429.25095707989544;474.7104266397498;482.15382004581966;496.30269471392705;541.9134635056711;31117;32399;32414.027579172605;32473.188170295754;40551.59448405515;42118;43400.3489947651;43479.3478097828;43523.78238108813;43524.56475435253;9116.817663646723;9280.257579393667;9312.16190542851;9326.393784404027;9333.113354231336;8342.41603087781;8565.914340856605;9099.04460031697;9183.816323673522;9225.861612075823;8398.706045288416;8468.872966905501;8474.533900635462;11040.889591104067;11330.71673208168;11058.944705276463;11145.777084458347;11154.721131971724;11156.888431115665;11159.38623375714;9340.859887101631;11007.119430445626;11048.834267485994;11060;11061.668149955434;31780.841095794374;32208.194795130075;39487.60512394897;40888.79555602203;40898.1820363591;3732.9361132077497;3866.0914685048992;4023.1350259694304;4117.5882411758885;4125.092479654471;25622.359441013938;30805.537916931265;31007.534886976715;31085.533716994265;31474;3020.0637802281362;3088.428640701455;3120.7659425542947;3124.265797537577;3127.8123312601315;474201.6289918563;474392.6280368576;477035;478718;479784;62148.68925655433;62532.749345012846;62658.68670656617;62759;62785.0936396996;66366.00450993239;66474.66762666155;66568.33431665719;66657.33342666608;66675.99986000214;15504.689906202038;15927.840721592636;16058.839411605735;16063.95584287041;16085.195740212943;12220.75558488843;12332;12358.44387002587;12382.62852114438;12388.194767340274;17113.91443042777;17395;17408.39070632522;17443.912780436018;17470.737938930924;5558.333000040021;6682;6850.957934818481;6891.965540172267;6914.343137402039;766.4902839611707;872.873433352173;890.7594949363636;911.4713466189594;919.5678031325266;23656.408589785395;29434.852825735736;29592.260193495335;30153.547696784564;30292.697073029427;1048.224314007629;1056.2236755984345;1089.2647462962468;1099.9120070394508;1175.9823602645968;13955.372008259652;15102.320395582225;15384.15387153695;15780.921095394679;15808.446704365291;503181;589737.9235868793;592741;594732;596062;60158.398416016156;60329.0950635732;60347.69826150841;60443.69778151081;60519;1429.9356528956223;1446.8553144685447;1461.4738694070127;1467.6330917270682;1468.2071681292196;25907;27362.905483780425;27822.5826612605;28788;29776.404471910006;50891.74554127206;51262;51283.2307515395;51300.23049654184;51401.7429912863;508361;509669;511418;511833;512855;37873.62126378701;39113;39331;39337.606623933396;39361.40957885577;45707.857303567675;46040.76979615215;46368.53631463777;46487.30269045899;46699;35341.29317413689;37167.6283237175;37680.351292952924;38337.42493862539;38399.616003839605;37329;37574.43638345482;38309.04227394338;38952.80523597364;39555;37182.88451346464;37383.25233495369;37452.250954980205;37804.62195378011;37835.81082094572;30700.53949190719;33391;33731.325373491905;33874.15314617056;33973;21755.891220543795;22492.762898040764;23333.53332933298;23673.52652946966;25025.249242522754 21:30:57 INFO - PROCESS | 1990 | |2;jquery.html;347.80001499137995;375.6712876233296;396.7203121799134;401.544247279338;425.6509662077098;15141.545753627395;15473.690526189483;17800.84294520855;18363.357282495115;20947.952602369896;21488.495805293598;21803;21960.90195490227;22143.889280553616;22147.446313842163;5898.88202235955;5977.491913187362;5987.940120598803;6049.848753781147;6129.785457508988;6026.517878569726;6087.11736798164;6100.176476175726;6100.206973093492;6102.847428814293;4163.271427500191;4446.3997360356425;4455.933161002587;6056.454919057284;6790.287019862917;6631.972044333136;6838.076859623937;6843.349881761224;6848.794536163923;6862.867626841565;5108.463611320795;5606.803761868315;5955.166276721263;5974.342822289588;5986.431289027579;22960.77039229603;24472.755272447226;26179.869100654374;26205.082822101325;26517.602235966475;2635.6310116583695;2777.1529683446543;2812.9015484457946;2819.84490853003;2826.18040768177;15759.212039397984;15942.920285398499;15948.441804536786;15952.202389880576;16727.916360418243;1744.0059166275228;1820.954476138094;1864.6177533605578;1876.5683892704617;1879.5301174706324;116163.41918290354;124976;125326.74673253243;125865.99999999908;128714;9183.403078799856;10322.48387580618;11435.828462573068;11660.06719462441;11697.958530782058;14145.43418263258;14276.500322488662;14624.634384140269;14625.92687036558;14656.780148297785;7002.684879180449;8494.830103397897;8712;8735.65057397697;8885.42244754089;8307.331319737328;8645.740627781177;8651.221390074923;8759.948806143177;8858.069902660256;6015.759369625253;6405.455536279375;6751.662416879137;7253.637318134072;7265.745698900619;1864.6923257662604;1900.4013735673218;1905.4283714885478;1912.814055285704;1915.2339064374362;850.7830503221638;961.2838435365558;978.3885071830106;994.6767300627325;1007.8891321954579;13488.055836091575;13777.173369597856;13836.031477796458;13969.65075873091;14030.877529797592;1003.2976916158718;1008.2941940641433;1019.2304809868501;1026.5637104230673;1026.563710423082;7035.964820175969;7323.231060738653;11297.378644174649;12383.947364473941;12570;633606.8319658373;702627.4868625726;719809;727065;739673;150939;151964;153565.2686887256;154404.2279788594;155926;990.2869933647762;1029.4543891737392;1058.8517607534952;1060.4697651174413;1074.7742973975553;20525.58948821045;20675.79324206799;20687;20794.584108318053;20866;57827.71086144543;59852.40147598642;60415.69792151011;61313.934303283764;61448.69275653593;88876.11123888678;89180;90379.09620903707;90911.54544227237;91910.08089919016;7170;8096.595170241347;8228.300594449538;8654.350923680624;8664.653413863374;11591.942040289745;13265.270410127536;13320.134191277535;13717.588472345846;13774.449022039005;11284.605038823602;11284.943575282072;11550.537978480766;11577;11786.528538858349;11098.667039988813;11281.153913456688;11384.089272857986;11501.424928753362;11700.35648039332;11292.435378230892;11616.709582260512;11840.703982400164;11844.28934263947;11913.046956243654;7149;7396.704131834882;7525.247475252431;8394.286485648789;8736.126387361213;8199.918000820155;10073.445960472245;11109.444527773418;11560.826587601361;11594.362310073027 21:30:57 INFO - PROCESS | 1990 | |3;mootools.html;1441.7549016667178;1476.512750792238;1480.20808867256;1489.3149151390357;1500.8874334424913;8085.595720213988;8500.702475413362;8506.617202225907;8515.403921725481;8555.101714319992;7405.22245164258;7679.347255483291;7689.923410722503;8034.397420193494;8222;2259.028617694395;2302.458922153293;2302.861828290308;2304.1704986205036;2305.7694230576976;1949.3177387914188;2298.402415371999;2322.883855807203;2336.5677349690277;2338.088145623208;1996.0418998880546;2076.7611724651706;2092.466421062627;2225.8330625203093;2297.448612333045;2143.2712877621607;2152.3758110148037;2156.676498525218;2163.4266919266406;2165.2313428732887;2167.881026050501;2315.571619250444;2329.173143534055;2333.6849525314205;2334.7548507406646;8349.749507514784;8381.874271885927;8402.075771665111;8429.915700842974;8430.030546487109;5017.096922553938;5174.249733788617;5175.456577059392;5192.402873669538;5197.818076367309;3212.4699424594914;3387.4072037393603;3390.86436542538;3438.5529881115544;3441.346144232588;1049.7218237167158;1144.3019757947645;1179.151011271883;1180.5100883133575;1242.5092088625033;10711.946440267826;10819.296745711503;10868.293560918593;10893;10923.508442120125;3884.941725874114;4461.353103799931;4587.03672228829;4684.367610372624;4693.967327188013;9488.383255088396;9517.428954262767;9525.523723813782;9560.426374417557;9566.952165239269;5224.294720212799;5233.659812112201;5234.685918844882;5237.711925844039;5241.135212689864;4009.318415869251;4627.421572303462;4695.248760198352;4774.474807771142;4785.641076919245;3791.734578579473;3800.600936901641;3860.208657225262;3890.1636148228267;3893.7469064510715;1262.8105784132454;1272.1603741530546;1273.1406300746958;1274.936253187337;1278.4822147030468;899.1008991008991;903.2864037410503;917.6146018672174;940.3793496292415;948.1324588002038;5674.716264186774;5764.13537969308;5903.321118071391;6008.909866352008;6094.969525152346;979.2019504104132;998.0917365197636;1012.473513772834;1012.6607586458472;1031.6176323726243;3791.260704162717;3796.886093417202;3821.3885778275344;3911.3155197840833;3930.8427662893164;9715.46564938935;9751.853722194173;9881.011898810062;9988.953369222312;10032.498375081363;9909;9918.752031199278;9926;9935.05616966387;9945.602175913027;7338.192798792129;7701.845963080707;7729.072511298793;7847.176046515148;7868.134505204423;5178.093833579184;5401.6218864679095;5803.216565763568;5861.35525092248;5895.322037965518;8829.911700882909;9033.096690330914;9240.815183696423;9280;9293.67472138472;9045.728628141167;9171.220446262143;9349.439033658002;9420.576074076545;9438.24494040489;7084.291570843081;7295.1610564783605;7327.560346379234;7343.37581305595;7346.7061317546695;7774.144844067261;7843.7254696085365;7855.175206603453;7906.723264685708;7927.881081783663;5682.431756824284;7026.297370262932;7148.535345202546;7161.820954476179;7187.9640601796655;5824.854378640568;6955.826104347432;7040.683169257498;7057.2237053923;7103.005579219017;6345.302016778059;6454.19322584677;6458.773942911976;6461.709223085067;6463.7737679181;4560.407147070992;4912.435069966999;4966.701997880139;5015.799368025238;5220.738963051756;5022.949770502394;5074.188129899198;5074.594032477319;5178.0679477694375;5209.635325527328 21:30:57 INFO - PROCESS | 1990 | |4;prototype.html;355.5111721383098;368.147737986561;369.9722520810938;374.52809460080323;377.1231885865362;5402.1908607524065;5410.675359478434;5426.484483974021;5428.4842939920745;5442.945570544293;4423.690341676084;5253.4221235664145;5331.5222005263595;5352.946470535294;5378.369600519653;3757.812109394526;3995.3008223560905;4102.753834769924;4123.36087906375;4135.449206547544;4064.552899181088;4069.3285607874814;4101.220768054075;4124.968757810532;4131.752094874302;3585.3725598020374;4057.878263652095;4073.327900896363;4078.490188726409;4086.7139300248996;3449;3999.9400008999887;4047.4738284023183;4083.8570650027254;4102.79486025699;2937.5740517624827;3017.7434918031995;3439.6560343965652;3461.238527523941;3547.290541891606;4555.9521310098535;5156.381234251876;5162.870928226786;5192.870178245536;5257.631965762398;4259.97870010648;4444.688871778977;4489.663275254369;4582.358469814229;4602.596208156511;5599.824036952245;5617.758592262856;5662.462066103713;5669.262995810518;5692.231548740909;3474.322507111114;3564.8395822188063;3667.9633203668154;3860.613938606117;3879.806009699532;4509.120721459317;4697.389339385858;5083.212102124176;5803.82588522345;5942.494887934531;3289.6052473703307;3599.028262369198;3737.663610275088;3863.459115723801;3868.7678739275734;3795.6773674237447;3908.9804550977065;3915.4322623219473;3943.2507823513442;3953.940690889639;4123.628873401348;4269.23153832307;4269.615734583902;4527.139843429738;4600.35595016698;4620.838270660511;5298.496642818926;5470.699111548903;5536.612437129443;5630.436956304418;1075.940198904079;1089.6022951622601;1108.4758457121459;1150.672058463334;1284.556827894375;776.3788968824917;803.8070862992839;824.4435006370676;873.9781505462414;885.7475619448426;4440.777961101932;4980.655223089818;5012.26341107657;5052.3937127544195;5105.719185444762;4925.630577706686;5329.960657671794;5569.493727822496;5609.382967873531;5629.662220266797;4746.857594272177;4765.617970788502;4813.7593120343845;5016.698998060128;5058.645894787403;2895.334073163142;2911.199420159473;2919.255589824581;2924.2835505300914;2942.043835753346;5574.247476590689;5737.819628541128;5741.813293621996;5776.480116789509;5790.971045144747;5434.945650543444;5601.355844077983;5658.292713410824;5722.37053924068;5724.914126288109;5117.518003768169;5861.9706901465215;5918.556108291896;6035.849103772441;6049.606775559574;5356.946430535801;5518.779248830002;5795.391483894299;5831.241938547962;5845.824625261249;4661.836835710734;5271.710055946806;5414.889947560662;5504.889902202013;5803.9419605803405;5379.892402151857;6005.339412664516;6008.429199226067;6039.939600604113;6041.879162416815;3881.9805900970314;3888.9805550973197;3889.630485103911;3913.295606790805;3915.6867450604454;4452.619687896762;5114.826198865541;5368.6249450856785;5675.801346952837;5693.80430109665;4785.641076919175;5100.591952643854;5245.973770131125;5606.271184745957;5623.522000629992;4357.586029327209;5584.301962254718;5624.8875022498505;5626.634268772516;5657.915131272952;4893.6085113191575;5187.870303242449;5216.895662086813;5490.890182196414;5538.390777014606;5562.888742225214;5575.609707320448;5608.074667679787;5609.775608975759;5656.745446454837;5032.320636714143;5226.869328266824;5288.418273989935;5501.4223506532835;5542.861428464321 21:30:57 INFO - PROCESS | 1990 | |5;yui.html;698.277283012082;720.229354590588;748.023828903281;815.1400272712289;858.3819649852109;14596.343164557595;15585.766213506806;15609;15613.921930390361;15683.529494115166;11982;14044.438222471088;14559.27203639819;14606.634834129152;14679.412823487048;828.9378296627777;851.6976473351964;854.6752234151014;869.9347548933823;871.9302455803552;687.5290426058166;832.8958880139983;861.8664107063415;863.935204859635;864.2955990867455;750.654698838535;909.4225167018958;923.2521657457447;929.3076657889882;930.0838673906197;926.6293482606944;930.2046750028695;934.9065093490597;935.4106912645024;935.4667839331584;529.1876968852831;692.4460431654657;692.8752824491589;693.0435998322283;695.7947405515386;12344.567940122142;14432.494862679861;14986.925065374713;14999;15331;14282.3572939218;14290.928545357207;14352.92823535886;14391.928040359835;14547.78178327326;11571.710707232302;11681.691509723978;11755.941220293844;11962.222455540363;12026.037916966709;3631.782093074424;3680.705543556509;3812.5806161322234;3832.770033797981;3882.844686212548;95682.52158739232;99619.50190249075;99693.50153249259;101040.48439273417;101288.49355753248;8515.531645759418;10155.593776249016;10730.302530335503;11328.376939268255;11510;22657.320280391614;22744.886275568515;22756.544869102527;22764.975576098783;22781.544369112526;7758.262965018314;7763.757798752173;7801.531908085533;8051;8123.756287311272;3746.8126593670754;4286.39990401344;4302.526722060634;4336.913261734748;4444.488883778342;3566.8038257896064;3615.837287322077;3629.564452265745;3646.3072016317346;3661.0115268877785;617.7498113264136;628.3622123544606;633.9017452294902;643.3823529411724;646.5861848417017;666.9599824010575;691.1844024051567;691.9135108111486;708.861771954464;721.6427868205167;10043.648472303581;10156.23828212887;10277.640282590222;10282.948585257025;10323.277370583986;629.4020680353682;697.9546329488567;706.6679309501524;706.8621618784288;708.2598684374841;4651.441826980784;4972.5027497249985;4981.90036199274;4986.376702912136;4996.950030499721;103108;104027;104232;104518.95481045244;105759;76811;78561.82157267646;81343.7798433024;82751.75872361919;96046;66822.66588667122;69004.65497672479;69375;73079;78642.21357786348;10754.40850753216;10911.072558832588;11077.889221108007;11195.328280303207;11269.71825704364;47710;49209.2618610714;49601.75199123981;49771;50604.49395505998;63405.68297158484;66458.6677066631;66871.99692004721;67073.99389009266;67770.66114669395;12571.405804103091;12622.810657839957;12888.355582221038;13307.334633268492;13547.661308466973;12721.300328482022;14215.388294851102;14631.26843657834;14655.560333190022;14699.632509187355;13383.866161338263;13488.393022313823;13584.864151358755;13609.183448992697;13785.862141378459;13519.594412167651;13610.93194534021;13749.106308089942;13767.242801646005;14056.929715351358;13073.346332683517;13390.531331403354;13558.86441135576;13767.105138165987;13921.58235252944;11101.515738066246;11108;11290.040346570633;11511.251768635011;11724.179307448738;9870;9937.111948729718;10903.12774977984;10907.563697452013;10921.071708904832 21:30:57 INFO - PROCESS | 1990 | __end_tp_report 21:30:57 INFO - PROCESS | 1990 | __start_cc_report 21:30:57 INFO - PROCESS | 1990 | _x_x_mozilla_cycle_collect,1783 21:30:57 INFO - PROCESS | 1990 | __end_cc_report 21:30:57 INFO - PROCESS | 1990 | __startTimestamp1485063057977__endTimestamp 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | ------- Summary: start ------- 21:30:57 INFO - PROCESS | 1990 | Number of tests: 6 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#0] dojo.html Cycles:165 Average:5781.11 Median:6076.97 stddev:619.05 (10.2%) stddev-sans-first:589.08 21:30:57 INFO - PROCESS | 1990 | Values: 3281.7 3282.9 3291.1 3314.5 3352.7 5633.4 5710.6 5739.7 5749.0 5796.5 5735.4 5788.9 5790.2 5791.6 5796.0 5150.8 5178.6 5189.4 5227.1 5257.7 5338.5 5343.5 5345.0 5351.9 5363.8 5335.1 5343.0 5345.4 5345.6 5349.3 5333.4 5336.6 5336.7 5337.3 5337.9 5108.4 5179.8 5252.2 5281.1 5282.4 5757.9 5792.7 5832.1 5909.9 5933.4 6151.2 6161.5 6175.4 6180.1 6194.2 6104.1 6104.4 6133.4 6134.3 6134.7 5977.9 5979.2 5984.6 5991.9 6013.5 6275.0 6277.0 6289.8 6297.8 6308.1 6052.5 6125.1 6129.5 6144.8 6162.7 6162.9 6216.8 6234.1 6234.3 6236.3 6073.5 6080.5 6154.9 6167.2 6171.6 6130.9 6131.3 6157.2 6157.4 6181.2 4992.6 5000.5 5050.2 5060.1 5078.2 4473.9 4484.8 4487.9 4517.0 4519.0 5866.0 5867.4 5868.7 5886.6 5903.4 6127.2 6138.8 6145.8 6159.2 6183.7 5852.8 5881.4 5908.3 5911.1 5945.7 5310.2 5375.2 5377.4 5378.0 5514.4 6210.3 6236.1 6282.2 6288.9 6303.6 6123.2 6134.4 6147.6 6170.7 6183.3 6137.6 6221.3 6238.8 6287.2 6292.2 6192.6 6216.7 6220.8 6226.8 6230.2 6120.3 6243.5 6255.8 6261.5 6267.5 5885.6 6103.3 6120.6 6133.0 6204.2 6130.3 6168.0 6179.9 6193.4 6197.4 6044.6 6079.7 6088.6 6091.4 6118.9 6037.7 6092.8 6108.8 6114.7 6139.3 6071.0 6072.0 6077.0 6081.8 6086.5 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#1] ext.html Cycles:180 Average:66308.66 Median:38368.52 stddev:139323.99 (363.1%) stddev-sans-first:139627.03 21:30:57 INFO - PROCESS | 1990 | Values: 429.3 474.7 482.2 496.3 541.9 31117.0 32399.0 32414.0 32473.2 40551.6 42118.0 43400.3 43479.3 43523.8 43524.6 9116.8 9280.3 9312.2 9326.4 9333.1 8342.4 8565.9 9099.0 9183.8 9225.9 8398.7 8468.9 8474.5 11040.9 11330.7 11058.9 11145.8 11154.7 11156.9 11159.4 9340.9 11007.1 11048.8 11060.0 11061.7 31780.8 32208.2 39487.6 40888.8 40898.2 3732.9 3866.1 4023.1 4117.6 4125.1 25622.4 30805.5 31007.5 31085.5 31474.0 3020.1 3088.4 3120.8 3124.3 3127.8 474201.6 474392.6 477035.0 478718.0 479784.0 62148.7 62532.7 62658.7 62759.0 62785.1 66366.0 66474.7 66568.3 66657.3 66676.0 15504.7 15927.8 16058.8 16064.0 16085.2 12220.8 12332.0 12358.4 12382.6 12388.2 17113.9 17395.0 17408.4 17443.9 17470.7 5558.3 6682.0 6851.0 6892.0 6914.3 766.5 872.9 890.8 911.5 919.6 23656.4 29434.9 29592.3 30153.5 30292.7 1048.2 1056.2 1089.3 1099.9 1176.0 13955.4 15102.3 15384.2 15780.9 15808.4 503181.0 589737.9 592741.0 594732.0 596062.0 60158.4 60329.1 60347.7 60443.7 60519.0 1429.9 1446.9 1461.5 1467.6 1468.2 25907.0 27362.9 27822.6 28788.0 29776.4 50891.7 51262.0 51283.2 51300.2 51401.7 508361.0 509669.0 511418.0 511833.0 512855.0 37873.6 39113.0 39331.0 39337.6 39361.4 45707.9 46040.8 46368.5 46487.3 46699.0 35341.3 37167.6 37680.4 38337.4 38399.6 37329.0 37574.4 38309.0 38952.8 39555.0 37182.9 37383.3 37452.3 37804.6 37835.8 30700.5 33391.0 33731.3 33874.2 33973.0 21755.9 22492.8 23333.5 23673.5 25025.2 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#2] jquery.html Cycles:180 Average:39472.87 Median:22554.11 stddev:117753.20 (522.1%) stddev-sans-first:118046.88 21:30:57 INFO - PROCESS | 1990 | Values: 347.8 375.7 396.7 401.5 425.7 15141.5 15473.7 17800.8 18363.4 20948.0 21488.5 21803.0 21960.9 22143.9 22147.4 5898.9 5977.5 5987.9 6049.8 6129.8 6026.5 6087.1 6100.2 6100.2 6102.8 4163.3 4446.4 4455.9 6056.5 6790.3 6632.0 6838.1 6843.3 6848.8 6862.9 5108.5 5606.8 5955.2 5974.3 5986.4 22960.8 24472.8 26179.9 26205.1 26517.6 2635.6 2777.2 2812.9 2819.8 2826.2 15759.2 15942.9 15948.4 15952.2 16727.9 1744.0 1821.0 1864.6 1876.6 1879.5 116163.4 124976.0 125326.7 125866.0 128714.0 9183.4 10322.5 11435.8 11660.1 11698.0 14145.4 14276.5 14624.6 14625.9 14656.8 7002.7 8494.8 8712.0 8735.7 8885.4 8307.3 8645.7 8651.2 8759.9 8858.1 6015.8 6405.5 6751.7 7253.6 7265.7 1864.7 1900.4 1905.4 1912.8 1915.2 850.8 961.3 978.4 994.7 1007.9 13488.1 13777.2 13836.0 13969.7 14030.9 1003.3 1008.3 1019.2 1026.6 1026.6 7036.0 7323.2 11297.4 12383.9 12570.0 633606.8 702627.5 719809.0 727065.0 739673.0 150939.0 151964.0 153565.3 154404.2 155926.0 990.3 1029.5 1058.9 1060.5 1074.8 20525.6 20675.8 20687.0 20794.6 20866.0 57827.7 59852.4 60415.7 61313.9 61448.7 88876.1 89180.0 90379.1 90911.5 91910.1 7170.0 8096.6 8228.3 8654.4 8664.7 11591.9 13265.3 13320.1 13717.6 13774.4 11284.6 11284.9 11550.5 11577.0 11786.5 11098.7 11281.2 11384.1 11501.4 11700.4 11292.4 11616.7 11840.7 11844.3 11913.0 7149.0 7396.7 7525.2 8394.3 8736.1 8199.9 10073.4 11109.4 11560.8 11594.4 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#3] mootools.html Cycles:180 Average:5421.68 Median:5228.98 stddev:2955.35 (56.5%) stddev-sans-first:2948.51 21:30:57 INFO - PROCESS | 1990 | Values: 1441.8 1476.5 1480.2 1489.3 1500.9 8085.6 8500.7 8506.6 8515.4 8555.1 7405.2 7679.3 7689.9 8034.4 8222.0 2259.0 2302.5 2302.9 2304.2 2305.8 1949.3 2298.4 2322.9 2336.6 2338.1 1996.0 2076.8 2092.5 2225.8 2297.4 2143.3 2152.4 2156.7 2163.4 2165.2 2167.9 2315.6 2329.2 2333.7 2334.8 8349.7 8381.9 8402.1 8429.9 8430.0 5017.1 5174.2 5175.5 5192.4 5197.8 3212.5 3387.4 3390.9 3438.6 3441.3 1049.7 1144.3 1179.2 1180.5 1242.5 10711.9 10819.3 10868.3 10893.0 10923.5 3884.9 4461.4 4587.0 4684.4 4694.0 9488.4 9517.4 9525.5 9560.4 9567.0 5224.3 5233.7 5234.7 5237.7 5241.1 4009.3 4627.4 4695.2 4774.5 4785.6 3791.7 3800.6 3860.2 3890.2 3893.7 1262.8 1272.2 1273.1 1274.9 1278.5 899.1 903.3 917.6 940.4 948.1 5674.7 5764.1 5903.3 6008.9 6095.0 979.2 998.1 1012.5 1012.7 1031.6 3791.3 3796.9 3821.4 3911.3 3930.8 9715.5 9751.9 9881.0 9989.0 10032.5 9909.0 9918.8 9926.0 9935.1 9945.6 7338.2 7701.8 7729.1 7847.2 7868.1 5178.1 5401.6 5803.2 5861.4 5895.3 8829.9 9033.1 9240.8 9280.0 9293.7 9045.7 9171.2 9349.4 9420.6 9438.2 7084.3 7295.2 7327.6 7343.4 7346.7 7774.1 7843.7 7855.2 7906.7 7927.9 5682.4 7026.3 7148.5 7161.8 7188.0 5824.9 6955.8 7040.7 7057.2 7103.0 6345.3 6454.2 6458.8 6461.7 6463.8 4560.4 4912.4 4966.7 5015.8 5220.7 5022.9 5074.2 5074.6 5178.1 5209.6 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#4] prototype.html Cycles:180 Average:4492.31 Median:5070.93 stddev:1389.17 (27.4%) stddev-sans-first:1357.93 21:30:57 INFO - PROCESS | 1990 | Values: 355.5 368.1 370.0 374.5 377.1 5402.2 5410.7 5426.5 5428.5 5442.9 4423.7 5253.4 5331.5 5352.9 5378.4 3757.8 3995.3 4102.8 4123.4 4135.4 4064.6 4069.3 4101.2 4125.0 4131.8 3585.4 4057.9 4073.3 4078.5 4086.7 3449.0 3999.9 4047.5 4083.9 4102.8 2937.6 3017.7 3439.7 3461.2 3547.3 4556.0 5156.4 5162.9 5192.9 5257.6 4260.0 4444.7 4489.7 4582.4 4602.6 5599.8 5617.8 5662.5 5669.3 5692.2 3474.3 3564.8 3668.0 3860.6 3879.8 4509.1 4697.4 5083.2 5803.8 5942.5 3289.6 3599.0 3737.7 3863.5 3868.8 3795.7 3909.0 3915.4 3943.3 3953.9 4123.6 4269.2 4269.6 4527.1 4600.4 4620.8 5298.5 5470.7 5536.6 5630.4 1075.9 1089.6 1108.5 1150.7 1284.6 776.4 803.8 824.4 874.0 885.7 4440.8 4980.7 5012.3 5052.4 5105.7 4925.6 5330.0 5569.5 5609.4 5629.7 4746.9 4765.6 4813.8 5016.7 5058.6 2895.3 2911.2 2919.3 2924.3 2942.0 5574.2 5737.8 5741.8 5776.5 5791.0 5434.9 5601.4 5658.3 5722.4 5724.9 5117.5 5862.0 5918.6 6035.8 6049.6 5356.9 5518.8 5795.4 5831.2 5845.8 4661.8 5271.7 5414.9 5504.9 5803.9 5379.9 6005.3 6008.4 6039.9 6041.9 3882.0 3889.0 3889.6 3913.3 3915.7 4452.6 5114.8 5368.6 5675.8 5693.8 4785.6 5100.6 5246.0 5606.3 5623.5 4357.6 5584.3 5624.9 5626.6 5657.9 4893.6 5187.9 5216.9 5490.9 5538.4 5562.9 5575.6 5608.1 5609.8 5656.7 5032.3 5226.9 5288.4 5501.4 5542.9 21:30:57 INFO - PROCESS | 1990 | 21:30:57 INFO - PROCESS | 1990 | [#5] yui.html Cycles:180 Average:19990.79 Median:3713.76 stddev:28188.96 (759.0%) stddev-sans-first:28230.81 21:30:58 INFO - PROCESS | 1990 | Values: 698.3 720.2 748.0 815.1 858.4 14596.3 15585.8 15609.0 15613.9 15683.5 11982.0 14044.4 14559.3 14606.6 14679.4 828.9 851.7 854.7 869.9 871.9 687.5 832.9 861.9 863.9 864.3 750.7 909.4 923.3 929.3 930.1 926.6 930.2 934.9 935.4 935.5 529.2 692.4 692.9 693.0 695.8 12344.6 14432.5 14986.9 14999.0 15331.0 14282.4 14290.9 14352.9 14391.9 14547.8 11571.7 11681.7 11755.9 11962.2 12026.0 3631.8 3680.7 3812.6 3832.8 3882.8 95682.5 99619.5 99693.5 101040.5 101288.5 8515.5 10155.6 10730.3 11328.4 11510.0 22657.3 22744.9 22756.5 22765.0 22781.5 7758.3 7763.8 7801.5 8051.0 8123.8 3746.8 4286.4 4302.5 4336.9 4444.5 3566.8 3615.8 3629.6 3646.3 3661.0 617.7 628.4 633.9 643.4 646.6 667.0 691.2 691.9 708.9 721.6 10043.6 10156.2 10277.6 10282.9 10323.3 629.4 698.0 706.7 706.9 708.3 4651.4 4972.5 4981.9 4986.4 4997.0 103108.0 104027.0 104232.0 104519.0 105759.0 76811.0 78561.8 81343.8 82751.8 96046.0 66822.7 69004.7 69375.0 73079.0 78642.2 10754.4 10911.1 11077.9 11195.3 11269.7 47710.0 49209.3 49601.8 49771.0 50604.5 63405.7 66458.7 66872.0 67074.0 67770.7 12571.4 12622.8 12888.4 13307.3 13547.7 12721.3 14215.4 14631.3 14655.6 14699.6 13383.9 13488.4 13584.9 13609.2 13785.9 13519.6 13610.9 13749.1 13767.2 14056.9 13073.3 13390.5 13558.9 13767.1 13921.6 11101.5 11108.0 11290.0 11511.3 11724.2 9870.0 9937.1 10903.1 10907.6 10921.1 21:30:58 INFO - PROCESS | 1990 | -------- Summary: end -------- 21:30:58 INFO - PROCESS | 1990 | 21:30:58 INFO - TEST-INFO | 1990: exit 0 21:30:58 INFO - TEST-OK | dromaeo_css | took 1119655ms 21:30:58 INFO - TEST-START | kraken 21:30:58 INFO - operating with platform_type : mac_ 21:30:58 INFO - Initialising browser for kraken test... 21:30:58 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmppFW8OZ/profile http://localhost:52696/getInfo.html) 21:31:00 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 21:31:00 INFO - PROCESS | 1994 | colorDepth:24 21:31:00 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 21:31:00 INFO - PROCESS | 1994 | __metrics 21:31:01 INFO - PROCESS | 1994 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 21:31:01 INFO - PROCESS | 1994 | 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" 21:31:01 INFO - PROCESS | 1994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:31:01 INFO - TEST-INFO | 1994: exit 0 21:31:01 INFO - Browser initialized. 21:31:01 INFO - Running cycle 1/1 for kraken test... 21:31:01 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmppFW8OZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:13 INFO - PROCESS | 1995 | RSS: Main: 235864064 21:31:13 INFO - PROCESS | 1995 | 21:31:16 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-beat-detection) 21:31:17 INFO - PROCESS | 1995 | RSS: Main: 289013760 21:31:17 INFO - PROCESS | 1995 | 21:31:20 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-dft) 21:31:20 INFO - PROCESS | 1995 | RSS: Main: 288690176 21:31:20 INFO - PROCESS | 1995 | 21:31:24 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-fft) 21:31:24 INFO - PROCESS | 1995 | RSS: Main: 377978880 21:31:24 INFO - PROCESS | 1995 | 21:31:26 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52696/tests/kraken/driver.html?testName=audio-oscillator) 21:31:27 INFO - PROCESS | 1995 | RSS: Main: 281563136 21:31:27 INFO - PROCESS | 1995 | 21:31:29 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:31:29 INFO - PROCESS | 1995 | RSS: Main: 285827072 21:31:29 INFO - PROCESS | 1995 | 21:31:32 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-darkroom) 21:31:33 INFO - PROCESS | 1995 | RSS: Main: 326778880 21:31:33 INFO - PROCESS | 1995 | 21:31:36 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52696/tests/kraken/driver.html?testName=imaging-desaturate) 21:31:36 INFO - PROCESS | 1995 | RSS: Main: 329785344 21:31:36 INFO - PROCESS | 1995 | 21:31:39 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52696/tests/kraken/driver.html?testName=json-parse-financial) 21:31:40 INFO - PROCESS | 1995 | RSS: Main: 325120000 21:31:40 INFO - PROCESS | 1995 | 21:31:42 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52696/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:31:42 INFO - PROCESS | 1995 | RSS: Main: 302854144 21:31:42 INFO - PROCESS | 1995 | 21:31:44 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:31:45 INFO - PROCESS | 1995 | RSS: Main: 307376128 21:31:45 INFO - PROCESS | 1995 | 21:31:47 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:31:48 INFO - PROCESS | 1995 | RSS: Main: 308875264 21:31:48 INFO - PROCESS | 1995 | 21:31:50 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:31:51 INFO - PROCESS | 1995 | RSS: Main: 326922240 21:31:51 INFO - PROCESS | 1995 | 21:31:54 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:31:55 INFO - PROCESS | 1995 | RSS: Main: 320249856 21:31:55 INFO - PROCESS | 1995 | 21:31:56 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:52696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52696/tests/kraken/driver.html?testName=ai-astar) 21:31:57 INFO - PROCESS | 1995 | RSS: Main: 363507712 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | __start_tp_report 21:31:57 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 21:31:57 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 21:31:57 INFO - PROCESS | 1995 | |i|pagename|runs| 21:31:57 INFO - PROCESS | 1995 | |0;ai-astar;118;165;152;161;143;114;114;114;115;115 21:31:57 INFO - PROCESS | 1995 | |1;audio-beat-detection;140;134;133;144;113;111;107;109;127;110 21:31:57 INFO - PROCESS | 1995 | |2;audio-dft;184;183;186;186;186;182;180;183;184;183 21:31:57 INFO - PROCESS | 1995 | |3;audio-fft;82;58;58;86;60;57;59;58;73;58 21:31:57 INFO - PROCESS | 1995 | |4;audio-oscillator;82;70;87;70;68;70;82;68;68;83 21:31:57 INFO - PROCESS | 1995 | |5;imaging-gaussian-blur;89;86;88;87;87;86;89;87;88;86 21:31:57 INFO - PROCESS | 1995 | |6;imaging-darkroom;94;94;94;107;148;95;95;96;94;94 21:31:57 INFO - PROCESS | 1995 | |7;imaging-desaturate;90;85;91;131;85;86;88;87;88;88 21:31:57 INFO - PROCESS | 1995 | |8;json-parse-financial;58;56;56;56;57;57;57;56;55;55 21:31:57 INFO - PROCESS | 1995 | |9;json-stringify-tinderbox;68;76;70;75;73;71;70;71;71;71 21:31:57 INFO - PROCESS | 1995 | |10;stanford-crypto-aes;88;85;90;87;85;87;86;90;86;87 21:31:57 INFO - PROCESS | 1995 | |11;stanford-crypto-ccm;145;150;128;139;139;140;139;140;180;179 21:31:57 INFO - PROCESS | 1995 | |12;stanford-crypto-pbkdf2;175;175;174;173;172;173;170;171;172;171 21:31:57 INFO - PROCESS | 1995 | |13;stanford-crypto-sha256-iterative;67;66;65;66;67;61;58;85;86;58 21:31:57 INFO - PROCESS | 1995 | __end_tp_report 21:31:57 INFO - PROCESS | 1995 | __start_cc_report 21:31:57 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,2015 21:31:57 INFO - PROCESS | 1995 | __end_cc_report 21:31:57 INFO - PROCESS | 1995 | __startTimestamp1485063117236__endTimestamp 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | ------- Summary: start ------- 21:31:57 INFO - PROCESS | 1995 | Number of tests: 14 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#0] ai-astar Cycles:10 Average:131.10 Median:130.50 stddev:21.57 (16.5%) stddev-sans-first:22.36 21:31:57 INFO - PROCESS | 1995 | Values: 118.0 165.0 152.0 161.0 143.0 114.0 114.0 114.0 115.0 115.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:130.00 stddev:14.27 (11.0%) stddev-sans-first:13.71 21:31:57 INFO - PROCESS | 1995 | Values: 140.0 134.0 133.0 144.0 113.0 111.0 107.0 109.0 127.0 110.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.95 (1.1%) stddev-sans-first:2.06 21:31:57 INFO - PROCESS | 1995 | Values: 184.0 183.0 186.0 186.0 186.0 182.0 180.0 183.0 184.0 183.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#3] audio-fft Cycles:10 Average:64.90 Median:59.50 stddev:11.13 (18.7%) stddev-sans-first:9.94 21:31:57 INFO - PROCESS | 1995 | Values: 82.0 58.0 58.0 86.0 60.0 57.0 59.0 58.0 73.0 58.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:76.00 stddev:7.66 (10.1%) stddev-sans-first:7.66 21:31:57 INFO - PROCESS | 1995 | Values: 82.0 70.0 87.0 70.0 68.0 70.0 82.0 68.0 68.0 83.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:87.50 stddev:1.16 (1.3%) stddev-sans-first:1.05 21:31:57 INFO - PROCESS | 1995 | Values: 89.0 86.0 88.0 87.0 87.0 86.0 89.0 87.0 88.0 86.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:94.00 stddev:16.95 (18.0%) stddev-sans-first:17.79 21:31:57 INFO - PROCESS | 1995 | Values: 94.0 94.0 94.0 107.0 148.0 95.0 95.0 96.0 94.0 94.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:88.00 stddev:13.88 (15.8%) stddev-sans-first:14.70 21:31:57 INFO - PROCESS | 1995 | Values: 90.0 85.0 91.0 131.0 85.0 86.0 88.0 87.0 88.0 88.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:0.95 (1.7%) stddev-sans-first:0.78 21:31:57 INFO - PROCESS | 1995 | Values: 58.0 56.0 56.0 56.0 57.0 57.0 57.0 56.0 55.0 55.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:2.41 (3.4%) stddev-sans-first:2.18 21:31:57 INFO - PROCESS | 1995 | Values: 68.0 76.0 70.0 75.0 73.0 71.0 70.0 71.0 71.0 71.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:1.79 (2.1%) stddev-sans-first:1.87 21:31:57 INFO - PROCESS | 1995 | Values: 88.0 85.0 90.0 87.0 85.0 87.0 86.0 90.0 86.0 87.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:142.50 stddev:17.54 (12.3%) stddev-sans-first:18.57 21:31:57 INFO - PROCESS | 1995 | Values: 145.0 150.0 128.0 139.0 139.0 140.0 139.0 140.0 180.0 179.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:1.71 (1.0%) stddev-sans-first:1.58 21:31:57 INFO - PROCESS | 1995 | Values: 175.0 175.0 174.0 173.0 172.0 173.0 170.0 171.0 172.0 171.0 21:31:57 INFO - PROCESS | 1995 | 21:31:57 INFO - PROCESS | 1995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:66.50 stddev:9.89 (14.9%) stddev-sans-first:10.49 21:31:57 INFO - PROCESS | 1995 | Values: 67.0 66.0 65.0 66.0 67.0 61.0 58.0 85.0 86.0 58.0 21:31:57 INFO - PROCESS | 1995 | -------- Summary: end -------- 21:31:57 INFO - PROCESS | 1995 | 21:31:58 INFO - TEST-INFO | 1995: exit 0 21:31:58 INFO - TEST-OK | kraken | took 59604ms 21:31:58 INFO - SUITE-END | took 1179s 21:31:58 INFO - Completed test suite (00:19:39) 21:31:58 INFO - javascript benchmark 21:31:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.7210537104347, 3282.852271647777, 3291.1443024813548, 3314.5359649649067, 3352.7150192233657, 5633.380328163909, 5710.600257981938, 5739.713014349287, 5748.971255143723, 5796.536277097833, 5735.397783232763, 5788.942110578893, 5790.160426738131, 5791.623544469607, 5795.9857025020665, 5150.793968241275, 5178.611604129686, 5189.42916279209, 5227.059129356714, 5257.684538927677, 5338.519533242007, 5343.465653434645, 5345.037893179227, 5351.946480535184, 5363.758630861621, 5335.146376579748, 5343.038253114438, 5345.412004679482, 5345.572354211654, 5349.277847490578, 5333.413324534298, 5336.573074154077, 5336.706481143536, 5337.332833395825, 5337.866553336159, 5108.4125325587665, 5179.818706345298, 5252.185911183773, 5281.102212623863, 5282.418933917266, 5757.913631295534, 5792.68140252286, 5832.066869300891, 5909.911351329733, 5933.406659334032, 6151.200343955302, 6161.476274516672, 6175.3515880832765, 6180.072989051633, 6194.225721784777, 6104.125697713681, 6104.368208815878, 6133.438468486935, 6134.314131579348, 6134.742747059152, 5977.850553736192, 5979.1629171915965, 5984.551158663117, 5991.880162396727, 6013.54898382623, 6274.996000639876, 6277.0, 6289.842753931097, 6297.842553936188, 6308.053791931247, 6052.515798736091, 6125.050617154348, 6129.540284478682, 6144.846378840475, 6162.661053642093, 6162.876742465126, 6216.7824126155365, 6234.096056071935, 6234.2830574483605, 6236.251649802053, 6073.453389194905, 6080.513558915364, 6154.876902461926, 6167.167432396569, 6171.629702217791, 6130.908036379458, 6131.346082861964, 6157.199564056644, 6157.353477884847, 6181.227346581677, 4992.550670439605, 5000.549950504472, 5050.242463630485, 5060.139776238048, 5078.238264260391, 4473.865784026484, 4484.798184081724, 4487.910241795211, 4516.977415112903, 4519.0058187198765, 5865.970670146622, 5867.442592953663, 5868.735906884201, 5886.6173698709445, 5903.439173278532, 6127.203463549799, 6138.786925362681, 6145.846353841101, 6159.199304090529, 6183.721732522047, 5852.765889364463, 5881.382454842265, 5908.291005079332, 5911.054231322968, 5945.702714864239, 5310.203469479609, 5375.19372094189, 5377.354717433933, 5378.0, 5514.448555144534, 6210.347913469202, 6236.126942228092, 6282.214723159514, 6288.905666415099, 6303.590266632654, 6123.1606109212, 6134.35589263121, 6147.647517546133, 6170.6914654268, 6183.319834818257, 6137.591499645336, 6221.3156552778255, 6238.812835614939, 6287.245530536365, 6292.182016337847, 6192.628442293477, 6216.689165541795, 6220.813375598739, 6226.813195604139, 6230.190075290183, 6120.325235636462, 6243.531735119794, 6255.843603909939, 6261.467775238973, 6267.46726528232, 5885.646861188342, 6103.277060575968, 6120.599512025131, 6132.967444181115, 6204.193454850841, 6130.264368275835, 6167.969160154171, 6179.907301390573, 6193.411625895533, 6197.380261973766, 6044.607100538451, 6079.726412311368, 6088.6042407243385, 6091.385737923878, 6118.938810611837, 6037.667928263988, 6092.75628974836, 6108.786192483241, 6114.6942652868065, 6139.3246742857355, 6071.0, 6072.0, 6076.966915624443, 6081.756729730938, 6086.543509236736], "value": 5740.7755667785605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.25095707989544, 474.7104266397498, 482.15382004581966, 496.30269471392705, 541.9134635056711, 31117.0, 32399.0, 32414.027579172605, 32473.188170295754, 40551.59448405515, 42118.0, 43400.3489947651, 43479.3478097828, 43523.78238108813, 43524.56475435253, 9116.817663646723, 9280.257579393667, 9312.16190542851, 9326.393784404027, 9333.113354231336, 8342.41603087781, 8565.914340856605, 9099.04460031697, 9183.816323673522, 9225.861612075823, 8398.706045288416, 8468.872966905501, 8474.533900635462, 11040.889591104067, 11330.71673208168, 11058.944705276463, 11145.777084458347, 11154.721131971724, 11156.888431115665, 11159.38623375714, 9340.859887101631, 11007.119430445626, 11048.834267485994, 11060.0, 11061.668149955434, 31780.841095794374, 32208.194795130075, 39487.60512394897, 40888.79555602203, 40898.1820363591, 3732.9361132077497, 3866.0914685048992, 4023.1350259694304, 4117.5882411758885, 4125.092479654471, 25622.359441013938, 30805.537916931265, 31007.534886976715, 31085.533716994265, 31474.0, 3020.0637802281362, 3088.428640701455, 3120.7659425542947, 3124.265797537577, 3127.8123312601315, 474201.6289918563, 474392.6280368576, 477035.0, 478718.0, 479784.0, 62148.68925655433, 62532.749345012846, 62658.68670656617, 62759.0, 62785.0936396996, 66366.00450993239, 66474.66762666155, 66568.33431665719, 66657.33342666608, 66675.99986000214, 15504.689906202038, 15927.840721592636, 16058.839411605735, 16063.95584287041, 16085.195740212943, 12220.75558488843, 12332.0, 12358.44387002587, 12382.62852114438, 12388.194767340274, 17113.91443042777, 17395.0, 17408.39070632522, 17443.912780436018, 17470.737938930924, 5558.333000040021, 6682.0, 6850.957934818481, 6891.965540172267, 6914.343137402039, 766.4902839611707, 872.873433352173, 890.7594949363636, 911.4713466189594, 919.5678031325266, 23656.408589785395, 29434.852825735736, 29592.260193495335, 30153.547696784564, 30292.697073029427, 1048.224314007629, 1056.2236755984345, 1089.2647462962468, 1099.9120070394508, 1175.9823602645968, 13955.372008259652, 15102.320395582225, 15384.15387153695, 15780.921095394679, 15808.446704365291, 503181.0, 589737.9235868793, 592741.0, 594732.0, 596062.0, 60158.398416016156, 60329.0950635732, 60347.69826150841, 60443.69778151081, 60519.0, 1429.9356528956223, 1446.8553144685447, 1461.4738694070127, 1467.6330917270682, 1468.2071681292196, 25907.0, 27362.905483780425, 27822.5826612605, 28788.0, 29776.404471910006, 50891.74554127206, 51262.0, 51283.2307515395, 51300.23049654184, 51401.7429912863, 508361.0, 509669.0, 511418.0, 511833.0, 512855.0, 37873.62126378701, 39113.0, 39331.0, 39337.606623933396, 39361.40957885577, 45707.857303567675, 46040.76979615215, 46368.53631463777, 46487.30269045899, 46699.0, 35341.29317413689, 37167.6283237175, 37680.351292952924, 38337.42493862539, 38399.616003839605, 37329.0, 37574.43638345482, 38309.04227394338, 38952.80523597364, 39555.0, 37182.88451346464, 37383.25233495369, 37452.250954980205, 37804.62195378011, 37835.81082094572, 30700.53949190719, 33391.0, 33731.325373491905, 33874.15314617056, 33973.0, 21755.891220543795, 22492.762898040764, 23333.53332933298, 23673.52652946966, 25025.249242522754], "value": 19785.60102635117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.80001499137995, 375.6712876233296, 396.7203121799134, 401.544247279338, 425.6509662077098, 15141.545753627395, 15473.690526189483, 17800.84294520855, 18363.357282495115, 20947.952602369896, 21488.495805293598, 21803.0, 21960.90195490227, 22143.889280553616, 22147.446313842163, 5898.88202235955, 5977.491913187362, 5987.940120598803, 6049.848753781147, 6129.785457508988, 6026.517878569726, 6087.11736798164, 6100.176476175726, 6100.206973093492, 6102.847428814293, 4163.271427500191, 4446.3997360356425, 4455.933161002587, 6056.454919057284, 6790.287019862917, 6631.972044333136, 6838.076859623937, 6843.349881761224, 6848.794536163923, 6862.867626841565, 5108.463611320795, 5606.803761868315, 5955.166276721263, 5974.342822289588, 5986.431289027579, 22960.77039229603, 24472.755272447226, 26179.869100654374, 26205.082822101325, 26517.602235966475, 2635.6310116583695, 2777.1529683446543, 2812.9015484457946, 2819.84490853003, 2826.18040768177, 15759.212039397984, 15942.920285398499, 15948.441804536786, 15952.202389880576, 16727.916360418243, 1744.0059166275228, 1820.954476138094, 1864.6177533605578, 1876.5683892704617, 1879.5301174706324, 116163.41918290354, 124976.0, 125326.74673253243, 125865.99999999908, 128714.0, 9183.403078799856, 10322.48387580618, 11435.828462573068, 11660.06719462441, 11697.958530782058, 14145.43418263258, 14276.500322488662, 14624.634384140269, 14625.92687036558, 14656.780148297785, 7002.684879180449, 8494.830103397897, 8712.0, 8735.65057397697, 8885.42244754089, 8307.331319737328, 8645.740627781177, 8651.221390074923, 8759.948806143177, 8858.069902660256, 6015.759369625253, 6405.455536279375, 6751.662416879137, 7253.637318134072, 7265.745698900619, 1864.6923257662604, 1900.4013735673218, 1905.4283714885478, 1912.814055285704, 1915.2339064374362, 850.7830503221638, 961.2838435365558, 978.3885071830106, 994.6767300627325, 1007.8891321954579, 13488.055836091575, 13777.173369597856, 13836.031477796458, 13969.65075873091, 14030.877529797592, 1003.2976916158718, 1008.2941940641433, 1019.2304809868501, 1026.5637104230673, 1026.563710423082, 7035.964820175969, 7323.231060738653, 11297.378644174649, 12383.947364473941, 12570.0, 633606.8319658373, 702627.4868625726, 719809.0, 727065.0, 739673.0, 150939.0, 151964.0, 153565.2686887256, 154404.2279788594, 155926.0, 990.2869933647762, 1029.4543891737392, 1058.8517607534952, 1060.4697651174413, 1074.7742973975553, 20525.58948821045, 20675.79324206799, 20687.0, 20794.584108318053, 20866.0, 57827.71086144543, 59852.40147598642, 60415.69792151011, 61313.934303283764, 61448.69275653593, 88876.11123888678, 89180.0, 90379.09620903707, 90911.54544227237, 91910.08089919016, 7170.0, 8096.595170241347, 8228.300594449538, 8654.350923680624, 8664.653413863374, 11591.942040289745, 13265.270410127536, 13320.134191277535, 13717.588472345846, 13774.449022039005, 11284.605038823602, 11284.943575282072, 11550.537978480766, 11577.0, 11786.528538858349, 11098.667039988813, 11281.153913456688, 11384.089272857986, 11501.424928753362, 11700.35648039332, 11292.435378230892, 11616.709582260512, 11840.703982400164, 11844.28934263947, 11913.046956243654, 7149.0, 7396.704131834882, 7525.247475252431, 8394.286485648789, 8736.126387361213, 8199.918000820155, 10073.445960472245, 11109.444527773418, 11560.826587601361, 11594.362310073027], "value": 9992.088789511361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.7549016667178, 1476.512750792238, 1480.20808867256, 1489.3149151390357, 1500.8874334424913, 8085.595720213988, 8500.702475413362, 8506.617202225907, 8515.403921725481, 8555.101714319992, 7405.22245164258, 7679.347255483291, 7689.923410722503, 8034.397420193494, 8222.0, 2259.028617694395, 2302.458922153293, 2302.861828290308, 2304.1704986205036, 2305.7694230576976, 1949.3177387914188, 2298.402415371999, 2322.883855807203, 2336.5677349690277, 2338.088145623208, 1996.0418998880546, 2076.7611724651706, 2092.466421062627, 2225.8330625203093, 2297.448612333045, 2143.2712877621607, 2152.3758110148037, 2156.676498525218, 2163.4266919266406, 2165.2313428732887, 2167.881026050501, 2315.571619250444, 2329.173143534055, 2333.6849525314205, 2334.7548507406646, 8349.749507514784, 8381.874271885927, 8402.075771665111, 8429.915700842974, 8430.030546487109, 5017.096922553938, 5174.249733788617, 5175.456577059392, 5192.402873669538, 5197.818076367309, 3212.4699424594914, 3387.4072037393603, 3390.86436542538, 3438.5529881115544, 3441.346144232588, 1049.7218237167158, 1144.3019757947645, 1179.151011271883, 1180.5100883133575, 1242.5092088625033, 10711.946440267826, 10819.296745711503, 10868.293560918593, 10893.0, 10923.508442120125, 3884.941725874114, 4461.353103799931, 4587.03672228829, 4684.367610372624, 4693.967327188013, 9488.383255088396, 9517.428954262767, 9525.523723813782, 9560.426374417557, 9566.952165239269, 5224.294720212799, 5233.659812112201, 5234.685918844882, 5237.711925844039, 5241.135212689864, 4009.318415869251, 4627.421572303462, 4695.248760198352, 4774.474807771142, 4785.641076919245, 3791.734578579473, 3800.600936901641, 3860.208657225262, 3890.1636148228267, 3893.7469064510715, 1262.8105784132454, 1272.1603741530546, 1273.1406300746958, 1274.936253187337, 1278.4822147030468, 899.1008991008991, 903.2864037410503, 917.6146018672174, 940.3793496292415, 948.1324588002038, 5674.716264186774, 5764.13537969308, 5903.321118071391, 6008.909866352008, 6094.969525152346, 979.2019504104132, 998.0917365197636, 1012.473513772834, 1012.6607586458472, 1031.6176323726243, 3791.260704162717, 3796.886093417202, 3821.3885778275344, 3911.3155197840833, 3930.8427662893164, 9715.46564938935, 9751.853722194173, 9881.011898810062, 9988.953369222312, 10032.498375081363, 9909.0, 9918.752031199278, 9926.0, 9935.05616966387, 9945.602175913027, 7338.192798792129, 7701.845963080707, 7729.072511298793, 7847.176046515148, 7868.134505204423, 5178.093833579184, 5401.6218864679095, 5803.216565763568, 5861.35525092248, 5895.322037965518, 8829.911700882909, 9033.096690330914, 9240.815183696423, 9280.0, 9293.67472138472, 9045.728628141167, 9171.220446262143, 9349.439033658002, 9420.576074076545, 9438.24494040489, 7084.291570843081, 7295.1610564783605, 7327.560346379234, 7343.37581305595, 7346.7061317546695, 7774.144844067261, 7843.7254696085365, 7855.175206603453, 7906.723264685708, 7927.881081783663, 5682.431756824284, 7026.297370262932, 7148.535345202546, 7161.820954476179, 7187.9640601796655, 5824.854378640568, 6955.826104347432, 7040.683169257498, 7057.2237053923, 7103.005579219017, 6345.302016778059, 6454.19322584677, 6458.773942911976, 6461.709223085067, 6463.7737679181, 4560.407147070992, 4912.435069966999, 4966.701997880139, 5015.799368025238, 5220.738963051756, 5022.949770502394, 5074.188129899198, 5074.594032477319, 5178.0679477694375, 5209.635325527328], "value": 4411.024365066319, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5111721383098, 368.147737986561, 369.9722520810938, 374.52809460080323, 377.1231885865362, 5402.1908607524065, 5410.675359478434, 5426.484483974021, 5428.4842939920745, 5442.945570544293, 4423.690341676084, 5253.4221235664145, 5331.5222005263595, 5352.946470535294, 5378.369600519653, 3757.812109394526, 3995.3008223560905, 4102.753834769924, 4123.36087906375, 4135.449206547544, 4064.552899181088, 4069.3285607874814, 4101.220768054075, 4124.968757810532, 4131.752094874302, 3585.3725598020374, 4057.878263652095, 4073.327900896363, 4078.490188726409, 4086.7139300248996, 3449.0, 3999.9400008999887, 4047.4738284023183, 4083.8570650027254, 4102.79486025699, 2937.5740517624827, 3017.7434918031995, 3439.6560343965652, 3461.238527523941, 3547.290541891606, 4555.9521310098535, 5156.381234251876, 5162.870928226786, 5192.870178245536, 5257.631965762398, 4259.97870010648, 4444.688871778977, 4489.663275254369, 4582.358469814229, 4602.596208156511, 5599.824036952245, 5617.758592262856, 5662.462066103713, 5669.262995810518, 5692.231548740909, 3474.322507111114, 3564.8395822188063, 3667.9633203668154, 3860.613938606117, 3879.806009699532, 4509.120721459317, 4697.389339385858, 5083.212102124176, 5803.82588522345, 5942.494887934531, 3289.6052473703307, 3599.028262369198, 3737.663610275088, 3863.459115723801, 3868.7678739275734, 3795.6773674237447, 3908.9804550977065, 3915.4322623219473, 3943.2507823513442, 3953.940690889639, 4123.628873401348, 4269.23153832307, 4269.615734583902, 4527.139843429738, 4600.35595016698, 4620.838270660511, 5298.496642818926, 5470.699111548903, 5536.612437129443, 5630.436956304418, 1075.940198904079, 1089.6022951622601, 1108.4758457121459, 1150.672058463334, 1284.556827894375, 776.3788968824917, 803.8070862992839, 824.4435006370676, 873.9781505462414, 885.7475619448426, 4440.777961101932, 4980.655223089818, 5012.26341107657, 5052.3937127544195, 5105.719185444762, 4925.630577706686, 5329.960657671794, 5569.493727822496, 5609.382967873531, 5629.662220266797, 4746.857594272177, 4765.617970788502, 4813.7593120343845, 5016.698998060128, 5058.645894787403, 2895.334073163142, 2911.199420159473, 2919.255589824581, 2924.2835505300914, 2942.043835753346, 5574.247476590689, 5737.819628541128, 5741.813293621996, 5776.480116789509, 5790.971045144747, 5434.945650543444, 5601.355844077983, 5658.292713410824, 5722.37053924068, 5724.914126288109, 5117.518003768169, 5861.9706901465215, 5918.556108291896, 6035.849103772441, 6049.606775559574, 5356.946430535801, 5518.779248830002, 5795.391483894299, 5831.241938547962, 5845.824625261249, 4661.836835710734, 5271.710055946806, 5414.889947560662, 5504.889902202013, 5803.9419605803405, 5379.892402151857, 6005.339412664516, 6008.429199226067, 6039.939600604113, 6041.879162416815, 3881.9805900970314, 3888.9805550973197, 3889.630485103911, 3913.295606790805, 3915.6867450604454, 4452.619687896762, 5114.826198865541, 5368.6249450856785, 5675.801346952837, 5693.80430109665, 4785.641076919175, 5100.591952643854, 5245.973770131125, 5606.271184745957, 5623.522000629992, 4357.586029327209, 5584.301962254718, 5624.8875022498505, 5626.634268772516, 5657.915131272952, 4893.6085113191575, 5187.870303242449, 5216.895662086813, 5490.890182196414, 5538.390777014606, 5562.888742225214, 5575.609707320448, 5608.074667679787, 5609.775608975759, 5656.745446454837, 5032.320636714143, 5226.869328266824, 5288.418273989935, 5501.4223506532835, 5542.861428464321], "value": 4056.2332149972394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.277283012082, 720.229354590588, 748.023828903281, 815.1400272712289, 858.3819649852109, 14596.343164557595, 15585.766213506806, 15609.0, 15613.921930390361, 15683.529494115166, 11982.0, 14044.438222471088, 14559.27203639819, 14606.634834129152, 14679.412823487048, 828.9378296627777, 851.6976473351964, 854.6752234151014, 869.9347548933823, 871.9302455803552, 687.5290426058166, 832.8958880139983, 861.8664107063415, 863.935204859635, 864.2955990867455, 750.654698838535, 909.4225167018958, 923.2521657457447, 929.3076657889882, 930.0838673906197, 926.6293482606944, 930.2046750028695, 934.9065093490597, 935.4106912645024, 935.4667839331584, 529.1876968852831, 692.4460431654657, 692.8752824491589, 693.0435998322283, 695.7947405515386, 12344.567940122142, 14432.494862679861, 14986.925065374713, 14999.0, 15331.0, 14282.3572939218, 14290.928545357207, 14352.92823535886, 14391.928040359835, 14547.78178327326, 11571.710707232302, 11681.691509723978, 11755.941220293844, 11962.222455540363, 12026.037916966709, 3631.782093074424, 3680.705543556509, 3812.5806161322234, 3832.770033797981, 3882.844686212548, 95682.52158739232, 99619.50190249075, 99693.50153249259, 101040.48439273417, 101288.49355753248, 8515.531645759418, 10155.593776249016, 10730.302530335503, 11328.376939268255, 11510.0, 22657.320280391614, 22744.886275568515, 22756.544869102527, 22764.975576098783, 22781.544369112526, 7758.262965018314, 7763.757798752173, 7801.531908085533, 8051.0, 8123.756287311272, 3746.8126593670754, 4286.39990401344, 4302.526722060634, 4336.913261734748, 4444.488883778342, 3566.8038257896064, 3615.837287322077, 3629.564452265745, 3646.3072016317346, 3661.0115268877785, 617.7498113264136, 628.3622123544606, 633.9017452294902, 643.3823529411724, 646.5861848417017, 666.9599824010575, 691.1844024051567, 691.9135108111486, 708.861771954464, 721.6427868205167, 10043.648472303581, 10156.23828212887, 10277.640282590222, 10282.948585257025, 10323.277370583986, 629.4020680353682, 697.9546329488567, 706.6679309501524, 706.8621618784288, 708.2598684374841, 4651.441826980784, 4972.5027497249985, 4981.90036199274, 4986.376702912136, 4996.950030499721, 103108.0, 104027.0, 104232.0, 104518.95481045244, 105759.0, 76811.0, 78561.82157267646, 81343.7798433024, 82751.75872361919, 96046.0, 66822.66588667122, 69004.65497672479, 69375.0, 73079.0, 78642.21357786348, 10754.40850753216, 10911.072558832588, 11077.889221108007, 11195.328280303207, 11269.71825704364, 47710.0, 49209.2618610714, 49601.75199123981, 49771.0, 50604.49395505998, 63405.68297158484, 66458.6677066631, 66871.99692004721, 67073.99389009266, 67770.66114669395, 12571.405804103091, 12622.810657839957, 12888.355582221038, 13307.334633268492, 13547.661308466973, 12721.300328482022, 14215.388294851102, 14631.26843657834, 14655.560333190022, 14699.632509187355, 13383.866161338263, 13488.393022313823, 13584.864151358755, 13609.183448992697, 13785.862141378459, 13519.594412167651, 13610.93194534021, 13749.106308089942, 13767.242801646005, 14056.929715351358, 13073.346332683517, 13390.531331403354, 13558.86441135576, 13767.105138165987, 13921.58235252944, 11101.515738066246, 11108.0, 11290.040346570633, 11511.251768635011, 11724.179307448738, 9870.0, 9937.111948729718, 10903.12774977984, 10907.563697452013, 10921.071708904832], "value": 7502.378697292406, "unit": "score"}], "name": "dromaeo_css", "value": 7308.264018717056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 165.0, 152.0, 161.0, 143.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 131.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 133.0, 144.0, 113.0, 111.0, 107.0, 109.0, 127.0, 110.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 186.0, 186.0, 182.0, 180.0, 183.0, 184.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 86.0, 60.0, 57.0, 59.0, 58.0, 73.0, 58.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 87.0, 70.0, 68.0, 70.0, 82.0, 68.0, 68.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 87.0, 87.0, 86.0, 89.0, 87.0, 88.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 107.0, 148.0, 95.0, 95.0, 96.0, 94.0, 94.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 91.0, 131.0, 85.0, 86.0, 88.0, 87.0, 88.0, 88.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 70.0, 75.0, 73.0, 71.0, 70.0, 71.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 90.0, 87.0, 85.0, 87.0, 86.0, 90.0, 86.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 128.0, 139.0, 139.0, 140.0, 139.0, 140.0, 180.0, 179.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 174.0, 173.0, 172.0, 173.0, 170.0, 171.0, 172.0, 171.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 67.0, 61.0, 58.0, 85.0, 86.0, 58.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1461.0, "alertThreshold": 2.0}]} 21:31:58 INFO - Return code: 0 21:31:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:31:58 ERROR - # TBPL SUCCESS # 21:31:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:31:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:31:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:31:58 INFO - 2017-01-21 21:31:58.573 screenresolution[1999:22468] starting screenresolution argv=screenresolution get 21:31:58 INFO - 2017-01-21 21:31:58.576 screenresolution[1999:22468] Display 0: 1600x1200x32@60 21:31:58 INFO - 2017-01-21 21:31:58.583 screenresolution[2000:22471] starting screenresolution argv=screenresolution list 21:31:58 INFO - Available Modes on Display 0 21:31:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:31:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:31:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:31:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:31:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:31:58 INFO - Intel Iris: 21:31:58 INFO - Chipset Model: Intel Iris 21:31:58 INFO - Type: GPU 21:31:58 INFO - Bus: Built-In 21:31:58 INFO - VRAM (Dynamic, Max): 1536 MB 21:31:58 INFO - Vendor: Intel (0x8086) 21:31:58 INFO - Device ID: 0x0a2e 21:31:58 INFO - Revision ID: 0x0009 21:31:58 INFO - Displays: 21:31:58 INFO - Display: 21:31:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:31:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:31:58 INFO - Display Serial Number: 1600x1200 60 21:31:58 INFO - Main Display: Yes 21:31:58 INFO - Mirror: Off 21:31:58 INFO - Online: Yes 21:31:58 INFO - Rotation: Supported 21:31:58 INFO - Return code: 0 21:31:58 INFO - Running post-action listener: _resource_record_post_action 21:31:58 INFO - [mozharness: 2017-01-22 05:31:58.831039Z] Finished run-tests step (success) 21:31:58 INFO - Running post-run listener: _resource_record_post_run 21:31:58 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 671744; Write bytes: 553783296; Read time: 6; Write time: 1676 21:31:58 INFO - TinderboxPrint: CPU usage
53.7% 21:31:58 INFO - TinderboxPrint: I/O read bytes / time
671,744 / 6 21:31:58 INFO - TinderboxPrint: I/O write bytes / time
553,783,296 / 1,676 21:31:58 INFO - TinderboxPrint: CPU idle
2,225.6 (46.3%) 21:31:58 INFO - TinderboxPrint: CPU system
963.9 (20.0%) 21:31:58 INFO - TinderboxPrint: CPU user
1,620.2 (33.7%) 21:31:58 INFO - TinderboxPrint: Swap in / out
251,363,328 / 0 21:31:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249448960; Write bytes: 243693568; Read time: 18073; Write time: 524 21:31:58 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 589824; Write bytes: 298551296; Read time: 4; Write time: 1116 21:31:59 INFO - Running post-run listener: _upload_blobber_files 21:31:59 INFO - Blob upload gear active. 21:31:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:31:59 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 21:31:59 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'] 21:31:59 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 21:31:59 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:00 INFO - (blobuploader) - INFO - Done attempting. 21:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:01 INFO - (blobuploader) - INFO - Done attempting. 21:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:02 INFO - (blobuploader) - INFO - Done attempting. 21:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:32:05 INFO - (blobuploader) - INFO - Done attempting. 21:32:05 INFO - (blobuploader) - INFO - Iteration through files over. 21:32:05 INFO - Return code: 0 21:32:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:32:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:32:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b5b3b800a53be9c96695c9b737503b6d353394b55aaffc33062c848ea5b0670f3ad7a5bf6b28f09816d37c91d78fd8212fb5fb3d4341db9d9b4623005877708f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8b65a00ba4df1179f87cdb1e6cefbd738a2dd92dc2d7682422096326c97d9874b46b6abeda0d3de4df1f96905939514b784e43cb04b5a42e4d95d41ffb1ff450", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/09dc1aa975fc65e8659e7aa674c3e12dbc7a77cc78a3bf91bce031dd76a07dce530810c9365ac560e9ed89ca2219a8f20aba3614e29b45722f495bf5b81a31d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/df8f43365fbf186536622489eb529b5d9bc3cb3b35d069c050f0693042fd816c8bc48148d22ad1c5e075e2bcfab4123986d018c16c88ab1dd8be39468b99f5ef"} 21:32:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:32:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:32:05 INFO - Contents: 21:32:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b5b3b800a53be9c96695c9b737503b6d353394b55aaffc33062c848ea5b0670f3ad7a5bf6b28f09816d37c91d78fd8212fb5fb3d4341db9d9b4623005877708f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8b65a00ba4df1179f87cdb1e6cefbd738a2dd92dc2d7682422096326c97d9874b46b6abeda0d3de4df1f96905939514b784e43cb04b5a42e4d95d41ffb1ff450", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/09dc1aa975fc65e8659e7aa674c3e12dbc7a77cc78a3bf91bce031dd76a07dce530810c9365ac560e9ed89ca2219a8f20aba3614e29b45722f495bf5b81a31d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/df8f43365fbf186536622489eb529b5d9bc3cb3b35d069c050f0693042fd816c8bc48148d22ad1c5e075e2bcfab4123986d018c16c88ab1dd8be39468b99f5ef"} 21:32:05 INFO - Running post-run listener: copy_logs_to_upload_dir 21:32:05 INFO - Copying logs to upload dir... 21:32:05 INFO - mkdir: /builds/slave/test/build/upload/logs 21:32:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.675250 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-21 21:32:05.099157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 21:32:05.104849) ========= 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.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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/b5b3b800a53be9c96695c9b737503b6d353394b55aaffc33062c848ea5b0670f3ad7a5bf6b28f09816d37c91d78fd8212fb5fb3d4341db9d9b4623005877708f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8b65a00ba4df1179f87cdb1e6cefbd738a2dd92dc2d7682422096326c97d9874b46b6abeda0d3de4df1f96905939514b784e43cb04b5a42e4d95d41ffb1ff450", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/09dc1aa975fc65e8659e7aa674c3e12dbc7a77cc78a3bf91bce031dd76a07dce530810c9365ac560e9ed89ca2219a8f20aba3614e29b45722f495bf5b81a31d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/df8f43365fbf186536622489eb529b5d9bc3cb3b35d069c050f0693042fd816c8bc48148d22ad1c5e075e2bcfab4123986d018c16c88ab1dd8be39468b99f5ef"} build_url:https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011494 build_url: 'https://queue.taskcluster.net/v1/task/bxDz_oSjRXer46Rp6OGxOg/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/b5b3b800a53be9c96695c9b737503b6d353394b55aaffc33062c848ea5b0670f3ad7a5bf6b28f09816d37c91d78fd8212fb5fb3d4341db9d9b4623005877708f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8b65a00ba4df1179f87cdb1e6cefbd738a2dd92dc2d7682422096326c97d9874b46b6abeda0d3de4df1f96905939514b784e43cb04b5a42e4d95d41ffb1ff450", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/09dc1aa975fc65e8659e7aa674c3e12dbc7a77cc78a3bf91bce031dd76a07dce530810c9365ac560e9ed89ca2219a8f20aba3614e29b45722f495bf5b81a31d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/df8f43365fbf186536622489eb529b5d9bc3cb3b35d069c050f0693042fd816c8bc48148d22ad1c5e075e2bcfab4123986d018c16c88ab1dd8be39468b99f5ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 21:32:05.139801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:32:05.140104) ========= 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.wwVZswkgcN/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.A1NzqLakm3/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005327 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:32:05.188897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 21:32:05.189184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 21:32:05.189482) ========= ========= Total master_lag: 0.18 =========