builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0255 starttime: 1481113605.04 results: success (0) buildid: 20161207020338 builduid: 6e4685cf06084f25a25249df5d4a0783 revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.045113) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.045619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.045912) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.238132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.238598) ========= 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.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-07 04:26:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.25M=0.001s 2016-12-07 04:26:45 (8.25 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118254 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.386830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.387143) ========= 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.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.019833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:45.435573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 04:26:45.435980) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --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 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-07 04:26:45,446 truncating revision to first 12 chars 2016-12-07 04:26:45,446 Setting DEBUG logging. 2016-12-07 04:26:45,446 attempt 1/10 2016-12-07 04:26:45,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/983a7399df86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 04:26:46,560 unpacking tar archive at: graphics-983a7399df86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371719 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 04:26:46.835855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:46.836183) ========= script_repo_revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:46.836578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:46.836866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 04:26:46.857374) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 04:26:46.857673) ========= /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.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:26:46 INFO - MultiFileLogger online at 20161207 04:26:46 in /builds/slave/test 04:26:46 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 04:26:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:46 INFO - {'append_to_log': False, 04:26:46 INFO - 'base_work_dir': '/builds/slave/test', 04:26:46 INFO - 'blob_upload_branch': 'Graphics', 04:26:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:46 INFO - 'branch': 'Graphics', 04:26:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:46 INFO - 'config_files': ('talos/mac_config.py',), 04:26:46 INFO - 'default_actions': ('clobber', 04:26:46 INFO - 'read-buildbot-config', 04:26:46 INFO - 'download-and-extract', 04:26:46 INFO - 'populate-webroot', 04:26:46 INFO - 'create-virtualenv', 04:26:46 INFO - 'install', 04:26:46 INFO - 'run-tests'), 04:26:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:46 INFO - 'download_minidump_stackwalk': True, 04:26:46 INFO - 'download_symbols': 'ondemand', 04:26:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:46 INFO - 'installer_path': 'installer.exe', 04:26:46 INFO - 'log_level': 'info', 04:26:46 INFO - 'log_name': 'talos', 04:26:46 INFO - 'log_to_console': True, 04:26:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:46 INFO - 'opt_config_files': (), 04:26:46 INFO - 'pip_index': False, 04:26:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:46 INFO - 'cmd': ('bash', 04:26:46 INFO - '-c', 04:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:46 INFO - 'enabled': True, 04:26:46 INFO - 'halt_on_failure': False, 04:26:46 INFO - 'name': 'check_screen_resolution'},), 04:26:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:46 INFO - 'cmd': ('bash', 04:26:46 INFO - '-c', 04:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:46 INFO - 'enabled': True, 04:26:46 INFO - 'halt_on_failure': False, 04:26:46 INFO - 'name': 'check_screen_resolution'},), 04:26:46 INFO - 'run_cmd_checks_enabled': True, 04:26:46 INFO - 'sps_profile': False, 04:26:46 INFO - 'sps_profile_interval': 0, 04:26:46 INFO - 'suite': 'dromaeojs', 04:26:46 INFO - 'system_bits': '32', 04:26:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:46 INFO - 'title': 't-yosemite-r7-0255', 04:26:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:46 INFO - 'use_talos_json': True, 04:26:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:46 INFO - 'work_dir': 'build'} 04:26:46 INFO - [mozharness: 2016-12-07 12:26:46.990630Z] Running clobber step. 04:26:46 INFO - Running pre-action listener: _resource_record_pre_action 04:26:46 INFO - Running main action method: clobber 04:26:46 INFO - rmtree: /builds/slave/test/build 04:26:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:47 INFO - Running post-action listener: _resource_record_post_action 04:26:47 INFO - [mozharness: 2016-12-07 12:26:47.152435Z] Finished clobber step (success) 04:26:47 INFO - [mozharness: 2016-12-07 12:26:47.152558Z] Running read-buildbot-config step. 04:26:47 INFO - Running pre-action listener: _resource_record_pre_action 04:26:47 INFO - Running main action method: read_buildbot_config 04:26:47 INFO - Using buildbot properties: 04:26:47 INFO - { 04:26:47 INFO - "project": "", 04:26:47 INFO - "product": "firefox", 04:26:47 INFO - "script_repo_revision": "default", 04:26:47 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 04:26:47 INFO - "repository": "", 04:26:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 04:26:47 INFO - "buildid": "20161207020338", 04:26:47 INFO - "pgo_build": "False", 04:26:47 INFO - "basedir": "/builds/slave/test", 04:26:47 INFO - "buildnumber": 8, 04:26:47 INFO - "slavename": "t-yosemite-r7-0255", 04:26:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:26:47 INFO - "platform": "yosemite_r7", 04:26:47 INFO - "scheduler": "tests-graphics-macosx64-talos", 04:26:47 INFO - "branch": "graphics", 04:26:47 INFO - "repo_path": "projects/graphics", 04:26:47 INFO - "revision": "983a7399df86ff30a8a8b45f44ccdc6727ac4477", 04:26:47 INFO - "stage_platform": "macosx64", 04:26:47 INFO - "builduid": "6e4685cf06084f25a25249df5d4a0783", 04:26:47 INFO - "slavebuilddir": "test" 04:26:47 INFO - } 04:26:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:26:47 INFO - Running post-action listener: _resource_record_post_action 04:26:47 INFO - [mozharness: 2016-12-07 12:26:47.155922Z] Finished read-buildbot-config step (success) 04:26:47 INFO - [mozharness: 2016-12-07 12:26:47.156006Z] Running download-and-extract step. 04:26:47 INFO - Running pre-action listener: _resource_record_pre_action 04:26:47 INFO - Running main action method: download_and_extract 04:26:47 INFO - mkdir: /builds/slave/test/build/tests 04:26:47 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')]} 04:26:47 INFO - trying https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:26:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 04:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 04:26:48 INFO - Downloaded 1199 bytes. 04:26:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:26:48 INFO - Using the following test package requirements: 04:26:48 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:26:48 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:26:48 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:26:48 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'jsshell-mac.zip'], 04:26:48 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:26:48 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:26:48 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:26:48 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:26:48 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:26:48 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:48 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:26:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:26:50 INFO - Expected file size: 16284331 04:26:50 INFO - Obtained file size: 16284331 04:26:56 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 04:26:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:26:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:26:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:26:57 INFO - Expected file size: 16284331 04:26:57 INFO - Obtained file size: 16284331 04:27:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:27:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:27:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:27:05 INFO - Expected file size: 14409734 04:27:05 INFO - Obtained file size: 14409734 04:27:05 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')]} 04:27:05 INFO - trying https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:27:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 04:27:08 INFO - Downloaded 107692468 bytes. 04:27:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:08 INFO - mkdir: /builds/slave/test/properties 04:27:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:08 INFO - Contents: 04:27:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:27:09 INFO - Running post-action listener: _resource_record_post_action 04:27:09 INFO - Running post-action listener: set_extra_try_arguments 04:27:09 INFO - [mozharness: 2016-12-07 12:27:09.367847Z] Finished download-and-extract step (success) 04:27:09 INFO - [mozharness: 2016-12-07 12:27:09.368004Z] Running populate-webroot step. 04:27:09 INFO - Running pre-action listener: _resource_record_pre_action 04:27:09 INFO - Running main action method: populate_webroot 04:27:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:09 INFO - '--tppagecycles', 04:27:09 INFO - '7'], 04:27:09 INFO - 'tests': ['tsvgm']}}, 04:27:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['damp', 'tps']}, 04:27:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'tests': ['damp', 'tps']}, 04:27:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['dromaeo_dom']}, 04:27:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['basic_compositor_video']}, 04:27:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['a11yr', 04:27:09 INFO - 'ts_paint', 04:27:09 INFO - 'tpaint', 04:27:09 INFO - 'sessionrestore', 04:27:09 INFO - 'sessionrestore_no_auto_restore', 04:27:09 INFO - 'tabpaint']}, 04:27:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['tsvgx', 04:27:09 INFO - 'tsvgr_opacity', 04:27:09 INFO - 'tart', 04:27:09 INFO - 'tscrollx', 04:27:09 INFO - 'cart', 04:27:09 INFO - 'tsvg_static']}, 04:27:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:09 INFO - 'tsvgr_opacity', 04:27:09 INFO - 'tart', 04:27:09 INFO - 'tscrollx', 04:27:09 INFO - 'cart', 04:27:09 INFO - 'tsvg_static']}, 04:27:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'talos_options': ['--disable-e10s'], 04:27:09 INFO - 'tests': ['tp5o']}, 04:27:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:27:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'talos_options': ['--disable-e10s', 04:27:09 INFO - '--xperf_path', 04:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:09 INFO - 'tests': ['tp5n']}, 04:27:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:27:09 INFO - 'talos_options': ['--xperf_path', 04:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:09 INFO - 'tests': ['tp5n']}}, 04:27:09 INFO - 'talos.zip': {'path': '', 04:27:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:09 INFO - Running post-action listener: _resource_record_post_action 04:27:09 INFO - [mozharness: 2016-12-07 12:27:09.386497Z] Finished populate-webroot step (success) 04:27:09 INFO - [mozharness: 2016-12-07 12:27:09.386609Z] Running create-virtualenv step. 04:27:09 INFO - Running pre-action listener: _resource_record_pre_action 04:27:09 INFO - Running main action method: create_virtualenv 04:27:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:27:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:09 INFO - Using real prefix '/tools/python27' 04:27:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:13 INFO - Installing pip.................done. 04:27:13 INFO - Return code: 0 04:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:27:13 INFO - Reading from file tmpfile_stdout 04:27:13 INFO - Output received: 04:27:13 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) 04:27:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:13 INFO - 'HOME': '/Users/cltbld', 04:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:13 INFO - 'LOGNAME': 'cltbld', 04:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:13 INFO - 'MOZ_NO_REMOTE': '1', 04:27:13 INFO - 'NO_EM_RESTART': '1', 04:27:13 INFO - 'PAGER': '/bin/cat', 04:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:13 INFO - 'PWD': '/builds/slave/test', 04:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:13 INFO - 'SHELL': '/bin/bash', 04:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:13 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:13 INFO - 'USER': 'cltbld', 04:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:13 INFO - 'XPC_FLAGS': '0x0', 04:27:13 INFO - 'XPC_SERVICE_NAME': '0', 04:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:27:13 INFO - Cleaning up... 04:27:13 INFO - Return code: 0 04:27:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:13 INFO - 'HOME': '/Users/cltbld', 04:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:13 INFO - 'LOGNAME': 'cltbld', 04:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:13 INFO - 'MOZ_NO_REMOTE': '1', 04:27:13 INFO - 'NO_EM_RESTART': '1', 04:27:13 INFO - 'PAGER': '/bin/cat', 04:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:13 INFO - 'PWD': '/builds/slave/test', 04:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:13 INFO - 'SHELL': '/bin/bash', 04:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:13 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:13 INFO - 'USER': 'cltbld', 04:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:13 INFO - 'XPC_FLAGS': '0x0', 04:27:13 INFO - 'XPC_SERVICE_NAME': '0', 04:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:13 INFO - Downloading/unpacking psutil>=3.1.1 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:17 INFO - Installing collected packages: psutil 04:27:17 INFO - Running setup.py install for psutil 04:27:17 INFO - building 'psutil._psutil_osx' extension 04:27:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:27:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:27:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:27:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:27:17 INFO - building 'psutil._psutil_posix' extension 04:27:17 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 04:27:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:27:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:27:17 INFO - ^ 04:27:17 INFO - 1 warning generated. 04:27:17 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 04:27:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:18 INFO - Successfully installed psutil 04:27:18 INFO - Cleaning up... 04:27:18 INFO - Return code: 0 04:27:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:18 INFO - 'HOME': '/Users/cltbld', 04:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:18 INFO - 'LOGNAME': 'cltbld', 04:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:18 INFO - 'MOZ_NO_REMOTE': '1', 04:27:18 INFO - 'NO_EM_RESTART': '1', 04:27:18 INFO - 'PAGER': '/bin/cat', 04:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:18 INFO - 'PWD': '/builds/slave/test', 04:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:18 INFO - 'SHELL': '/bin/bash', 04:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:18 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:18 INFO - 'USER': 'cltbld', 04:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:18 INFO - 'XPC_FLAGS': '0x0', 04:27:18 INFO - 'XPC_SERVICE_NAME': '0', 04:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:21 INFO - Installing collected packages: mozsystemmonitor 04:27:21 INFO - Running setup.py install for mozsystemmonitor 04:27:21 INFO - Successfully installed mozsystemmonitor 04:27:21 INFO - Cleaning up... 04:27:21 INFO - Return code: 0 04:27:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:21 INFO - 'HOME': '/Users/cltbld', 04:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:21 INFO - 'LOGNAME': 'cltbld', 04:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:21 INFO - 'MOZ_NO_REMOTE': '1', 04:27:21 INFO - 'NO_EM_RESTART': '1', 04:27:21 INFO - 'PAGER': '/bin/cat', 04:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:21 INFO - 'PWD': '/builds/slave/test', 04:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:21 INFO - 'SHELL': '/bin/bash', 04:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:21 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:21 INFO - 'USER': 'cltbld', 04:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:21 INFO - 'XPC_FLAGS': '0x0', 04:27:21 INFO - 'XPC_SERVICE_NAME': '0', 04:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:21 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 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 04:27:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:24 INFO - warning: no files found matching '*.txt' 04:27:24 INFO - no previously-included directories found matching 'build' 04:27:24 INFO - no previously-included directories found matching 'dist' 04:27:24 INFO - no previously-included directories found matching '.git*' 04:27:24 INFO - Installing collected packages: jsonschema, functools32 04:27:24 INFO - Running setup.py install for functools32 04:27:24 INFO - warning: no files found matching '*.txt' 04:27:24 INFO - no previously-included directories found matching 'build' 04:27:24 INFO - no previously-included directories found matching 'dist' 04:27:24 INFO - no previously-included directories found matching '.git*' 04:27:24 INFO - Successfully installed jsonschema functools32 04:27:24 INFO - Cleaning up... 04:27:24 INFO - Return code: 0 04:27:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:25 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:25 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 04:27:25 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 04:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:25 INFO - 'HOME': '/Users/cltbld', 04:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:25 INFO - 'LOGNAME': 'cltbld', 04:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:25 INFO - 'MOZ_NO_REMOTE': '1', 04:27:25 INFO - 'NO_EM_RESTART': '1', 04:27:25 INFO - 'PAGER': '/bin/cat', 04:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:25 INFO - 'PWD': '/builds/slave/test', 04:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:25 INFO - 'SHELL': '/bin/bash', 04:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:25 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:25 INFO - 'USER': 'cltbld', 04:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:25 INFO - 'XPC_FLAGS': '0x0', 04:27:25 INFO - 'XPC_SERVICE_NAME': '0', 04:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:25 INFO - Cleaning up... 04:27:25 INFO - Return code: 0 04:27:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:25 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')]} 04:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:25 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')]} 04:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:26 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:26 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 04:27:26 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 04:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:26 INFO - 'HOME': '/Users/cltbld', 04:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:26 INFO - 'LOGNAME': 'cltbld', 04:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:26 INFO - 'MOZ_NO_REMOTE': '1', 04:27:26 INFO - 'NO_EM_RESTART': '1', 04:27:26 INFO - 'PAGER': '/bin/cat', 04:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:26 INFO - 'PWD': '/builds/slave/test', 04:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:26 INFO - 'SHELL': '/bin/bash', 04:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:26 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:26 INFO - 'USER': 'cltbld', 04:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:26 INFO - 'XPC_FLAGS': '0x0', 04:27:26 INFO - 'XPC_SERVICE_NAME': '0', 04:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:26 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 04:27:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:29 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 04:27:30 INFO - Downloading docopt-0.6.1.tar.gz 04:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:30 INFO - Running setup.py install for blobuploader 04:27:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:30 INFO - Running setup.py install for requests 04:27:30 INFO - Running setup.py install for docopt 04:27:31 INFO - Successfully installed blobuploader requests docopt 04:27:31 INFO - Cleaning up... 04:27:31 INFO - Return code: 0 04:27:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:31 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')]} 04:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:31 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')]} 04:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:31 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:31 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 04:27:31 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 04:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:31 INFO - 'HOME': '/Users/cltbld', 04:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:31 INFO - 'LOGNAME': 'cltbld', 04:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:31 INFO - 'MOZ_NO_REMOTE': '1', 04:27:31 INFO - 'NO_EM_RESTART': '1', 04:27:31 INFO - 'PAGER': '/bin/cat', 04:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:31 INFO - 'PWD': '/builds/slave/test', 04:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:31 INFO - 'SHELL': '/bin/bash', 04:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:31 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:31 INFO - 'USER': 'cltbld', 04:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:31 INFO - 'XPC_FLAGS': '0x0', 04:27:31 INFO - 'XPC_SERVICE_NAME': '0', 04:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-MTAWx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-5j6UJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Davk6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-VCjNIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-hbng6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:31 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-rgUykF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-yrgNUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-H97_qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-lGXnEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-L6Yhf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-A5GjdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-DCK3Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-s4yZAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-OSx522-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:32 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-JLqU5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:33 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-lOQWpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:33 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-UskefG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:33 INFO - Running setup.py install for manifestparser 04:27:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:33 INFO - Running setup.py install for mozcrash 04:27:33 INFO - Running setup.py install for mozdebug 04:27:33 INFO - Running setup.py install for mozdevice 04:27:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:33 INFO - Running setup.py install for mozfile 04:27:33 INFO - Running setup.py install for mozhttpd 04:27:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Running setup.py install for mozinfo 04:27:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Running setup.py install for mozInstall 04:27:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Running setup.py install for mozleak 04:27:34 INFO - Running setup.py install for mozlog 04:27:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Running setup.py install for moznetwork 04:27:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:34 INFO - Running setup.py install for mozprocess 04:27:35 INFO - Running setup.py install for mozprofile 04:27:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:35 INFO - Running setup.py install for mozrunner 04:27:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:35 INFO - Running setup.py install for mozscreenshot 04:27:35 INFO - Running setup.py install for moztest 04:27:35 INFO - Running setup.py install for mozversion 04:27:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:35 INFO - Cleaning up... 04:27:35 INFO - Return code: 0 04:27:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:35 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')]} 04:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 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')]} 04:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:35 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:35 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 04:27:35 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 04:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:35 INFO - 'HOME': '/Users/cltbld', 04:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:35 INFO - 'LOGNAME': 'cltbld', 04:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:35 INFO - 'MOZ_NO_REMOTE': '1', 04:27:35 INFO - 'NO_EM_RESTART': '1', 04:27:35 INFO - 'PAGER': '/bin/cat', 04:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:35 INFO - 'PWD': '/builds/slave/test', 04:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:35 INFO - 'SHELL': '/bin/bash', 04:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:35 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:35 INFO - 'USER': 'cltbld', 04:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:35 INFO - 'XPC_FLAGS': '0x0', 04:27:35 INFO - 'XPC_SERVICE_NAME': '0', 04:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-bEv77S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-1zgQp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-in4AVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-cY2qJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-SHjVZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Lssypw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-sgLuuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-AkLfNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:36 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)) 04:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:36 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-z0kfEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-UbYR8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-qZMiSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-p063Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-sASbV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-bpCdx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-UIEWHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:37 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)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-wek0n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:37 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-qcjzM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:37 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)) 04:27:37 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)) 04:27:37 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)) 04:27:37 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)) 04:27:37 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)) 04:27:37 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)) 04:27:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:40 INFO - Downloading blessings-1.6.tar.gz 04:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:40 INFO - Installing collected packages: blessings 04:27:40 INFO - Running setup.py install for blessings 04:27:40 INFO - Successfully installed blessings 04:27:40 INFO - Cleaning up... 04:27:40 INFO - Return code: 0 04:27:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:41 INFO - Reading from file tmpfile_stdout 04:27:41 INFO - Current package versions: 04:27:41 INFO - blessings == 1.6 04:27:41 INFO - blobuploader == 1.2.4 04:27:41 INFO - docopt == 0.6.1 04:27:41 INFO - functools32 == 3.2.3-2 04:27:41 INFO - jsonschema == 2.5.1 04:27:41 INFO - manifestparser == 1.1 04:27:41 INFO - mozInstall == 1.12 04:27:41 INFO - mozcrash == 1.0 04:27:41 INFO - mozdebug == 0.1 04:27:41 INFO - mozdevice == 0.49 04:27:41 INFO - mozfile == 1.2 04:27:41 INFO - mozhttpd == 0.7 04:27:41 INFO - mozinfo == 0.9 04:27:41 INFO - mozleak == 0.1 04:27:41 INFO - mozlog == 3.4 04:27:41 INFO - moznetwork == 0.27 04:27:41 INFO - mozprocess == 0.23 04:27:41 INFO - mozprofile == 0.28 04:27:41 INFO - mozrunner == 6.13 04:27:41 INFO - mozscreenshot == 0.1 04:27:41 INFO - mozsystemmonitor == 0.3 04:27:41 INFO - moztest == 0.7 04:27:41 INFO - mozversion == 1.4 04:27:41 INFO - psutil == 3.1.1 04:27:41 INFO - requests == 1.2.3 04:27:41 INFO - wsgiref == 0.1.2 04:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:41 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:41 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 04:27:41 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 04:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:41 INFO - 'HOME': '/Users/cltbld', 04:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:41 INFO - 'LOGNAME': 'cltbld', 04:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:41 INFO - 'MOZ_NO_REMOTE': '1', 04:27:41 INFO - 'NO_EM_RESTART': '1', 04:27:41 INFO - 'PAGER': '/bin/cat', 04:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:41 INFO - 'PWD': '/builds/slave/test', 04:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:41 INFO - 'SHELL': '/bin/bash', 04:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:41 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:41 INFO - 'USER': 'cltbld', 04:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:41 INFO - 'XPC_FLAGS': '0x0', 04:27:41 INFO - 'XPC_SERVICE_NAME': '0', 04:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 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)) 04:27:41 INFO - Cleaning up... 04:27:41 INFO - Return code: 0 04:27:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:41 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 0x1075b33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107529570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd22594ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, '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.WHr3EHBNmm/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.04J08c4Xb5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 04:27:41 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 04:27:41 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 04:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:41 INFO - 'HOME': '/Users/cltbld', 04:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:41 INFO - 'LOGNAME': 'cltbld', 04:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:41 INFO - 'MOZ_NO_REMOTE': '1', 04:27:41 INFO - 'NO_EM_RESTART': '1', 04:27:41 INFO - 'PAGER': '/bin/cat', 04:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:41 INFO - 'PWD': '/builds/slave/test', 04:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:41 INFO - 'SHELL': '/bin/bash', 04:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:27:41 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:41 INFO - 'USER': 'cltbld', 04:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:41 INFO - 'XPC_FLAGS': '0x0', 04:27:41 INFO - 'XPC_SERVICE_NAME': '0', 04:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:41 INFO - Cleaning up... 04:27:41 INFO - Return code: 0 04:27:41 INFO - Running post-action listener: _resource_record_post_action 04:27:41 INFO - Running post-action listener: _start_resource_monitoring 04:27:41 INFO - Starting resource monitoring. 04:27:41 INFO - [mozharness: 2016-12-07 12:27:41.681307Z] Finished create-virtualenv step (success) 04:27:41 INFO - [mozharness: 2016-12-07 12:27:41.682287Z] Running install step. 04:27:41 INFO - Running pre-action listener: _resource_record_pre_action 04:27:41 INFO - Running main action method: install 04:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:41 INFO - Reading from file tmpfile_stdout 04:27:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:42 INFO - Reading from file tmpfile_stdout 04:27:42 INFO - Output received: 04:27:42 INFO - Usage: mozinstall [options] installer 04:27:42 INFO - Options: 04:27:42 INFO - -h, --help show this help message and exit 04:27:42 INFO - -d DEST, --destination=DEST 04:27:42 INFO - Directory to install application into. [default: 04:27:42 INFO - "/builds/slave/test"] 04:27:42 INFO - --app=APP Application being installed. [default: firefox] 04:27:42 INFO - mkdir: /builds/slave/test/build/application 04:27:42 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'] 04:27:42 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 04:28:15 INFO - Reading from file tmpfile_stdout 04:28:15 INFO - Output received: 04:28:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:28:15 INFO - Running post-action listener: _resource_record_post_action 04:28:15 INFO - [mozharness: 2016-12-07 12:28:15.019814Z] Finished install step (success) 04:28:15 INFO - [mozharness: 2016-12-07 12:28:15.019933Z] Running run-tests step. 04:28:15 INFO - Running pre-action listener: _resource_record_pre_action 04:28:15 INFO - Running main action method: run_tests 04:28:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:15 INFO - 2016-12-07 04:28:15.034 screenresolution[1895:10462] starting screenresolution argv=screenresolution get 04:28:15 INFO - 2016-12-07 04:28:15.037 screenresolution[1895:10462] Display 0: 1600x1200x32@60 04:28:15 INFO - 2016-12-07 04:28:15.043 screenresolution[1896:10464] starting screenresolution argv=screenresolution list 04:28:15 INFO - Available Modes on Display 0 04:28:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:15 INFO - Intel Iris: 04:28:15 INFO - Chipset Model: Intel Iris 04:28:15 INFO - Type: GPU 04:28:15 INFO - Bus: Built-In 04:28:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:15 INFO - Vendor: Intel (0x8086) 04:28:15 INFO - Device ID: 0x0a2e 04:28:15 INFO - Revision ID: 0x0009 04:28:15 INFO - Displays: 04:28:15 INFO - Display: 04:28:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:15 INFO - Display Serial Number: 1600x1200 60 04:28:15 INFO - Main Display: Yes 04:28:15 INFO - Mirror: Off 04:28:15 INFO - Online: Yes 04:28:15 INFO - Rotation: Supported 04:28:15 INFO - Return code: 0 04:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:15 INFO - Python 2.7.3 04:28:15 INFO - Return code: 0 04:28:15 INFO - grabbing minidump binary from tooltool 04:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c8d30>, '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 0x10722fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:28:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:28:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:28:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:15 INFO - Return code: 0 04:28:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:15 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 04:28:15 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0255 --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 04:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WHr3EHBNmm/Render', 04:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:15 INFO - 'HOME': '/Users/cltbld', 04:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:15 INFO - 'LOGNAME': 'cltbld', 04:28:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:15 INFO - 'MOZ_NO_REMOTE': '1', 04:28:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:15 INFO - 'NO_EM_RESTART': '1', 04:28:15 INFO - 'PAGER': '/bin/cat', 04:28:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:15 INFO - 'PWD': '/builds/slave/test', 04:28:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:15 INFO - 'SHELL': '/bin/bash', 04:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04J08c4Xb5/Listeners', 04:28:15 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 04:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:15 INFO - 'USER': 'cltbld', 04:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:15 INFO - 'XPC_FLAGS': '0x0', 04:28:15 INFO - 'XPC_SERVICE_NAME': '0', 04:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:15 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 04:28:15 INFO - mozversion application_buildid: 20161207020338 04:28:15 INFO - mozversion application_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 04:28:15 INFO - mozversion application_display_name: Nightly 04:28:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:15 INFO - mozversion application_name: Firefox 04:28:15 INFO - mozversion application_remotingname: firefox 04:28:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 04:28:15 INFO - mozversion application_vendor: Mozilla 04:28:15 INFO - mozversion application_version: 53.0a1 04:28:15 INFO - mozversion platform_buildid: 20161207020338 04:28:15 INFO - mozversion platform_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 04:28:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 04:28:15 INFO - mozversion platform_version: 53.0a1 04:28:15 INFO - using testdate: 1481113695 04:28:15 INFO - actual date: 1481113695 04:28:15 INFO - starting webserver on 'localhost:49368' 04:28:15 INFO - SUITE-START | Running 2 tests 04:28:15 INFO - TEST-START | dromaeo_css 04:28:15 INFO - operating with platform_type : mac_ 04:28:15 INFO - Initialising browser for dromaeo_css test... 04:28:15 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpvL5Qvt/profile http://localhost:49368/getInfo.html) 04:28:18 INFO - PROCESS | 1906 | __metrics Screen width/height:1600/1200 04:28:18 INFO - PROCESS | 1906 | colorDepth:24 04:28:18 INFO - PROCESS | 1906 | Browser inner width/height: 1024/689 04:28:18 INFO - PROCESS | 1906 | __metrics 04:28:18 INFO - PROCESS | 1906 | 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" 04:28:18 INFO - PROCESS | 1906 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:19 INFO - TEST-INFO | 1906: exit 0 04:28:19 INFO - Browser initialized. 04:28:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:19 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpvL5Qvt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:32 INFO - PROCESS | 1908 | RSS: Main: 244342784 04:28:32 INFO - PROCESS | 1908 | 04:29:22 INFO - PROCESS | 1908 | 1481113762855 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:31:35 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49368/tests/dromaeo/cssquery-ext.html) 04:31:37 INFO - PROCESS | 1908 | RSS: Main: 382861312 04:31:37 INFO - PROCESS | 1908 | 04:34:40 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-ext.html (next: http://localhost:49368/tests/dromaeo/cssquery-jquery.html) 04:34:41 INFO - PROCESS | 1908 | RSS: Main: 383631360 04:34:41 INFO - PROCESS | 1908 | 04:37:43 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49368/tests/dromaeo/cssquery-mootools.html) 04:37:44 INFO - PROCESS | 1908 | RSS: Main: 339968000 04:37:44 INFO - PROCESS | 1908 | 04:40:46 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49368/tests/dromaeo/cssquery-prototype.html) 04:40:47 INFO - PROCESS | 1908 | RSS: Main: 339128320 04:40:47 INFO - PROCESS | 1908 | 04:43:50 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49368/tests/dromaeo/cssquery-yui.html) 04:43:51 INFO - PROCESS | 1908 | RSS: Main: 332365824 04:43:51 INFO - PROCESS | 1908 | 04:46:54 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-yui.html (next: http://localhost:49368/tests/dromaeo/cssquery-dojo.html) 04:46:55 INFO - PROCESS | 1908 | RSS: Main: 383488000 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | __start_tp_report 04:46:55 INFO - PROCESS | 1908 | _x_x_mozilla_page_load 04:46:55 INFO - PROCESS | 1908 | _x_x_mozilla_page_load_details 04:46:55 INFO - PROCESS | 1908 | |i|pagename|runs| 04:46:55 INFO - PROCESS | 1908 | |0;dojo.html;2740.890364385424;3213.66256543063;3216.935661286775;3242.627097883741;3268.0032590060023;5316.175992721125;5330.89338213236;5347.385050719168;5399;5424.701641409721;5279.41926388098;5329.493698098684;5346.599005074616;5375;5424.484673955978;4919.360483137187;4921.950780492194;4942.3327850740225;4944.7774850131655;5034.798608055692;4932;4986.675866068712;5032.622553308498;5068.493150684939;5069.569086627641;5030.748462576875;5065.797368105272;5072.010957863218;5085.949140508603;5107.080725469414;4916.508349165055;4951.306817045616;4955.1080805455;4987.625928055374;5025.648204625678;4987.875303117415;5007.69953802773;5013.172826483626;5027.396712394499;5047.7476126193915;5409.350877894639;5420.91868621971;5421.241026256327;5457.263269458612;5461.918071228934;5706.087026075808;5779.711014449261;5870.412958704095;5888.676122813244;5897.705114744289;5913.2608423947;5913.46778789911;5922.200502932092;5922.3781502942;5932.644041357489;5495.2856128703415;5499.50504454601;5506.449355064502;5511.834644960658;5533.889322213533;5998.070299103646;6046.576739628272;6120.959436895739;6126.23422072241;6186.505079593621;5768.682722450306;5788.0449725795615;5790.88418231633;5800.274965629296;5818.5345172386105;5952.7321270542925;5978.402159784074;5982.162497250389;5992.370801065913;5993.250843644544;5126.897462050738;5649.830505084854;5701.572382071361;5738.96698594257;5773;5887.175795388649;5891.998360278762;5907.054871220584;5930.169776231331;5947.345791962881;4753.595944344769;4759.690620109682;4762.333273341735;4776.928346074812;4806.2310030394965;4236.512801027921;4258.936115958263;4262.808173632194;4282.443282373334;4307.655387568987;5466.480684334982;5476.069068258405;5536.529395001389;5574.16387541872;5582.637128586629;5961.374055724174;5979.043353063489;5985.431384018511;6006.819795406145;6021.2774467063355;5474.014677358114;5491.341039075257;5520.751566179531;5521;5526.032944234743;5072.416672082758;5133.922991155136;5135.897282054338;5139.563137133311;5190.325257716473;6010.068439391901;6065.636061836304;6085.66528840918;6117.3402608778015;6117.401149625572;5926.7925622603;5941.970290148522;5982.52139828804;5988.431099045583;6011.759529618941;5923;6059.6364218147055;6071.453569178795;6092.055731361646;6108.205933228652;5728.140778883201;5787.56593255516;5801.477866991991;5817.243758311562;5893.970530147321;5778.971105144447;5832.3292821326095;5849.5612829037145;5915.556333274935;5946.940530594638;5652.4064973178865;5727.055035919193;5730.71346432685;5741.45456181662;5795.94204057954;5602.243697101002;5655.519280861173;5672.347680016851;5680.630759000652;5685.744141513725;5594.888102238014;5637.379888212211;5651.15232715096;5661.2923384576925;5691.77232910679;4876.487968763229;5680.318361796611;5689.459501347365;5695.1457281406465;5713.457221563945;5380.139177731544;5458.808941687022;5611.579131565068;5614.326280846161;5655.660660360227 04:46:55 INFO - PROCESS | 1908 | |1;ext.html;461.9745913974731;501.70148761486905;514.5883293365307;514.7374838832194;528.7646997086298;29878.551821722664;30241;35529.46705799415;38924.22151556967;40172.59827401725;40887.38668919969;41092.79453602735;41186.58813411865;41251.58748412515;41275.58724412755;9211.631534738619;9384.953075234615;9393.85909211359;9395.483248421335;9395.530223488833;8504.489730616151;8722.651093956265;10382.169426445904;11230.213885028052;11262.662120136369;11186;11220.270682405659;11247.718807029849;11248.38133902635;11253;8398.202170793826;11141.944290278538;11196.992270695595;11204.271722338104;11237.325760454358;8391.035030971456;8534.530600816952;8543.957280213559;8547.401681882271;10991.780164396747;37814.621853781384;39564.80217598894;39612.40581391282;39614.801925990476;39647.40528892069;3305.5702758641464;3410;3532.2405682778067;3616.6021737608844;3714.9442758358646;29226.41547169045;29510.70489295101;29613.763904699164;30157.698423015707;30270.84864575685;3099.8613037447944;3132.561441398206;3262.070309961673;3313.287643156709;3316.2538428853554;425717;448030;450061;450265.7486712578;450822;56160.43839561634;56206.71896640491;56305.1847407628;56550.151747723816;56800;57092.429075709544;57161.42838571561;57247.14129288064;59080.704596477604;59163.70418147882;13541.66145846342;13909.930450347683;13962.58112256634;13993.440262389595;14096.50662226817;9738.172255358373;10114.342567733074;10685.412302323291;10861.07680847121;10941.781164376667;12952.80570791439;13945.16329020262;15433;15569.221538923008;15790.9210453947;6104.633721976696;6111.54163437744;6141.907871381933;6179.443850053517;6181.289151747516;830.5556527257888;926.5089502563652;955.7658373698349;990.6285143071349;1021.3922715983978;25555;25635.846386912635;28635.427291454052;28884.844606215935;29788.553171702442;958.166395236149;993.2550587059706;1019.9235057370727;1020.2908978260039;1115.3753897817248;12871.613851584467;15074.170920599472;15352.53942381708;15396.923015385075;15632;176575.11712441355;177606;179131.20868791407;179320;179531;55969.720151398986;56077;56135.59661008507;56149.438505614424;56186.719066405225;1202.8616709078567;1245.7446223524155;1305.9804102938274;1331.2012792324529;1354.9051566390258;28826.27934301659;29284.56073158947;30089;30274.09177724672;30880.073597792103;47231.76384118195;52674.736626316626;54232;57366.85266294734;57652;564830;570787;570916;571169;571620;24722;24835.503289934462;25137.87431062833;25234.74765252324;25491.617625736;44361.77819110884;44921.55078449305;45004.549954500035;45499.77250113861;45520.54479455163;32580.02259932111;34416.82791586026;36818.447723284706;37239.25521489609;38198.61801382062;36852.262954741294;36954.63045369512;36972.63896734905;37831.62168378391;38126.618733812305;36504;36983.63016369802;37048.81475592605;37183.07042323964;37268.440973385965;30810;32805.83597081999;32994.505082423304;33170.33659326848;33253.83373083119;23354.416139596648;23640.88179559091;24316.145729644202;24358.634620480352;24599.33279878037 04:46:55 INFO - PROCESS | 1908 | |2;jquery.html;288.4792948727546;339.69766907452373;343.29966867590133;348.78201124297306;361.4830791967485;14776.77834832477;15327.463538776145;18576.721349179756;19024.42926712201;19978.70031949522;19133.234670613158;19232.519187020298;19568.11943462544;19574;19609.31367402141;5248.134057880445;5740.483356497914;5744.597878148531;5785.16115163301;5797.043487824525;3933;5621.409751976045;5749.281339832521;5754.856128596777;5762.135679648065;4208.158368326332;4253.425787518692;6344.968275158641;6376.36236376361;6419.069234960928;6127.172831667713;6274.780382686584;6362.936370636281;6378.649174295412;6402.3917727816015;5436.646617969859;5438.782448702087;5446.564274858041;5448.673079615196;5449.155380915964;23959.153960450323;24095.79521023942;24146.637800433007;24148.034078636832;24458.021679132813;1677.8573821225089;2052.004777682823;2104.7684754676975;2274.385915802724;2400.3879010852297;8695.478271303742;9654.75863103428;9799.412035277906;9990.90009099907;9999.050090241415;1810.384469280451;1851.6019055902912;1876.2682553804027;1897.1747289928787;1900.752902122729;93724.06275937222;109946.90053099446;111818.44090779575;113853.29220061623;114869;10521.684349469528;10553.841692374466;10610.89389106099;11162.274452160584;11302.265352752045;14135.85864141366;14167.362468688934;14183.858161418253;14208.573742787732;14210.85789142116;6361.840953976095;6607.57050791697;7394.963025184839;7635.66375884218;7789.883151752728;6009.729562169713;7342.265773422615;7492.925070749223;7514.586697731677;7553.73561925341;4301.720388174758;4396.318570621559;4403.691741578123;4468.185043422623;4490.281554951192;1688.4090568301242;1822.475870918787;1879.718042293667;1883.4255552056754;1888.2635772048911;750.1111183247759;804.3364224514681;928.5032507608397;930.2883294279882;948.5826236455937;17246.965182089116;17612.823871761117;19495.512612184524;20344.287949921978;20453.693194602092;779.6647441600167;858.6908712863365;867.8090820019586;895.3687650206589;910.1762904571374;10202;10697.572097116185;10747.086497647788;10762.73093172677;10995.955384238485;522221;524650;524914;530420.347898258;531668;71296.19470350585;95240.0475995245;110739.44630276797;114084.42957785158;116801.41599292119;898.3172788680649;939.9389039712397;956.8325543029941;979.5004547680734;979.7109852593502;17909.552261193574;18192.81807181964;18331.35840245585;18405.263789448272;18688.626227475645;50897.236541451166;51175.74412127915;51295.74352128216;51622;51734;53978;73589.63205184155;73614.63192684003;74569.6271518639;75005.62497187479;7446.292602202782;7624.5425274483705;7878.290953814184;7880.847660935671;8180.509169449852;10236.232282578687;12077.57728479499;12245.02036838049;12439.502419903103;12492;9175.632974680939;10843.45782710877;10857.891421085687;10903.454827258764;10974;9484.762880928032;9570.425774453555;10892.945535272273;11335.773284534429;11383.886161138282;10707.089897358812;11009.174311926798;11486.425678716198;11611;11688.649340519798;7958.3235424989525;8012;8077.434579579373;8162.877556836771;8232.958835205785;9169.266458683423;11152.553897843994;11213.15901307389;11262.718432039264;11278.661640150809 04:46:55 INFO - PROCESS | 1908 | |3;mootools.html;1320.683036071343;1451.4629587052789;1591.7771511988324;1771.5748220427101;1810.9456716298507;7651;7985;7989.800254993628;7992.8001799954955;7994.120646728869;7220.675069621867;7454.105507339127;7461.850762984751;7512.361449276805;7843.7646870593835;1991.5718120604104;2024.9898750506227;2162.340486151723;2233.944151396212;2234.854734442264;2241.361212054565;2245.8989345479495;2249.5490408686387;2250.1112060736;2250.9324720258337;2184.8252139828855;2209.933701988935;2215.977840221601;2225.3324002799177;2228.1198926424054;1995.3215906591684;2047.5667033076757;2162.5350549631826;2188.026328283914;2195.484061245614;2209.4697272654607;2217.8336624753047;2218.6561083032157;2221.4224301681515;2224.377174391173;7871.21287871214;7891.092524359658;7963.761087167394;8015.559144247064;8021.318187954031;4722.5513576210205;4822.7829747661435;4891.608671306322;4905.117078925792;4905.4358748744;3145.685431456859;3168.318811455525;3230.0794273632137;3368.59576850777;3370.5281260623533;850.6724910909282;953.7091187187905;971.5530855806337;987.1214618989105;991.7917237380159;10402.271840971134;10403.427811470367;10411.427371494565;10423.530941107745;10456.111230545413;3880.932743495505;4303.397524346594;4454.10917816438;4502.774861256924;4502.954970450319;8135.227153420416;8191.631376588068;8197.221263979913;8227.13615070421;8283.37874659403;4873.488283730228;4877.512248775094;4880.243562247857;4881.926771098437;4885.7312847793;4357.629601483846;4512.4133862597655;4590.150822097922;4597.977010114995;4599.310103484504;3193.409219294438;3287.178205448638;3288.5067239914206;3311.403947289463;3395.6434574369337;1050.56926660069;1075.0539525217757;1087.6465148826662;1088.3306766338644;1090.803655342046;729.2233771033832;760.7261385901071;771.3289438188699;836.5817091454273;867.483847110968;4033.3748269018347;5015.824446144367;5188.351456067991;5225.921611175835;5292.153255479182;739.6117038554694;825.3892119831281;857.9832898015871;869.3697069624598;929.5863340813273;3453.5165076889257;3597.2086141048926;3637.5453068366455;3648.5986541480415;3872.903177420587;7870.6851725931465;9321.254299656011;9460.668876589287;9480.762980925532;9489.525523723787;9419;9431.717048488556;9434.90565094354;9438.197753191056;9460.716178514656;6932.168139823153;7219.855602887913;7447.515911465737;7458.70165193397;7486.962565187139;4628.166929952641;5088.338515992898;5360.839174824761;5393.487618676219;5588.329400471806;8542.487450752975;8733.65065397377;8763.518006509703;8979.416337938013;9006.009338972839;8932.151445612657;9056.27549796028;9115.27077833785;9130.771730706785;9206.263498920205;6845.178578570603;6904.516683832084;6906.447484201352;6945.965270173617;6961.75633852833;6051.515878729603;6808;7344.706211751683;7417.8887316689215;7471.215522370073;6455.128557644658;6511.251206111168;6788.694508747217;6823.624700641512;6891.586504809728;5673.836863443067;6307.148534947723;6717.16035495563;6734.158230221223;6743.662816859235;6403.103565500741;6411.839704007437;6420.06908998202;6442.291347951816;6524.184476940382;4549.3176023596725;4556.157110934488;4590.74750888691;4621.214393553171;4733.384659994179;3925.4700615417696;4445.955540444555;4642.605378542862;4673.415823022122;4748.92876606858 04:46:55 INFO - PROCESS | 1908 | |4;prototype.html;252.15276670387496;287.4222812147584;291.1861347533644;297.6324239564137;298.817721190074;4487.384541565042;5107.055194788966;5174.301469301643;5214.165733482643;5232.6075544334135;4295.140971805636;5145.459726728695;5173.456787037363;5180.715060671661;5241.344831896013;3178.2372230664705;3745.8648570314863;3828.9617103829023;3858.5176852893387;3956.1692044670654;3637.254362855608;3742.868999585015;3922.3920292354733;3950.6246906543834;3957.7427467214684;3910.882673519799;3922.7254092213557;3938.0154961259686;3941.6401341537126;3978.542467616218;3220.9194770130935;3501.824908754552;3638.6361363863666;3712.573054098786;3748.981255093707;3411.4712219606;3418.3163367326633;3434.7541573213325;3458.6195518492946;3463.1169051891857;4129.91740165198;5036.244563315496;5046.772895219724;5053.444121146671;5056;4254.383114448418;4479.888002799924;4504.1892459357305;4516.051629157881;4528.660350473728;5291.523762861322;5381.304888959965;5456.135528847347;5506.669599823983;5521.751521181556;3468.514407982884;3767.811609419518;3779.9244015119543;3787.110029143149;3808.21931504041;5000.649954503187;5280.867978300496;5778.7350147167135;5782.306123265193;5784.595078344518;3199.480246882759;3818.9618103818607;3820.8471661133244;3823.5794062653085;3849.8075096245634;3868.593797651206;3876.8449262029203;3890.8832735017995;3903.980480097581;3916.686665066788;3637.9818100909324;4499.752513611717;4505.07645932583;4513;4536.659750518725;4844.95155048452;5244.318238628954;5492.066348720727;5521;5548.361938377057;1113.04834366617;1229.6987238126717;1237.270010693695;1239.4732238798474;1248.1076030637955;790.4032455496178;824.6824972385675;830.7424698343533;837.7738010737189;843.477523070863;4740.885891815421;4979.6265280104135;5121.487851214849;5145.768440420115;5152.0586751135415;5022.924656130161;5383.5423988961375;5639.238702775155;5669.716514174357;5671.574631902624;4396.758178300224;4432.988145728121;5142.125838607446;5204.947950520522;5256.868578285574;2560.8463492190153;2724.5479068838204;2815.7747380209535;2824.390097644323;2825.6609206895305;4453.040662108662;5048.419431765321;5091.847244582668;5477.67133971963;5511.58663100269;4345.891352716144;4933.87665308363;5128;5328.92006619901;5863.5309175265875;4478.686491945533;5581.716205272729;5828.446297601721;5847;5870.941290587125;5021.548060674557;5732.856678582902;5743.368229494836;5802.6808525531505;5821.72952548498;5283.550898173545;5626.746796394254;5653.689047102284;5655.943440565542;5658.726786473011;4886.828960986349;5822.184894114743;5836.103266438339;5842.766289348378;5884.47039766423;3356.7482438816696;3508.421110516736;3567.23304489536;3706.2031663191465;3754.3805272129794;4890.877728056827;5218.8173413931845;5689.573282003784;5694.430556944272;5705.486506214461;4734.958309171977;5526.613137080527;5539.7230138492105;5546.473085056913;5564.221009058816;5161.251618515369;5503.972480137734;5512.751926163252;5516.393196748274;5545;4966.130927087673;5115.667481613683;5361.496343071838;5450.91823622638;5480.1231802912935;5219.660722053054;5399.352077750695;5420.945790542044;5424.647397919281;5586.486081263366;4631.606313463393;5449.128139497661;5461;5470.64440811346;5549.528290095387 04:46:55 INFO - PROCESS | 1908 | |5;yui.html;680.9795706128816;688.9448844092473;706.0715159565171;749.1048197404101;761.6648674583183;14905.105693658374;15852.524424267262;15852.52442426729;15871.127088010155;15897.920510397445;14194.432222711104;14361.28193590319;14363.49727759526;14373;14397.712045759079;661.5468404143153;673.5049738442241;796.1481215099817;804.7424824056304;823.2426167925493;818.1981657975188;823.3865770001357;824.5094168969483;829.9170082991712;830.4726498673325;871.7384784564637;872.7730789994583;873.3144481581959;873.8732883731855;874.7813046738315;668.3951024322947;867.1761826265074;869.4174902815129;869.7825543614097;871.01575220001;509.63815690859536;512.3186162403994;513.5095983335942;513.560905425863;609.5976655407454;13592.980526460457;13599.252041137734;14021.64945876351;14025.649358766112;14042.438302467888;13282.269475178862;13405.262710550916;13523.120997135155;13626.727465450735;13723.176609403468;12603.912588978988;12703;12780.61658150257;12822.42299096543;12980.15628984113;4317.805698743564;4410.081614497703;4527.683062185648;4553.134904368159;4629.51390104041;118439;121910.39044804809;124348.75651243553;125377.37311313476;125472;10311.089812707167;10577.894221057844;10631.46842657864;10753.78492430147;10850.403227822546;19485.512862178275;20358.694619580718;20379.184832606825;20441.182352705724;20901.895490522755;6921.757738479229;7592.620368981528;7629.19893411195;7670.693172273158;7834.804129896685;4227.196832601858;4287.185434767446;4292.59220374064;4301.268784306675;4332.458442694663;3184.092533627905;3276.1809547613097;3281.3765384576855;3288.4245257080393;3291.9341613167603;591.2668291318734;600.342624825815;602.0367412140628;613.923259592551;615.9137720719103;563.9967174794238;573.0716239691726;596.7762089216544;605.3946053946054;625.8591816841174;8338.207870252316;8653.394262401698;8721.345899057469;8863.656629908082;8975.192232698957;575.683374144219;590.2533295381346;590.3948452835878;608.0939400293619;634.7968650032038;4094.2630326541507;4267.359896015622;4321.5678432157165;4392.38506609075;4398.186335527874;109337;115143;115973;116883.97392312977;117219;103397;104161.47919260355;104339.478302608;104783;107131;91648;91840.62239066554;91915;93289.5335523318;93713;6687.565308254948;7371.299726525972;8051.993500812398;8336.374771892253;8356.498610083414;50774.74612626913;57718.7114064427;57911.84176316534;58052;58614.70692646509;82385;83035.339293215;84720;85340;85425.57287213524;11296;11307.886921131012;11327.490262938352;11762.294262344287;11767.941160294144;11955.521779128738;12005;12033.616134144686;12157.209781364183;12524.436400362189;11458.436638435489;11554.826677599674;11594.304341739522;11699.473523691284;11750;9344.299177561847;11285.887141128813;11652.242604230698;12934.223946563236;13195.076344655781;12978.480860765463;13174.143680660727;13184.143030702973;13210.339483026002;13214.867851321364;10129.797404052026;10817.51321190564;11081.11351091927;11305.321680699184;11644.6506604802;8489.533075680896;11090.390028548507;11275.04162146194;11446.542138314708;11464.25482343645 04:46:55 INFO - PROCESS | 1908 | __end_tp_report 04:46:55 INFO - PROCESS | 1908 | __start_cc_report 04:46:55 INFO - PROCESS | 1908 | _x_x_mozilla_cycle_collect,1491 04:46:55 INFO - PROCESS | 1908 | __end_cc_report 04:46:55 INFO - PROCESS | 1908 | __startTimestamp1481114815164__endTimestamp 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | ------- Summary: start ------- 04:46:55 INFO - PROCESS | 1908 | Number of tests: 6 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#0] dojo.html Cycles:165 Average:5455.53 Median:5614.33 stddev:599.90 (10.7%) stddev-sans-first:562.67 04:46:55 INFO - PROCESS | 1908 | Values: 2740.9 3213.7 3216.9 3242.6 3268.0 5316.2 5330.9 5347.4 5399.0 5424.7 5279.4 5329.5 5346.6 5375.0 5424.5 4919.4 4922.0 4942.3 4944.8 5034.8 4932.0 4986.7 5032.6 5068.5 5069.6 5030.7 5065.8 5072.0 5085.9 5107.1 4916.5 4951.3 4955.1 4987.6 5025.6 4987.9 5007.7 5013.2 5027.4 5047.7 5409.4 5420.9 5421.2 5457.3 5461.9 5706.1 5779.7 5870.4 5888.7 5897.7 5913.3 5913.5 5922.2 5922.4 5932.6 5495.3 5499.5 5506.4 5511.8 5533.9 5998.1 6046.6 6121.0 6126.2 6186.5 5768.7 5788.0 5790.9 5800.3 5818.5 5952.7 5978.4 5982.2 5992.4 5993.3 5126.9 5649.8 5701.6 5739.0 5773.0 5887.2 5892.0 5907.1 5930.2 5947.3 4753.6 4759.7 4762.3 4776.9 4806.2 4236.5 4258.9 4262.8 4282.4 4307.7 5466.5 5476.1 5536.5 5574.2 5582.6 5961.4 5979.0 5985.4 6006.8 6021.3 5474.0 5491.3 5520.8 5521.0 5526.0 5072.4 5133.9 5135.9 5139.6 5190.3 6010.1 6065.6 6085.7 6117.3 6117.4 5926.8 5942.0 5982.5 5988.4 6011.8 5923.0 6059.6 6071.5 6092.1 6108.2 5728.1 5787.6 5801.5 5817.2 5894.0 5779.0 5832.3 5849.6 5915.6 5946.9 5652.4 5727.1 5730.7 5741.5 5795.9 5602.2 5655.5 5672.3 5680.6 5685.7 5594.9 5637.4 5651.2 5661.3 5691.8 4876.5 5680.3 5689.5 5695.1 5713.5 5380.1 5458.8 5611.6 5614.3 5655.7 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#1] ext.html Cycles:180 Average:54947.06 Median:36661.22 stddev:115223.82 (314.3%) stddev-sans-first:115474.43 04:46:55 INFO - PROCESS | 1908 | Values: 462.0 501.7 514.6 514.7 528.8 29878.6 30241.0 35529.5 38924.2 40172.6 40887.4 41092.8 41186.6 41251.6 41275.6 9211.6 9385.0 9393.9 9395.5 9395.5 8504.5 8722.7 10382.2 11230.2 11262.7 11186.0 11220.3 11247.7 11248.4 11253.0 8398.2 11141.9 11197.0 11204.3 11237.3 8391.0 8534.5 8544.0 8547.4 10991.8 37814.6 39564.8 39612.4 39614.8 39647.4 3305.6 3410.0 3532.2 3616.6 3714.9 29226.4 29510.7 29613.8 30157.7 30270.8 3099.9 3132.6 3262.1 3313.3 3316.3 425717.0 448030.0 450061.0 450265.7 450822.0 56160.4 56206.7 56305.2 56550.2 56800.0 57092.4 57161.4 57247.1 59080.7 59163.7 13541.7 13909.9 13962.6 13993.4 14096.5 9738.2 10114.3 10685.4 10861.1 10941.8 12952.8 13945.2 15433.0 15569.2 15790.9 6104.6 6111.5 6141.9 6179.4 6181.3 830.6 926.5 955.8 990.6 1021.4 25555.0 25635.8 28635.4 28884.8 29788.6 958.2 993.3 1019.9 1020.3 1115.4 12871.6 15074.2 15352.5 15396.9 15632.0 176575.1 177606.0 179131.2 179320.0 179531.0 55969.7 56077.0 56135.6 56149.4 56186.7 1202.9 1245.7 1306.0 1331.2 1354.9 28826.3 29284.6 30089.0 30274.1 30880.1 47231.8 52674.7 54232.0 57366.9 57652.0 564830.0 570787.0 570916.0 571169.0 571620.0 24722.0 24835.5 25137.9 25234.7 25491.6 44361.8 44921.6 45004.5 45499.8 45520.5 32580.0 34416.8 36818.4 37239.3 38198.6 36852.3 36954.6 36972.6 37831.6 38126.6 36504.0 36983.6 37048.8 37183.1 37268.4 30810.0 32805.8 32994.5 33170.3 33253.8 23354.4 23640.9 24316.1 24358.6 24599.3 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#2] jquery.html Cycles:180 Average:31371.95 Median:4277.57 stddev:87764.47 (2051.7%) stddev-sans-first:87979.64 04:46:55 INFO - PROCESS | 1908 | Values: 288.5 339.7 343.3 348.8 361.5 14776.8 15327.5 18576.7 19024.4 19978.7 19133.2 19232.5 19568.1 19574.0 19609.3 5248.1 5740.5 5744.6 5785.2 5797.0 3933.0 5621.4 5749.3 5754.9 5762.1 4208.2 4253.4 6345.0 6376.4 6419.1 6127.2 6274.8 6362.9 6378.6 6402.4 5436.6 5438.8 5446.6 5448.7 5449.2 23959.2 24095.8 24146.6 24148.0 24458.0 1677.9 2052.0 2104.8 2274.4 2400.4 8695.5 9654.8 9799.4 9990.9 9999.1 1810.4 1851.6 1876.3 1897.2 1900.8 93724.1 109946.9 111818.4 113853.3 114869.0 10521.7 10553.8 10610.9 11162.3 11302.3 14135.9 14167.4 14183.9 14208.6 14210.9 6361.8 6607.6 7395.0 7635.7 7789.9 6009.7 7342.3 7492.9 7514.6 7553.7 4301.7 4396.3 4403.7 4468.2 4490.3 1688.4 1822.5 1879.7 1883.4 1888.3 750.1 804.3 928.5 930.3 948.6 17247.0 17612.8 19495.5 20344.3 20453.7 779.7 858.7 867.8 895.4 910.2 10202.0 10697.6 10747.1 10762.7 10996.0 522221.0 524650.0 524914.0 530420.3 531668.0 71296.2 95240.0 110739.4 114084.4 116801.4 898.3 939.9 956.8 979.5 979.7 17909.6 18192.8 18331.4 18405.3 18688.6 50897.2 51175.7 51295.7 51622.0 51734.0 53978.0 73589.6 73614.6 74569.6 75005.6 7446.3 7624.5 7878.3 7880.8 8180.5 10236.2 12077.6 12245.0 12439.5 12492.0 9175.6 10843.5 10857.9 10903.5 10974.0 9484.8 9570.4 10892.9 11335.8 11383.9 10707.1 11009.2 11486.4 11611.0 11688.6 7958.3 8012.0 8077.4 8162.9 8233.0 9169.3 11152.6 11213.2 11262.7 11278.7 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#3] mootools.html Cycles:180 Average:5096.97 Median:5259.04 stddev:2793.46 (53.1%) stddev-sans-first:2786.88 04:46:55 INFO - PROCESS | 1908 | Values: 1320.7 1451.5 1591.8 1771.6 1810.9 7651.0 7985.0 7989.8 7992.8 7994.1 7220.7 7454.1 7461.9 7512.4 7843.8 1991.6 2025.0 2162.3 2233.9 2234.9 2241.4 2245.9 2249.5 2250.1 2250.9 2184.8 2209.9 2216.0 2225.3 2228.1 1995.3 2047.6 2162.5 2188.0 2195.5 2209.5 2217.8 2218.7 2221.4 2224.4 7871.2 7891.1 7963.8 8015.6 8021.3 4722.6 4822.8 4891.6 4905.1 4905.4 3145.7 3168.3 3230.1 3368.6 3370.5 850.7 953.7 971.6 987.1 991.8 10402.3 10403.4 10411.4 10423.5 10456.1 3880.9 4303.4 4454.1 4502.8 4503.0 8135.2 8191.6 8197.2 8227.1 8283.4 4873.5 4877.5 4880.2 4881.9 4885.7 4357.6 4512.4 4590.2 4598.0 4599.3 3193.4 3287.2 3288.5 3311.4 3395.6 1050.6 1075.1 1087.6 1088.3 1090.8 729.2 760.7 771.3 836.6 867.5 4033.4 5015.8 5188.4 5225.9 5292.2 739.6 825.4 858.0 869.4 929.6 3453.5 3597.2 3637.5 3648.6 3872.9 7870.7 9321.3 9460.7 9480.8 9489.5 9419.0 9431.7 9434.9 9438.2 9460.7 6932.2 7219.9 7447.5 7458.7 7487.0 4628.2 5088.3 5360.8 5393.5 5588.3 8542.5 8733.7 8763.5 8979.4 9006.0 8932.2 9056.3 9115.3 9130.8 9206.3 6845.2 6904.5 6906.4 6946.0 6961.8 6051.5 6808.0 7344.7 7417.9 7471.2 6455.1 6511.3 6788.7 6823.6 6891.6 5673.8 6307.1 6717.2 6734.2 6743.7 6403.1 6411.8 6420.1 6442.3 6524.2 4549.3 4556.2 4590.7 4621.2 4733.4 3925.5 4446.0 4642.6 4673.4 4748.9 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#4] prototype.html Cycles:180 Average:4409.29 Median:5041.51 stddev:1378.84 (27.3%) stddev-sans-first:1346.94 04:46:55 INFO - PROCESS | 1908 | Values: 252.2 287.4 291.2 297.6 298.8 4487.4 5107.1 5174.3 5214.2 5232.6 4295.1 5145.5 5173.5 5180.7 5241.3 3178.2 3745.9 3829.0 3858.5 3956.2 3637.3 3742.9 3922.4 3950.6 3957.7 3910.9 3922.7 3938.0 3941.6 3978.5 3220.9 3501.8 3638.6 3712.6 3749.0 3411.5 3418.3 3434.8 3458.6 3463.1 4129.9 5036.2 5046.8 5053.4 5056.0 4254.4 4479.9 4504.2 4516.1 4528.7 5291.5 5381.3 5456.1 5506.7 5521.8 3468.5 3767.8 3779.9 3787.1 3808.2 5000.6 5280.9 5778.7 5782.3 5784.6 3199.5 3819.0 3820.8 3823.6 3849.8 3868.6 3876.8 3890.9 3904.0 3916.7 3638.0 4499.8 4505.1 4513.0 4536.7 4845.0 5244.3 5492.1 5521.0 5548.4 1113.0 1229.7 1237.3 1239.5 1248.1 790.4 824.7 830.7 837.8 843.5 4740.9 4979.6 5121.5 5145.8 5152.1 5022.9 5383.5 5639.2 5669.7 5671.6 4396.8 4433.0 5142.1 5204.9 5256.9 2560.8 2724.5 2815.8 2824.4 2825.7 4453.0 5048.4 5091.8 5477.7 5511.6 4345.9 4933.9 5128.0 5328.9 5863.5 4478.7 5581.7 5828.4 5847.0 5870.9 5021.5 5732.9 5743.4 5802.7 5821.7 5283.6 5626.7 5653.7 5655.9 5658.7 4886.8 5822.2 5836.1 5842.8 5884.5 3356.7 3508.4 3567.2 3706.2 3754.4 4890.9 5218.8 5689.6 5694.4 5705.5 4735.0 5526.6 5539.7 5546.5 5564.2 5161.3 5504.0 5512.8 5516.4 5545.0 4966.1 5115.7 5361.5 5450.9 5480.1 5219.7 5399.4 5420.9 5424.6 5586.5 4631.6 5449.1 5461.0 5470.6 5549.5 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - PROCESS | 1908 | [#5] yui.html Cycles:180 Average:22378.97 Median:4277.27 stddev:34626.11 (809.5%) stddev-sans-first:34684.92 04:46:55 INFO - PROCESS | 1908 | Values: 681.0 688.9 706.1 749.1 761.7 14905.1 15852.5 15852.5 15871.1 15897.9 14194.4 14361.3 14363.5 14373.0 14397.7 661.5 673.5 796.1 804.7 823.2 818.2 823.4 824.5 829.9 830.5 871.7 872.8 873.3 873.9 874.8 668.4 867.2 869.4 869.8 871.0 509.6 512.3 513.5 513.6 609.6 13593.0 13599.3 14021.6 14025.6 14042.4 13282.3 13405.3 13523.1 13626.7 13723.2 12603.9 12703.0 12780.6 12822.4 12980.2 4317.8 4410.1 4527.7 4553.1 4629.5 118439.0 121910.4 124348.8 125377.4 125472.0 10311.1 10577.9 10631.5 10753.8 10850.4 19485.5 20358.7 20379.2 20441.2 20901.9 6921.8 7592.6 7629.2 7670.7 7834.8 4227.2 4287.2 4292.6 4301.3 4332.5 3184.1 3276.2 3281.4 3288.4 3291.9 591.3 600.3 602.0 613.9 615.9 564.0 573.1 596.8 605.4 625.9 8338.2 8653.4 8721.3 8863.7 8975.2 575.7 590.3 590.4 608.1 634.8 4094.3 4267.4 4321.6 4392.4 4398.2 109337.0 115143.0 115973.0 116884.0 117219.0 103397.0 104161.5 104339.5 104783.0 107131.0 91648.0 91840.6 91915.0 93289.5 93713.0 6687.6 7371.3 8052.0 8336.4 8356.5 50774.7 57718.7 57911.8 58052.0 58614.7 82385.0 83035.3 84720.0 85340.0 85425.6 11296.0 11307.9 11327.5 11762.3 11767.9 11955.5 12005.0 12033.6 12157.2 12524.4 11458.4 11554.8 11594.3 11699.5 11750.0 9344.3 11285.9 11652.2 12934.2 13195.1 12978.5 13174.1 13184.1 13210.3 13214.9 10129.8 10817.5 11081.1 11305.3 11644.7 8489.5 11090.4 11275.0 11446.5 11464.3 04:46:55 INFO - PROCESS | 1908 | -------- Summary: end -------- 04:46:55 INFO - PROCESS | 1908 | 04:46:55 INFO - TEST-INFO | 1908: exit 0 04:46:55 INFO - TEST-OK | dromaeo_css | took 1120180ms 04:46:55 INFO - TEST-START | kraken 04:46:55 INFO - operating with platform_type : mac_ 04:46:55 INFO - Initialising browser for kraken test... 04:46:55 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpcO2i5e/profile http://localhost:49368/getInfo.html) 04:46:58 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 04:46:58 INFO - PROCESS | 1914 | colorDepth:24 04:46:58 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 04:46:58 INFO - PROCESS | 1914 | __metrics 04:46:58 INFO - PROCESS | 1914 | 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" 04:46:58 INFO - PROCESS | 1914 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:59 INFO - TEST-INFO | 1914: exit 0 04:46:59 INFO - Browser initialized. 04:46:59 INFO - Running cycle 1/1 for kraken test... 04:46:59 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpcO2i5e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:11 INFO - PROCESS | 1915 | RSS: Main: 244195328 04:47:11 INFO - PROCESS | 1915 | 04:47:14 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:15 INFO - PROCESS | 1915 | RSS: Main: 294252544 04:47:15 INFO - PROCESS | 1915 | 04:47:17 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-dft) 04:47:18 INFO - PROCESS | 1915 | RSS: Main: 295280640 04:47:18 INFO - PROCESS | 1915 | 04:47:21 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-fft) 04:47:22 INFO - PROCESS | 1915 | RSS: Main: 387694592 04:47:22 INFO - PROCESS | 1915 | 04:47:24 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator) 04:47:25 INFO - PROCESS | 1915 | RSS: Main: 291840000 04:47:25 INFO - PROCESS | 1915 | 04:47:27 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:27 INFO - PROCESS | 1915 | RSS: Main: 294010880 04:47:27 INFO - PROCESS | 1915 | 04:47:30 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:31 INFO - PROCESS | 1915 | RSS: Main: 337272832 04:47:31 INFO - PROCESS | 1915 | 04:47:34 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:34 INFO - PROCESS | 1915 | RSS: Main: 337813504 04:47:34 INFO - PROCESS | 1915 | 04:47:37 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial) 04:47:38 INFO - PROCESS | 1915 | RSS: Main: 336494592 04:47:38 INFO - PROCESS | 1915 | 04:47:39 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:40 INFO - PROCESS | 1915 | RSS: Main: 310697984 04:47:40 INFO - PROCESS | 1915 | 04:47:42 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:42 INFO - PROCESS | 1915 | RSS: Main: 315322368 04:47:42 INFO - PROCESS | 1915 | 04:47:45 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:45 INFO - PROCESS | 1915 | RSS: Main: 316559360 04:47:45 INFO - PROCESS | 1915 | 04:47:48 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:49 INFO - PROCESS | 1915 | RSS: Main: 335249408 04:47:49 INFO - PROCESS | 1915 | 04:47:52 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:53 INFO - PROCESS | 1915 | RSS: Main: 328290304 04:47:53 INFO - PROCESS | 1915 | 04:47:54 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49368/tests/kraken/driver.html?testName=ai-astar) 04:47:55 INFO - PROCESS | 1915 | RSS: Main: 372359168 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | __start_tp_report 04:47:55 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 04:47:55 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 04:47:55 INFO - PROCESS | 1915 | |i|pagename|runs| 04:47:55 INFO - PROCESS | 1915 | |0;ai-astar;113;115;114;113;114;115;114;113;114;114 04:47:55 INFO - PROCESS | 1915 | |1;audio-beat-detection;154;114;114;153;112;115;112;116;134;115 04:47:55 INFO - PROCESS | 1915 | |2;audio-dft;183;183;185;184;185;187;182;181;184;184 04:47:55 INFO - PROCESS | 1915 | |3;audio-fft;89;81;82;107;62;59;61;58;77;58 04:47:55 INFO - PROCESS | 1915 | |4;audio-oscillator;85;71;86;69;69;69;82;68;70;84 04:47:55 INFO - PROCESS | 1915 | |5;imaging-gaussian-blur;89;86;90;87;89;86;89;86;88;86 04:47:55 INFO - PROCESS | 1915 | |6;imaging-darkroom;97;97;97;98;97;97;98;115;165;97 04:47:55 INFO - PROCESS | 1915 | |7;imaging-desaturate;87;85;85;87;84;85;86;84;87;86 04:47:55 INFO - PROCESS | 1915 | |8;json-parse-financial;55;54;53;54;55;55;54;54;54;54 04:47:55 INFO - PROCESS | 1915 | |9;json-stringify-tinderbox;64;70;65;69;73;74;71;72;70;71 04:47:55 INFO - PROCESS | 1915 | |10;stanford-crypto-aes;89;89;101;108;107;108;87;87;88;87 04:47:55 INFO - PROCESS | 1915 | |11;stanford-crypto-ccm;151;155;146;146;145;144;146;146;196;145 04:47:55 INFO - PROCESS | 1915 | |12;stanford-crypto-pbkdf2;175;175;233;198;173;172;173;177;171;172 04:47:55 INFO - PROCESS | 1915 | |13;stanford-crypto-sha256-iterative;69;68;69;67;67;67;68;68;65;65 04:47:55 INFO - PROCESS | 1915 | __end_tp_report 04:47:55 INFO - PROCESS | 1915 | __start_cc_report 04:47:55 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,1992 04:47:55 INFO - PROCESS | 1915 | __end_cc_report 04:47:55 INFO - PROCESS | 1915 | __startTimestamp1481114875166__endTimestamp 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | ------- Summary: start ------- 04:47:55 INFO - PROCESS | 1915 | Number of tests: 14 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 04:47:55 INFO - PROCESS | 1915 | Values: 113.0 115.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:115.50 stddev:16.85 (14.6%) stddev-sans-first:13.91 04:47:55 INFO - PROCESS | 1915 | Values: 154.0 114.0 114.0 153.0 112.0 115.0 112.0 116.0 134.0 115.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.69 (0.9%) stddev-sans-first:1.76 04:47:55 INFO - PROCESS | 1915 | Values: 183.0 183.0 185.0 184.0 185.0 187.0 182.0 181.0 184.0 184.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#3] audio-fft Cycles:10 Average:73.40 Median:69.50 stddev:16.61 (23.9%) stddev-sans-first:16.63 04:47:55 INFO - PROCESS | 1915 | Values: 89.0 81.0 82.0 107.0 62.0 59.0 61.0 58.0 77.0 58.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:7.80 (10.2%) stddev-sans-first:7.45 04:47:55 INFO - PROCESS | 1915 | Values: 85.0 71.0 86.0 69.0 69.0 69.0 82.0 68.0 70.0 84.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.58 (1.8%) stddev-sans-first:1.59 04:47:55 INFO - PROCESS | 1915 | Values: 89.0 86.0 90.0 87.0 89.0 86.0 89.0 86.0 88.0 86.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:97.00 stddev:21.54 (22.2%) stddev-sans-first:22.61 04:47:55 INFO - PROCESS | 1915 | Values: 97.0 97.0 97.0 98.0 97.0 97.0 98.0 115.0 165.0 97.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.13 04:47:55 INFO - PROCESS | 1915 | Values: 87.0 85.0 85.0 87.0 84.0 85.0 86.0 84.0 87.0 86.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 04:47:55 INFO - PROCESS | 1915 | Values: 55.0 54.0 53.0 54.0 55.0 55.0 54.0 54.0 54.0 54.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:3.21 (4.5%) stddev-sans-first:2.60 04:47:55 INFO - PROCESS | 1915 | Values: 64.0 70.0 65.0 69.0 73.0 74.0 71.0 72.0 70.0 71.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:87.00 stddev:9.61 (11.0%) stddev-sans-first:9.93 04:47:55 INFO - PROCESS | 1915 | Values: 89.0 89.0 101.0 108.0 107.0 108.0 87.0 87.0 88.0 87.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:146.00 stddev:15.82 (10.8%) stddev-sans-first:16.77 04:47:55 INFO - PROCESS | 1915 | Values: 151.0 155.0 146.0 146.0 145.0 144.0 146.0 146.0 196.0 145.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:175.00 stddev:19.62 (11.2%) stddev-sans-first:20.65 04:47:55 INFO - PROCESS | 1915 | Values: 175.0 175.0 233.0 198.0 173.0 172.0 173.0 177.0 171.0 172.0 04:47:55 INFO - PROCESS | 1915 | 04:47:55 INFO - PROCESS | 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 04:47:55 INFO - PROCESS | 1915 | Values: 69.0 68.0 69.0 67.0 67.0 67.0 68.0 68.0 65.0 65.0 04:47:55 INFO - PROCESS | 1915 | -------- Summary: end -------- 04:47:55 INFO - PROCESS | 1915 | 04:47:56 INFO - TEST-INFO | 1915: exit 0 04:47:56 INFO - TEST-OK | kraken | took 60445ms 04:47:56 INFO - SUITE-END | took 1180s 04:47:56 INFO - Completed test suite (00:19:40) 04:47:56 INFO - javascript benchmark 04:47:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2740.890364385424, 3213.66256543063, 3216.935661286775, 3242.627097883741, 3268.0032590060023, 5316.175992721125, 5330.89338213236, 5347.385050719168, 5399.0, 5424.701641409721, 5279.41926388098, 5329.493698098684, 5346.599005074616, 5375.0, 5424.484673955978, 4919.360483137187, 4921.950780492194, 4942.3327850740225, 4944.7774850131655, 5034.798608055692, 4932.0, 4986.675866068712, 5032.622553308498, 5068.493150684939, 5069.569086627641, 5030.748462576875, 5065.797368105272, 5072.010957863218, 5085.949140508603, 5107.080725469414, 4916.508349165055, 4951.306817045616, 4955.1080805455, 4987.625928055374, 5025.648204625678, 4987.875303117415, 5007.69953802773, 5013.172826483626, 5027.396712394499, 5047.7476126193915, 5409.350877894639, 5420.91868621971, 5421.241026256327, 5457.263269458612, 5461.918071228934, 5706.087026075808, 5779.711014449261, 5870.412958704095, 5888.676122813244, 5897.705114744289, 5913.2608423947, 5913.46778789911, 5922.200502932092, 5922.3781502942, 5932.644041357489, 5495.2856128703415, 5499.50504454601, 5506.449355064502, 5511.834644960658, 5533.889322213533, 5998.070299103646, 6046.576739628272, 6120.959436895739, 6126.23422072241, 6186.505079593621, 5768.682722450306, 5788.0449725795615, 5790.88418231633, 5800.274965629296, 5818.5345172386105, 5952.7321270542925, 5978.402159784074, 5982.162497250389, 5992.370801065913, 5993.250843644544, 5126.897462050738, 5649.830505084854, 5701.572382071361, 5738.96698594257, 5773.0, 5887.175795388649, 5891.998360278762, 5907.054871220584, 5930.169776231331, 5947.345791962881, 4753.595944344769, 4759.690620109682, 4762.333273341735, 4776.928346074812, 4806.2310030394965, 4236.512801027921, 4258.936115958263, 4262.808173632194, 4282.443282373334, 4307.655387568987, 5466.480684334982, 5476.069068258405, 5536.529395001389, 5574.16387541872, 5582.637128586629, 5961.374055724174, 5979.043353063489, 5985.431384018511, 6006.819795406145, 6021.2774467063355, 5474.014677358114, 5491.341039075257, 5520.751566179531, 5521.0, 5526.032944234743, 5072.416672082758, 5133.922991155136, 5135.897282054338, 5139.563137133311, 5190.325257716473, 6010.068439391901, 6065.636061836304, 6085.66528840918, 6117.3402608778015, 6117.401149625572, 5926.7925622603, 5941.970290148522, 5982.52139828804, 5988.431099045583, 6011.759529618941, 5923.0, 6059.6364218147055, 6071.453569178795, 6092.055731361646, 6108.205933228652, 5728.140778883201, 5787.56593255516, 5801.477866991991, 5817.243758311562, 5893.970530147321, 5778.971105144447, 5832.3292821326095, 5849.5612829037145, 5915.556333274935, 5946.940530594638, 5652.4064973178865, 5727.055035919193, 5730.71346432685, 5741.45456181662, 5795.94204057954, 5602.243697101002, 5655.519280861173, 5672.347680016851, 5680.630759000652, 5685.744141513725, 5594.888102238014, 5637.379888212211, 5651.15232715096, 5661.2923384576925, 5691.77232910679, 4876.487968763229, 5680.318361796611, 5689.459501347365, 5695.1457281406465, 5713.457221563945, 5380.139177731544, 5458.808941687022, 5611.579131565068, 5614.326280846161, 5655.660660360227], "value": 5416.846498881252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.9745913974731, 501.70148761486905, 514.5883293365307, 514.7374838832194, 528.7646997086298, 29878.551821722664, 30241.0, 35529.46705799415, 38924.22151556967, 40172.59827401725, 40887.38668919969, 41092.79453602735, 41186.58813411865, 41251.58748412515, 41275.58724412755, 9211.631534738619, 9384.953075234615, 9393.85909211359, 9395.483248421335, 9395.530223488833, 8504.489730616151, 8722.651093956265, 10382.169426445904, 11230.213885028052, 11262.662120136369, 11186.0, 11220.270682405659, 11247.718807029849, 11248.38133902635, 11253.0, 8398.202170793826, 11141.944290278538, 11196.992270695595, 11204.271722338104, 11237.325760454358, 8391.035030971456, 8534.530600816952, 8543.957280213559, 8547.401681882271, 10991.780164396747, 37814.621853781384, 39564.80217598894, 39612.40581391282, 39614.801925990476, 39647.40528892069, 3305.5702758641464, 3410.0, 3532.2405682778067, 3616.6021737608844, 3714.9442758358646, 29226.41547169045, 29510.70489295101, 29613.763904699164, 30157.698423015707, 30270.84864575685, 3099.8613037447944, 3132.561441398206, 3262.070309961673, 3313.287643156709, 3316.2538428853554, 425717.0, 448030.0, 450061.0, 450265.7486712578, 450822.0, 56160.43839561634, 56206.71896640491, 56305.1847407628, 56550.151747723816, 56800.0, 57092.429075709544, 57161.42838571561, 57247.14129288064, 59080.704596477604, 59163.70418147882, 13541.66145846342, 13909.930450347683, 13962.58112256634, 13993.440262389595, 14096.50662226817, 9738.172255358373, 10114.342567733074, 10685.412302323291, 10861.07680847121, 10941.781164376667, 12952.80570791439, 13945.16329020262, 15433.0, 15569.221538923008, 15790.9210453947, 6104.633721976696, 6111.54163437744, 6141.907871381933, 6179.443850053517, 6181.289151747516, 830.5556527257888, 926.5089502563652, 955.7658373698349, 990.6285143071349, 1021.3922715983978, 25555.0, 25635.846386912635, 28635.427291454052, 28884.844606215935, 29788.553171702442, 958.166395236149, 993.2550587059706, 1019.9235057370727, 1020.2908978260039, 1115.3753897817248, 12871.613851584467, 15074.170920599472, 15352.53942381708, 15396.923015385075, 15632.0, 176575.11712441355, 177606.0, 179131.20868791407, 179320.0, 179531.0, 55969.720151398986, 56077.0, 56135.59661008507, 56149.438505614424, 56186.719066405225, 1202.8616709078567, 1245.7446223524155, 1305.9804102938274, 1331.2012792324529, 1354.9051566390258, 28826.27934301659, 29284.56073158947, 30089.0, 30274.09177724672, 30880.073597792103, 47231.76384118195, 52674.736626316626, 54232.0, 57366.85266294734, 57652.0, 564830.0, 570787.0, 570916.0, 571169.0, 571620.0, 24722.0, 24835.503289934462, 25137.87431062833, 25234.74765252324, 25491.617625736, 44361.77819110884, 44921.55078449305, 45004.549954500035, 45499.77250113861, 45520.54479455163, 32580.02259932111, 34416.82791586026, 36818.447723284706, 37239.25521489609, 38198.61801382062, 36852.262954741294, 36954.63045369512, 36972.63896734905, 37831.62168378391, 38126.618733812305, 36504.0, 36983.63016369802, 37048.81475592605, 37183.07042323964, 37268.440973385965, 30810.0, 32805.83597081999, 32994.505082423304, 33170.33659326848, 33253.83373083119, 23354.416139596648, 23640.88179559091, 24316.145729644202, 24358.634620480352, 24599.33279878037], "value": 18460.64815575631, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.4792948727546, 339.69766907452373, 343.29966867590133, 348.78201124297306, 361.4830791967485, 14776.77834832477, 15327.463538776145, 18576.721349179756, 19024.42926712201, 19978.70031949522, 19133.234670613158, 19232.519187020298, 19568.11943462544, 19574.0, 19609.31367402141, 5248.134057880445, 5740.483356497914, 5744.597878148531, 5785.16115163301, 5797.043487824525, 3933.0, 5621.409751976045, 5749.281339832521, 5754.856128596777, 5762.135679648065, 4208.158368326332, 4253.425787518692, 6344.968275158641, 6376.36236376361, 6419.069234960928, 6127.172831667713, 6274.780382686584, 6362.936370636281, 6378.649174295412, 6402.3917727816015, 5436.646617969859, 5438.782448702087, 5446.564274858041, 5448.673079615196, 5449.155380915964, 23959.153960450323, 24095.79521023942, 24146.637800433007, 24148.034078636832, 24458.021679132813, 1677.8573821225089, 2052.004777682823, 2104.7684754676975, 2274.385915802724, 2400.3879010852297, 8695.478271303742, 9654.75863103428, 9799.412035277906, 9990.90009099907, 9999.050090241415, 1810.384469280451, 1851.6019055902912, 1876.2682553804027, 1897.1747289928787, 1900.752902122729, 93724.06275937222, 109946.90053099446, 111818.44090779575, 113853.29220061623, 114869.0, 10521.684349469528, 10553.841692374466, 10610.89389106099, 11162.274452160584, 11302.265352752045, 14135.85864141366, 14167.362468688934, 14183.858161418253, 14208.573742787732, 14210.85789142116, 6361.840953976095, 6607.57050791697, 7394.963025184839, 7635.66375884218, 7789.883151752728, 6009.729562169713, 7342.265773422615, 7492.925070749223, 7514.586697731677, 7553.73561925341, 4301.720388174758, 4396.318570621559, 4403.691741578123, 4468.185043422623, 4490.281554951192, 1688.4090568301242, 1822.475870918787, 1879.718042293667, 1883.4255552056754, 1888.2635772048911, 750.1111183247759, 804.3364224514681, 928.5032507608397, 930.2883294279882, 948.5826236455937, 17246.965182089116, 17612.823871761117, 19495.512612184524, 20344.287949921978, 20453.693194602092, 779.6647441600167, 858.6908712863365, 867.8090820019586, 895.3687650206589, 910.1762904571374, 10202.0, 10697.572097116185, 10747.086497647788, 10762.73093172677, 10995.955384238485, 522221.0, 524650.0, 524914.0, 530420.347898258, 531668.0, 71296.19470350585, 95240.0475995245, 110739.44630276797, 114084.42957785158, 116801.41599292119, 898.3172788680649, 939.9389039712397, 956.8325543029941, 979.5004547680734, 979.7109852593502, 17909.552261193574, 18192.81807181964, 18331.35840245585, 18405.263789448272, 18688.626227475645, 50897.236541451166, 51175.74412127915, 51295.74352128216, 51622.0, 51734.0, 53978.0, 73589.63205184155, 73614.63192684003, 74569.6271518639, 75005.62497187479, 7446.292602202782, 7624.5425274483705, 7878.290953814184, 7880.847660935671, 8180.509169449852, 10236.232282578687, 12077.57728479499, 12245.02036838049, 12439.502419903103, 12492.0, 9175.632974680939, 10843.45782710877, 10857.891421085687, 10903.454827258764, 10974.0, 9484.762880928032, 9570.425774453555, 10892.945535272273, 11335.773284534429, 11383.886161138282, 10707.089897358812, 11009.174311926798, 11486.425678716198, 11611.0, 11688.649340519798, 7958.3235424989525, 8012.0, 8077.434579579373, 8162.877556836771, 8232.958835205785, 9169.266458683423, 11152.553897843994, 11213.15901307389, 11262.718432039264, 11278.661640150809], "value": 8994.763182668597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.683036071343, 1451.4629587052789, 1591.7771511988324, 1771.5748220427101, 1810.9456716298507, 7651.0, 7985.0, 7989.800254993628, 7992.8001799954955, 7994.120646728869, 7220.675069621867, 7454.105507339127, 7461.850762984751, 7512.361449276805, 7843.7646870593835, 1991.5718120604104, 2024.9898750506227, 2162.340486151723, 2233.944151396212, 2234.854734442264, 2241.361212054565, 2245.8989345479495, 2249.5490408686387, 2250.1112060736, 2250.9324720258337, 2184.8252139828855, 2209.933701988935, 2215.977840221601, 2225.3324002799177, 2228.1198926424054, 1995.3215906591684, 2047.5667033076757, 2162.5350549631826, 2188.026328283914, 2195.484061245614, 2209.4697272654607, 2217.8336624753047, 2218.6561083032157, 2221.4224301681515, 2224.377174391173, 7871.21287871214, 7891.092524359658, 7963.761087167394, 8015.559144247064, 8021.318187954031, 4722.5513576210205, 4822.7829747661435, 4891.608671306322, 4905.117078925792, 4905.4358748744, 3145.685431456859, 3168.318811455525, 3230.0794273632137, 3368.59576850777, 3370.5281260623533, 850.6724910909282, 953.7091187187905, 971.5530855806337, 987.1214618989105, 991.7917237380159, 10402.271840971134, 10403.427811470367, 10411.427371494565, 10423.530941107745, 10456.111230545413, 3880.932743495505, 4303.397524346594, 4454.10917816438, 4502.774861256924, 4502.954970450319, 8135.227153420416, 8191.631376588068, 8197.221263979913, 8227.13615070421, 8283.37874659403, 4873.488283730228, 4877.512248775094, 4880.243562247857, 4881.926771098437, 4885.7312847793, 4357.629601483846, 4512.4133862597655, 4590.150822097922, 4597.977010114995, 4599.310103484504, 3193.409219294438, 3287.178205448638, 3288.5067239914206, 3311.403947289463, 3395.6434574369337, 1050.56926660069, 1075.0539525217757, 1087.6465148826662, 1088.3306766338644, 1090.803655342046, 729.2233771033832, 760.7261385901071, 771.3289438188699, 836.5817091454273, 867.483847110968, 4033.3748269018347, 5015.824446144367, 5188.351456067991, 5225.921611175835, 5292.153255479182, 739.6117038554694, 825.3892119831281, 857.9832898015871, 869.3697069624598, 929.5863340813273, 3453.5165076889257, 3597.2086141048926, 3637.5453068366455, 3648.5986541480415, 3872.903177420587, 7870.6851725931465, 9321.254299656011, 9460.668876589287, 9480.762980925532, 9489.525523723787, 9419.0, 9431.717048488556, 9434.90565094354, 9438.197753191056, 9460.716178514656, 6932.168139823153, 7219.855602887913, 7447.515911465737, 7458.70165193397, 7486.962565187139, 4628.166929952641, 5088.338515992898, 5360.839174824761, 5393.487618676219, 5588.329400471806, 8542.487450752975, 8733.65065397377, 8763.518006509703, 8979.416337938013, 9006.009338972839, 8932.151445612657, 9056.27549796028, 9115.27077833785, 9130.771730706785, 9206.263498920205, 6845.178578570603, 6904.516683832084, 6906.447484201352, 6945.965270173617, 6961.75633852833, 6051.515878729603, 6808.0, 7344.706211751683, 7417.8887316689215, 7471.215522370073, 6455.128557644658, 6511.251206111168, 6788.694508747217, 6823.624700641512, 6891.586504809728, 5673.836863443067, 6307.148534947723, 6717.16035495563, 6734.158230221223, 6743.662816859235, 6403.103565500741, 6411.839704007437, 6420.06908998202, 6442.291347951816, 6524.184476940382, 4549.3176023596725, 4556.157110934488, 4590.74750888691, 4621.214393553171, 4733.384659994179, 3925.4700615417696, 4445.955540444555, 4642.605378542862, 4673.415823022122, 4748.92876606858], "value": 4126.220987196547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.15276670387496, 287.4222812147584, 291.1861347533644, 297.6324239564137, 298.817721190074, 4487.384541565042, 5107.055194788966, 5174.301469301643, 5214.165733482643, 5232.6075544334135, 4295.140971805636, 5145.459726728695, 5173.456787037363, 5180.715060671661, 5241.344831896013, 3178.2372230664705, 3745.8648570314863, 3828.9617103829023, 3858.5176852893387, 3956.1692044670654, 3637.254362855608, 3742.868999585015, 3922.3920292354733, 3950.6246906543834, 3957.7427467214684, 3910.882673519799, 3922.7254092213557, 3938.0154961259686, 3941.6401341537126, 3978.542467616218, 3220.9194770130935, 3501.824908754552, 3638.6361363863666, 3712.573054098786, 3748.981255093707, 3411.4712219606, 3418.3163367326633, 3434.7541573213325, 3458.6195518492946, 3463.1169051891857, 4129.91740165198, 5036.244563315496, 5046.772895219724, 5053.444121146671, 5056.0, 4254.383114448418, 4479.888002799924, 4504.1892459357305, 4516.051629157881, 4528.660350473728, 5291.523762861322, 5381.304888959965, 5456.135528847347, 5506.669599823983, 5521.751521181556, 3468.514407982884, 3767.811609419518, 3779.9244015119543, 3787.110029143149, 3808.21931504041, 5000.649954503187, 5280.867978300496, 5778.7350147167135, 5782.306123265193, 5784.595078344518, 3199.480246882759, 3818.9618103818607, 3820.8471661133244, 3823.5794062653085, 3849.8075096245634, 3868.593797651206, 3876.8449262029203, 3890.8832735017995, 3903.980480097581, 3916.686665066788, 3637.9818100909324, 4499.752513611717, 4505.07645932583, 4513.0, 4536.659750518725, 4844.95155048452, 5244.318238628954, 5492.066348720727, 5521.0, 5548.361938377057, 1113.04834366617, 1229.6987238126717, 1237.270010693695, 1239.4732238798474, 1248.1076030637955, 790.4032455496178, 824.6824972385675, 830.7424698343533, 837.7738010737189, 843.477523070863, 4740.885891815421, 4979.6265280104135, 5121.487851214849, 5145.768440420115, 5152.0586751135415, 5022.924656130161, 5383.5423988961375, 5639.238702775155, 5669.716514174357, 5671.574631902624, 4396.758178300224, 4432.988145728121, 5142.125838607446, 5204.947950520522, 5256.868578285574, 2560.8463492190153, 2724.5479068838204, 2815.7747380209535, 2824.390097644323, 2825.6609206895305, 4453.040662108662, 5048.419431765321, 5091.847244582668, 5477.67133971963, 5511.58663100269, 4345.891352716144, 4933.87665308363, 5128.0, 5328.92006619901, 5863.5309175265875, 4478.686491945533, 5581.716205272729, 5828.446297601721, 5847.0, 5870.941290587125, 5021.548060674557, 5732.856678582902, 5743.368229494836, 5802.6808525531505, 5821.72952548498, 5283.550898173545, 5626.746796394254, 5653.689047102284, 5655.943440565542, 5658.726786473011, 4886.828960986349, 5822.184894114743, 5836.103266438339, 5842.766289348378, 5884.47039766423, 3356.7482438816696, 3508.421110516736, 3567.23304489536, 3706.2031663191465, 3754.3805272129794, 4890.877728056827, 5218.8173413931845, 5689.573282003784, 5694.430556944272, 5705.486506214461, 4734.958309171977, 5526.613137080527, 5539.7230138492105, 5546.473085056913, 5564.221009058816, 5161.251618515369, 5503.972480137734, 5512.751926163252, 5516.393196748274, 5545.0, 4966.130927087673, 5115.667481613683, 5361.496343071838, 5450.91823622638, 5480.1231802912935, 5219.660722053054, 5399.352077750695, 5420.945790542044, 5424.647397919281, 5586.486081263366, 4631.606313463393, 5449.128139497661, 5461.0, 5470.64440811346, 5549.528290095387], "value": 3960.6231420632666, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9795706128816, 688.9448844092473, 706.0715159565171, 749.1048197404101, 761.6648674583183, 14905.105693658374, 15852.524424267262, 15852.52442426729, 15871.127088010155, 15897.920510397445, 14194.432222711104, 14361.28193590319, 14363.49727759526, 14373.0, 14397.712045759079, 661.5468404143153, 673.5049738442241, 796.1481215099817, 804.7424824056304, 823.2426167925493, 818.1981657975188, 823.3865770001357, 824.5094168969483, 829.9170082991712, 830.4726498673325, 871.7384784564637, 872.7730789994583, 873.3144481581959, 873.8732883731855, 874.7813046738315, 668.3951024322947, 867.1761826265074, 869.4174902815129, 869.7825543614097, 871.01575220001, 509.63815690859536, 512.3186162403994, 513.5095983335942, 513.560905425863, 609.5976655407454, 13592.980526460457, 13599.252041137734, 14021.64945876351, 14025.649358766112, 14042.438302467888, 13282.269475178862, 13405.262710550916, 13523.120997135155, 13626.727465450735, 13723.176609403468, 12603.912588978988, 12703.0, 12780.61658150257, 12822.42299096543, 12980.15628984113, 4317.805698743564, 4410.081614497703, 4527.683062185648, 4553.134904368159, 4629.51390104041, 118439.0, 121910.39044804809, 124348.75651243553, 125377.37311313476, 125472.0, 10311.089812707167, 10577.894221057844, 10631.46842657864, 10753.78492430147, 10850.403227822546, 19485.512862178275, 20358.694619580718, 20379.184832606825, 20441.182352705724, 20901.895490522755, 6921.757738479229, 7592.620368981528, 7629.19893411195, 7670.693172273158, 7834.804129896685, 4227.196832601858, 4287.185434767446, 4292.59220374064, 4301.268784306675, 4332.458442694663, 3184.092533627905, 3276.1809547613097, 3281.3765384576855, 3288.4245257080393, 3291.9341613167603, 591.2668291318734, 600.342624825815, 602.0367412140628, 613.923259592551, 615.9137720719103, 563.9967174794238, 573.0716239691726, 596.7762089216544, 605.3946053946054, 625.8591816841174, 8338.207870252316, 8653.394262401698, 8721.345899057469, 8863.656629908082, 8975.192232698957, 575.683374144219, 590.2533295381346, 590.3948452835878, 608.0939400293619, 634.7968650032038, 4094.2630326541507, 4267.359896015622, 4321.5678432157165, 4392.38506609075, 4398.186335527874, 109337.0, 115143.0, 115973.0, 116883.97392312977, 117219.0, 103397.0, 104161.47919260355, 104339.478302608, 104783.0, 107131.0, 91648.0, 91840.62239066554, 91915.0, 93289.5335523318, 93713.0, 6687.565308254948, 7371.299726525972, 8051.993500812398, 8336.374771892253, 8356.498610083414, 50774.74612626913, 57718.7114064427, 57911.84176316534, 58052.0, 58614.70692646509, 82385.0, 83035.339293215, 84720.0, 85340.0, 85425.57287213524, 11296.0, 11307.886921131012, 11327.490262938352, 11762.294262344287, 11767.941160294144, 11955.521779128738, 12005.0, 12033.616134144686, 12157.209781364183, 12524.436400362189, 11458.436638435489, 11554.826677599674, 11594.304341739522, 11699.473523691284, 11750.0, 9344.299177561847, 11285.887141128813, 11652.242604230698, 12934.223946563236, 13195.076344655781, 12978.480860765463, 13174.143680660727, 13184.143030702973, 13210.339483026002, 13214.867851321364, 10129.797404052026, 10817.51321190564, 11081.11351091927, 11305.321680699184, 11644.6506604802, 8489.533075680896, 11090.390028548507, 11275.04162146194, 11446.542138314708, 11464.25482343645], "value": 7289.619499865588, "unit": "score"}], "name": "dromaeo_css", "value": 6891.949277222748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 114.0, 114.0, 153.0, 112.0, 115.0, 112.0, 116.0, 134.0, 115.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 184.0, 185.0, 187.0, 182.0, 181.0, 184.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 82.0, 107.0, 62.0, 59.0, 61.0, 58.0, 77.0, 58.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 86.0, 69.0, 69.0, 69.0, 82.0, 68.0, 70.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 89.0, 86.0, 89.0, 86.0, 88.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 98.0, 115.0, 165.0, 97.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 87.0, 84.0, 85.0, 86.0, 84.0, 87.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 65.0, 69.0, 73.0, 74.0, 71.0, 72.0, 70.0, 71.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 101.0, 108.0, 107.0, 108.0, 87.0, 87.0, 88.0, 87.0], "value": 95.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 146.0, 146.0, 145.0, 144.0, 146.0, 146.0, 196.0, 145.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 233.0, 198.0, 173.0, 172.0, 173.0, 177.0, 171.0, 172.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 67.0, 67.0, 67.0, 68.0, 68.0, 65.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1469.7, "alertThreshold": 2.0}]} 04:47:56 INFO - Return code: 0 04:47:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:56 INFO - # TBPL SUCCESS # 04:47:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:56 INFO - 2016-12-07 04:47:56.476 screenresolution[1919:12704] starting screenresolution argv=screenresolution get 04:47:56 INFO - 2016-12-07 04:47:56.479 screenresolution[1919:12704] Display 0: 1600x1200x32@60 04:47:56 INFO - 2016-12-07 04:47:56.485 screenresolution[1920:12707] starting screenresolution argv=screenresolution list 04:47:56 INFO - Available Modes on Display 0 04:47:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:56 INFO - Intel Iris: 04:47:56 INFO - Chipset Model: Intel Iris 04:47:56 INFO - Type: GPU 04:47:56 INFO - Bus: Built-In 04:47:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:56 INFO - Vendor: Intel (0x8086) 04:47:56 INFO - Device ID: 0x0a2e 04:47:56 INFO - Revision ID: 0x0009 04:47:56 INFO - Displays: 04:47:56 INFO - Display: 04:47:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:56 INFO - Display Serial Number: 1600x1200 60 04:47:56 INFO - Main Display: Yes 04:47:56 INFO - Mirror: Off 04:47:56 INFO - Online: Yes 04:47:56 INFO - Rotation: Supported 04:47:56 INFO - Return code: 0 04:47:56 INFO - Running post-action listener: _resource_record_post_action 04:47:56 INFO - [mozharness: 2016-12-07 12:47:56.734682Z] Finished run-tests step (success) 04:47:56 INFO - Running post-run listener: _resource_record_post_run 04:47:56 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 2289664; Write bytes: 694321664; Read time: 23; Write time: 1942 04:47:56 INFO - TinderboxPrint: CPU usage
53.6% 04:47:56 INFO - TinderboxPrint: I/O read bytes / time
2,289,664 / 23 04:47:56 INFO - TinderboxPrint: I/O write bytes / time
694,321,664 / 1,942 04:47:56 INFO - TinderboxPrint: CPU idle
2,255.7 (46.4%) 04:47:56 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 04:47:56 INFO - TinderboxPrint: CPU user
1,631.1 (33.6%) 04:47:56 INFO - TinderboxPrint: Swap in / out
386,928,640 / 0 04:47:56 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 379449856; Write bytes: 374777856; Read time: 28887; Write time: 767 04:47:56 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 1368064; Write bytes: 305162752; Read time: 18; Write time: 1135 04:47:57 INFO - Running post-run listener: _upload_blobber_files 04:47:57 INFO - Blob upload gear active. 04:47:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:57 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 04:47:57 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'] 04:47:57 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 04:47:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:59 INFO - (blobuploader) - INFO - Done attempting. 04:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:00 INFO - (blobuploader) - INFO - Done attempting. 04:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:02 INFO - (blobuploader) - INFO - Done attempting. 04:48:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:02 INFO - Return code: 0 04:48:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29bc96dee492b41bdfcd3e9f3ebd12819e5d52e7d243b76ae4b3874ab92c59548e733a55eb3d50882a7d1acd847cda6f1e13d48dddb869b884bc10be03fb188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/24cf8a3cf355e0a9d68b2f448042fd3aced2fb08c6ceb7294a93b0bf18e50934ba1fd79318f60756dc947a43e3b7b34415a54790e8e9fbc1caba245785cfca05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a30e4c082211a6530fd2b8b96ebef1a8c9d50b75c73ff7be634efe97cb43a6428b031efd86ba8c29892505874654df724430284cca33b242ab45bd8273dbc9ce"} 04:48:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:02 INFO - Contents: 04:48:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/29bc96dee492b41bdfcd3e9f3ebd12819e5d52e7d243b76ae4b3874ab92c59548e733a55eb3d50882a7d1acd847cda6f1e13d48dddb869b884bc10be03fb188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/24cf8a3cf355e0a9d68b2f448042fd3aced2fb08c6ceb7294a93b0bf18e50934ba1fd79318f60756dc947a43e3b7b34415a54790e8e9fbc1caba245785cfca05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a30e4c082211a6530fd2b8b96ebef1a8c9d50b75c73ff7be634efe97cb43a6428b031efd86ba8c29892505874654df724430284cca33b242ab45bd8273dbc9ce"} 04:48:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:02 INFO - Copying logs to upload dir... 04:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.900425 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 04:48:02.795042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 04:48:02.798205) ========= 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.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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/29bc96dee492b41bdfcd3e9f3ebd12819e5d52e7d243b76ae4b3874ab92c59548e733a55eb3d50882a7d1acd847cda6f1e13d48dddb869b884bc10be03fb188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/24cf8a3cf355e0a9d68b2f448042fd3aced2fb08c6ceb7294a93b0bf18e50934ba1fd79318f60756dc947a43e3b7b34415a54790e8e9fbc1caba245785cfca05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a30e4c082211a6530fd2b8b96ebef1a8c9d50b75c73ff7be634efe97cb43a6428b031efd86ba8c29892505874654df724430284cca33b242ab45bd8273dbc9ce"} build_url:https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011029 build_url: 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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/29bc96dee492b41bdfcd3e9f3ebd12819e5d52e7d243b76ae4b3874ab92c59548e733a55eb3d50882a7d1acd847cda6f1e13d48dddb869b884bc10be03fb188a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/24cf8a3cf355e0a9d68b2f448042fd3aced2fb08c6ceb7294a93b0bf18e50934ba1fd79318f60756dc947a43e3b7b34415a54790e8e9fbc1caba245785cfca05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a30e4c082211a6530fd2b8b96ebef1a8c9d50b75c73ff7be634efe97cb43a6428b031efd86ba8c29892505874654df724430284cca33b242ab45bd8273dbc9ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 04:48:02.833018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:48:02.833365) ========= 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.WHr3EHBNmm/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.04J08c4Xb5/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.005109 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:48:02.881418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 04:48:02.881728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 04:48:02.882042) ========= ========= Total master_lag: 0.19 =========