builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1479315886.87 results: success (0) buildid: 20161116061237 builduid: bcd3cfd89c5d431f81006907ca18823d revision: 50dd0b8e139f152b7c3a7d68b70f139319035fd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.865494) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.865935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.866207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.889656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.890002) ========= 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.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-11-16 09:04:46-- 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% 7.93M=0.001s 2016-11-16 09:04:46 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.992894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:46.993206) ========= 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.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.021035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:47.041508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:47.041882) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 50dd0b8e139f152b7c3a7d68b70f139319035fd8 --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 50dd0b8e139f152b7c3a7d68b70f139319035fd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-11-16 09:04:47,120 truncating revision to first 12 chars 2016-11-16 09:04:47,120 Setting DEBUG logging. 2016-11-16 09:04:47,120 attempt 1/10 2016-11-16 09:04:47,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/50dd0b8e139f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 09:04:47,835 unpacking tar archive at: graphics-50dd0b8e139f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:48.033443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:48.033785) ========= script_repo_revision: 50dd0b8e139f152b7c3a7d68b70f139319035fd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:48.034222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:48.034544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 09:04:48.053559) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-16 09:04:48.053977) ========= /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.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:04:48 INFO - MultiFileLogger online at 20161116 09:04:48 in /builds/slave/test 09:04:48 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 09:04:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:48 INFO - {'append_to_log': False, 09:04:48 INFO - 'base_work_dir': '/builds/slave/test', 09:04:48 INFO - 'blob_upload_branch': 'Graphics', 09:04:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:48 INFO - 'branch': 'Graphics', 09:04:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:48 INFO - 'config_files': ('talos/mac_config.py',), 09:04:48 INFO - 'default_actions': ('clobber', 09:04:48 INFO - 'read-buildbot-config', 09:04:48 INFO - 'download-and-extract', 09:04:48 INFO - 'populate-webroot', 09:04:48 INFO - 'create-virtualenv', 09:04:48 INFO - 'install', 09:04:48 INFO - 'run-tests'), 09:04:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:48 INFO - 'download_minidump_stackwalk': True, 09:04:48 INFO - 'download_symbols': 'ondemand', 09:04:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:48 INFO - 'installer_path': 'installer.exe', 09:04:48 INFO - 'log_level': 'info', 09:04:48 INFO - 'log_name': 'talos', 09:04:48 INFO - 'log_to_console': True, 09:04:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:04:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:04:48 INFO - 'opt_config_files': (), 09:04:48 INFO - 'pip_index': False, 09:04:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:48 INFO - 'cmd': ('bash', 09:04:48 INFO - '-c', 09:04:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:48 INFO - 'enabled': True, 09:04:48 INFO - 'halt_on_failure': False, 09:04:48 INFO - 'name': 'check_screen_resolution'},), 09:04:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:48 INFO - 'cmd': ('bash', 09:04:48 INFO - '-c', 09:04:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:48 INFO - 'enabled': True, 09:04:48 INFO - 'halt_on_failure': False, 09:04:48 INFO - 'name': 'check_screen_resolution'},), 09:04:48 INFO - 'run_cmd_checks_enabled': True, 09:04:48 INFO - 'sps_profile': False, 09:04:48 INFO - 'sps_profile_interval': 0, 09:04:48 INFO - 'suite': 'dromaeojs', 09:04:48 INFO - 'system_bits': '32', 09:04:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:48 INFO - 'title': 't-yosemite-r7-0102', 09:04:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:48 INFO - 'use_talos_json': True, 09:04:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:48 INFO - 'work_dir': 'build'} 09:04:48 INFO - [mozharness: 2016-11-16 17:04:48.266336Z] Running clobber step. 09:04:48 INFO - Running pre-action listener: _resource_record_pre_action 09:04:48 INFO - Running main action method: clobber 09:04:48 INFO - rmtree: /builds/slave/test/build 09:04:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:50 INFO - Running post-action listener: _resource_record_post_action 09:04:50 INFO - [mozharness: 2016-11-16 17:04:50.434958Z] Finished clobber step (success) 09:04:50 INFO - [mozharness: 2016-11-16 17:04:50.435219Z] Running read-buildbot-config step. 09:04:50 INFO - Running pre-action listener: _resource_record_pre_action 09:04:50 INFO - Running main action method: read_buildbot_config 09:04:50 INFO - Using buildbot properties: 09:04:50 INFO - { 09:04:50 INFO - "project": "", 09:04:50 INFO - "product": "firefox", 09:04:50 INFO - "script_repo_revision": "default", 09:04:50 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:04:50 INFO - "repository": "", 09:04:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:04:50 INFO - "buildid": "20161116061237", 09:04:50 INFO - "pgo_build": "False", 09:04:50 INFO - "basedir": "/builds/slave/test", 09:04:50 INFO - "buildnumber": 0, 09:04:50 INFO - "slavename": "t-yosemite-r7-0102", 09:04:50 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:04:50 INFO - "platform": "yosemite_r7", 09:04:50 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:04:50 INFO - "branch": "graphics", 09:04:50 INFO - "repo_path": "projects/graphics", 09:04:50 INFO - "revision": "50dd0b8e139f152b7c3a7d68b70f139319035fd8", 09:04:50 INFO - "stage_platform": "macosx64", 09:04:50 INFO - "builduid": "bcd3cfd89c5d431f81006907ca18823d", 09:04:50 INFO - "slavebuilddir": "test" 09:04:50 INFO - } 09:04:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:04:50 INFO - Running post-action listener: _resource_record_post_action 09:04:50 INFO - [mozharness: 2016-11-16 17:04:50.440833Z] Finished read-buildbot-config step (success) 09:04:50 INFO - [mozharness: 2016-11-16 17:04:50.441066Z] Running download-and-extract step. 09:04:50 INFO - Running pre-action listener: _resource_record_pre_action 09:04:50 INFO - Running main action method: download_and_extract 09:04:50 INFO - mkdir: /builds/slave/test/build/tests 09:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:50 INFO - trying https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:04:50 INFO - Downloading https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/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 09:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/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 09:04:51 INFO - Downloaded 1199 bytes. 09:04:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:04:51 INFO - Using the following test package requirements: 09:04:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:04:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:04:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:04:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'jsshell-mac.zip'], 09:04:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:04:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:04:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:04:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:04:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:04:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:04:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:04:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:04:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:04:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:04:51 INFO - Fetch https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:04:52 INFO - Http code: 200 09:04:52 INFO - via: 1.1 990c804118e679d7ea0f4d3ca3cc4534.cloudfront.net (CloudFront) 09:04:52 INFO - x-amz-cf-id: ahaDbGMZcCGAd533Qp7qYHHG6Mc7wz5uHoPYfhUF1ONMofCkdht6hw== 09:04:52 INFO - x-amz-version-id: d.vKJAmkiXNSbbJbtOwFzgvjCHJxyyGA 09:04:52 INFO - Expected file size: 16268112 09:04:52 INFO - Obtained file size: 16268112 09:04:59 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 09:04:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:04:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:04:59 INFO - Fetch https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:04:59 INFO - Http code: 200 09:04:59 INFO - via: 1.1 9767e262e4af15c8d83a726bb0f44fa5.cloudfront.net (CloudFront) 09:04:59 INFO - x-amz-cf-id: E-pNBoZ6NEYcfRypqjCuuwbI9Co2AsJGYHfre7H8Q9JciWy-09QI1A== 09:04:59 INFO - x-amz-version-id: d.vKJAmkiXNSbbJbtOwFzgvjCHJxyyGA 09:05:00 INFO - Expected file size: 16268112 09:05:00 INFO - Obtained file size: 16268112 09:05:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:05:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:05:06 INFO - Fetch https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:05:07 INFO - Http code: 200 09:05:07 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 09:05:07 INFO - x-amz-cf-id: eoVJtENWP_pl43F1YHNObhF975gGPAstfI5k1MIA5cNAE8LkvA1TNQ== 09:05:07 INFO - x-amz-version-id: Sdl0lKckoHAEPTPYEoj0n_6fnhKRMUW4 09:05:07 INFO - Expected file size: 14409366 09:05:07 INFO - Obtained file size: 14409366 09:05:07 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')]} 09:05:07 INFO - trying https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:05:07 INFO - Downloading https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/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 09:05:10 INFO - Downloaded 111139082 bytes. 09:05:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:05:10 INFO - mkdir: /builds/slave/test/properties 09:05:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:10 INFO - Contents: 09:05:10 INFO - build_url:https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:05:11 INFO - Running post-action listener: _resource_record_post_action 09:05:11 INFO - Running post-action listener: set_extra_try_arguments 09:05:11 INFO - [mozharness: 2016-11-16 17:05:11.171820Z] Finished download-and-extract step (success) 09:05:11 INFO - [mozharness: 2016-11-16 17:05:11.171980Z] Running populate-webroot step. 09:05:11 INFO - Running pre-action listener: _resource_record_pre_action 09:05:11 INFO - Running main action method: populate_webroot 09:05:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:11 INFO - '--tppagecycles', 09:05:11 INFO - '7'], 09:05:11 INFO - 'tests': ['tsvgm']}}, 09:05:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['damp', 'tps']}, 09:05:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'tests': ['damp', 'tps']}, 09:05:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['dromaeo_dom']}, 09:05:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['basic_compositor_video']}, 09:05:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['a11yr', 09:05:11 INFO - 'ts_paint', 09:05:11 INFO - 'tpaint', 09:05:11 INFO - 'sessionrestore', 09:05:11 INFO - 'sessionrestore_no_auto_restore', 09:05:11 INFO - 'tabpaint']}, 09:05:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['tsvgx', 09:05:11 INFO - 'tsvgr_opacity', 09:05:11 INFO - 'tart', 09:05:11 INFO - 'tscrollx', 09:05:11 INFO - 'cart']}, 09:05:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:11 INFO - 'tsvgr_opacity', 09:05:11 INFO - 'tart', 09:05:11 INFO - 'tscrollx', 09:05:11 INFO - 'cart']}, 09:05:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'talos_options': ['--disable-e10s'], 09:05:11 INFO - 'tests': ['tp5o']}, 09:05:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:05:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'talos_options': ['--disable-e10s', 09:05:11 INFO - '--xperf_path', 09:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:11 INFO - 'tests': ['tp5n']}, 09:05:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:05:11 INFO - 'talos_options': ['--xperf_path', 09:05:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:11 INFO - 'tests': ['tp5n']}}, 09:05:11 INFO - 'talos.zip': {'path': '', 09:05:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:11 INFO - Running post-action listener: _resource_record_post_action 09:05:11 INFO - [mozharness: 2016-11-16 17:05:11.190269Z] Finished populate-webroot step (success) 09:05:11 INFO - [mozharness: 2016-11-16 17:05:11.190401Z] Running create-virtualenv step. 09:05:11 INFO - Running pre-action listener: _resource_record_pre_action 09:05:11 INFO - Running main action method: create_virtualenv 09:05:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:11 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 09:05:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:11 INFO - Using real prefix '/tools/python27' 09:05:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:14 INFO - Installing pip.................done. 09:05:14 INFO - Return code: 0 09:05:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:15 INFO - Reading from file tmpfile_stdout 09:05:15 INFO - Output received: 09:05:15 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) 09:05:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:15 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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:15 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 09:05:15 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 09:05:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:15 INFO - 'HOME': '/Users/cltbld', 09:05:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:15 INFO - 'LOGNAME': 'cltbld', 09:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:15 INFO - 'MOZ_NO_REMOTE': '1', 09:05:15 INFO - 'NO_EM_RESTART': '1', 09:05:15 INFO - 'PAGER': '/bin/cat', 09:05:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:15 INFO - 'PWD': '/builds/slave/test', 09:05:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:15 INFO - 'SHELL': '/bin/bash', 09:05:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:15 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:15 INFO - 'USER': 'cltbld', 09:05:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:15 INFO - 'XPC_FLAGS': '0x0', 09:05:15 INFO - 'XPC_SERVICE_NAME': '0', 09:05:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:15 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 09:05:15 INFO - Cleaning up... 09:05:15 INFO - Return code: 0 09:05:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:15 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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:15 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 09:05:15 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 09:05:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:15 INFO - 'HOME': '/Users/cltbld', 09:05:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:15 INFO - 'LOGNAME': 'cltbld', 09:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:15 INFO - 'MOZ_NO_REMOTE': '1', 09:05:15 INFO - 'NO_EM_RESTART': '1', 09:05:15 INFO - 'PAGER': '/bin/cat', 09:05:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:15 INFO - 'PWD': '/builds/slave/test', 09:05:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:15 INFO - 'SHELL': '/bin/bash', 09:05:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:15 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:15 INFO - 'USER': 'cltbld', 09:05:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:15 INFO - 'XPC_FLAGS': '0x0', 09:05:15 INFO - 'XPC_SERVICE_NAME': '0', 09:05:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:15 INFO - Downloading/unpacking psutil>=3.1.1 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:19 INFO - Installing collected packages: psutil 09:05:19 INFO - Running setup.py install for psutil 09:05:19 INFO - building 'psutil._psutil_osx' extension 09:05:19 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 09:05:19 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 09:05:19 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 09:05:19 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 09:05:19 INFO - building 'psutil._psutil_posix' extension 09:05:19 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 09:05:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:05:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:05:19 INFO - ^ 09:05:19 INFO - 1 warning generated. 09:05:19 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 09:05:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:19 INFO - Successfully installed psutil 09:05:19 INFO - Cleaning up... 09:05:19 INFO - Return code: 0 09:05:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:19 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 09:05:19 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 09:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:19 INFO - 'HOME': '/Users/cltbld', 09:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:19 INFO - 'LOGNAME': 'cltbld', 09:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:19 INFO - 'MOZ_NO_REMOTE': '1', 09:05:19 INFO - 'NO_EM_RESTART': '1', 09:05:19 INFO - 'PAGER': '/bin/cat', 09:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:19 INFO - 'PWD': '/builds/slave/test', 09:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:19 INFO - 'SHELL': '/bin/bash', 09:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:19 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:19 INFO - 'USER': 'cltbld', 09:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:19 INFO - 'XPC_FLAGS': '0x0', 09:05:19 INFO - 'XPC_SERVICE_NAME': '0', 09:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:20 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 09:05:20 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 09:05:20 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 09:05:20 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 09:05:20 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 09:05:20 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 09:05:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:22 INFO - Installing collected packages: mozsystemmonitor 09:05:22 INFO - Running setup.py install for mozsystemmonitor 09:05:22 INFO - Successfully installed mozsystemmonitor 09:05:22 INFO - Cleaning up... 09:05:22 INFO - Return code: 0 09:05:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:22 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')]} 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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')]} 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:22 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 09:05:22 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 09:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:22 INFO - 'HOME': '/Users/cltbld', 09:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:22 INFO - 'LOGNAME': 'cltbld', 09:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:22 INFO - 'MOZ_NO_REMOTE': '1', 09:05:22 INFO - 'NO_EM_RESTART': '1', 09:05:22 INFO - 'PAGER': '/bin/cat', 09:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:22 INFO - 'PWD': '/builds/slave/test', 09:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:22 INFO - 'SHELL': '/bin/bash', 09:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:22 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:22 INFO - 'USER': 'cltbld', 09:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:22 INFO - 'XPC_FLAGS': '0x0', 09:05:22 INFO - 'XPC_SERVICE_NAME': '0', 09:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:23 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 09:05:23 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 09:05:23 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 09:05:23 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 09:05:23 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 09:05:23 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 09:05:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:26 INFO - warning: no files found matching '*.txt' 09:05:26 INFO - no previously-included directories found matching 'build' 09:05:26 INFO - no previously-included directories found matching 'dist' 09:05:26 INFO - no previously-included directories found matching '.git*' 09:05:26 INFO - Installing collected packages: jsonschema, functools32 09:05:26 INFO - Running setup.py install for functools32 09:05:26 INFO - warning: no files found matching '*.txt' 09:05:26 INFO - no previously-included directories found matching 'build' 09:05:26 INFO - no previously-included directories found matching 'dist' 09:05:26 INFO - no previously-included directories found matching '.git*' 09:05:26 INFO - Successfully installed jsonschema functools32 09:05:26 INFO - Cleaning up... 09:05:26 INFO - Return code: 0 09:05:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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', '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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:05: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 functools32==3.2.3-2 09:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:26 INFO - 'HOME': '/Users/cltbld', 09:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:26 INFO - 'LOGNAME': 'cltbld', 09:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:26 INFO - 'MOZ_NO_REMOTE': '1', 09:05:26 INFO - 'NO_EM_RESTART': '1', 09:05:26 INFO - 'PAGER': '/bin/cat', 09:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:26 INFO - 'PWD': '/builds/slave/test', 09:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:26 INFO - 'SHELL': '/bin/bash', 09:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:26 INFO - 'USER': 'cltbld', 09:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:26 INFO - 'XPC_FLAGS': '0x0', 09:05:26 INFO - 'XPC_SERVICE_NAME': '0', 09:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:26 INFO - Cleaning up... 09:05:26 INFO - Return code: 0 09:05:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05: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 09:05: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 09:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:26 INFO - 'HOME': '/Users/cltbld', 09:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:26 INFO - 'LOGNAME': 'cltbld', 09:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:26 INFO - 'MOZ_NO_REMOTE': '1', 09:05:26 INFO - 'NO_EM_RESTART': '1', 09:05:26 INFO - 'PAGER': '/bin/cat', 09:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:26 INFO - 'PWD': '/builds/slave/test', 09:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:26 INFO - 'SHELL': '/bin/bash', 09:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:26 INFO - 'USER': 'cltbld', 09:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:26 INFO - 'XPC_FLAGS': '0x0', 09:05:26 INFO - 'XPC_SERVICE_NAME': '0', 09:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 INFO - Downloading docopt-0.6.1.tar.gz 09:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:30 INFO - Running setup.py install for blobuploader 09:05:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:31 INFO - Running setup.py install for requests 09:05:31 INFO - Running setup.py install for docopt 09:05:31 INFO - Successfully installed blobuploader requests docopt 09:05:31 INFO - Cleaning up... 09:05:31 INFO - Return code: 0 09:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05: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 09:05: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 09:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:31 INFO - 'HOME': '/Users/cltbld', 09:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:31 INFO - 'LOGNAME': 'cltbld', 09:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:31 INFO - 'MOZ_NO_REMOTE': '1', 09:05:31 INFO - 'NO_EM_RESTART': '1', 09:05:31 INFO - 'PAGER': '/bin/cat', 09:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:31 INFO - 'PWD': '/builds/slave/test', 09:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:31 INFO - 'SHELL': '/bin/bash', 09:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:31 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:31 INFO - 'USER': 'cltbld', 09:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:31 INFO - 'XPC_FLAGS': '0x0', 09:05:31 INFO - 'XPC_SERVICE_NAME': '0', 09:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-S9R2pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DGBccR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PAMA5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jzyBMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-3flV6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-fEQOqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-oGTRko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XHXPAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JRXcsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gEE7Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bAxSWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-7SPjhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Rnxlne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-drGZD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-z9xxkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QM86E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ooHpIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:33 INFO - Running setup.py install for manifestparser 09:05:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozcrash 09:05:34 INFO - Running setup.py install for mozdebug 09:05:34 INFO - Running setup.py install for mozdevice 09:05:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozfile 09:05:34 INFO - Running setup.py install for mozhttpd 09:05:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozinfo 09:05:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:34 INFO - Running setup.py install for mozInstall 09:05:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Running setup.py install for mozleak 09:05:35 INFO - Running setup.py install for mozlog 09:05:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Running setup.py install for moznetwork 09:05:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Running setup.py install for mozprocess 09:05:35 INFO - Running setup.py install for mozprofile 09:05:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Running setup.py install for mozrunner 09:05:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozscreenshot 09:05:36 INFO - Running setup.py install for moztest 09:05:36 INFO - Running setup.py install for mozversion 09:05:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:36 INFO - Cleaning up... 09:05:36 INFO - Return code: 0 09:05:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:36 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 09:05:36 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 09:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:36 INFO - 'HOME': '/Users/cltbld', 09:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:36 INFO - 'LOGNAME': 'cltbld', 09:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:36 INFO - 'MOZ_NO_REMOTE': '1', 09:05:36 INFO - 'NO_EM_RESTART': '1', 09:05:36 INFO - 'PAGER': '/bin/cat', 09:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:36 INFO - 'PWD': '/builds/slave/test', 09:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:36 INFO - 'SHELL': '/bin/bash', 09:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:36 INFO - 'USER': 'cltbld', 09:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:36 INFO - 'XPC_FLAGS': '0x0', 09:05:36 INFO - 'XPC_SERVICE_NAME': '0', 09:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9GRbsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05: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)) 09:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:36 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CXqXO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PWOCGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-lNZwa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9CUiDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-NvQ6y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GzK_xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4TJHHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CzFY8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05: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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-1rnsc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05: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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-qM2NaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-L42PLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-7qC36c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-79PoYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-y_fLYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-c73mxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-mPmac8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:38 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)) 09:05:38 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)) 09:05:38 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)) 09:05:38 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)) 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:38 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 09:05:38 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 09:05:38 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 09:05:38 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 09:05:38 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 09:05:38 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 09:05:41 INFO - Downloading blessings-1.6.tar.gz 09:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:41 INFO - Installing collected packages: blessings 09:05:41 INFO - Running setup.py install for blessings 09:05:41 INFO - Successfully installed blessings 09:05:41 INFO - Cleaning up... 09:05:41 INFO - Return code: 0 09:05:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:41 INFO - Reading from file tmpfile_stdout 09:05:41 INFO - Current package versions: 09:05:41 INFO - blessings == 1.6 09:05:41 INFO - blobuploader == 1.2.4 09:05:41 INFO - docopt == 0.6.1 09:05:41 INFO - functools32 == 3.2.3-2 09:05:41 INFO - jsonschema == 2.5.1 09:05:41 INFO - manifestparser == 1.1 09:05:41 INFO - mozInstall == 1.12 09:05:41 INFO - mozcrash == 1.0 09:05:41 INFO - mozdebug == 0.1 09:05:41 INFO - mozdevice == 0.48 09:05:41 INFO - mozfile == 1.2 09:05:41 INFO - mozhttpd == 0.7 09:05:41 INFO - mozinfo == 0.9 09:05:41 INFO - mozleak == 0.1 09:05:41 INFO - mozlog == 3.4 09:05:41 INFO - moznetwork == 0.27 09:05:41 INFO - mozprocess == 0.23 09:05:41 INFO - mozprofile == 0.28 09:05:41 INFO - mozrunner == 6.13 09:05:41 INFO - mozscreenshot == 0.1 09:05:41 INFO - mozsystemmonitor == 0.3 09:05:41 INFO - moztest == 0.7 09:05:41 INFO - mozversion == 1.4 09:05:41 INFO - psutil == 3.1.1 09:05:41 INFO - requests == 1.2.3 09:05:41 INFO - wsgiref == 0.1.2 09:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05: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 09:05: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 09:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:41 INFO - 'HOME': '/Users/cltbld', 09:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:41 INFO - 'LOGNAME': 'cltbld', 09:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:41 INFO - 'MOZ_NO_REMOTE': '1', 09:05:41 INFO - 'NO_EM_RESTART': '1', 09:05:41 INFO - 'PAGER': '/bin/cat', 09:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:41 INFO - 'PWD': '/builds/slave/test', 09:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:41 INFO - 'SHELL': '/bin/bash', 09:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:41 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:41 INFO - 'USER': 'cltbld', 09:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:41 INFO - 'XPC_FLAGS': '0x0', 09:05:41 INFO - 'XPC_SERVICE_NAME': '0', 09:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05: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)) 09:05:41 INFO - Cleaning up... 09:05:42 INFO - Return code: 0 09:05:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a637570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb90856f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, '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.5QM7ONznTP/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.CGMKStsDLD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:05:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:42 INFO - 'HOME': '/Users/cltbld', 09:05:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:42 INFO - 'LOGNAME': 'cltbld', 09:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:42 INFO - 'MOZ_NO_REMOTE': '1', 09:05:42 INFO - 'NO_EM_RESTART': '1', 09:05:42 INFO - 'PAGER': '/bin/cat', 09:05:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:42 INFO - 'PWD': '/builds/slave/test', 09:05:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:42 INFO - 'SHELL': '/bin/bash', 09:05:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:05:42 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:05:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:42 INFO - 'USER': 'cltbld', 09:05:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:42 INFO - 'XPC_FLAGS': '0x0', 09:05:42 INFO - 'XPC_SERVICE_NAME': '0', 09:05:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:42 INFO - Cleaning up... 09:05:42 INFO - Return code: 0 09:05:42 INFO - Running post-action listener: _resource_record_post_action 09:05:42 INFO - Running post-action listener: _start_resource_monitoring 09:05:42 INFO - Starting resource monitoring. 09:05:42 INFO - [mozharness: 2016-11-16 17:05:42.307963Z] Finished create-virtualenv step (success) 09:05:42 INFO - [mozharness: 2016-11-16 17:05:42.308974Z] Running install step. 09:05:42 INFO - Running pre-action listener: _resource_record_pre_action 09:05:42 INFO - Running main action method: install 09:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:42 INFO - Reading from file tmpfile_stdout 09:05:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:42 INFO - Reading from file tmpfile_stdout 09:05:42 INFO - Output received: 09:05:42 INFO - Usage: mozinstall [options] installer 09:05:42 INFO - Options: 09:05:42 INFO - -h, --help show this help message and exit 09:05:42 INFO - -d DEST, --destination=DEST 09:05:42 INFO - Directory to install application into. [default: 09:05:42 INFO - "/builds/slave/test"] 09:05:42 INFO - --app=APP Application being installed. [default: firefox] 09:05:42 INFO - mkdir: /builds/slave/test/build/application 09:05: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'] 09:05: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 09:06:16 INFO - Reading from file tmpfile_stdout 09:06:16 INFO - Output received: 09:06:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:06:16 INFO - Running post-action listener: _resource_record_post_action 09:06:16 INFO - [mozharness: 2016-11-16 17:06:16.183449Z] Finished install step (success) 09:06:16 INFO - [mozharness: 2016-11-16 17:06:16.183595Z] Running run-tests step. 09:06:16 INFO - Running pre-action listener: _resource_record_pre_action 09:06:16 INFO - Running main action method: run_tests 09:06:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:16 INFO - 2016-11-16 09:06:16.198 screenresolution[2663:26563] starting screenresolution argv=screenresolution get 09:06:16 INFO - 2016-11-16 09:06:16.201 screenresolution[2663:26563] Display 0: 1600x1200x32@60 09:06:16 INFO - 2016-11-16 09:06:16.207 screenresolution[2664:26566] starting screenresolution argv=screenresolution list 09:06:16 INFO - Available Modes on Display 0 09:06:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:16 INFO - Intel Iris: 09:06:16 INFO - Chipset Model: Intel Iris 09:06:16 INFO - Type: GPU 09:06:16 INFO - Bus: Built-In 09:06:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:16 INFO - Vendor: Intel (0x8086) 09:06:16 INFO - Device ID: 0x0a2e 09:06:16 INFO - Revision ID: 0x0009 09:06:16 INFO - Displays: 09:06:16 INFO - Display: 09:06:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:16 INFO - Display Serial Number: 1600x1200 60 09:06:16 INFO - Main Display: Yes 09:06:16 INFO - Mirror: Off 09:06:16 INFO - Online: Yes 09:06:16 INFO - Rotation: Supported 09:06:16 INFO - Return code: 0 09:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:16 INFO - Python 2.7.3 09:06:16 INFO - Return code: 0 09:06:16 INFO - grabbing minidump binary from tooltool 09:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:16 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 0x10a4d7d30>, '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 0x10a33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:16 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 09:06:16 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 09:06:16 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 09:06:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:16 INFO - Return code: 0 09:06:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:06:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:06:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:16 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/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 09:06:16 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/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 09:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QM7ONznTP/Render', 09:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:16 INFO - 'HOME': '/Users/cltbld', 09:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:16 INFO - 'LOGNAME': 'cltbld', 09:06:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:16 INFO - 'MOZ_NO_REMOTE': '1', 09:06:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:16 INFO - 'NO_EM_RESTART': '1', 09:06:16 INFO - 'PAGER': '/bin/cat', 09:06:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:16 INFO - 'PWD': '/builds/slave/test', 09:06:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:16 INFO - 'SHELL': '/bin/bash', 09:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CGMKStsDLD/Listeners', 09:06:16 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:16 INFO - 'USER': 'cltbld', 09:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:16 INFO - 'XPC_FLAGS': '0x0', 09:06:16 INFO - 'XPC_SERVICE_NAME': '0', 09:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:16 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/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 09:06:16 INFO - mozversion application_buildid: 20161116061237 09:06:16 INFO - mozversion application_changeset: 50dd0b8e139f152b7c3a7d68b70f139319035fd8 09:06:16 INFO - mozversion application_display_name: Nightly 09:06:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:16 INFO - mozversion application_name: Firefox 09:06:16 INFO - mozversion application_remotingname: firefox 09:06:16 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:06:16 INFO - mozversion application_vendor: Mozilla 09:06:16 INFO - mozversion application_version: 53.0a1 09:06:16 INFO - mozversion platform_buildid: 20161116061237 09:06:16 INFO - mozversion platform_changeset: 50dd0b8e139f152b7c3a7d68b70f139319035fd8 09:06:16 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:06:16 INFO - mozversion platform_version: 53.0a1 09:06:16 INFO - using testdate: 1479315976 09:06:16 INFO - actual date: 1479315976 09:06:16 INFO - starting webserver on 'localhost:56590' 09:06:16 INFO - SUITE-START | Running 2 tests 09:06:16 INFO - TEST-START | dromaeo_css 09:06:16 INFO - operating with platform_type : mac_ 09:06:16 INFO - Initialising browser for dromaeo_css test... 09:06:16 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmptMdQtL/profile http://localhost:56590/getInfo.html) 09:06:19 INFO - PROCESS | 2674 | __metrics Screen width/height:1600/1200 09:06:19 INFO - PROCESS | 2674 | colorDepth:24 09:06:19 INFO - PROCESS | 2674 | Browser inner width/height: 1024/689 09:06:19 INFO - PROCESS | 2674 | __metrics 09:06:19 INFO - PROCESS | 2674 | 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" 09:06:19 INFO - PROCESS | 2674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:20 INFO - TEST-INFO | 2674: exit 0 09:06:20 INFO - Browser initialized. 09:06:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:20 INFO - TEST-INFO | started process 2676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmptMdQtL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:32 INFO - PROCESS | 2676 | RSS: Main: 238993408 09:06:32 INFO - PROCESS | 2676 | 09:07:22 INFO - PROCESS | 2676 | 1479316042964 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] 09:09:37 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56590/tests/dromaeo/cssquery-ext.html) 09:09:38 INFO - PROCESS | 2676 | RSS: Main: 376807424 09:09:38 INFO - PROCESS | 2676 | 09:12:41 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-ext.html (next: http://localhost:56590/tests/dromaeo/cssquery-jquery.html) 09:12:42 INFO - PROCESS | 2676 | RSS: Main: 383750144 09:12:42 INFO - PROCESS | 2676 | 09:15:44 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56590/tests/dromaeo/cssquery-mootools.html) 09:15:45 INFO - PROCESS | 2676 | RSS: Main: 334725120 09:15:45 INFO - PROCESS | 2676 | 09:18:47 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56590/tests/dromaeo/cssquery-prototype.html) 09:18:48 INFO - PROCESS | 2676 | RSS: Main: 333901824 09:18:48 INFO - PROCESS | 2676 | 09:21:51 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56590/tests/dromaeo/cssquery-yui.html) 09:21:52 INFO - PROCESS | 2676 | RSS: Main: 328060928 09:21:52 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | Cycle 1(1): loaded http://localhost:56590/tests/dromaeo/cssquery-yui.html (next: http://localhost:56590/tests/dromaeo/cssquery-dojo.html) 09:24:55 INFO - PROCESS | 2676 | RSS: Main: 428171264 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | __start_tp_report 09:24:55 INFO - PROCESS | 2676 | _x_x_mozilla_page_load 09:24:55 INFO - PROCESS | 2676 | _x_x_mozilla_page_load_details 09:24:55 INFO - PROCESS | 2676 | |i|pagename|runs| 09:24:55 INFO - PROCESS | 2676 | |0;dojo.html;3292.5555050068247;3300.2904375559256;3316.237265428951;3351.257346179988;3368.5115658229556;5505.449455054492;5591.384947655754;5673;5724.685142317171;5726.198332233485;5597.104463285875;5646.604737668365;5652.236948012017;5661.631993920402;5680.261565996425;5113.616478764098;5153.639245252815;5161.27742116104;5180;5184.326037615105;5273.971575542771;5304.973475132639;5305.336832895888;5310.07073762092;5312.389075256337;5184.844454666366;5215.374155101393;5229.8954020919555;5240.423553409122;5305.469453054702;5287.286216360781;5291.550218231436;5300.708461034642;5320.547753440962;5348.384935732402;5101.311322971388;5112.079825631385;5182.689038657692;5225.137852254374;5253.369595648508;5569.637973531708;5655.349634791969;5669.121286200645;5689.772409103631;5690.971545142248;6232.470240029603;6235.971064774307;6244.656543890084;6255.78104766331;6257.030160325156;6126.956114243554;6201.5348848836065;6212.65830379329;6281.089242059921;6325.778597749103;5696.458836410535;5744.51171650406;5767.711614419304;5772.278465191851;5817.38917413674;6223.471004964538;6264.498840092781;6267.655278959701;6303.149074874833;6312.021636646327;5984.1323008164445;6114.296855861544;6130.724117414727;6133.631982081;6147.108669242934;6107.083937409336;6137.438273608292;6145.893739126911;6187.071939209155;6246.531510136758;5274.709890955957;6145.508359331332;6230.937690623126;6240.095186197976;6241.34465881085;6215.409536094064;6233.3143354231;6248.281447633581;6251.874962500725;6271.216097987752;4847.2729090636685;4892.363992680928;4892.437369702529;4927.802887884516;4936.925946110811;4328.978355108267;4372.3878656988045;4376.956230437719;4390.736555806662;4441.222786012435;5668.348139963957;5679.801206957736;5685.602007859493;5691.174779656926;5698.116791897262;6113.755449781959;6203.100550420164;6225.408586184305;6233.688315584202;6237.407446292595;5692.402297758676;5727.398623144593;5730.255066841284;5732.140178973187;5732.283464566929;5333.200019996954;5382.30030096085;5388.892222155535;5391.32608423947;5395.514403703607;6200.914839903089;6248.500119990299;6259.624422534663;6261.405166509175;6275.497960163176;6271.3415091414745;6273.9372606273355;6290.591111577733;6308.495320374267;6316.242050953915;6270.686465676789;6276.6547839869245;6285.402886725754;6291.842703932438;6303.023031430135;6026.096085587197;6095.786647467317;6120.9347721082095;6128.325884152829;6208.472279856082;6103.938960610515;6224.439800417984;6262.4990000800735;6264.436200741773;6278.811635650938;6135.110408990582;6139.754409823557;6140.201773769381;6143.6928153593035;6144.938550614436;5915.822525324247;5937.3468918418075;6057.030875060145;6123.112148738319;6134.04922237054;5808.041673123887;5913.91129133072;5925.288965324189;5959.970200148971;5977.790777322773;6108.961476548909;6109.969450152721;6112.724927378367;6139.26328840542;6144.662043587646;5738.397468265772;5847.5906686533235;5929.347771745191;5947.04847224442;5964.761409543743 09:24:55 INFO - PROCESS | 2676 | |1;ext.html;417.91432756284956;470.6705306285599;473.64476642518133;477.58927322502643;529.3330403691348;29831.403371932574;31218.687813121862;31303.373932521365;38537.42193867087;40006.59976900809;40876.38685419721;41183.97040073992;41287.79356103215;41372;41384.172316553726;9239.953800231006;9413.905860941371;9425.293103017268;9427.622895084189;9429.622815087389;9262.953685231565;9370.39092458988;9376.81246375072;9381.484018378986;9388.342816002883;9332.113449222346;9400.106989835955;9402.62389504419;9415.858762118574;9431.481268530228;9366.438013719164;9373.859392109056;9376.812463750755;9389.248860091244;9399.248060155205;9243.953780231055;9318.580663870142;9322.25421966241;9324.300677449219;9325.906740932573;38783;39232.41151382731;39284;39312.21375572501;39326.410103848466;3214.148250713563;3290.276139249361;3297.159224397787;3317.9668203318142;3624.72814538908;24898;29510.26224344387;30179.849100754574;30294;30396.696033039607;3182.9363412731846;3184.601924759405;3186.522021696741;3193.552902593639;3302.3725492156414;341274;344705.55294447235;345271;346408.26795866113;346625;32452.350952980807;54959.72520137374;55278.17082743762;55300.72349638226;55337.72331138399;33437.16407089842;34455;34528.82735586306;34685.65314346875;34748;13964.860351396559;14096.788548171786;14098.929505352407;14111.518290579546;14113.78829317561;11851.585194518151;11920.344381059125;11929.761404771856;11965.40172991347;12019.579314723942;7665.118511371152;7691.50005249657;7764.689412423553;7765.22347765219;7769.72805951789;3167.4298626247037;3215.839208039589;3216.903492895217;3222.258880457508;3247.8376081195847;736.5507040705165;923.1691477670016;953.6519170502717;1007.6573964851985;1035.5495359518634;28440.715592843808;28972.42055158927;29233.561496577568;29705.405891882474;29718.702812972027;976.4092723902079;993.4858264671694;1016.1058268723476;1031.83490641497;1092.180864351736;13370.859277708592;13634.318284085954;15124.470643527644;15423.074615523105;15461.994970326892;622653;626762;627843;628579;629363;54815.90368192614;55200.72399637976;55216;55228.44771552233;55287.447125529034;1306.2162702378496;1338.43785610044;1354.8645135486768;1355.7695191817415;1356.531996461239;28388;28544.42911141807;28742;29190.41619167647;29209.831606735494;47738.806529835645;48001;48055.5194448065;48206.75896620494;48234.75882620705;544820;545495;546757;546874;548946;25373.492530149662;25670.743292566836;25769;25793.87103064473;26429.60355594629;44227;44456.888577785816;45324.32013519734;45648.31527527156;45882;36607.45088823616;36840.81579592085;37083.443748343256;37152.628473715995;38208.42687359636;36814;36823.26353472862;37063.81468092642;38059.42910856395;38849.726530081105;36590;36820.63179368279;37478.2504349906;37738.81130594439;39004.609953901236;29341.26646833761;31328.843355783985;32942.835285823414;33022.66977330196;33095.007149785546;19514.414567562995;24454.87772561126;24531;25244.49511009806;25334 09:24:55 INFO - PROCESS | 2676 | |2;jquery.html;303.8769298434135;363.60367199752284;363.6399964035605;379.2680127354206;399.4168513969604;14922.701545969074;15419.922900385496;17483.388081417135;20776.896115519437;20794.792052079476;19144.712829307573;20118.396448106545;20128.79871201291;20149.29477468289;20154.59690806183;5743.684097374653;6036.939630603703;6048.1834952281315;6059.818205453821;6062.18160548327;4113.321301985169;4195.769232692201;4415.072834704716;4419.779011049451;6659.667016649172;6673.566218195826;6676.699548520328;6678.198616166067;6692.657569850538;6700.229473610524;6338.3027866934835;6534.60792352458;6580.210374755012;6580.967095164541;6581.308962558958;5428.511433970962;5691.630044047165;5702.686352250625;5716.628419152742;5727.742251598688;24934.50130997388;25442.236732898044;25635.180130185665;25755.742442575523;26043.95824167031;1925.2491528303972;2112.767595564487;2124.7662757096705;2208.3706143749114;2714.429969706364;9970.903200647923;10038.397696138256;10235.334703244265;14742.262886855615;15602.43975602442;1837.9264829406807;1849.5838436351848;1870.7661542307212;1897.3928342930267;1938.9709154362695;124978;128077;130901;131090.34454827665;133770;10996.615118470816;11412.144089193343;11434.485448154854;11458.083353331713;11612.535498580131;14453.205073720836;14530.85469145295;14537.345819438151;14575.271236438135;14585.343659535347;6634.535582509275;8072.273495385326;8312.958435207785;8329.708460203863;8461.830763384698;8161.7551473454705;8173.141820108922;8207.507549547046;8345.874811877828;8417.831643367099;4377.289557164077;4496.39298694672;4507.684462087688;4568.588827005519;4606.769661516911;1681.3358723304227;1810.4297146398842;1827.1777700035038;1880.9059547022594;1887.311131437043;727.9818004549822;759.8708219602681;778.5445514374154;822.9012518497699;888.1651247827022;20277.18891244363;20791.792082078984;20855;20948;20973;894.3158483759929;925.5973651461636;943.7546237978038;951.8619800128943;953.5994882149375;9146;10443.634472793416;11010.834837477445;11019.008289254005;11077.667669969915;565517;567236;569628;581421;582196;102777;128306;129085.06372404422;129601;131961.02058469132;919.2048877720723;931.8695382646434;959.203860795538;961.5576834656136;962.1100482054072;14719.411223550938;19032.904835475732;19048.238070477026;19250.518737031685;19294.22823087117;41818;45169.19323227034;48481.5151848477;56996.430035700774;57370.426295736506;59519;76258.61870690611;77221.45557088939;77767.61116194383;77956;6101.816945491642;6914;7277.59973201479;7330.230325815713;7435.7025718970635;8193.877091843508;10254.436006019741;11908.285502869856;12930.870691293343;12973.286469244282;8792.34057445707;9127.178553930178;10513.158947284352;10765.815760266521;11143.777124457303;10416.32293900894;10697.625583104555;10713.57145714194;11068.612598559012;11154.274972126786;10841.457927103456;11279.492422840827;11364.977152056355;11438.885611143782;11487.8276825846;6840.794776156723;7230.9638451807405;7453.105627324756;7531.774046778605;7693.692252309845;9006.324525660471;9071.410358326688;9945.850812237677;10730.356178629307;10907.563697452013 09:24:55 INFO - PROCESS | 2676 | |3;mootools.html;1462.5685422800273;1493.469818214534;1634.2237437217323;1755.683976884162;1805.9367922122728;8009.319207867331;8411.116832732552;8423.326133909288;8447.408681392306;8448.57757112145;7418.740344087958;7701.614919254043;7732.96133519333;7768.572728499945;7781.2996830285265;2063.9277625283116;2097.6329142400095;2206.6028114939304;2282.349530383841;2286.2569664858906;2301.7468078511433;2304.2971893572453;2304.412374844412;2312.583734927712;2312.8034117100065;1951.8581629746616;2207.415035015722;2275.8065564427043;2281.3840263128945;2283.4291427143216;2242.237639202671;2248.6964259824877;2265.3543740034092;2272.488690044743;2275.3515248154195;1882.397632757518;2257.9887100564392;2263.7170353705787;2284.1320298286546;2291.576058429196;7720.459567830254;7749.883751743729;8255.339572834158;8266.173382661686;8370.958145209295;4959.206526955706;5124.256982737519;5126.6923984561045;5130.179171332569;5132.409772876093;3285.2772390074147;3453.533772940671;3472.166679996808;3551.4317709166667;3563.9109022274392;1011.8077565262577;1038.256523877421;1059.947002649872;1065.6430095917876;1071.405370019639;10905.291156074909;10964.396958167377;10981;10990.505427255714;11000.284981476258;4286.164197981426;4546.590806827401;4639.118567472237;4664.65015123867;4670.416197975253;9332;9349.111834375723;9350.064993500731;9361.953190234006;9371.62513499466;5125.615578831603;5129.358830146231;5133.794648214104;5141.845744627667;5143.202803565453;4554.3851580036935;4691.249400095969;4717.433907931001;4749.430068391746;4754.429468463806;3439.4324936385215;3571.982140089283;3572.7677700949357;3590.8329792816917;3591.4612808078473;1166.9183157178916;1182.6215611004395;1203.3080978437433;1239.7230852222046;1252.123513540507;819.8032472206628;820.659426338063;857.34413173922;858.3819649852096;879.6569337958201;5452.536534394541;5494.313210848644;5609.915851262234;5773.134029895466;5819.039858423313;872.4677946452658;955.4888134847962;982.1651596143221;997.1773287038222;1013.9138173255355;3674.356987527172;3690.409534474525;3691.9815400922826;3781.0925377909653;3808.2383523295453;9730.464824434583;10007.849882251772;10161.644342447978;10189.133923616428;10202.030807073315;9493.620255189853;9863.556139973718;10118.696439106838;10125.177468055821;10131.138853197413;7581.810454738566;7786.610669466504;7826.178251283533;7827.569483678339;7832.686692532349;5486.91769623448;5491.643043202179;5556.333240011225;5710.2696128522;5838.12428135783;9274.675386361445;9305.348625596414;9313.906860931304;9463.952680236554;9507.286953478379;9265.027172147096;9484.762880928032;9545.0454954504;9679.032096790264;9684.41893486393;7043.577385356895;7059.752908648173;7173.282671732994;7244.203137654959;7246.927530724625;7724.266194711493;7800.492967957065;7817.452778305692;7820.882686759817;7828.960855195687;6775.644871025716;7032.613206273704;7061.399781018466;7078.504504684623;7128.714851406093;6936.271691472322;6960.269171737097;6997.755078572225;7074;7170.677319520739;6580.21037475506;6587.143671322698;6685.09751183584;6686.53194276396;6690.732370705117;4708.741019243975;4750.548697873696;4793.592544633745;4816.397950256218;4894.559489645949;4807.086653535817;4818.084563932842;4847.127517046965;4890.731009794496;4930.975345123252 09:24:55 INFO - PROCESS | 2676 | |4;prototype.html;299.11163843385145;301.30248474780865;309.0743224043988;311.1334932213785;316.2930849551254;4562.7642455196965;5001.549860512553;5089.694618322898;5125.8462246132585;5148.794048238071;4728.267118596615;4938.925916111261;4940.431850337212;5026.547610715035;5186.611004174692;3874.764571582725;3880.7865567393783;3929.3123703351944;3934.3311637021775;3940.4286378475103;3890.3580909149955;3914.099757055879;3916.4908561886914;3917.275304068742;3924.3721004639265;3781.7163712721517;3880.844766209348;3883.26218018577;3892.70804689648;3899.337112690849;3230.8707651693903;3719.758215715983;3894.8636797711943;3929.2337994091163;3957.3272543667645;3382.883648396048;3402.42158832999;3406.914827129317;3438.5186073949667;3463.5670541182353;4252.808623611914;4944.505549445063;4950.257461380786;4969.627277954168;4974.90050198994;4271.209826182135;4427.4908385535755;4464.665150113755;4470.195364834329;4485.439320084989;4468.827132735762;4677.953220467786;5212.087884620177;5367.007103685831;5397.514223719845;3056.9541456878164;3666.5600127984812;3678.172411207457;3736.1220113273357;3795.1650636859845;4342.609165175149;5107.438181799999;5145.665531740425;5257.737113144366;5573.54763903881;3129.264622813637;3703.870364537282;3783.243351329745;3802.490356364786;3823.9426408603895;3829.4064420014943;3831.3295173344554;3836.156045670004;3842.080019185439;3845.65389114981;3840.409217381701;4330.7401555906745;4335.848245311399;4405.647548196201;4445.444319460067;4215.831366745296;5313.760880760375;5340.768834854857;5363.141897296414;5365.409804921455;1228.1648479034343;1235.9011279097651;1236.486857953939;1242.9627111186678;1243.9689007774698;802.5626033811586;828.8093738440072;858.4076986879033;885.3846576629181;891.1801142948374;4109.972506873281;4237.915241695149;4635.884102897455;4639.652026098056;4642.814287428465;4979.763153949889;5223.634345595772;5233.4243233244315;5243.659162154448;5263.6315457918345;3703.370427027412;4037.9192416151513;4286.218790667081;4532.0256144928335;4649.488556258809;2347.683062786536;2422.297533715203;2626.2515183173086;2675.3579141006016;2680.32991752062;4739.938126914803;5349.5720342372515;5375.682957675394;5425.430329815392;5447.529167124854;4663.533646635377;4954.9009019819405;5066.9746651266505;5266.815661451831;5413.7834486620095;5030.773615187325;5051.898962020739;5146.511081447256;5462.726863656881;5472.151816468454;4571.954280457153;4601.032334144391;4665;4889.119958407521;5305.522502974596;4417.425734654475;5100.2349647553165;5137.460566640599;5605.439456054362;5620.4098569649595;5090.287359769562;5887.558433117448;5895.528357731286;5898.9115163273445;5901.259128557;3772.3398405279513;3808.6572208501366;3810.9237815244096;3816;3823.4264860271182;4502.774861256989;4936.555709986119;5085.135526960499;5594.86012849682;5689.630174038674;5058.570021548062;5425.728713564385;5482.616216864782;5509.283793106871;5509.283793107031;4875.7074575525585;4884.951150488591;5464.644798088111;5484.561235101262;5530.806421775219;4085.5914408558906;5330.840074797762;5331.626786124934;5394.217838413487;5396.760344457163;4901.9264711028645;5232.450592687713;5325.121354976385;5346.930613877318;5383.81156659515;4679.672422930362;5250.18622113573;5308.548773354308;5365.517103460707;5400.62195646301 09:24:55 INFO - PROCESS | 2676 | |5;yui.html;566.6118708684552;697.4106879686663;739.7299985505292;744.6872313628277;749.3218637133393;14329.283535823206;15101.471448499306;15111;15112.6977460451;15161.620959476004;13469.595912122628;13618.659533511667;13649.454021839114;13669.316534173302;13683.521076762316;647.893097638889;671.134236834483;672.6031641331614;810.3274282345668;815.612584022589;785.3952456608408;810.6757297081156;812.8374325134968;821.4783612406105;822.8107535266893;869.6304070769929;876.8071024374627;876.9079246679103;880.2737741363369;880.867869819529;687.5599616245606;709.2517394149171;865.5628907401754;871.6426265231288;874.558348034245;585.4759989809139;657.3754932813846;663.8970959501285;665.1884700665181;667.4326822201139;13758.93120534401;13806.447742090304;13810.65473363164;13819.792703109462;13830.930845345809;9784.95107524465;12733.87266127336;13037.41331640069;13042.282674452901;13236.470541178342;11791.292522448595;11913;12058.879411205864;12481.50073997039;12487.75024499514;4300.956990430087;4322.438083049215;4338.848140315105;4505.932411013838;4512.458504979423;78494.607526962;94228.52885735597;95815;96058;98586;8461.746147615582;10285.662863827803;10385;10412.375257484424;10457.68626941193;19527.414177574694;19579.510512237022;19580.412587622395;19582.216711331388;19587.80412195888;7340.96329518349;7377.3360397564475;7400.037995060716;7419.6661150248365;7597.430192735567;4161.3549899765585;4195.769232692171;4198.055437526532;4224.429701990253;4250.851220207278;3156.352947645727;3233.644299127094;3244.383567122239;3250.154959710492;3251.235959549504;611.4741322462678;628.3873223606946;629.4397985792648;640.0623087177307;649.052383520066;513.2914691355005;576.3717547872839;589.3016775121495;614.3948211012149;638.7381173718753;8415.663373464993;8786.033536311;8820.8676869847;9003.904983716746;9423.764405889908;503.2099603622351;573.4638113364018;575.3153747041091;619.5786864931889;636.7166610858217;4208.810603522848;4218.282891908383;4408.623615131276;4561.794719237642;4622.329762184464;112674;117014.41492792481;117674.23488647677;121311;122680;82154.76767848487;105338.3022939808;106718;108028.05845678406;110324.34513482304;65324.71363502255;71360.64319678368;90554;93384.59923101158;97442.51278743561;9467.479288639192;9668.758281042748;9670;9685.467299298325;9788.265880058882;48165.75917120392;56517.43482565122;57370.713146434;57497.42502575088;58615.70692146682;78568.60715696384;82061;84476;85721.57139214514;86077.56961215154;12156.209846359958;12216.26702397859;12220.083493737828;12457.937710311753;12599.87400125987;14243.21662308583;14326.283685815875;14328.426862925366;14539.41842326295;14904.403823846924;12561.120721549403;12982.675433114247;13050.201112707653;13250.204987700768;13550.5446111241;12509.74980500403;13187.274699891597;13577.456901723821;13814.329969021524;14011.929940350234;13059.412326445143;13101;13124.14693044949;13207.867921320663;13291.20252784836;11056.447177640925;11187.384693841592;11197.944010279896;11248.212625116163;11513.827292590451;11252.549898003988;11294.265872718248;11416.486258118572;11451.828222576834;11556.826647600461 09:24:55 INFO - PROCESS | 2676 | __end_tp_report 09:24:55 INFO - PROCESS | 2676 | __start_cc_report 09:24:55 INFO - PROCESS | 2676 | _x_x_mozilla_cycle_collect,1452 09:24:55 INFO - PROCESS | 2676 | __end_cc_report 09:24:55 INFO - PROCESS | 2676 | __startTimestamp1479317095684__endTimestamp 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | ------- Summary: start ------- 09:24:55 INFO - PROCESS | 2676 | Number of tests: 6 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#0] dojo.html Cycles:165 Average:5728.40 Median:5929.35 stddev:638.18 (10.8%) stddev-sans-first:610.86 09:24:55 INFO - PROCESS | 2676 | Values: 3292.6 3300.3 3316.2 3351.3 3368.5 5505.4 5591.4 5673.0 5724.7 5726.2 5597.1 5646.6 5652.2 5661.6 5680.3 5113.6 5153.6 5161.3 5180.0 5184.3 5274.0 5305.0 5305.3 5310.1 5312.4 5184.8 5215.4 5229.9 5240.4 5305.5 5287.3 5291.6 5300.7 5320.5 5348.4 5101.3 5112.1 5182.7 5225.1 5253.4 5569.6 5655.3 5669.1 5689.8 5691.0 6232.5 6236.0 6244.7 6255.8 6257.0 6127.0 6201.5 6212.7 6281.1 6325.8 5696.5 5744.5 5767.7 5772.3 5817.4 6223.5 6264.5 6267.7 6303.1 6312.0 5984.1 6114.3 6130.7 6133.6 6147.1 6107.1 6137.4 6145.9 6187.1 6246.5 5274.7 6145.5 6230.9 6240.1 6241.3 6215.4 6233.3 6248.3 6251.9 6271.2 4847.3 4892.4 4892.4 4927.8 4936.9 4329.0 4372.4 4377.0 4390.7 4441.2 5668.3 5679.8 5685.6 5691.2 5698.1 6113.8 6203.1 6225.4 6233.7 6237.4 5692.4 5727.4 5730.3 5732.1 5732.3 5333.2 5382.3 5388.9 5391.3 5395.5 6200.9 6248.5 6259.6 6261.4 6275.5 6271.3 6273.9 6290.6 6308.5 6316.2 6270.7 6276.7 6285.4 6291.8 6303.0 6026.1 6095.8 6120.9 6128.3 6208.5 6103.9 6224.4 6262.5 6264.4 6278.8 6135.1 6139.8 6140.2 6143.7 6144.9 5915.8 5937.3 6057.0 6123.1 6134.0 5808.0 5913.9 5925.3 5960.0 5977.8 6109.0 6110.0 6112.7 6139.3 6144.7 5738.4 5847.6 5929.3 5947.0 5964.8 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#1] ext.html Cycles:180 Average:62666.80 Median:37073.63 stddev:139352.87 (375.9%) stddev-sans-first:139665.42 09:24:55 INFO - PROCESS | 2676 | Values: 417.9 470.7 473.6 477.6 529.3 29831.4 31218.7 31303.4 38537.4 40006.6 40876.4 41184.0 41287.8 41372.0 41384.2 9240.0 9413.9 9425.3 9427.6 9429.6 9263.0 9370.4 9376.8 9381.5 9388.3 9332.1 9400.1 9402.6 9415.9 9431.5 9366.4 9373.9 9376.8 9389.2 9399.2 9244.0 9318.6 9322.3 9324.3 9325.9 38783.0 39232.4 39284.0 39312.2 39326.4 3214.1 3290.3 3297.2 3318.0 3624.7 24898.0 29510.3 30179.8 30294.0 30396.7 3182.9 3184.6 3186.5 3193.6 3302.4 341274.0 344705.6 345271.0 346408.3 346625.0 32452.4 54959.7 55278.2 55300.7 55337.7 33437.2 34455.0 34528.8 34685.7 34748.0 13964.9 14096.8 14098.9 14111.5 14113.8 11851.6 11920.3 11929.8 11965.4 12019.6 7665.1 7691.5 7764.7 7765.2 7769.7 3167.4 3215.8 3216.9 3222.3 3247.8 736.6 923.2 953.7 1007.7 1035.5 28440.7 28972.4 29233.6 29705.4 29718.7 976.4 993.5 1016.1 1031.8 1092.2 13370.9 13634.3 15124.5 15423.1 15462.0 622653.0 626762.0 627843.0 628579.0 629363.0 54815.9 55200.7 55216.0 55228.4 55287.4 1306.2 1338.4 1354.9 1355.8 1356.5 28388.0 28544.4 28742.0 29190.4 29209.8 47738.8 48001.0 48055.5 48206.8 48234.8 544820.0 545495.0 546757.0 546874.0 548946.0 25373.5 25670.7 25769.0 25793.9 26429.6 44227.0 44456.9 45324.3 45648.3 45882.0 36607.5 36840.8 37083.4 37152.6 38208.4 36814.0 36823.3 37063.8 38059.4 38849.7 36590.0 36820.6 37478.3 37738.8 39004.6 29341.3 31328.8 32942.8 33022.7 33095.0 19514.4 24454.9 24531.0 25244.5 25334.0 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#2] jquery.html Cycles:180 Average:34139.49 Median:389.34 stddev:96137.59 (24692.3%) stddev-sans-first:96373.71 09:24:55 INFO - PROCESS | 2676 | Values: 303.9 363.6 363.6 379.3 399.4 14922.7 15419.9 17483.4 20776.9 20794.8 19144.7 20118.4 20128.8 20149.3 20154.6 5743.7 6036.9 6048.2 6059.8 6062.2 4113.3 4195.8 4415.1 4419.8 6659.7 6673.6 6676.7 6678.2 6692.7 6700.2 6338.3 6534.6 6580.2 6581.0 6581.3 5428.5 5691.6 5702.7 5716.6 5727.7 24934.5 25442.2 25635.2 25755.7 26044.0 1925.2 2112.8 2124.8 2208.4 2714.4 9970.9 10038.4 10235.3 14742.3 15602.4 1837.9 1849.6 1870.8 1897.4 1939.0 124978.0 128077.0 130901.0 131090.3 133770.0 10996.6 11412.1 11434.5 11458.1 11612.5 14453.2 14530.9 14537.3 14575.3 14585.3 6634.5 8072.3 8313.0 8329.7 8461.8 8161.8 8173.1 8207.5 8345.9 8417.8 4377.3 4496.4 4507.7 4568.6 4606.8 1681.3 1810.4 1827.2 1880.9 1887.3 728.0 759.9 778.5 822.9 888.2 20277.2 20791.8 20855.0 20948.0 20973.0 894.3 925.6 943.8 951.9 953.6 9146.0 10443.6 11010.8 11019.0 11077.7 565517.0 567236.0 569628.0 581421.0 582196.0 102777.0 128306.0 129085.1 129601.0 131961.0 919.2 931.9 959.2 961.6 962.1 14719.4 19032.9 19048.2 19250.5 19294.2 41818.0 45169.2 48481.5 56996.4 57370.4 59519.0 76258.6 77221.5 77767.6 77956.0 6101.8 6914.0 7277.6 7330.2 7435.7 8193.9 10254.4 11908.3 12930.9 12973.3 8792.3 9127.2 10513.2 10765.8 11143.8 10416.3 10697.6 10713.6 11068.6 11154.3 10841.5 11279.5 11365.0 11438.9 11487.8 6840.8 7231.0 7453.1 7531.8 7693.7 9006.3 9071.4 9945.9 10730.4 10907.6 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#3] mootools.html Cycles:180 Average:5409.03 Median:5126.15 stddev:2980.55 (58.1%) stddev-sans-first:2974.16 09:24:55 INFO - PROCESS | 2676 | Values: 1462.6 1493.5 1634.2 1755.7 1805.9 8009.3 8411.1 8423.3 8447.4 8448.6 7418.7 7701.6 7733.0 7768.6 7781.3 2063.9 2097.6 2206.6 2282.3 2286.3 2301.7 2304.3 2304.4 2312.6 2312.8 1951.9 2207.4 2275.8 2281.4 2283.4 2242.2 2248.7 2265.4 2272.5 2275.4 1882.4 2258.0 2263.7 2284.1 2291.6 7720.5 7749.9 8255.3 8266.2 8371.0 4959.2 5124.3 5126.7 5130.2 5132.4 3285.3 3453.5 3472.2 3551.4 3563.9 1011.8 1038.3 1059.9 1065.6 1071.4 10905.3 10964.4 10981.0 10990.5 11000.3 4286.2 4546.6 4639.1 4664.7 4670.4 9332.0 9349.1 9350.1 9362.0 9371.6 5125.6 5129.4 5133.8 5141.8 5143.2 4554.4 4691.2 4717.4 4749.4 4754.4 3439.4 3572.0 3572.8 3590.8 3591.5 1166.9 1182.6 1203.3 1239.7 1252.1 819.8 820.7 857.3 858.4 879.7 5452.5 5494.3 5609.9 5773.1 5819.0 872.5 955.5 982.2 997.2 1013.9 3674.4 3690.4 3692.0 3781.1 3808.2 9730.5 10007.8 10161.6 10189.1 10202.0 9493.6 9863.6 10118.7 10125.2 10131.1 7581.8 7786.6 7826.2 7827.6 7832.7 5486.9 5491.6 5556.3 5710.3 5838.1 9274.7 9305.3 9313.9 9464.0 9507.3 9265.0 9484.8 9545.0 9679.0 9684.4 7043.6 7059.8 7173.3 7244.2 7246.9 7724.3 7800.5 7817.5 7820.9 7829.0 6775.6 7032.6 7061.4 7078.5 7128.7 6936.3 6960.3 6997.8 7074.0 7170.7 6580.2 6587.1 6685.1 6686.5 6690.7 4708.7 4750.5 4793.6 4816.4 4894.6 4807.1 4818.1 4847.1 4890.7 4931.0 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#4] prototype.html Cycles:180 Average:4275.18 Median:4664.27 stddev:1295.29 (27.8%) stddev-sans-first:1264.08 09:24:55 INFO - PROCESS | 2676 | Values: 299.1 301.3 309.1 311.1 316.3 4562.8 5001.5 5089.7 5125.8 5148.8 4728.3 4938.9 4940.4 5026.5 5186.6 3874.8 3880.8 3929.3 3934.3 3940.4 3890.4 3914.1 3916.5 3917.3 3924.4 3781.7 3880.8 3883.3 3892.7 3899.3 3230.9 3719.8 3894.9 3929.2 3957.3 3382.9 3402.4 3406.9 3438.5 3463.6 4252.8 4944.5 4950.3 4969.6 4974.9 4271.2 4427.5 4464.7 4470.2 4485.4 4468.8 4678.0 5212.1 5367.0 5397.5 3057.0 3666.6 3678.2 3736.1 3795.2 4342.6 5107.4 5145.7 5257.7 5573.5 3129.3 3703.9 3783.2 3802.5 3823.9 3829.4 3831.3 3836.2 3842.1 3845.7 3840.4 4330.7 4335.8 4405.6 4445.4 4215.8 5313.8 5340.8 5363.1 5365.4 1228.2 1235.9 1236.5 1243.0 1244.0 802.6 828.8 858.4 885.4 891.2 4110.0 4237.9 4635.9 4639.7 4642.8 4979.8 5223.6 5233.4 5243.7 5263.6 3703.4 4037.9 4286.2 4532.0 4649.5 2347.7 2422.3 2626.3 2675.4 2680.3 4739.9 5349.6 5375.7 5425.4 5447.5 4663.5 4954.9 5067.0 5266.8 5413.8 5030.8 5051.9 5146.5 5462.7 5472.2 4572.0 4601.0 4665.0 4889.1 5305.5 4417.4 5100.2 5137.5 5605.4 5620.4 5090.3 5887.6 5895.5 5898.9 5901.3 3772.3 3808.7 3810.9 3816.0 3823.4 4502.8 4936.6 5085.1 5594.9 5689.6 5058.6 5425.7 5482.6 5509.3 5509.3 4875.7 4885.0 5464.6 5484.6 5530.8 4085.6 5330.8 5331.6 5394.2 5396.8 4901.9 5232.5 5325.1 5346.9 5383.8 4679.7 5250.2 5308.5 5365.5 5400.6 09:24:55 INFO - PROCESS | 2676 | 09:24:55 INFO - PROCESS | 2676 | [#5] yui.html Cycles:180 Average:21393.76 Median:4330.64 stddev:32071.86 (740.6%) stddev-sans-first:32123.70 09:24:55 INFO - PROCESS | 2676 | Values: 566.6 697.4 739.7 744.7 749.3 14329.3 15101.5 15111.0 15112.7 15161.6 13469.6 13618.7 13649.5 13669.3 13683.5 647.9 671.1 672.6 810.3 815.6 785.4 810.7 812.8 821.5 822.8 869.6 876.8 876.9 880.3 880.9 687.6 709.3 865.6 871.6 874.6 585.5 657.4 663.9 665.2 667.4 13758.9 13806.4 13810.7 13819.8 13830.9 9785.0 12733.9 13037.4 13042.3 13236.5 11791.3 11913.0 12058.9 12481.5 12487.8 4301.0 4322.4 4338.8 4505.9 4512.5 78494.6 94228.5 95815.0 96058.0 98586.0 8461.7 10285.7 10385.0 10412.4 10457.7 19527.4 19579.5 19580.4 19582.2 19587.8 7341.0 7377.3 7400.0 7419.7 7597.4 4161.4 4195.8 4198.1 4224.4 4250.9 3156.4 3233.6 3244.4 3250.2 3251.2 611.5 628.4 629.4 640.1 649.1 513.3 576.4 589.3 614.4 638.7 8415.7 8786.0 8820.9 9003.9 9423.8 503.2 573.5 575.3 619.6 636.7 4208.8 4218.3 4408.6 4561.8 4622.3 112674.0 117014.4 117674.2 121311.0 122680.0 82154.8 105338.3 106718.0 108028.1 110324.3 65324.7 71360.6 90554.0 93384.6 97442.5 9467.5 9668.8 9670.0 9685.5 9788.3 48165.8 56517.4 57370.7 57497.4 58615.7 78568.6 82061.0 84476.0 85721.6 86077.6 12156.2 12216.3 12220.1 12457.9 12599.9 14243.2 14326.3 14328.4 14539.4 14904.4 12561.1 12982.7 13050.2 13250.2 13550.5 12509.7 13187.3 13577.5 13814.3 14011.9 13059.4 13101.0 13124.1 13207.9 13291.2 11056.4 11187.4 11197.9 11248.2 11513.8 11252.5 11294.3 11416.5 11451.8 11556.8 09:24:55 INFO - PROCESS | 2676 | -------- Summary: end -------- 09:24:55 INFO - PROCESS | 2676 | 09:24:56 INFO - TEST-INFO | 2676: exit 0 09:24:56 INFO - TEST-OK | dromaeo_css | took 1119556ms 09:24:56 INFO - TEST-START | kraken 09:24:56 INFO - operating with platform_type : mac_ 09:24:56 INFO - Initialising browser for kraken test... 09:24:56 INFO - TEST-INFO | started process 2680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZtuWtZ/profile http://localhost:56590/getInfo.html) 09:24:58 INFO - PROCESS | 2680 | __metrics Screen width/height:1600/1200 09:24:58 INFO - PROCESS | 2680 | colorDepth:24 09:24:58 INFO - PROCESS | 2680 | Browser inner width/height: 1024/689 09:24:58 INFO - PROCESS | 2680 | __metrics 09:24:58 INFO - PROCESS | 2680 | 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" 09:24:58 INFO - PROCESS | 2680 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:59 INFO - TEST-INFO | 2680: exit 0 09:24:59 INFO - Browser initialized. 09:24:59 INFO - Running cycle 1/1 for kraken test... 09:24:59 INFO - TEST-INFO | started process 2681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZtuWtZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:11 INFO - PROCESS | 2681 | RSS: Main: 230907904 09:25:11 INFO - PROCESS | 2681 | 09:25:14 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56590/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:15 INFO - PROCESS | 2681 | RSS: Main: 290611200 09:25:15 INFO - PROCESS | 2681 | 09:25:17 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56590/tests/kraken/driver.html?testName=audio-dft) 09:25:18 INFO - PROCESS | 2681 | RSS: Main: 291921920 09:25:18 INFO - PROCESS | 2681 | 09:25:22 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56590/tests/kraken/driver.html?testName=audio-fft) 09:25:22 INFO - PROCESS | 2681 | RSS: Main: 380338176 09:25:22 INFO - PROCESS | 2681 | 09:25:24 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56590/tests/kraken/driver.html?testName=audio-oscillator) 09:25:25 INFO - PROCESS | 2681 | RSS: Main: 281563136 09:25:25 INFO - PROCESS | 2681 | 09:25:27 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:27 INFO - PROCESS | 2681 | RSS: Main: 287608832 09:25:27 INFO - PROCESS | 2681 | 09:25:30 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56590/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:31 INFO - PROCESS | 2681 | RSS: Main: 330493952 09:25:31 INFO - PROCESS | 2681 | 09:25:34 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56590/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:34 INFO - PROCESS | 2681 | RSS: Main: 330924032 09:25:34 INFO - PROCESS | 2681 | 09:25:37 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56590/tests/kraken/driver.html?testName=json-parse-financial) 09:25:38 INFO - PROCESS | 2681 | RSS: Main: 327958528 09:25:38 INFO - PROCESS | 2681 | 09:25:40 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:40 INFO - PROCESS | 2681 | RSS: Main: 303853568 09:25:40 INFO - PROCESS | 2681 | 09:25:42 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:43 INFO - PROCESS | 2681 | RSS: Main: 306589696 09:25:43 INFO - PROCESS | 2681 | 09:25:45 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:46 INFO - PROCESS | 2681 | RSS: Main: 308711424 09:25:46 INFO - PROCESS | 2681 | 09:25:49 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:50 INFO - PROCESS | 2681 | RSS: Main: 327196672 09:25:50 INFO - PROCESS | 2681 | 09:25:53 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:53 INFO - PROCESS | 2681 | RSS: Main: 321286144 09:25:53 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | Cycle 1(1): loaded http://localhost:56590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56590/tests/kraken/driver.html?testName=ai-astar) 09:25:55 INFO - PROCESS | 2681 | RSS: Main: 365490176 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | __start_tp_report 09:25:55 INFO - PROCESS | 2681 | _x_x_mozilla_page_load 09:25:55 INFO - PROCESS | 2681 | _x_x_mozilla_page_load_details 09:25:55 INFO - PROCESS | 2681 | |i|pagename|runs| 09:25:55 INFO - PROCESS | 2681 | |0;ai-astar;104;112;114;119;164;161;114;114;113;114 09:25:55 INFO - PROCESS | 2681 | |1;audio-beat-detection;171;114;112;148;113;113;115;117;142;111 09:25:55 INFO - PROCESS | 2681 | |2;audio-dft;187;183;187;186;186;186;185;182;181;195 09:25:55 INFO - PROCESS | 2681 | |3;audio-fft;86;60;58;89;60;59;59;58;83;59 09:25:55 INFO - PROCESS | 2681 | |4;audio-oscillator;87;71;92;69;68;69;89;67;69;93 09:25:55 INFO - PROCESS | 2681 | |5;imaging-gaussian-blur;88;84;88;84;87;84;88;85;87;83 09:25:55 INFO - PROCESS | 2681 | |6;imaging-darkroom;93;93;93;93;103;93;93;94;92;92 09:25:55 INFO - PROCESS | 2681 | |7;imaging-desaturate;71;126;130;139;84;87;86;85;84;85 09:25:55 INFO - PROCESS | 2681 | |8;json-parse-financial;57;52;53;75;86;56;54;54;55;54 09:25:55 INFO - PROCESS | 2681 | |9;json-stringify-tinderbox;66;69;71;80;76;72;72;71;71;74 09:25:55 INFO - PROCESS | 2681 | |10;stanford-crypto-aes;88;95;107;76;102;108;109;109;103;88 09:25:55 INFO - PROCESS | 2681 | |11;stanford-crypto-ccm;151;147;152;160;160;153;150;149;189;164 09:25:55 INFO - PROCESS | 2681 | |12;stanford-crypto-pbkdf2;172;176;186;240;193;175;173;173;173;172 09:25:55 INFO - PROCESS | 2681 | |13;stanford-crypto-sha256-iterative;60;79;89;70;67;67;67;66;66;65 09:25:55 INFO - PROCESS | 2681 | __end_tp_report 09:25:55 INFO - PROCESS | 2681 | __start_cc_report 09:25:55 INFO - PROCESS | 2681 | _x_x_mozilla_cycle_collect,1997 09:25:55 INFO - PROCESS | 2681 | __end_cc_report 09:25:55 INFO - PROCESS | 2681 | __startTimestamp1479317155787__endTimestamp 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | ------- Summary: start ------- 09:25:55 INFO - PROCESS | 2681 | Number of tests: 14 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#0] ai-astar Cycles:10 Average:122.90 Median:114.00 stddev:21.21 (18.6%) stddev-sans-first:21.36 09:25:55 INFO - PROCESS | 2681 | Values: 104.0 112.0 114.0 119.0 164.0 161.0 114.0 114.0 113.0 114.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:116.00 stddev:20.73 (17.9%) stddev-sans-first:14.05 09:25:55 INFO - PROCESS | 2681 | Values: 171.0 114.0 112.0 148.0 113.0 113.0 115.0 117.0 142.0 111.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.00 stddev:3.85 (2.1%) stddev-sans-first:4.06 09:25:55 INFO - PROCESS | 2681 | Values: 187.0 183.0 187.0 186.0 186.0 186.0 185.0 182.0 181.0 195.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#3] audio-fft Cycles:10 Average:67.10 Median:60.00 stddev:13.14 (21.9%) stddev-sans-first:12.02 09:25:55 INFO - PROCESS | 2681 | Values: 86.0 60.0 58.0 89.0 60.0 59.0 59.0 58.0 83.0 59.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.00 stddev:11.22 (14.2%) stddev-sans-first:11.35 09:25:55 INFO - PROCESS | 2681 | Values: 87.0 71.0 92.0 69.0 68.0 69.0 89.0 67.0 69.0 93.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.99 (2.3%) stddev-sans-first:1.94 09:25:55 INFO - PROCESS | 2681 | Values: 88.0 84.0 88.0 84.0 87.0 84.0 88.0 85.0 87.0 83.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:93.00 stddev:3.25 (3.5%) stddev-sans-first:3.43 09:25:55 INFO - PROCESS | 2681 | Values: 93.0 93.0 93.0 93.0 103.0 93.0 93.0 94.0 92.0 92.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:84.50 stddev:24.06 (28.5%) stddev-sans-first:23.51 09:25:55 INFO - PROCESS | 2681 | Values: 71.0 126.0 130.0 139.0 84.0 87.0 86.0 85.0 84.0 85.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:55.50 stddev:11.40 (20.5%) stddev-sans-first:12.06 09:25:55 INFO - PROCESS | 2681 | Values: 57.0 52.0 53.0 75.0 86.0 56.0 54.0 54.0 55.0 54.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.82 (5.3%) stddev-sans-first:3.33 09:25:55 INFO - PROCESS | 2681 | Values: 66.0 69.0 71.0 80.0 76.0 72.0 72.0 71.0 71.0 74.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:92.50 stddev:11.33 (12.2%) stddev-sans-first:11.36 09:25:55 INFO - PROCESS | 2681 | Values: 88.0 95.0 107.0 76.0 102.0 108.0 109.0 109.0 103.0 88.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:156.50 stddev:12.38 (7.9%) stddev-sans-first:12.90 09:25:55 INFO - PROCESS | 2681 | Values: 151.0 147.0 152.0 160.0 160.0 153.0 150.0 149.0 189.0 164.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:175.50 stddev:21.11 (12.0%) stddev-sans-first:21.99 09:25:55 INFO - PROCESS | 2681 | Values: 172.0 176.0 186.0 240.0 193.0 175.0 173.0 173.0 173.0 172.0 09:25:55 INFO - PROCESS | 2681 | 09:25:55 INFO - PROCESS | 2681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:67.00 stddev:8.33 (12.4%) stddev-sans-first:8.08 09:25:55 INFO - PROCESS | 2681 | Values: 60.0 79.0 89.0 70.0 67.0 67.0 67.0 66.0 66.0 65.0 09:25:55 INFO - PROCESS | 2681 | -------- Summary: end -------- 09:25:55 INFO - PROCESS | 2681 | 09:25:56 INFO - TEST-INFO | 2681: exit 0 09:25:56 INFO - TEST-OK | kraken | took 60393ms 09:25:56 INFO - SUITE-END | took 1179s 09:25:56 INFO - Completed test suite (00:19:40) 09:25:56 INFO - javascript benchmark 09:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.5555050068247, 3300.2904375559256, 3316.237265428951, 3351.257346179988, 3368.5115658229556, 5505.449455054492, 5591.384947655754, 5673.0, 5724.685142317171, 5726.198332233485, 5597.104463285875, 5646.604737668365, 5652.236948012017, 5661.631993920402, 5680.261565996425, 5113.616478764098, 5153.639245252815, 5161.27742116104, 5180.0, 5184.326037615105, 5273.971575542771, 5304.973475132639, 5305.336832895888, 5310.07073762092, 5312.389075256337, 5184.844454666366, 5215.374155101393, 5229.8954020919555, 5240.423553409122, 5305.469453054702, 5287.286216360781, 5291.550218231436, 5300.708461034642, 5320.547753440962, 5348.384935732402, 5101.311322971388, 5112.079825631385, 5182.689038657692, 5225.137852254374, 5253.369595648508, 5569.637973531708, 5655.349634791969, 5669.121286200645, 5689.772409103631, 5690.971545142248, 6232.470240029603, 6235.971064774307, 6244.656543890084, 6255.78104766331, 6257.030160325156, 6126.956114243554, 6201.5348848836065, 6212.65830379329, 6281.089242059921, 6325.778597749103, 5696.458836410535, 5744.51171650406, 5767.711614419304, 5772.278465191851, 5817.38917413674, 6223.471004964538, 6264.498840092781, 6267.655278959701, 6303.149074874833, 6312.021636646327, 5984.1323008164445, 6114.296855861544, 6130.724117414727, 6133.631982081, 6147.108669242934, 6107.083937409336, 6137.438273608292, 6145.893739126911, 6187.071939209155, 6246.531510136758, 5274.709890955957, 6145.508359331332, 6230.937690623126, 6240.095186197976, 6241.34465881085, 6215.409536094064, 6233.3143354231, 6248.281447633581, 6251.874962500725, 6271.216097987752, 4847.2729090636685, 4892.363992680928, 4892.437369702529, 4927.802887884516, 4936.925946110811, 4328.978355108267, 4372.3878656988045, 4376.956230437719, 4390.736555806662, 4441.222786012435, 5668.348139963957, 5679.801206957736, 5685.602007859493, 5691.174779656926, 5698.116791897262, 6113.755449781959, 6203.100550420164, 6225.408586184305, 6233.688315584202, 6237.407446292595, 5692.402297758676, 5727.398623144593, 5730.255066841284, 5732.140178973187, 5732.283464566929, 5333.200019996954, 5382.30030096085, 5388.892222155535, 5391.32608423947, 5395.514403703607, 6200.914839903089, 6248.500119990299, 6259.624422534663, 6261.405166509175, 6275.497960163176, 6271.3415091414745, 6273.9372606273355, 6290.591111577733, 6308.495320374267, 6316.242050953915, 6270.686465676789, 6276.6547839869245, 6285.402886725754, 6291.842703932438, 6303.023031430135, 6026.096085587197, 6095.786647467317, 6120.9347721082095, 6128.325884152829, 6208.472279856082, 6103.938960610515, 6224.439800417984, 6262.4990000800735, 6264.436200741773, 6278.811635650938, 6135.110408990582, 6139.754409823557, 6140.201773769381, 6143.6928153593035, 6144.938550614436, 5915.822525324247, 5937.3468918418075, 6057.030875060145, 6123.112148738319, 6134.04922237054, 5808.041673123887, 5913.91129133072, 5925.288965324189, 5959.970200148971, 5977.790777322773, 6108.961476548909, 6109.969450152721, 6112.724927378367, 6139.26328840542, 6144.662043587646, 5738.397468265772, 5847.5906686533235, 5929.347771745191, 5947.04847224442, 5964.761409543743], "value": 5686.620822941176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.91432756284956, 470.6705306285599, 473.64476642518133, 477.58927322502643, 529.3330403691348, 29831.403371932574, 31218.687813121862, 31303.373932521365, 38537.42193867087, 40006.59976900809, 40876.38685419721, 41183.97040073992, 41287.79356103215, 41372.0, 41384.172316553726, 9239.953800231006, 9413.905860941371, 9425.293103017268, 9427.622895084189, 9429.622815087389, 9262.953685231565, 9370.39092458988, 9376.81246375072, 9381.484018378986, 9388.342816002883, 9332.113449222346, 9400.106989835955, 9402.62389504419, 9415.858762118574, 9431.481268530228, 9366.438013719164, 9373.859392109056, 9376.812463750755, 9389.248860091244, 9399.248060155205, 9243.953780231055, 9318.580663870142, 9322.25421966241, 9324.300677449219, 9325.906740932573, 38783.0, 39232.41151382731, 39284.0, 39312.21375572501, 39326.410103848466, 3214.148250713563, 3290.276139249361, 3297.159224397787, 3317.9668203318142, 3624.72814538908, 24898.0, 29510.26224344387, 30179.849100754574, 30294.0, 30396.696033039607, 3182.9363412731846, 3184.601924759405, 3186.522021696741, 3193.552902593639, 3302.3725492156414, 341274.0, 344705.55294447235, 345271.0, 346408.26795866113, 346625.0, 32452.350952980807, 54959.72520137374, 55278.17082743762, 55300.72349638226, 55337.72331138399, 33437.16407089842, 34455.0, 34528.82735586306, 34685.65314346875, 34748.0, 13964.860351396559, 14096.788548171786, 14098.929505352407, 14111.518290579546, 14113.78829317561, 11851.585194518151, 11920.344381059125, 11929.761404771856, 11965.40172991347, 12019.579314723942, 7665.118511371152, 7691.50005249657, 7764.689412423553, 7765.22347765219, 7769.72805951789, 3167.4298626247037, 3215.839208039589, 3216.903492895217, 3222.258880457508, 3247.8376081195847, 736.5507040705165, 923.1691477670016, 953.6519170502717, 1007.6573964851985, 1035.5495359518634, 28440.715592843808, 28972.42055158927, 29233.561496577568, 29705.405891882474, 29718.702812972027, 976.4092723902079, 993.4858264671694, 1016.1058268723476, 1031.83490641497, 1092.180864351736, 13370.859277708592, 13634.318284085954, 15124.470643527644, 15423.074615523105, 15461.994970326892, 622653.0, 626762.0, 627843.0, 628579.0, 629363.0, 54815.90368192614, 55200.72399637976, 55216.0, 55228.44771552233, 55287.447125529034, 1306.2162702378496, 1338.43785610044, 1354.8645135486768, 1355.7695191817415, 1356.531996461239, 28388.0, 28544.42911141807, 28742.0, 29190.41619167647, 29209.831606735494, 47738.806529835645, 48001.0, 48055.5194448065, 48206.75896620494, 48234.75882620705, 544820.0, 545495.0, 546757.0, 546874.0, 548946.0, 25373.492530149662, 25670.743292566836, 25769.0, 25793.87103064473, 26429.60355594629, 44227.0, 44456.888577785816, 45324.32013519734, 45648.31527527156, 45882.0, 36607.45088823616, 36840.81579592085, 37083.443748343256, 37152.628473715995, 38208.42687359636, 36814.0, 36823.26353472862, 37063.81468092642, 38059.42910856395, 38849.726530081105, 36590.0, 36820.63179368279, 37478.2504349906, 37738.81130594439, 39004.609953901236, 29341.26646833761, 31328.843355783985, 32942.835285823414, 33022.66977330196, 33095.007149785546, 19514.414567562995, 24454.87772561126, 24531.0, 25244.49511009806, 25334.0], "value": 17773.570666337226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8769298434135, 363.60367199752284, 363.6399964035605, 379.2680127354206, 399.4168513969604, 14922.701545969074, 15419.922900385496, 17483.388081417135, 20776.896115519437, 20794.792052079476, 19144.712829307573, 20118.396448106545, 20128.79871201291, 20149.29477468289, 20154.59690806183, 5743.684097374653, 6036.939630603703, 6048.1834952281315, 6059.818205453821, 6062.18160548327, 4113.321301985169, 4195.769232692201, 4415.072834704716, 4419.779011049451, 6659.667016649172, 6673.566218195826, 6676.699548520328, 6678.198616166067, 6692.657569850538, 6700.229473610524, 6338.3027866934835, 6534.60792352458, 6580.210374755012, 6580.967095164541, 6581.308962558958, 5428.511433970962, 5691.630044047165, 5702.686352250625, 5716.628419152742, 5727.742251598688, 24934.50130997388, 25442.236732898044, 25635.180130185665, 25755.742442575523, 26043.95824167031, 1925.2491528303972, 2112.767595564487, 2124.7662757096705, 2208.3706143749114, 2714.429969706364, 9970.903200647923, 10038.397696138256, 10235.334703244265, 14742.262886855615, 15602.43975602442, 1837.9264829406807, 1849.5838436351848, 1870.7661542307212, 1897.3928342930267, 1938.9709154362695, 124978.0, 128077.0, 130901.0, 131090.34454827665, 133770.0, 10996.615118470816, 11412.144089193343, 11434.485448154854, 11458.083353331713, 11612.535498580131, 14453.205073720836, 14530.85469145295, 14537.345819438151, 14575.271236438135, 14585.343659535347, 6634.535582509275, 8072.273495385326, 8312.958435207785, 8329.708460203863, 8461.830763384698, 8161.7551473454705, 8173.141820108922, 8207.507549547046, 8345.874811877828, 8417.831643367099, 4377.289557164077, 4496.39298694672, 4507.684462087688, 4568.588827005519, 4606.769661516911, 1681.3358723304227, 1810.4297146398842, 1827.1777700035038, 1880.9059547022594, 1887.311131437043, 727.9818004549822, 759.8708219602681, 778.5445514374154, 822.9012518497699, 888.1651247827022, 20277.18891244363, 20791.792082078984, 20855.0, 20948.0, 20973.0, 894.3158483759929, 925.5973651461636, 943.7546237978038, 951.8619800128943, 953.5994882149375, 9146.0, 10443.634472793416, 11010.834837477445, 11019.008289254005, 11077.667669969915, 565517.0, 567236.0, 569628.0, 581421.0, 582196.0, 102777.0, 128306.0, 129085.06372404422, 129601.0, 131961.02058469132, 919.2048877720723, 931.8695382646434, 959.203860795538, 961.5576834656136, 962.1100482054072, 14719.411223550938, 19032.904835475732, 19048.238070477026, 19250.518737031685, 19294.22823087117, 41818.0, 45169.19323227034, 48481.5151848477, 56996.430035700774, 57370.426295736506, 59519.0, 76258.61870690611, 77221.45557088939, 77767.61116194383, 77956.0, 6101.816945491642, 6914.0, 7277.59973201479, 7330.230325815713, 7435.7025718970635, 8193.877091843508, 10254.436006019741, 11908.285502869856, 12930.870691293343, 12973.286469244282, 8792.34057445707, 9127.178553930178, 10513.158947284352, 10765.815760266521, 11143.777124457303, 10416.32293900894, 10697.625583104555, 10713.57145714194, 11068.612598559012, 11154.274972126786, 10841.457927103456, 11279.492422840827, 11364.977152056355, 11438.885611143782, 11487.8276825846, 6840.794776156723, 7230.9638451807405, 7453.105627324756, 7531.774046778605, 7693.692252309845, 9006.324525660471, 9071.410358326688, 9945.850812237677, 10730.356178629307, 10907.563697452013], "value": 9292.61959756921, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.5685422800273, 1493.469818214534, 1634.2237437217323, 1755.683976884162, 1805.9367922122728, 8009.319207867331, 8411.116832732552, 8423.326133909288, 8447.408681392306, 8448.57757112145, 7418.740344087958, 7701.614919254043, 7732.96133519333, 7768.572728499945, 7781.2996830285265, 2063.9277625283116, 2097.6329142400095, 2206.6028114939304, 2282.349530383841, 2286.2569664858906, 2301.7468078511433, 2304.2971893572453, 2304.412374844412, 2312.583734927712, 2312.8034117100065, 1951.8581629746616, 2207.415035015722, 2275.8065564427043, 2281.3840263128945, 2283.4291427143216, 2242.237639202671, 2248.6964259824877, 2265.3543740034092, 2272.488690044743, 2275.3515248154195, 1882.397632757518, 2257.9887100564392, 2263.7170353705787, 2284.1320298286546, 2291.576058429196, 7720.459567830254, 7749.883751743729, 8255.339572834158, 8266.173382661686, 8370.958145209295, 4959.206526955706, 5124.256982737519, 5126.6923984561045, 5130.179171332569, 5132.409772876093, 3285.2772390074147, 3453.533772940671, 3472.166679996808, 3551.4317709166667, 3563.9109022274392, 1011.8077565262577, 1038.256523877421, 1059.947002649872, 1065.6430095917876, 1071.405370019639, 10905.291156074909, 10964.396958167377, 10981.0, 10990.505427255714, 11000.284981476258, 4286.164197981426, 4546.590806827401, 4639.118567472237, 4664.65015123867, 4670.416197975253, 9332.0, 9349.111834375723, 9350.064993500731, 9361.953190234006, 9371.62513499466, 5125.615578831603, 5129.358830146231, 5133.794648214104, 5141.845744627667, 5143.202803565453, 4554.3851580036935, 4691.249400095969, 4717.433907931001, 4749.430068391746, 4754.429468463806, 3439.4324936385215, 3571.982140089283, 3572.7677700949357, 3590.8329792816917, 3591.4612808078473, 1166.9183157178916, 1182.6215611004395, 1203.3080978437433, 1239.7230852222046, 1252.123513540507, 819.8032472206628, 820.659426338063, 857.34413173922, 858.3819649852096, 879.6569337958201, 5452.536534394541, 5494.313210848644, 5609.915851262234, 5773.134029895466, 5819.039858423313, 872.4677946452658, 955.4888134847962, 982.1651596143221, 997.1773287038222, 1013.9138173255355, 3674.356987527172, 3690.409534474525, 3691.9815400922826, 3781.0925377909653, 3808.2383523295453, 9730.464824434583, 10007.849882251772, 10161.644342447978, 10189.133923616428, 10202.030807073315, 9493.620255189853, 9863.556139973718, 10118.696439106838, 10125.177468055821, 10131.138853197413, 7581.810454738566, 7786.610669466504, 7826.178251283533, 7827.569483678339, 7832.686692532349, 5486.91769623448, 5491.643043202179, 5556.333240011225, 5710.2696128522, 5838.12428135783, 9274.675386361445, 9305.348625596414, 9313.906860931304, 9463.952680236554, 9507.286953478379, 9265.027172147096, 9484.762880928032, 9545.0454954504, 9679.032096790264, 9684.41893486393, 7043.577385356895, 7059.752908648173, 7173.282671732994, 7244.203137654959, 7246.927530724625, 7724.266194711493, 7800.492967957065, 7817.452778305692, 7820.882686759817, 7828.960855195687, 6775.644871025716, 7032.613206273704, 7061.399781018466, 7078.504504684623, 7128.714851406093, 6936.271691472322, 6960.269171737097, 6997.755078572225, 7074.0, 7170.677319520739, 6580.21037475506, 6587.143671322698, 6685.09751183584, 6686.53194276396, 6690.732370705117, 4708.741019243975, 4750.548697873696, 4793.592544633745, 4816.397950256218, 4894.559489645949, 4807.086653535817, 4818.084563932842, 4847.127517046965, 4890.731009794496, 4930.975345123252], "value": 4375.325678122448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.11163843385145, 301.30248474780865, 309.0743224043988, 311.1334932213785, 316.2930849551254, 4562.7642455196965, 5001.549860512553, 5089.694618322898, 5125.8462246132585, 5148.794048238071, 4728.267118596615, 4938.925916111261, 4940.431850337212, 5026.547610715035, 5186.611004174692, 3874.764571582725, 3880.7865567393783, 3929.3123703351944, 3934.3311637021775, 3940.4286378475103, 3890.3580909149955, 3914.099757055879, 3916.4908561886914, 3917.275304068742, 3924.3721004639265, 3781.7163712721517, 3880.844766209348, 3883.26218018577, 3892.70804689648, 3899.337112690849, 3230.8707651693903, 3719.758215715983, 3894.8636797711943, 3929.2337994091163, 3957.3272543667645, 3382.883648396048, 3402.42158832999, 3406.914827129317, 3438.5186073949667, 3463.5670541182353, 4252.808623611914, 4944.505549445063, 4950.257461380786, 4969.627277954168, 4974.90050198994, 4271.209826182135, 4427.4908385535755, 4464.665150113755, 4470.195364834329, 4485.439320084989, 4468.827132735762, 4677.953220467786, 5212.087884620177, 5367.007103685831, 5397.514223719845, 3056.9541456878164, 3666.5600127984812, 3678.172411207457, 3736.1220113273357, 3795.1650636859845, 4342.609165175149, 5107.438181799999, 5145.665531740425, 5257.737113144366, 5573.54763903881, 3129.264622813637, 3703.870364537282, 3783.243351329745, 3802.490356364786, 3823.9426408603895, 3829.4064420014943, 3831.3295173344554, 3836.156045670004, 3842.080019185439, 3845.65389114981, 3840.409217381701, 4330.7401555906745, 4335.848245311399, 4405.647548196201, 4445.444319460067, 4215.831366745296, 5313.760880760375, 5340.768834854857, 5363.141897296414, 5365.409804921455, 1228.1648479034343, 1235.9011279097651, 1236.486857953939, 1242.9627111186678, 1243.9689007774698, 802.5626033811586, 828.8093738440072, 858.4076986879033, 885.3846576629181, 891.1801142948374, 4109.972506873281, 4237.915241695149, 4635.884102897455, 4639.652026098056, 4642.814287428465, 4979.763153949889, 5223.634345595772, 5233.4243233244315, 5243.659162154448, 5263.6315457918345, 3703.370427027412, 4037.9192416151513, 4286.218790667081, 4532.0256144928335, 4649.488556258809, 2347.683062786536, 2422.297533715203, 2626.2515183173086, 2675.3579141006016, 2680.32991752062, 4739.938126914803, 5349.5720342372515, 5375.682957675394, 5425.430329815392, 5447.529167124854, 4663.533646635377, 4954.9009019819405, 5066.9746651266505, 5266.815661451831, 5413.7834486620095, 5030.773615187325, 5051.898962020739, 5146.511081447256, 5462.726863656881, 5472.151816468454, 4571.954280457153, 4601.032334144391, 4665.0, 4889.119958407521, 5305.522502974596, 4417.425734654475, 5100.2349647553165, 5137.460566640599, 5605.439456054362, 5620.4098569649595, 5090.287359769562, 5887.558433117448, 5895.528357731286, 5898.9115163273445, 5901.259128557, 3772.3398405279513, 3808.6572208501366, 3810.9237815244096, 3816.0, 3823.4264860271182, 4502.774861256989, 4936.555709986119, 5085.135526960499, 5594.86012849682, 5689.630174038674, 5058.570021548062, 5425.728713564385, 5482.616216864782, 5509.283793106871, 5509.283793107031, 4875.7074575525585, 4884.951150488591, 5464.644798088111, 5484.561235101262, 5530.806421775219, 4085.5914408558906, 5330.840074797762, 5331.626786124934, 5394.217838413487, 5396.760344457163, 4901.9264711028645, 5232.450592687713, 5325.121354976385, 5346.930613877318, 5383.81156659515, 4679.672422930362, 5250.18622113573, 5308.548773354308, 5365.517103460707, 5400.62195646301], "value": 3868.050080476206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6118708684552, 697.4106879686663, 739.7299985505292, 744.6872313628277, 749.3218637133393, 14329.283535823206, 15101.471448499306, 15111.0, 15112.6977460451, 15161.620959476004, 13469.595912122628, 13618.659533511667, 13649.454021839114, 13669.316534173302, 13683.521076762316, 647.893097638889, 671.134236834483, 672.6031641331614, 810.3274282345668, 815.612584022589, 785.3952456608408, 810.6757297081156, 812.8374325134968, 821.4783612406105, 822.8107535266893, 869.6304070769929, 876.8071024374627, 876.9079246679103, 880.2737741363369, 880.867869819529, 687.5599616245606, 709.2517394149171, 865.5628907401754, 871.6426265231288, 874.558348034245, 585.4759989809139, 657.3754932813846, 663.8970959501285, 665.1884700665181, 667.4326822201139, 13758.93120534401, 13806.447742090304, 13810.65473363164, 13819.792703109462, 13830.930845345809, 9784.95107524465, 12733.87266127336, 13037.41331640069, 13042.282674452901, 13236.470541178342, 11791.292522448595, 11913.0, 12058.879411205864, 12481.50073997039, 12487.75024499514, 4300.956990430087, 4322.438083049215, 4338.848140315105, 4505.932411013838, 4512.458504979423, 78494.607526962, 94228.52885735597, 95815.0, 96058.0, 98586.0, 8461.746147615582, 10285.662863827803, 10385.0, 10412.375257484424, 10457.68626941193, 19527.414177574694, 19579.510512237022, 19580.412587622395, 19582.216711331388, 19587.80412195888, 7340.96329518349, 7377.3360397564475, 7400.037995060716, 7419.6661150248365, 7597.430192735567, 4161.3549899765585, 4195.769232692171, 4198.055437526532, 4224.429701990253, 4250.851220207278, 3156.352947645727, 3233.644299127094, 3244.383567122239, 3250.154959710492, 3251.235959549504, 611.4741322462678, 628.3873223606946, 629.4397985792648, 640.0623087177307, 649.052383520066, 513.2914691355005, 576.3717547872839, 589.3016775121495, 614.3948211012149, 638.7381173718753, 8415.663373464993, 8786.033536311, 8820.8676869847, 9003.904983716746, 9423.764405889908, 503.2099603622351, 573.4638113364018, 575.3153747041091, 619.5786864931889, 636.7166610858217, 4208.810603522848, 4218.282891908383, 4408.623615131276, 4561.794719237642, 4622.329762184464, 112674.0, 117014.41492792481, 117674.23488647677, 121311.0, 122680.0, 82154.76767848487, 105338.3022939808, 106718.0, 108028.05845678406, 110324.34513482304, 65324.71363502255, 71360.64319678368, 90554.0, 93384.59923101158, 97442.51278743561, 9467.479288639192, 9668.758281042748, 9670.0, 9685.467299298325, 9788.265880058882, 48165.75917120392, 56517.43482565122, 57370.713146434, 57497.42502575088, 58615.70692146682, 78568.60715696384, 82061.0, 84476.0, 85721.57139214514, 86077.56961215154, 12156.209846359958, 12216.26702397859, 12220.083493737828, 12457.937710311753, 12599.87400125987, 14243.21662308583, 14326.283685815875, 14328.426862925366, 14539.41842326295, 14904.403823846924, 12561.120721549403, 12982.675433114247, 13050.201112707653, 13250.204987700768, 13550.5446111241, 12509.74980500403, 13187.274699891597, 13577.456901723821, 13814.329969021524, 14011.929940350234, 13059.412326445143, 13101.0, 13124.14693044949, 13207.867921320663, 13291.20252784836, 11056.447177640925, 11187.384693841592, 11197.944010279896, 11248.212625116163, 11513.827292590451, 11252.549898003988, 11294.265872718248, 11416.486258118572, 11451.828222576834, 11556.826647600461], "value": 7315.441755841474, "unit": "score"}], "name": "dromaeo_css", "value": 6986.493635413645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 119.0, 164.0, 161.0, 114.0, 114.0, 113.0, 114.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 114.0, 112.0, 148.0, 113.0, 113.0, 115.0, 117.0, 142.0, 111.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 187.0, 186.0, 186.0, 186.0, 185.0, 182.0, 181.0, 195.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 58.0, 89.0, 60.0, 59.0, 59.0, 58.0, 83.0, 59.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 92.0, 69.0, 68.0, 69.0, 89.0, 67.0, 69.0, 93.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 84.0, 87.0, 84.0, 88.0, 85.0, 87.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 103.0, 93.0, 93.0, 94.0, 92.0, 92.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 126.0, 130.0, 139.0, 84.0, 87.0, 86.0, 85.0, 84.0, 85.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 75.0, 86.0, 56.0, 54.0, 54.0, 55.0, 54.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 71.0, 80.0, 76.0, 72.0, 72.0, 71.0, 71.0, 74.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 107.0, 76.0, 102.0, 108.0, 109.0, 109.0, 103.0, 88.0], "value": 98.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 152.0, 160.0, 160.0, 153.0, 150.0, 149.0, 189.0, 164.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 186.0, 240.0, 193.0, 175.0, 173.0, 173.0, 173.0, 172.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 79.0, 89.0, 70.0, 67.0, 67.0, 67.0, 66.0, 66.0, 65.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1496.8999999999999, "alertThreshold": 2.0}]} 09:25:57 INFO - Return code: 0 09:25:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:57 INFO - # TBPL SUCCESS # 09:25:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:57 INFO - 2016-11-16 09:25:57.114 screenresolution[2685:28701] starting screenresolution argv=screenresolution get 09:25:57 INFO - 2016-11-16 09:25:57.117 screenresolution[2685:28701] Display 0: 1600x1200x32@60 09:25:57 INFO - 2016-11-16 09:25:57.124 screenresolution[2686:28703] starting screenresolution argv=screenresolution list 09:25:57 INFO - Available Modes on Display 0 09:25:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:57 INFO - Intel Iris: 09:25:57 INFO - Chipset Model: Intel Iris 09:25:57 INFO - Type: GPU 09:25:57 INFO - Bus: Built-In 09:25:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:57 INFO - Vendor: Intel (0x8086) 09:25:57 INFO - Device ID: 0x0a2e 09:25:57 INFO - Revision ID: 0x0009 09:25:57 INFO - Displays: 09:25:57 INFO - Display: 09:25:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:57 INFO - Display Serial Number: 1600x1200 60 09:25:57 INFO - Main Display: Yes 09:25:57 INFO - Mirror: Off 09:25:57 INFO - Online: Yes 09:25:57 INFO - Rotation: Supported 09:25:57 INFO - Return code: 0 09:25:57 INFO - Running post-action listener: _resource_record_post_action 09:25:57 INFO - [mozharness: 2016-11-16 17:25:57.362894Z] Finished run-tests step (success) 09:25:57 INFO - Running post-run listener: _resource_record_post_run 09:25:57 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 159744; Write bytes: 700582912; Read time: 3; Write time: 2041 09:25:57 INFO - TinderboxPrint: CPU usage
53.5% 09:25:57 INFO - TinderboxPrint: I/O read bytes / time
159,744 / 3 09:25:57 INFO - TinderboxPrint: I/O write bytes / time
700,582,912 / 2,041 09:25:57 INFO - TinderboxPrint: CPU idle
2,257.0 (46.5%) 09:25:57 INFO - TinderboxPrint: CPU system
971.3 (20.0%) 09:25:57 INFO - TinderboxPrint: CPU user
1,629.3 (33.5%) 09:25:57 INFO - TinderboxPrint: Swap in / out
398,467,072 / 0 09:25:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381444608; Write bytes: 375330304; Read time: 28254; Write time: 736 09:25:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 159744; Write bytes: 299480576; Read time: 3; Write time: 1252 09:25:57 INFO - Running post-run listener: _upload_blobber_files 09:25:57 INFO - Blob upload gear active. 09:25:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25: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 09:25: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'] 09:25: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 09:25:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:59 INFO - (blobuploader) - INFO - Done attempting. 09:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:00 INFO - (blobuploader) - INFO - Done attempting. 09:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:02 INFO - (blobuploader) - INFO - Done attempting. 09:26:02 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:02 INFO - Return code: 0 09:26:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/80322c9a8758c53f61c25bf596009af857ccd9e2fc90ff0045a5346646b8ccbe6ae1aae09a8c720aa02bacbb24064626f6da72bfda50fe18f4aad9c7a4ebade6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ed5b8d23a2c7879250cb8638b0e42f4bf6171735cadbdabeca6f7adb48c5f3581227fee8a05208e57af512bbdb8e2d31fa1b903b3e66cc0afac5bb0a96cf36dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/17883b265e2f9f1c5298dda8a8ae7b6e8ddab18f74ffe9b4baaa435fc5327388159b89e6ce9a492c00901ca397ec49f318ed7badcd602983a0101f81ce857a99"} 09:26:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:02 INFO - Contents: 09:26:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/80322c9a8758c53f61c25bf596009af857ccd9e2fc90ff0045a5346646b8ccbe6ae1aae09a8c720aa02bacbb24064626f6da72bfda50fe18f4aad9c7a4ebade6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ed5b8d23a2c7879250cb8638b0e42f4bf6171735cadbdabeca6f7adb48c5f3581227fee8a05208e57af512bbdb8e2d31fa1b903b3e66cc0afac5bb0a96cf36dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/17883b265e2f9f1c5298dda8a8ae7b6e8ddab18f74ffe9b4baaa435fc5327388159b89e6ce9a492c00901ca397ec49f318ed7badcd602983a0101f81ce857a99"} 09:26:02 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:02 INFO - Copying logs to upload dir... 09:26:02 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.879385 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-16 09:26:02.969888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 09:26:02.973060) ========= 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.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/80322c9a8758c53f61c25bf596009af857ccd9e2fc90ff0045a5346646b8ccbe6ae1aae09a8c720aa02bacbb24064626f6da72bfda50fe18f4aad9c7a4ebade6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ed5b8d23a2c7879250cb8638b0e42f4bf6171735cadbdabeca6f7adb48c5f3581227fee8a05208e57af512bbdb8e2d31fa1b903b3e66cc0afac5bb0a96cf36dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/17883b265e2f9f1c5298dda8a8ae7b6e8ddab18f74ffe9b4baaa435fc5327388159b89e6ce9a492c00901ca397ec49f318ed7badcd602983a0101f81ce857a99"} build_url:https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/SfTExFTyRGqHkYfJArIcNQ/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/80322c9a8758c53f61c25bf596009af857ccd9e2fc90ff0045a5346646b8ccbe6ae1aae09a8c720aa02bacbb24064626f6da72bfda50fe18f4aad9c7a4ebade6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ed5b8d23a2c7879250cb8638b0e42f4bf6171735cadbdabeca6f7adb48c5f3581227fee8a05208e57af512bbdb8e2d31fa1b903b3e66cc0afac5bb0a96cf36dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/17883b265e2f9f1c5298dda8a8ae7b6e8ddab18f74ffe9b4baaa435fc5327388159b89e6ce9a492c00901ca397ec49f318ed7badcd602983a0101f81ce857a99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 09:26:03.006306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:26:03.006597) ========= 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.5QM7ONznTP/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.CGMKStsDLD/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005251 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 09:26:03.054306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 09:26:03.054600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 09:26:03.054912) ========= ========= Total master_lag: 0.17 =========