builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1480078339.87 results: success (0) buildid: 20161125015119 builduid: 7ca95eb8e8454b6a86afa2292d008894 revision: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:19.866217) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:19.866681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:19.866979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:19.894284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:19.894801) ========= 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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-25 04:52:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2016-11-25 04:52:20 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376949 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:20.299906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:20.300397) ========= 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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.024150 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:20.349290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 04:52:20.349653) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-25 04:52:20,442 truncating revision to first 12 chars 2016-11-25 04:52:20,442 Setting DEBUG logging. 2016-11-25 04:52:20,442 attempt 1/10 2016-11-25 04:52:20,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/1d31baa686c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 04:52:21,944 unpacking tar archive at: cedar-1d31baa686c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.777442 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 04:52:22.154448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:22.154752) ========= script_repo_revision: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:22.155130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:22.155443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 04:52:22.175587) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-25 04:52:22.176053) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:52:22 INFO - MultiFileLogger online at 20161125 04:52:22 in /builds/slave/test 04:52:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 04:52:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:22 INFO - {'append_to_log': False, 04:52:22 INFO - 'base_work_dir': '/builds/slave/test', 04:52:22 INFO - 'blob_upload_branch': 'Cedar', 04:52:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:22 INFO - 'branch': 'Cedar', 04:52:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:22 INFO - 'config_files': ('talos/mac_config.py',), 04:52:22 INFO - 'default_actions': ('clobber', 04:52:22 INFO - 'read-buildbot-config', 04:52:22 INFO - 'download-and-extract', 04:52:22 INFO - 'populate-webroot', 04:52:22 INFO - 'create-virtualenv', 04:52:22 INFO - 'install', 04:52:22 INFO - 'run-tests'), 04:52:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:22 INFO - 'download_minidump_stackwalk': True, 04:52:22 INFO - 'download_symbols': 'ondemand', 04:52:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:22 INFO - 'installer_path': 'installer.exe', 04:52:22 INFO - 'log_level': 'info', 04:52:22 INFO - 'log_name': 'talos', 04:52:22 INFO - 'log_to_console': True, 04:52:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:52:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:52:22 INFO - 'opt_config_files': (), 04:52:22 INFO - 'pip_index': False, 04:52:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:22 INFO - 'cmd': ('bash', 04:52:22 INFO - '-c', 04:52:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:22 INFO - 'enabled': True, 04:52:22 INFO - 'halt_on_failure': False, 04:52:22 INFO - 'name': 'check_screen_resolution'},), 04:52:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:22 INFO - 'cmd': ('bash', 04:52:22 INFO - '-c', 04:52:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:22 INFO - 'enabled': True, 04:52:22 INFO - 'halt_on_failure': False, 04:52:22 INFO - 'name': 'check_screen_resolution'},), 04:52:22 INFO - 'run_cmd_checks_enabled': True, 04:52:22 INFO - 'sps_profile': False, 04:52:22 INFO - 'sps_profile_interval': 0, 04:52:22 INFO - 'suite': 'dromaeojs', 04:52:22 INFO - 'system_bits': '32', 04:52:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:22 INFO - 'title': 't-yosemite-r7-0152', 04:52:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:22 INFO - 'use_talos_json': True, 04:52:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:22 INFO - 'work_dir': 'build'} 04:52:22 INFO - [mozharness: 2016-11-25 12:52:22.380212Z] Running clobber step. 04:52:22 INFO - Running pre-action listener: _resource_record_pre_action 04:52:22 INFO - Running main action method: clobber 04:52:22 INFO - rmtree: /builds/slave/test/build 04:52:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:24 INFO - Running post-action listener: _resource_record_post_action 04:52:24 INFO - [mozharness: 2016-11-25 12:52:24.771007Z] Finished clobber step (success) 04:52:24 INFO - [mozharness: 2016-11-25 12:52:24.771192Z] Running read-buildbot-config step. 04:52:24 INFO - Running pre-action listener: _resource_record_pre_action 04:52:24 INFO - Running main action method: read_buildbot_config 04:52:24 INFO - Using buildbot properties: 04:52:24 INFO - { 04:52:24 INFO - "project": "", 04:52:24 INFO - "product": "firefox", 04:52:24 INFO - "script_repo_revision": "default", 04:52:24 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 04:52:24 INFO - "repository": "", 04:52:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 04:52:24 INFO - "buildid": "20161125015119", 04:52:24 INFO - "pgo_build": "False", 04:52:24 INFO - "basedir": "/builds/slave/test", 04:52:24 INFO - "buildnumber": 2, 04:52:24 INFO - "slavename": "t-yosemite-r7-0152", 04:52:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:52:24 INFO - "platform": "yosemite_r7", 04:52:24 INFO - "scheduler": "tests-cedar-macosx64-talos", 04:52:24 INFO - "branch": "cedar", 04:52:24 INFO - "repo_path": "projects/cedar", 04:52:24 INFO - "revision": "1d31baa686c55268e4ec5364704b8ea5d7c33fe2", 04:52:24 INFO - "stage_platform": "macosx64", 04:52:24 INFO - "builduid": "7ca95eb8e8454b6a86afa2292d008894", 04:52:24 INFO - "slavebuilddir": "test" 04:52:24 INFO - } 04:52:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:52:24 INFO - Running post-action listener: _resource_record_post_action 04:52:24 INFO - [mozharness: 2016-11-25 12:52:24.776704Z] Finished read-buildbot-config step (success) 04:52:24 INFO - [mozharness: 2016-11-25 12:52:24.776875Z] Running download-and-extract step. 04:52:24 INFO - Running pre-action listener: _resource_record_pre_action 04:52:24 INFO - Running main action method: download_and_extract 04:52:24 INFO - mkdir: /builds/slave/test/build/tests 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:24 INFO - trying https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:52:24 INFO - Downloading https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:52:26 INFO - Downloaded 1199 bytes. 04:52:26 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:52:26 INFO - Using the following test package requirements: 04:52:26 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:52:26 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:26 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:52:26 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'jsshell-mac.zip'], 04:52:26 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:52:26 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:52:26 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:52:26 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:52:26 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:52:26 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:52:26 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:52:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:26 INFO - Fetch https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:52:26 INFO - Http code: 200 04:52:26 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 04:52:26 INFO - x-amz-cf-id: xDhSi6EDOi0kuxqZaNEMPyY1xXbSFn3lnrdZK3HkkTCafxHtg9PgZw== 04:52:26 INFO - x-amz-version-id: MGYvlExjzahnIXtDDmt.75AHCNW.HBnh 04:52:27 INFO - Expected file size: 16268544 04:52:27 INFO - Obtained file size: 16268544 04:52:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:52:34 INFO - Http code: 200 04:52:34 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 04:52:34 INFO - x-amz-cf-id: L-EXwtJWgGnoZkBgJC8naDhRMzQVN58AZxvgHyi5SSHq8j4ks0Zbgg== 04:52:34 INFO - x-amz-version-id: MGYvlExjzahnIXtDDmt.75AHCNW.HBnh 04:52:34 INFO - Expected file size: 16268544 04:52:34 INFO - Obtained file size: 16268544 04:52:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:52:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:52:41 INFO - Fetch https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:52:42 INFO - Http code: 200 04:52:42 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 04:52:42 INFO - x-amz-cf-id: w7SEfGjGJc_0lAmmp928tjYv47WDDmpnuHdiLULTmt379oUtJv6qgw== 04:52:42 INFO - x-amz-version-id: MaAJSqympUPLZN9k_Mw.sV5EGKUb4V8k 04:52:42 INFO - Expected file size: 14409749 04:52:42 INFO - Obtained file size: 14409749 04:52: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')]} 04:52:42 INFO - trying https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:52:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:52:45 INFO - Downloaded 107594624 bytes. 04:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:52:45 INFO - mkdir: /builds/slave/test/properties 04:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:45 INFO - Contents: 04:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - Running post-action listener: set_extra_try_arguments 04:52:46 INFO - [mozharness: 2016-11-25 12:52:46.152562Z] Finished download-and-extract step (success) 04:52:46 INFO - [mozharness: 2016-11-25 12:52:46.152686Z] Running populate-webroot step. 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: populate_webroot 04:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:46 INFO - '--tppagecycles', 04:52:46 INFO - '7'], 04:52:46 INFO - 'tests': ['tsvgm']}}, 04:52:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['damp', 'tps']}, 04:52:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'tests': ['damp', 'tps']}, 04:52:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['dromaeo_dom']}, 04:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['basic_compositor_video']}, 04:52:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:52:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore', 04:52:46 INFO - 'tabpaint']}, 04:52:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['tsvgx', 04:52:46 INFO - 'tsvgr_opacity', 04:52:46 INFO - 'tart', 04:52:46 INFO - 'tscrollx', 04:52:46 INFO - 'cart', 04:52:46 INFO - 'tsvg_static']}, 04:52:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:46 INFO - 'tsvgr_opacity', 04:52:46 INFO - 'tart', 04:52:46 INFO - 'tscrollx', 04:52:46 INFO - 'cart', 04:52:46 INFO - 'tsvg_static']}, 04:52:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'talos_options': ['--disable-e10s'], 04:52:46 INFO - 'tests': ['tp5o']}, 04:52:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'talos_options': ['--disable-e10s', 04:52:46 INFO - '--xperf_path', 04:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:46 INFO - 'tests': ['tp5n']}, 04:52:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:46 INFO - 'talos_options': ['--xperf_path', 04:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:46 INFO - 'tests': ['tp5n']}}, 04:52:46 INFO - 'talos.zip': {'path': '', 04:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - [mozharness: 2016-11-25 12:52:46.170873Z] Finished populate-webroot step (success) 04:52:46 INFO - [mozharness: 2016-11-25 12:52:46.171003Z] Running create-virtualenv step. 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: create_virtualenv 04:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:46 INFO - Using real prefix '/tools/python27' 04:52:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:49 INFO - Installing pip.................done. 04:52:49 INFO - Return code: 0 04:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:50 INFO - Reading from file tmpfile_stdout 04:52:50 INFO - Output received: 04:52:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:50 INFO - 'HOME': '/Users/cltbld', 04:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:50 INFO - 'LOGNAME': 'cltbld', 04:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:50 INFO - 'MOZ_NO_REMOTE': '1', 04:52:50 INFO - 'NO_EM_RESTART': '1', 04:52:50 INFO - 'PAGER': '/bin/cat', 04:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:50 INFO - 'PWD': '/builds/slave/test', 04:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:50 INFO - 'SHELL': '/bin/bash', 04:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:52:50 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:50 INFO - 'USER': 'cltbld', 04:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:50 INFO - 'XPC_FLAGS': '0x0', 04:52:50 INFO - 'XPC_SERVICE_NAME': '0', 04:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:52:50 INFO - Cleaning up... 04:52:50 INFO - Return code: 0 04:52:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:50 INFO - 'HOME': '/Users/cltbld', 04:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:50 INFO - 'LOGNAME': 'cltbld', 04:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:50 INFO - 'MOZ_NO_REMOTE': '1', 04:52:50 INFO - 'NO_EM_RESTART': '1', 04:52:50 INFO - 'PAGER': '/bin/cat', 04:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:50 INFO - 'PWD': '/builds/slave/test', 04:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:50 INFO - 'SHELL': '/bin/bash', 04:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:52:50 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:50 INFO - 'USER': 'cltbld', 04:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:50 INFO - 'XPC_FLAGS': '0x0', 04:52:50 INFO - 'XPC_SERVICE_NAME': '0', 04:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:50 INFO - Downloading/unpacking psutil>=3.1.1 04:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:54 INFO - Installing collected packages: psutil 04:52:54 INFO - Running setup.py install for psutil 04:52:54 INFO - building 'psutil._psutil_osx' extension 04:52:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:52:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:52:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:52:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:52:55 INFO - building 'psutil._psutil_posix' extension 04:52:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:52:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:52:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:52:55 INFO - ^ 04:52:55 INFO - 1 warning generated. 04:52:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:55 INFO - Successfully installed psutil 04:52:55 INFO - Cleaning up... 04:52:55 INFO - Return code: 0 04:52:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:52:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:52:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:55 INFO - 'HOME': '/Users/cltbld', 04:52:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:55 INFO - 'LOGNAME': 'cltbld', 04:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:55 INFO - 'MOZ_NO_REMOTE': '1', 04:52:55 INFO - 'NO_EM_RESTART': '1', 04:52:55 INFO - 'PAGER': '/bin/cat', 04:52:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:55 INFO - 'PWD': '/builds/slave/test', 04:52:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:55 INFO - 'SHELL': '/bin/bash', 04:52:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:52:55 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:52:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:55 INFO - 'USER': 'cltbld', 04:52:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:55 INFO - 'XPC_FLAGS': '0x0', 04:52:55 INFO - 'XPC_SERVICE_NAME': '0', 04:52:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:58 INFO - Installing collected packages: mozsystemmonitor 04:52:58 INFO - Running setup.py install for mozsystemmonitor 04:52:58 INFO - Successfully installed mozsystemmonitor 04:52:58 INFO - Cleaning up... 04:52:58 INFO - Return code: 0 04:52:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:58 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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:58 INFO - 'HOME': '/Users/cltbld', 04:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:58 INFO - 'LOGNAME': 'cltbld', 04:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:58 INFO - 'MOZ_NO_REMOTE': '1', 04:52:58 INFO - 'NO_EM_RESTART': '1', 04:52:58 INFO - 'PAGER': '/bin/cat', 04:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:58 INFO - 'PWD': '/builds/slave/test', 04:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:58 INFO - 'SHELL': '/bin/bash', 04:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:52:58 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:58 INFO - 'USER': 'cltbld', 04:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:58 INFO - 'XPC_FLAGS': '0x0', 04:52:58 INFO - 'XPC_SERVICE_NAME': '0', 04:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:01 INFO - warning: no files found matching '*.txt' 04:53:01 INFO - no previously-included directories found matching 'build' 04:53:01 INFO - no previously-included directories found matching 'dist' 04:53:01 INFO - no previously-included directories found matching '.git*' 04:53:01 INFO - Installing collected packages: jsonschema, functools32 04:53:01 INFO - Running setup.py install for functools32 04:53:01 INFO - warning: no files found matching '*.txt' 04:53:01 INFO - no previously-included directories found matching 'build' 04:53:01 INFO - no previously-included directories found matching 'dist' 04:53:01 INFO - no previously-included directories found matching '.git*' 04:53:01 INFO - Successfully installed jsonschema functools32 04:53:01 INFO - Cleaning up... 04:53:02 INFO - Return code: 0 04:53:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:02 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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:02 INFO - 'HOME': '/Users/cltbld', 04:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:02 INFO - 'LOGNAME': 'cltbld', 04:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:02 INFO - 'MOZ_NO_REMOTE': '1', 04:53:02 INFO - 'NO_EM_RESTART': '1', 04:53:02 INFO - 'PAGER': '/bin/cat', 04:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:02 INFO - 'PWD': '/builds/slave/test', 04:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:02 INFO - 'SHELL': '/bin/bash', 04:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:02 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:02 INFO - 'USER': 'cltbld', 04:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:02 INFO - 'XPC_FLAGS': '0x0', 04:53:02 INFO - 'XPC_SERVICE_NAME': '0', 04:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:02 INFO - Cleaning up... 04:53:02 INFO - Return code: 0 04:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:02 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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:02 INFO - 'HOME': '/Users/cltbld', 04:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:02 INFO - 'LOGNAME': 'cltbld', 04:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:02 INFO - 'MOZ_NO_REMOTE': '1', 04:53:02 INFO - 'NO_EM_RESTART': '1', 04:53:02 INFO - 'PAGER': '/bin/cat', 04:53:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:02 INFO - 'PWD': '/builds/slave/test', 04:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:02 INFO - 'SHELL': '/bin/bash', 04:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:02 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:02 INFO - 'USER': 'cltbld', 04:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:02 INFO - 'XPC_FLAGS': '0x0', 04:53:02 INFO - 'XPC_SERVICE_NAME': '0', 04:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - Downloading docopt-0.6.1.tar.gz 04:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:06 INFO - Running setup.py install for blobuploader 04:53:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:06 INFO - Running setup.py install for requests 04:53:07 INFO - Running setup.py install for docopt 04:53:07 INFO - Successfully installed blobuploader requests docopt 04:53:07 INFO - Cleaning up... 04:53:07 INFO - Return code: 0 04:53:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:07 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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:07 INFO - 'HOME': '/Users/cltbld', 04:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:07 INFO - 'LOGNAME': 'cltbld', 04:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:07 INFO - 'MOZ_NO_REMOTE': '1', 04:53:07 INFO - 'NO_EM_RESTART': '1', 04:53:07 INFO - 'PAGER': '/bin/cat', 04:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:07 INFO - 'PWD': '/builds/slave/test', 04:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:07 INFO - 'SHELL': '/bin/bash', 04:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:07 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:07 INFO - 'USER': 'cltbld', 04:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:07 INFO - 'XPC_FLAGS': '0x0', 04:53:07 INFO - 'XPC_SERVICE_NAME': '0', 04:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-yjGw5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Miahsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-cnYbzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-pQSqdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-H1wUDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-HeZQB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-UV7mPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-yy_TfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZcdBtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-J34RwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-B8OTeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-_lOstQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Dq0RwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:08 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-LWHOec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:09 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-vdkaYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:09 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-uTQcmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:09 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-9WoifQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:09 INFO - Running setup.py install for manifestparser 04:53:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:09 INFO - Running setup.py install for mozcrash 04:53:09 INFO - Running setup.py install for mozdebug 04:53:09 INFO - Running setup.py install for mozdevice 04:53:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:09 INFO - Running setup.py install for mozfile 04:53:10 INFO - Running setup.py install for mozhttpd 04:53:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Running setup.py install for mozinfo 04:53:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Running setup.py install for mozInstall 04:53:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Running setup.py install for mozleak 04:53:10 INFO - Running setup.py install for mozlog 04:53:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Running setup.py install for moznetwork 04:53:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Running setup.py install for mozprocess 04:53:11 INFO - Running setup.py install for mozprofile 04:53:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:11 INFO - Running setup.py install for mozrunner 04:53:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:11 INFO - Running setup.py install for mozscreenshot 04:53:11 INFO - Running setup.py install for moztest 04:53:11 INFO - Running setup.py install for mozversion 04:53:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:11 INFO - Cleaning up... 04:53:11 INFO - Return code: 0 04:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:11 INFO - 'HOME': '/Users/cltbld', 04:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:11 INFO - 'LOGNAME': 'cltbld', 04:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:11 INFO - 'MOZ_NO_REMOTE': '1', 04:53:11 INFO - 'NO_EM_RESTART': '1', 04:53:11 INFO - 'PAGER': '/bin/cat', 04:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:11 INFO - 'PWD': '/builds/slave/test', 04:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:11 INFO - 'SHELL': '/bin/bash', 04:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:11 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:11 INFO - 'USER': 'cltbld', 04:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:11 INFO - 'XPC_FLAGS': '0x0', 04:53:11 INFO - 'XPC_SERVICE_NAME': '0', 04:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-XCTwbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-U_9veu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-k_JBSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-o5JIgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-o7zxa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-xSJ_Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5V_WwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Mk6jqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ntsHC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-HV29L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-IATqeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4pRDcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-91mY2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-sZ5nag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-QJmkjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-URJA9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:13 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-odILNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - Downloading blessings-1.6.tar.gz 04:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:16 INFO - Installing collected packages: blessings 04:53:16 INFO - Running setup.py install for blessings 04:53:16 INFO - Successfully installed blessings 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:17 INFO - Reading from file tmpfile_stdout 04:53:17 INFO - Current package versions: 04:53:17 INFO - blessings == 1.6 04:53:17 INFO - blobuploader == 1.2.4 04:53:17 INFO - docopt == 0.6.1 04:53:17 INFO - functools32 == 3.2.3-2 04:53:17 INFO - jsonschema == 2.5.1 04:53:17 INFO - manifestparser == 1.1 04:53:17 INFO - mozInstall == 1.12 04:53:17 INFO - mozcrash == 1.0 04:53:17 INFO - mozdebug == 0.1 04:53:17 INFO - mozdevice == 0.49 04:53:17 INFO - mozfile == 1.2 04:53:17 INFO - mozhttpd == 0.7 04:53:17 INFO - mozinfo == 0.9 04:53:17 INFO - mozleak == 0.1 04:53:17 INFO - mozlog == 3.4 04:53:17 INFO - moznetwork == 0.27 04:53:17 INFO - mozprocess == 0.23 04:53:17 INFO - mozprofile == 0.28 04:53:17 INFO - mozrunner == 6.13 04:53:17 INFO - mozscreenshot == 0.1 04:53:17 INFO - mozsystemmonitor == 0.3 04:53:17 INFO - moztest == 0.7 04:53:17 INFO - mozversion == 1.4 04:53:17 INFO - psutil == 3.1.1 04:53:17 INFO - requests == 1.2.3 04:53:17 INFO - wsgiref == 0.1.2 04:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 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 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:18 INFO - 'HOME': '/Users/cltbld', 04:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:18 INFO - 'LOGNAME': 'cltbld', 04:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:18 INFO - 'MOZ_NO_REMOTE': '1', 04:53:18 INFO - 'NO_EM_RESTART': '1', 04:53:18 INFO - 'PAGER': '/bin/cat', 04:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:18 INFO - 'PWD': '/builds/slave/test', 04:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:18 INFO - 'SHELL': '/bin/bash', 04:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:18 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:18 INFO - 'USER': 'cltbld', 04:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:18 INFO - 'XPC_FLAGS': '0x0', 04:53:18 INFO - 'XPC_SERVICE_NAME': '0', 04:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:18 INFO - Cleaning up... 04:53:18 INFO - Return code: 0 04:53:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a303f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0d157e710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, '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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:18 INFO - 'HOME': '/Users/cltbld', 04:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:18 INFO - 'LOGNAME': 'cltbld', 04:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:18 INFO - 'MOZ_NO_REMOTE': '1', 04:53:18 INFO - 'NO_EM_RESTART': '1', 04:53:18 INFO - 'PAGER': '/bin/cat', 04:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:18 INFO - 'PWD': '/builds/slave/test', 04:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:18 INFO - 'SHELL': '/bin/bash', 04:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:18 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:18 INFO - 'USER': 'cltbld', 04:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:18 INFO - 'XPC_FLAGS': '0x0', 04:53:18 INFO - 'XPC_SERVICE_NAME': '0', 04:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:18 INFO - Cleaning up... 04:53:18 INFO - Return code: 0 04:53:18 INFO - Running post-action listener: _resource_record_post_action 04:53:18 INFO - Running post-action listener: _start_resource_monitoring 04:53:18 INFO - Starting resource monitoring. 04:53:18 INFO - [mozharness: 2016-11-25 12:53:18.989608Z] Finished create-virtualenv step (success) 04:53:18 INFO - [mozharness: 2016-11-25 12:53:18.990570Z] Running install step. 04:53:18 INFO - Running pre-action listener: _resource_record_pre_action 04:53:18 INFO - Running main action method: install 04:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:19 INFO - Reading from file tmpfile_stdout 04:53:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:19 INFO - Reading from file tmpfile_stdout 04:53:19 INFO - Output received: 04:53:19 INFO - Usage: mozinstall [options] installer 04:53:19 INFO - Options: 04:53:19 INFO - -h, --help show this help message and exit 04:53:19 INFO - -d DEST, --destination=DEST 04:53:19 INFO - Directory to install application into. [default: 04:53:19 INFO - "/builds/slave/test"] 04:53:19 INFO - --app=APP Application being installed. [default: firefox] 04:53:19 INFO - mkdir: /builds/slave/test/build/application 04:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:53:51 INFO - Reading from file tmpfile_stdout 04:53:51 INFO - Output received: 04:53:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:51 INFO - Running post-action listener: _resource_record_post_action 04:53:51 INFO - [mozharness: 2016-11-25 12:53:51.798408Z] Finished install step (success) 04:53:51 INFO - [mozharness: 2016-11-25 12:53:51.798531Z] Running run-tests step. 04:53:51 INFO - Running pre-action listener: _resource_record_pre_action 04:53:51 INFO - Running main action method: run_tests 04:53:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:51 INFO - 2016-11-25 04:53:51.812 screenresolution[1625:7496] starting screenresolution argv=screenresolution get 04:53:51 INFO - 2016-11-25 04:53:51.815 screenresolution[1625:7496] Display 0: 1600x1200x32@60 04:53:51 INFO - 2016-11-25 04:53:51.821 screenresolution[1626:7498] starting screenresolution argv=screenresolution list 04:53:51 INFO - Available Modes on Display 0 04:53:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:52 INFO - Intel Iris: 04:53:52 INFO - Chipset Model: Intel Iris 04:53:52 INFO - Type: GPU 04:53:52 INFO - Bus: Built-In 04:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:52 INFO - Vendor: Intel (0x8086) 04:53:52 INFO - Device ID: 0x0a2e 04:53:52 INFO - Revision ID: 0x0009 04:53:52 INFO - Displays: 04:53:52 INFO - Display: 04:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:52 INFO - Display Serial Number: 1600x1200 60 04:53:52 INFO - Main Display: Yes 04:53:52 INFO - Mirror: Off 04:53:52 INFO - Online: Yes 04:53:52 INFO - Rotation: Supported 04:53:52 INFO - Return code: 0 04:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:52 INFO - Python 2.7.3 04:53:52 INFO - Return code: 0 04:53:52 INFO - grabbing minidump binary from tooltool 04:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:52 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 0x107846d30>, '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 0x1076addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:53:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:53:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:53:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:52 INFO - Return code: 0 04:53:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hw1LVi8yVr/Render', 04:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:52 INFO - 'HOME': '/Users/cltbld', 04:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:52 INFO - 'LOGNAME': 'cltbld', 04:53:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:52 INFO - 'MOZ_NO_REMOTE': '1', 04:53:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:52 INFO - 'NO_EM_RESTART': '1', 04:53:52 INFO - 'PAGER': '/bin/cat', 04:53:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:52 INFO - 'PWD': '/builds/slave/test', 04:53:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:52 INFO - 'SHELL': '/bin/bash', 04:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.olLlhUzYEz/Listeners', 04:53:52 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:52 INFO - 'USER': 'cltbld', 04:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:52 INFO - 'XPC_FLAGS': '0x0', 04:53:52 INFO - 'XPC_SERVICE_NAME': '0', 04:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:52 INFO - mozversion application_buildid: 20161125015119 04:53:52 INFO - mozversion application_changeset: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 04:53:52 INFO - mozversion application_display_name: Nightly 04:53:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:52 INFO - mozversion application_name: Firefox 04:53:52 INFO - mozversion application_remotingname: firefox 04:53:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 04:53:52 INFO - mozversion application_vendor: Mozilla 04:53:52 INFO - mozversion application_version: 53.0a1 04:53:52 INFO - mozversion platform_buildid: 20161125015119 04:53:52 INFO - mozversion platform_changeset: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 04:53:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 04:53:52 INFO - mozversion platform_version: 53.0a1 04:53:52 INFO - using testdate: 1480078432 04:53:52 INFO - actual date: 1480078432 04:53:52 INFO - starting webserver on 'localhost:49241' 04:53:52 INFO - SUITE-START | Running 2 tests 04:53:52 INFO - TEST-START | dromaeo_css 04:53:52 INFO - operating with platform_type : mac_ 04:53:52 INFO - Initialising browser for dromaeo_css test... 04:53:52 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpq1UStY/profile http://localhost:49241/getInfo.html) 04:53:55 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 04:53:55 INFO - PROCESS | 1636 | colorDepth:24 04:53:55 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 04:53:55 INFO - PROCESS | 1636 | __metrics 04:53:55 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:55 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:56 INFO - TEST-INFO | 1636: exit 0 04:53:56 INFO - Browser initialized. 04:53:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:56 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpq1UStY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:08 INFO - PROCESS | 1638 | RSS: Main: 244662272 04:54:08 INFO - PROCESS | 1638 | 04:55:00 INFO - PROCESS | 1638 | 1480078500245 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:57:12 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:57:14 INFO - PROCESS | 1638 | RSS: Main: 417062912 04:57:14 INFO - PROCESS | 1638 | 05:00:17 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:00:18 INFO - PROCESS | 1638 | RSS: Main: 372854784 05:00:18 INFO - PROCESS | 1638 | 05:03:20 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:03:21 INFO - PROCESS | 1638 | RSS: Main: 365207552 05:03:21 INFO - PROCESS | 1638 | 05:06:23 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:06:24 INFO - PROCESS | 1638 | RSS: Main: 344043520 05:06:24 INFO - PROCESS | 1638 | 05:09:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:09:28 INFO - PROCESS | 1638 | RSS: Main: 337555456 05:09:28 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:12:31 INFO - PROCESS | 1638 | RSS: Main: 397766656 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | __start_tp_report 05:12:31 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 05:12:31 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 05:12:31 INFO - PROCESS | 1638 | |i|pagename|runs| 05:12:31 INFO - PROCESS | 1638 | |0;dojo.html;3228.773985820992;3261.9673803261962;3269.4932285495756;3272.6563710810365;3310.957048529713;5437.673739575628;5479.232907392963;5533.972330138344;5583.944160558393;5623.044082505973;5495.010898038361;5544.750486228119;5551.528120109796;5561.054620714478;5615;4991.900161996758;5011.273365362021;5015;5048.242763585473;5103.183490641498;4445.5776701213335;5081.46644602317;5117.974410127944;5200.583953283747;5217.504337087989;4973.2291494818;5108.846734597968;5115.744212789365;5123.641345105844;5195;5016.623753218523;5028.622853285981;5074.568661663763;5090.287359769635;5103.744812759384;4173.353130264783;5074.086664400406;5086.79652813887;5126.307948426952;5142.665726727788;5550.944490555124;5551.77792888284;5565.471280228372;5587.05020146576;5591.133374326986;5890.646561206341;5939.524838012949;5955.987482128048;6077.483413909823;6079.513638908877;6072.605280656743;6103.526537179873;6104.466343479301;6153.077038444225;6181.752729890799;5635.549156067505;5645.915311270334;5647.745851436654;5650.802221922213;5680.176374425727;6092.878142437126;6181.629102253879;6244.219472565929;6247.500199983991;6249.6562689052535;5796.014677504834;5807.128930660435;5853;5871.3541510433815;5875.882482350329;6062;6063.393660633989;6069.15031895535;6092.329843717188;6093.11649810775;5906.7637294508595;5953.958057339948;5961.850953726192;5967.045272756338;5968.582199246098;5995.46040856325;6001;6010.278766548042;6012.609180403259;6022.096685497123;4716.103940251342;4813.855584332476;4818.253170758538;4821.783019764119;4840.636952228597;4271.188474189894;4280.379344995021;4285.678574106954;4325.264705000094;4404.383386325917;5597.776088956478;5600.103983362643;5601.719914004283;5662.433756624387;5685.0619647758485;5267.078261304257;6147.600405973598;6192.566520343623;6197.287311959092;6211.720472578745;5484.149956756629;5551.500364967092;5552.833414997556;5579.721013949286;5640.266765320482;5281.049411105961;5337.226102215157;5350.170723537858;5350.9732451337495;5352.892942141136;6256.967600345983;6262.5929314594405;6267.310595834455;6267.96866015667;6273.968630156911;6014.548908831767;6185.8144255672405;6199.3490683477585;6200.658963757037;6210.099535567408;6137.714085983886;6175.9382406177165;6187.474064704371;6191.690415479298;6200.937990620036;6045.032794752994;6065.878682426239;6078.422549857756;6087.69561521931;6123.693815309306;5954.225950626565;6095.664738439428;6168.321484636776;6171.47542458896;6193.4425901669065;5790.884182316246;5862.765489380377;5882.5293976480925;6000.909986350295;6020.096985452217;5879.676617786063;5945.613535120204;5964.7912323068485;6025.638461692137;6046.123312119806;4817.27740838877;5783.219265399285;5794.82615521535;5800.071988481823;5818.156367326798;5917.5857689961285;5992.161097446448;6002.069679199731;6033.215681961317;6038.728257228523;5653.575981801464;5704.458076482728;5718.571107166896;5733.71331433435;5778.8266352009505 05:12:31 INFO - PROCESS | 1638 | |1;ext.html;464.3058627352108;488.1652374439708;511.7952818872451;532.7602578839524;546.5682111132206;29807.65865536051;37938.810305948464;38966;39212.80393598035;41076.79461602695;39864.60135398645;40454;40461.19077618453;40480;40542.39186412206;8235.588220588947;9141.634334626624;9330.300227482932;9336.719898403058;9368.81262374752;8261.091279959199;10936;11126.109911207084;11153.10775137987;11378.032867206297;11028.117750579975;11052;11073.390963497044;11109.277896936714;11137.944310278437;11040.392778397185;11100.333979961228;11101.83347249792;11102.833457498144;11112.499937502831;11010.174236932182;11071.889281107166;11074.612388566442;11075.889241107567;11091.168162387854;30822.38355232883;37972;38102;38151.80924095362;38152.23695526074;3239.5302681111107;3286.5727455430642;3317.369699757063;3334.416477116495;3415.1803567143957;28822.027644254802;29241.561376579368;29293.26766830825;29369;29747.851260743773;2602.6325363954975;3107.7043518761575;3192.457282262021;3214.61424629046;3245.675432456759;363809;503102;504216;511082;511659.4417027928;54873.45126548763;56061.439385606434;56414.71792641011;56465.15302270469;56549.151762723595;58762.41237587655;59011.704941475014;59012.40987590155;59062.40937590655;59130;12659.303738294482;14920.253987300808;15107.39570417171;15117.244137793066;15334.386624534895;10826.458677066115;11077.335359878272;12056.156069075256;12085.697857553632;12100.273983561014;11057.391843448688;11897.643070707893;14915.030523015968;15103.32035058425;15221.923890380698;6371.235451745728;6431.163948686641;6496.967515162489;6499.967500162469;6509.544331896816;901.3870568013814;941.2281928818303;983.2478154211891;996.6511720897628;1023.2990401574945;27651.58522622162;28584.714152858207;29267;29314.560281595794;29830.701692983228;1013.3717095400751;1016.7102375822855;1054.3779170289565;1101.0530943388678;1127.6617014895498;11959.521619135137;14024.649383765487;14757.541899441341;14835.851641483663;14958;591081.0891891113;624281;631037.844810773;650941;652283;52466.73766631143;52742.736286319094;52749.208761868606;52753;52784;1234.2471092633486;1271.491403438595;1272.9299888506036;1356.87109724576;1384.4116250593459;22006.669899951834;27652.308692282048;28948;29842.403151937273;30633;51495.74252128715;51971.48028519667;52173.7391313041;52192;52297.38513074255;483056;578491;583369;583999;587114.0644296751;22165.778342217018;22744;24216;24349.51300974006;24720.13479528208;37549.81225093857;37787;37898.62101379061;38006.80996594999;43546.12907741764;32764.50853237251;33833.98498045062;35078.64921350856;36914;38034.809825950695;28950.710492894803;35014.82492587521;36587.63412365949;37238.62761372352;37917.431238530895;35836.67061640985;35859.64140358563;35981.820090899375;35986.4602030975;37219.06952326214;32486.675133248365;32495.050296982256;33263;33658.66341336555;34442;21178.25876094391;24097.277081687578;24366.878165609058;24576.385590360384;25149.24552263435 05:12:31 INFO - PROCESS | 1638 | |2;jquery.html;368.86167687117313;371.5448575495018;382.34809649547526;392.19012738694573;399.99601001486263;14982.32579533921;16549.420770273042;19593.608127837433;20133.697994530095;20327.796722032774;11357.829632555518;11763.764724705523;11774.234674746136;11778.29330240184;11783.646490605273;4808.663393562452;5265.631405801595;5326.467353264681;5332.200169974496;5337.332833395825;3807.8667246646232;4000.799960002003;4022.3162062449455;5164.767585458645;7008.299170082976;7215.927840721578;7479.326860582546;7500.662470188855;7583.241675832428;7598.278163574451;7453.925460745378;7519.511231769918;7541.7360392386;7542.35889949355;7552.962235188844;6715.2277488089;7113.964430177868;7209.351158395717;7254.637268136625;7292.562446253241;23080.76919230803;28213;28407.85796071027;28531.57202641962;28749.56875646867;2485.8135639826905;2488.7760101590943;2531.860747658878;2560.8079394045335;2608.804339674513;12827.935860320638;15072.321745521369;16165.676686466204;16669.999800011916;17098.14509274531;1890.9243630254773;1954.9315773947844;1970.4088773367932;1984.2063174730079;2169.349195241437;122763.38618306941;133239;139681.3015934924;140235;143880.5611943888;20757.792422075887;20851.061702223436;20974.790252097588;21031.8948405257;21485.355439336843;34578.30843383118;34636;34674.653253467644;34730;34867.302653947285;10282.177425805918;10497.580096796195;10532.05211530966;10645.78708425827;10658.946705266579;6823.0106634537715;7408.85182296351;8735.563221838882;8865.734027979172;8887.022427532966;9201.769955751026;9455.30726256975;9528.189643967624;9538.475383853955;9610.615575377047;2616.6990796058317;3513.94729079064;3608.5358056265754;3640.927181456409;3697.7041836653;823.872299793533;898.3352319283683;922.1188774899265;933.2533972821716;944.9149576538144;20322.593548128956;21121.577568448545;21156.259530916344;21174.729516229076;21258.78741212599;920.6179435534178;921.7833809054866;940.9858852117223;1007.4710776842217;1015.7409860485529;10509.264351495474;11087.667369978913;11174.944125279322;11175.608853690082;11176;594353;598620;604270;605495;613017;78218;79009.60495197488;138076;139761;147108;959.640134949394;990.64336838738;994.7714572502953;1012.3217444312328;1012.4532752313816;17046.57383565371;17560.473185804447;18681.43955681332;18900.621987559898;19331.226750929804;55897;57043.71478142583;57196.71401642965;58642.706786467505;58680;79333.22333718292;79967.60016199882;80937.59531202307;82442.76335854847;84559;7767.961160194162;8048.436609437284;8056.556889371141;8070.757877263692;8132.593370331341;9068.455892646462;12122.151449398458;12432.00933298115;12528.248305101723;12718.491260349483;8581.613827377907;10738.785224295627;10931.672049838518;11062.225644205151;11107.389093599606;10381.429021403594;10543.947280263856;10602.840957385491;10759.515821787882;10982.286151400134;11055.391953442639;11274;11281.943590281997;11355.829662555234;11367.886321137014;7663.808404789925;7712.305892469704;7977.760667179994;7987.201279872199;8004.719834805754;9385.577649005947;10642.148628109888;10960.068394186583;11165.274257173258;11178.608748693756 05:12:31 INFO - PROCESS | 1638 | |3;mootools.html;1465.1355700136917;1498.9881829764909;1648.6620242850217;1744.9040302783358;1832.4319460967101;7422.962885185567;7701.22987701231;7850.175731548191;8304.958475207623;8306.252437280651;7511.586862722548;7811.492253003565;8015.839683206347;8024.95987520063;8150.592470376472;2260.8756518391524;2303.8156947444163;2304.665823455598;2312.5143719818857;2315.351701523576;1676.8407001334915;2289.6679981402685;2318.3392733071078;2342.543204075206;2348.4598542335275;2057.105159255721;2099.863508871926;2188.6388745856916;2277.7836105569945;2285.3600991722346;1902.3246747404748;2253.8985745641403;2273.45437095096;2305.250793492113;2311.6301391777233;2293.3005433342823;2315.386422598013;2326.278853555403;2327.4297797039835;2328.941776455585;7913.1691172426645;8089.271965523131;8096.3118134958595;8121.228483294078;8140.592970351518;4947.6289278304275;5066.493350664941;5072.898542029138;5123.180291153435;5126.5642420394315;3167.4932010878147;3271.7382609391193;3509.350770107538;3510.8420121094614;3520.577530696333;892.2282225874636;1061.5912873543664;1069.3476979042778;1075.9193060520493;1083.2796190533286;10242.231832612584;10494.527746251437;10495.632652857113;10587.470626468723;10704.197185211062;4410.117976404667;4509.6392288616835;4593.002044110823;4646.512116227815;4669.34629151919;9260.675876344296;9261.490618016074;9267.860982085274;9283.303752218475;9289.34974551775;5108.795648174031;5109.693418394908;5113.079645663742;5119.769610367543;5122.308488354024;4573.862784116482;4604.309353596987;4675.462321832964;4692.389989301437;4703.294505824086;3600.6759391654355;3647.854085836537;3648.8175591220333;3671.541057367829;3698.1679122197293;1195.8445402097846;1220.7741567809983;1221.2733423612935;1232.1498166265249;1232.9951089861734;609.3723464831231;690.6270613868555;771.3388808610205;787.9960600196962;848.6011574559947;5306.708131052829;5356.491133342326;5422.240886275925;5594.1608758686525;5597.776088956396;868.5961028121953;877.9692710755093;892.6340200517757;924.9398789078689;927.7216834949488;3570.589382221026;3598.5142005829402;3788.109794198361;3868.941965870514;3911.647951684362;9665.081817227492;9763.170130538983;9878.703638890845;9890.505474726378;9912.454814985102;9843.507824608741;9862;9863.901360986298;9871.753206169904;9875.160611348116;7185.568865868065;7549.962250188714;7666.4633475656165;7736.381089512825;7737.264959828807;5299.5760339172;5355.30381050461;5447.782088716565;5500.202470641654;5819.79630712923;9058.320625953213;9060.744768034656;9066.909330906607;9155.771105722144;9208.12522810332;9178.586963586522;9310.301727370339;9328.53357332117;9344.205742511962;9392.906070939203;6819.113515242987;7055.470839686941;7060.929390706027;7067;7080.2919708028785;7206.747763828241;7446.032015837906;7508.962455187689;7520.586367749826;7627.237276272328;6843.863122737617;6874.793756187322;6908.965455172692;6936.618485983117;6946.583205007716;6711.832204194934;6819.5908245505425;6829.248782634006;6855.5543889647015;6856.382925536725;6340.144080549251;6469.061986012096;6477.093206951125;6479.708413121515;6489.86427375198;4614.146382919171;4698.2952557116705;4735.17134501454;4751.952480475151;4839.177339852304;4517.728936263835;4671.995520963009;4834.323194752667;4935.876603084952;4998.525140111684 05:12:31 INFO - PROCESS | 1638 | |4;prototype.html;295.6415271825962;300.42618598476906;300.9458297506449;309.76612657443627;309.87295208964326;3984.4222587724835;4659.976700116499;5185.962807438508;5269.2886460327845;5269.841904742854;4729.952700472994;5107.648993894981;5154.484551544843;5177.948220517794;5187.766550505227;3539.699125574329;3856.479375284343;3887.494625698655;3894.49371581694;3982.721209515335;3977.264206121862;4031.798410079499;4031.9395209071886;4035.385845661744;4046.7774272415154;3441.380551500729;3729.067733066733;3995.962059349738;4005.7796821174825;4020.7989600520004;3344.8160351180677;3629.618890016563;3775.7734535927657;3808.9619103808886;4018.377151541501;3502.231373156565;3504.9649503505148;3527.25400926543;3544.3620148373284;3563.518924945125;5089.592832573385;5106.897862042739;5109.259157422153;5121.436641969381;5138.3833939927445;3443.9151667224746;3985.262726395626;4000.3599424092295;4171.561985991488;4515.5032946376205;4437;5411;5439.972800136014;5455.399906010375;5455.427180146067;3485.723419985231;3639.854405823764;3834.830376735095;3846.3268927937497;3881.4371916072296;4864.683795553277;5000.799648154836;5684.317881854204;5699.059655156894;5765.423457654201;3758.774473531597;3878.8836334909997;3899.395593682984;3920.2747491714126;3924.1170736584613;3274.9192766387036;3955.9011024724614;3970.7617542947514;3994.500687414073;4003.4795476587856;4275.5296917339065;4523.909521809545;4547.3179023146795;4559.0881823634745;4562.064776720765;4837.9032419351415;5436.392723825349;5475.835724928259;5501.4223506532035;5572.959604286941;1224.302147775777;1256.7926292161874;1268.8984881209665;1274.6112435707198;1278.4247088810073;795.5385876191795;812.6627449608465;881.9647214111492;883.6700765348238;884.6417201033463;3987.1626958338493;4366.65066794662;4533.682642215013;4545.318202269686;5088.338515992971;4580.290055041474;5492.423295553989;5628.240187574707;5634.746436410372;5651.383114806527;3965.6490265725415;5022.694099534147;5163.035341790305;5163.638545301793;5171.3018742469285;2439.7560243975818;2474.381404648838;2495.589991654709;2765.925555833125;2773.5285001549787;4844.394450693663;5200.76596553156;5334;5579.832605021856;5595.888082238333;4636.768161591907;5084.898302034013;5350.571954243651;5421.241026256248;5469.179623056573;4391.253486907233;4909;5030.949690503121;5481.862953426196;5483.259759932358;4239.80920858556;4912.873186523338;5253.947460525345;5326.36083669962;5326.680399176062;4563.726176429424;4585.610223130938;5213.661112027706;5239.135542635422;5368.758405871823;4723.417655085447;5400.405955344988;5792.536597072309;5873.913326034697;5943.346231914573;3273.1817045738567;3767.811609419573;3817.0838998640684;3824.8007395748114;3881.7865017424315;4616.976915115537;5000.549401152761;5751.424857514216;5770.567207459373;5788.536917046542;5058.671186372874;5331.040412725747;5484.725763711878;5524.751386187711;5545.584081193846;4719.952800472089;4803.087413391444;5380.932868265051;5441.863953401196;5518.972405137949;4753.667243292936;4913.975430122827;5094.270939817157;5446.754896029767;5509.449055094458;4783.808647654055;5266.183741520071;5299.364076310867;5497.175423686479;5505.109817345926;4546.727196368229;5282.498162674539;5327.401779466222;5409.350877894678;5448.45515448452 05:12:31 INFO - PROCESS | 1638 | |5;yui.html;676.3844901139963;721.6536062689909;726.9527480713754;749.2806905370844;759.9202083781202;14551.854481455182;15116.244187790622;15145.697086058271;15162.014469059503;15165.165915874622;13394.12938159019;13432.126911750729;13486.662833429169;13506.594802155927;13516.932415337935;652.7454292825802;677.606987946992;681.1689738518999;803.8392321535687;806.6934564865358;825.5005721538473;828.411827602403;838.3083955736512;838.4717627894418;842.540815255684;846.7383598438344;890.0698769785557;893.2541327991136;893.9106089391074;894.4454438248296;679.813051410861;710.3784188834769;880.7577916073035;881.3433991676178;882.6116508736168;614.7848253111375;643.2955913274957;646.941775240226;650.9804705858832;652.4063102576632;13873.37569809361;13954.441822327095;14248.572542823731;14264.429422823074;14267.357968891321;13025.283609401478;13150.60548183556;13228.338583070808;13231.404586793617;13355.265460399674;12136.15046946714;12167.695807604792;12212.145149839514;12312.815307770301;12343.567975120917;4395.7142785718825;4449.354843547668;4568.908621827545;4583.747893865836;4597.655175861823;89377.65933510938;89621;89659;90412.54793726055;90459;10098.343607665478;10103.292769506064;10372.170226381872;10464.162866970624;10768.623098191525;19715.309964151187;19954.60090798205;20005.399838004592;20102.89948550277;20333.89833050825;6052.697365131726;6069.848253793691;6100.145979562864;6124.265088189446;6224.937750622526;4150.958490415057;4165.8958526037095;4203.327467605169;4209.663226941837;4225.091605304813;3199.6640352762624;3248.5289633003554;3255.641879393312;3268.313654132659;3307.9173020674675;618.2025187508065;625.1778910732372;627.0750642801922;635.2948227467507;644.4972921121532;570.7060863655221;606.5147881694627;612.8958077126899;622.2346513788066;624.5003996802631;6719;6948.513604047769;7543.170251272356;8125.309348705308;8286.129956354616;474.41409858824323;563.5801328010658;611.3611276216365;611.7247238742494;622.1414448061736;3990.960090399059;4170.436991006236;4226.788660566959;4238.894027649272;4367.934480982788;74040.62979685067;98414.5079274599;114270.86041070952;118439;120765.79234207545;60726;80275.19724802794;83402.16597833944;84868.57565712255;92664.53667731753;56985;57982.42017579854;58149;58796.706016470496;76567.19477259963;9198.356115071882;9433.103855133751;9468.810623787624;9589.904100958902;9735.756606084904;41805.79097104495;53555.46444535505;53566.857325706536;53957;56670;69505.30494694988;71606.64196679191;71910.64044679953;72078.63960680373;75168.62415687887;10044.2513155795;12097.516099356279;12218.87781122213;12307.569235077088;12634.620961371174;12439.315837629018;13574.59276221715;13963.650908726957;14128.78806817919;14235.857641423454;12824.358782061046;12963.546275880677;13208.405621746851;13496.190228586316;13615.863841361459;12827.358632068546;12912.16070955385;13090.80363794563;13283.335833208494;13512.93243533776;12535.310557919402;12723.86609394173;12748.002067512492;12761.93619031899;12857.49181202305;10677.786444270916;10750.677479675622;10908.290961087503;11089.833652495057;11299.774004520028;10774.892251077388;10942.72643183895;11017.889821102008;11202;11230.270032447865 05:12:31 INFO - PROCESS | 1638 | __end_tp_report 05:12:31 INFO - PROCESS | 1638 | __start_cc_report 05:12:31 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1638 05:12:31 INFO - PROCESS | 1638 | __end_cc_report 05:12:31 INFO - PROCESS | 1638 | __startTimestamp1480079551944__endTimestamp 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | ------- Summary: start ------- 05:12:31 INFO - PROCESS | 1638 | Number of tests: 6 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5592.38 Median:5783.22 stddev:643.31 (11.1%) stddev-sans-first:617.99 05:12:31 INFO - PROCESS | 1638 | Values: 3228.8 3262.0 3269.5 3272.7 3311.0 5437.7 5479.2 5534.0 5583.9 5623.0 5495.0 5544.8 5551.5 5561.1 5615.0 4991.9 5011.3 5015.0 5048.2 5103.2 4445.6 5081.5 5118.0 5200.6 5217.5 4973.2 5108.8 5115.7 5123.6 5195.0 5016.6 5028.6 5074.6 5090.3 5103.7 4173.4 5074.1 5086.8 5126.3 5142.7 5550.9 5551.8 5565.5 5587.1 5591.1 5890.6 5939.5 5956.0 6077.5 6079.5 6072.6 6103.5 6104.5 6153.1 6181.8 5635.5 5645.9 5647.7 5650.8 5680.2 6092.9 6181.6 6244.2 6247.5 6249.7 5796.0 5807.1 5853.0 5871.4 5875.9 6062.0 6063.4 6069.2 6092.3 6093.1 5906.8 5954.0 5961.9 5967.0 5968.6 5995.5 6001.0 6010.3 6012.6 6022.1 4716.1 4813.9 4818.3 4821.8 4840.6 4271.2 4280.4 4285.7 4325.3 4404.4 5597.8 5600.1 5601.7 5662.4 5685.1 5267.1 6147.6 6192.6 6197.3 6211.7 5484.1 5551.5 5552.8 5579.7 5640.3 5281.0 5337.2 5350.2 5351.0 5352.9 6257.0 6262.6 6267.3 6268.0 6274.0 6014.5 6185.8 6199.3 6200.7 6210.1 6137.7 6175.9 6187.5 6191.7 6200.9 6045.0 6065.9 6078.4 6087.7 6123.7 5954.2 6095.7 6168.3 6171.5 6193.4 5790.9 5862.8 5882.5 6000.9 6020.1 5879.7 5945.6 5964.8 6025.6 6046.1 4817.3 5783.2 5794.8 5800.1 5818.2 5917.6 5992.2 6002.1 6033.2 6038.7 5653.6 5704.5 5718.6 5733.7 5778.8 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67836.49 Median:18496.54 stddev:150503.17 (813.7%) stddev-sans-first:150840.37 05:12:31 INFO - PROCESS | 1638 | Values: 464.3 488.2 511.8 532.8 546.6 29807.7 37938.8 38966.0 39212.8 41076.8 39864.6 40454.0 40461.2 40480.0 40542.4 8235.6 9141.6 9330.3 9336.7 9368.8 8261.1 10936.0 11126.1 11153.1 11378.0 11028.1 11052.0 11073.4 11109.3 11137.9 11040.4 11100.3 11101.8 11102.8 11112.5 11010.2 11071.9 11074.6 11075.9 11091.2 30822.4 37972.0 38102.0 38151.8 38152.2 3239.5 3286.6 3317.4 3334.4 3415.2 28822.0 29241.6 29293.3 29369.0 29747.9 2602.6 3107.7 3192.5 3214.6 3245.7 363809.0 503102.0 504216.0 511082.0 511659.4 54873.5 56061.4 56414.7 56465.2 56549.2 58762.4 59011.7 59012.4 59062.4 59130.0 12659.3 14920.3 15107.4 15117.2 15334.4 10826.5 11077.3 12056.2 12085.7 12100.3 11057.4 11897.6 14915.0 15103.3 15221.9 6371.2 6431.2 6497.0 6500.0 6509.5 901.4 941.2 983.2 996.7 1023.3 27651.6 28584.7 29267.0 29314.6 29830.7 1013.4 1016.7 1054.4 1101.1 1127.7 11959.5 14024.6 14757.5 14835.9 14958.0 591081.1 624281.0 631037.8 650941.0 652283.0 52466.7 52742.7 52749.2 52753.0 52784.0 1234.2 1271.5 1272.9 1356.9 1384.4 22006.7 27652.3 28948.0 29842.4 30633.0 51495.7 51971.5 52173.7 52192.0 52297.4 483056.0 578491.0 583369.0 583999.0 587114.1 22165.8 22744.0 24216.0 24349.5 24720.1 37549.8 37787.0 37898.6 38006.8 43546.1 32764.5 33834.0 35078.6 36914.0 38034.8 28950.7 35014.8 36587.6 37238.6 37917.4 35836.7 35859.6 35981.8 35986.5 37219.1 32486.7 32495.1 33263.0 33658.7 34442.0 21178.3 24097.3 24366.9 24576.4 25149.2 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:36547.00 Median:34607.15 stddev:100836.19 (291.4%) stddev-sans-first:101082.47 05:12:31 INFO - PROCESS | 1638 | Values: 368.9 371.5 382.3 392.2 400.0 14982.3 16549.4 19593.6 20133.7 20327.8 11357.8 11763.8 11774.2 11778.3 11783.6 4808.7 5265.6 5326.5 5332.2 5337.3 3807.9 4000.8 4022.3 5164.8 7008.3 7215.9 7479.3 7500.7 7583.2 7598.3 7453.9 7519.5 7541.7 7542.4 7553.0 6715.2 7114.0 7209.4 7254.6 7292.6 23080.8 28213.0 28407.9 28531.6 28749.6 2485.8 2488.8 2531.9 2560.8 2608.8 12827.9 15072.3 16165.7 16670.0 17098.1 1890.9 1954.9 1970.4 1984.2 2169.3 122763.4 133239.0 139681.3 140235.0 143880.6 20757.8 20851.1 20974.8 21031.9 21485.4 34578.3 34636.0 34674.7 34730.0 34867.3 10282.2 10497.6 10532.1 10645.8 10658.9 6823.0 7408.9 8735.6 8865.7 8887.0 9201.8 9455.3 9528.2 9538.5 9610.6 2616.7 3513.9 3608.5 3640.9 3697.7 823.9 898.3 922.1 933.3 944.9 20322.6 21121.6 21156.3 21174.7 21258.8 920.6 921.8 941.0 1007.5 1015.7 10509.3 11087.7 11174.9 11175.6 11176.0 594353.0 598620.0 604270.0 605495.0 613017.0 78218.0 79009.6 138076.0 139761.0 147108.0 959.6 990.6 994.8 1012.3 1012.5 17046.6 17560.5 18681.4 18900.6 19331.2 55897.0 57043.7 57196.7 58642.7 58680.0 79333.2 79967.6 80937.6 82442.8 84559.0 7768.0 8048.4 8056.6 8070.8 8132.6 9068.5 12122.2 12432.0 12528.2 12718.5 8581.6 10738.8 10931.7 11062.2 11107.4 10381.4 10543.9 10602.8 10759.5 10982.3 11055.4 11274.0 11281.9 11355.8 11367.9 7663.8 7712.3 7977.8 7987.2 8004.7 9385.6 10642.1 10960.1 11165.3 11178.6 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5316.39 Median:5331.01 stddev:2900.75 (54.4%) stddev-sans-first:2894.45 05:12:31 INFO - PROCESS | 1638 | Values: 1465.1 1499.0 1648.7 1744.9 1832.4 7423.0 7701.2 7850.2 8305.0 8306.3 7511.6 7811.5 8015.8 8025.0 8150.6 2260.9 2303.8 2304.7 2312.5 2315.4 1676.8 2289.7 2318.3 2342.5 2348.5 2057.1 2099.9 2188.6 2277.8 2285.4 1902.3 2253.9 2273.5 2305.3 2311.6 2293.3 2315.4 2326.3 2327.4 2328.9 7913.2 8089.3 8096.3 8121.2 8140.6 4947.6 5066.5 5072.9 5123.2 5126.6 3167.5 3271.7 3509.4 3510.8 3520.6 892.2 1061.6 1069.3 1075.9 1083.3 10242.2 10494.5 10495.6 10587.5 10704.2 4410.1 4509.6 4593.0 4646.5 4669.3 9260.7 9261.5 9267.9 9283.3 9289.3 5108.8 5109.7 5113.1 5119.8 5122.3 4573.9 4604.3 4675.5 4692.4 4703.3 3600.7 3647.9 3648.8 3671.5 3698.2 1195.8 1220.8 1221.3 1232.1 1233.0 609.4 690.6 771.3 788.0 848.6 5306.7 5356.5 5422.2 5594.2 5597.8 868.6 878.0 892.6 924.9 927.7 3570.6 3598.5 3788.1 3868.9 3911.6 9665.1 9763.2 9878.7 9890.5 9912.5 9843.5 9862.0 9863.9 9871.8 9875.2 7185.6 7550.0 7666.5 7736.4 7737.3 5299.6 5355.3 5447.8 5500.2 5819.8 9058.3 9060.7 9066.9 9155.8 9208.1 9178.6 9310.3 9328.5 9344.2 9392.9 6819.1 7055.5 7060.9 7067.0 7080.3 7206.7 7446.0 7509.0 7520.6 7627.2 6843.9 6874.8 6909.0 6936.6 6946.6 6711.8 6819.6 6829.2 6855.6 6856.4 6340.1 6469.1 6477.1 6479.7 6489.9 4614.1 4698.3 4735.2 4752.0 4839.2 4517.7 4672.0 4834.3 4935.9 4998.5 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4338.15 Median:4793.45 stddev:1322.80 (27.6%) stddev-sans-first:1291.24 05:12:31 INFO - PROCESS | 1638 | Values: 295.6 300.4 300.9 309.8 309.9 3984.4 4660.0 5186.0 5269.3 5269.8 4730.0 5107.6 5154.5 5177.9 5187.8 3539.7 3856.5 3887.5 3894.5 3982.7 3977.3 4031.8 4031.9 4035.4 4046.8 3441.4 3729.1 3996.0 4005.8 4020.8 3344.8 3629.6 3775.8 3809.0 4018.4 3502.2 3505.0 3527.3 3544.4 3563.5 5089.6 5106.9 5109.3 5121.4 5138.4 3443.9 3985.3 4000.4 4171.6 4515.5 4437.0 5411.0 5440.0 5455.4 5455.4 3485.7 3639.9 3834.8 3846.3 3881.4 4864.7 5000.8 5684.3 5699.1 5765.4 3758.8 3878.9 3899.4 3920.3 3924.1 3274.9 3955.9 3970.8 3994.5 4003.5 4275.5 4523.9 4547.3 4559.1 4562.1 4837.9 5436.4 5475.8 5501.4 5573.0 1224.3 1256.8 1268.9 1274.6 1278.4 795.5 812.7 882.0 883.7 884.6 3987.2 4366.7 4533.7 4545.3 5088.3 4580.3 5492.4 5628.2 5634.7 5651.4 3965.6 5022.7 5163.0 5163.6 5171.3 2439.8 2474.4 2495.6 2765.9 2773.5 4844.4 5200.8 5334.0 5579.8 5595.9 4636.8 5084.9 5350.6 5421.2 5469.2 4391.3 4909.0 5030.9 5481.9 5483.3 4239.8 4912.9 5253.9 5326.4 5326.7 4563.7 4585.6 5213.7 5239.1 5368.8 4723.4 5400.4 5792.5 5873.9 5943.3 3273.2 3767.8 3817.1 3824.8 3881.8 4617.0 5000.5 5751.4 5770.6 5788.5 5058.7 5331.0 5484.7 5524.8 5545.6 4720.0 4803.1 5380.9 5441.9 5519.0 4753.7 4914.0 5094.3 5446.8 5509.4 4783.8 5266.2 5299.4 5497.2 5505.1 4546.7 5282.5 5327.4 5409.4 5448.5 05:12:31 INFO - PROCESS | 1638 | 05:12:31 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19218.76 Median:4509.13 stddev:27605.46 (612.2%) stddev-sans-first:27647.79 05:12:31 INFO - PROCESS | 1638 | Values: 676.4 721.7 727.0 749.3 759.9 14551.9 15116.2 15145.7 15162.0 15165.2 13394.1 13432.1 13486.7 13506.6 13516.9 652.7 677.6 681.2 803.8 806.7 825.5 828.4 838.3 838.5 842.5 846.7 890.1 893.3 893.9 894.4 679.8 710.4 880.8 881.3 882.6 614.8 643.3 646.9 651.0 652.4 13873.4 13954.4 14248.6 14264.4 14267.4 13025.3 13150.6 13228.3 13231.4 13355.3 12136.2 12167.7 12212.1 12312.8 12343.6 4395.7 4449.4 4568.9 4583.7 4597.7 89377.7 89621.0 89659.0 90412.5 90459.0 10098.3 10103.3 10372.2 10464.2 10768.6 19715.3 19954.6 20005.4 20102.9 20333.9 6052.7 6069.8 6100.1 6124.3 6224.9 4151.0 4165.9 4203.3 4209.7 4225.1 3199.7 3248.5 3255.6 3268.3 3307.9 618.2 625.2 627.1 635.3 644.5 570.7 606.5 612.9 622.2 624.5 6719.0 6948.5 7543.2 8125.3 8286.1 474.4 563.6 611.4 611.7 622.1 3991.0 4170.4 4226.8 4238.9 4367.9 74040.6 98414.5 114270.9 118439.0 120765.8 60726.0 80275.2 83402.2 84868.6 92664.5 56985.0 57982.4 58149.0 58796.7 76567.2 9198.4 9433.1 9468.8 9589.9 9735.8 41805.8 53555.5 53566.9 53957.0 56670.0 69505.3 71606.6 71910.6 72078.6 75168.6 10044.3 12097.5 12218.9 12307.6 12634.6 12439.3 13574.6 13963.7 14128.8 14235.9 12824.4 12963.5 13208.4 13496.2 13615.9 12827.4 12912.2 13090.8 13283.3 13512.9 12535.3 12723.9 12748.0 12761.9 12857.5 10677.8 10750.7 10908.3 11089.8 11299.8 10774.9 10942.7 11017.9 11202.0 11230.3 05:12:31 INFO - PROCESS | 1638 | -------- Summary: end -------- 05:12:31 INFO - PROCESS | 1638 | 05:12:32 INFO - TEST-INFO | 1638: exit 0 05:12:32 INFO - TEST-OK | dromaeo_css | took 1120217ms 05:12:32 INFO - TEST-START | kraken 05:12:32 INFO - operating with platform_type : mac_ 05:12:32 INFO - Initialising browser for kraken test... 05:12:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpq8qvsP/profile http://localhost:49241/getInfo.html) 05:12:35 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:12:35 INFO - PROCESS | 1648 | colorDepth:24 05:12:35 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:12:35 INFO - PROCESS | 1648 | __metrics 05:12:35 INFO - PROCESS | 1648 | 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" 05:12:35 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:36 INFO - TEST-INFO | 1648: exit 0 05:12:36 INFO - Browser initialized. 05:12:36 INFO - Running cycle 1/1 for kraken test... 05:12:36 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpq8qvsP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:48 INFO - PROCESS | 1649 | RSS: Main: 236494848 05:12:48 INFO - PROCESS | 1649 | 05:12:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:52 INFO - PROCESS | 1649 | RSS: Main: 294776832 05:12:52 INFO - PROCESS | 1649 | 05:12:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:12:55 INFO - PROCESS | 1649 | RSS: Main: 297136128 05:12:55 INFO - PROCESS | 1649 | 05:12:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:12:59 INFO - PROCESS | 1649 | RSS: Main: 389775360 05:12:59 INFO - PROCESS | 1649 | 05:13:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:13:02 INFO - PROCESS | 1649 | RSS: Main: 290070528 05:13:02 INFO - PROCESS | 1649 | 05:13:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:04 INFO - PROCESS | 1649 | RSS: Main: 293281792 05:13:04 INFO - PROCESS | 1649 | 05:13:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:08 INFO - PROCESS | 1649 | RSS: Main: 335818752 05:13:08 INFO - PROCESS | 1649 | 05:13:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:11 INFO - PROCESS | 1649 | RSS: Main: 337006592 05:13:11 INFO - PROCESS | 1649 | 05:13:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:13:15 INFO - PROCESS | 1649 | RSS: Main: 336470016 05:13:15 INFO - PROCESS | 1649 | 05:13:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:17 INFO - PROCESS | 1649 | RSS: Main: 310128640 05:13:17 INFO - PROCESS | 1649 | 05:13:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:20 INFO - PROCESS | 1649 | RSS: Main: 314310656 05:13:20 INFO - PROCESS | 1649 | 05:13:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:22 INFO - PROCESS | 1649 | RSS: Main: 315977728 05:13:22 INFO - PROCESS | 1649 | 05:13:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:26 INFO - PROCESS | 1649 | RSS: Main: 325099520 05:13:26 INFO - PROCESS | 1649 | 05:13:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:30 INFO - PROCESS | 1649 | RSS: Main: 323850240 05:13:30 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:13:32 INFO - PROCESS | 1649 | RSS: Main: 367771648 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | __start_tp_report 05:13:32 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:13:32 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:13:32 INFO - PROCESS | 1649 | |i|pagename|runs| 05:13:32 INFO - PROCESS | 1649 | |0;ai-astar;103;114;115;115;116;115;115;115;114;114 05:13:32 INFO - PROCESS | 1649 | |1;audio-beat-detection;148;116;118;181;145;114;112;112;134;119 05:13:32 INFO - PROCESS | 1649 | |2;audio-dft;183;186;184;186;180;197;258;184;184;181 05:13:32 INFO - PROCESS | 1649 | |3;audio-fft;81;59;60;89;63;60;59;59;75;59 05:13:32 INFO - PROCESS | 1649 | |4;audio-oscillator;85;72;86;69;68;70;82;68;69;85 05:13:32 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;90;131;129;84;87;84;88;84;90;84 05:13:32 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;94;94;94;94;93;93;92;94 05:13:32 INFO - PROCESS | 1649 | |7;imaging-desaturate;87;87;84;85;88;86;87;87;88;85 05:13:32 INFO - PROCESS | 1649 | |8;json-parse-financial;59;55;54;53;54;54;54;55;54;55 05:13:32 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;65;68;83;77;74;72;70;71;74;71 05:13:32 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;89;87;88;88;87;87;90;97;104;90 05:13:32 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;144;146;148;149;148;149;150;151;285;192 05:13:32 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;175;178;211;172;173;173;174;177;236;216 05:13:32 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;68;67;68;68;68;67;67;67;67;66 05:13:32 INFO - PROCESS | 1649 | __end_tp_report 05:13:32 INFO - PROCESS | 1649 | __start_cc_report 05:13:32 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1961 05:13:32 INFO - PROCESS | 1649 | __end_cc_report 05:13:32 INFO - PROCESS | 1649 | __startTimestamp1480079612489__endTimestamp 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:13:32 INFO - PROCESS | 1649 | Number of tests: 14 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.78 (3.3%) stddev-sans-first:0.67 05:13:32 INFO - PROCESS | 1649 | Values: 103.0 114.0 115.0 115.0 116.0 115.0 115.0 115.0 114.0 114.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:126.50 stddev:22.44 (17.7%) stddev-sans-first:22.82 05:13:32 INFO - PROCESS | 1649 | Values: 148.0 116.0 118.0 181.0 145.0 114.0 112.0 112.0 134.0 119.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:192.30 Median:185.00 stddev:23.55 (12.7%) stddev-sans-first:24.73 05:13:32 INFO - PROCESS | 1649 | Values: 183.0 186.0 184.0 186.0 180.0 197.0 258.0 184.0 184.0 181.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.50 stddev:11.11 (18.1%) stddev-sans-first:10.45 05:13:32 INFO - PROCESS | 1649 | Values: 81.0 59.0 60.0 89.0 63.0 60.0 59.0 59.0 75.0 59.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:7.97 (10.4%) stddev-sans-first:7.66 05:13:32 INFO - PROCESS | 1649 | Values: 85.0 72.0 86.0 69.0 68.0 70.0 82.0 68.0 69.0 85.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:85.50 stddev:18.56 (21.7%) stddev-sans-first:19.59 05:13:32 INFO - PROCESS | 1649 | Values: 90.0 131.0 129.0 84.0 87.0 84.0 88.0 84.0 90.0 84.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:13:32 INFO - PROCESS | 1649 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 92.0 94.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 05:13:32 INFO - PROCESS | 1649 | Values: 87.0 87.0 84.0 85.0 88.0 86.0 87.0 87.0 88.0 85.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:1.64 (3.0%) stddev-sans-first:0.67 05:13:32 INFO - PROCESS | 1649 | Values: 59.0 55.0 54.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:4.97 (6.8%) stddev-sans-first:4.47 05:13:32 INFO - PROCESS | 1649 | Values: 65.0 68.0 83.0 77.0 74.0 72.0 70.0 71.0 74.0 71.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:88.50 stddev:5.54 (6.3%) stddev-sans-first:5.84 05:13:32 INFO - PROCESS | 1649 | Values: 89.0 87.0 88.0 88.0 87.0 87.0 90.0 97.0 104.0 90.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:166.20 Median:149.50 stddev:44.00 (29.4%) stddev-sans-first:45.93 05:13:32 INFO - PROCESS | 1649 | Values: 144.0 146.0 148.0 149.0 148.0 149.0 150.0 151.0 285.0 192.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.50 Median:177.50 stddev:23.35 (13.2%) stddev-sans-first:24.25 05:13:32 INFO - PROCESS | 1649 | Values: 175.0 178.0 211.0 172.0 173.0 173.0 174.0 177.0 236.0 216.0 05:13:32 INFO - PROCESS | 1649 | 05:13:32 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:13:32 INFO - PROCESS | 1649 | Values: 68.0 67.0 68.0 68.0 68.0 67.0 67.0 67.0 67.0 66.0 05:13:32 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:13:32 INFO - PROCESS | 1649 | 05:13:33 INFO - TEST-INFO | 1649: exit 0 05:13:33 INFO - TEST-OK | kraken | took 61070ms 05:13:33 INFO - SUITE-END | took 1181s 05:13:34 INFO - Completed test suite (00:19:41) 05:13:34 INFO - javascript benchmark 05:13:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.773985820992, 3261.9673803261962, 3269.4932285495756, 3272.6563710810365, 3310.957048529713, 5437.673739575628, 5479.232907392963, 5533.972330138344, 5583.944160558393, 5623.044082505973, 5495.010898038361, 5544.750486228119, 5551.528120109796, 5561.054620714478, 5615.0, 4991.900161996758, 5011.273365362021, 5015.0, 5048.242763585473, 5103.183490641498, 4445.5776701213335, 5081.46644602317, 5117.974410127944, 5200.583953283747, 5217.504337087989, 4973.2291494818, 5108.846734597968, 5115.744212789365, 5123.641345105844, 5195.0, 5016.623753218523, 5028.622853285981, 5074.568661663763, 5090.287359769635, 5103.744812759384, 4173.353130264783, 5074.086664400406, 5086.79652813887, 5126.307948426952, 5142.665726727788, 5550.944490555124, 5551.77792888284, 5565.471280228372, 5587.05020146576, 5591.133374326986, 5890.646561206341, 5939.524838012949, 5955.987482128048, 6077.483413909823, 6079.513638908877, 6072.605280656743, 6103.526537179873, 6104.466343479301, 6153.077038444225, 6181.752729890799, 5635.549156067505, 5645.915311270334, 5647.745851436654, 5650.802221922213, 5680.176374425727, 6092.878142437126, 6181.629102253879, 6244.219472565929, 6247.500199983991, 6249.6562689052535, 5796.014677504834, 5807.128930660435, 5853.0, 5871.3541510433815, 5875.882482350329, 6062.0, 6063.393660633989, 6069.15031895535, 6092.329843717188, 6093.11649810775, 5906.7637294508595, 5953.958057339948, 5961.850953726192, 5967.045272756338, 5968.582199246098, 5995.46040856325, 6001.0, 6010.278766548042, 6012.609180403259, 6022.096685497123, 4716.103940251342, 4813.855584332476, 4818.253170758538, 4821.783019764119, 4840.636952228597, 4271.188474189894, 4280.379344995021, 4285.678574106954, 4325.264705000094, 4404.383386325917, 5597.776088956478, 5600.103983362643, 5601.719914004283, 5662.433756624387, 5685.0619647758485, 5267.078261304257, 6147.600405973598, 6192.566520343623, 6197.287311959092, 6211.720472578745, 5484.149956756629, 5551.500364967092, 5552.833414997556, 5579.721013949286, 5640.266765320482, 5281.049411105961, 5337.226102215157, 5350.170723537858, 5350.9732451337495, 5352.892942141136, 6256.967600345983, 6262.5929314594405, 6267.310595834455, 6267.96866015667, 6273.968630156911, 6014.548908831767, 6185.8144255672405, 6199.3490683477585, 6200.658963757037, 6210.099535567408, 6137.714085983886, 6175.9382406177165, 6187.474064704371, 6191.690415479298, 6200.937990620036, 6045.032794752994, 6065.878682426239, 6078.422549857756, 6087.69561521931, 6123.693815309306, 5954.225950626565, 6095.664738439428, 6168.321484636776, 6171.47542458896, 6193.4425901669065, 5790.884182316246, 5862.765489380377, 5882.5293976480925, 6000.909986350295, 6020.096985452217, 5879.676617786063, 5945.613535120204, 5964.7912323068485, 6025.638461692137, 6046.123312119806, 4817.27740838877, 5783.219265399285, 5794.82615521535, 5800.071988481823, 5818.156367326798, 5917.5857689961285, 5992.161097446448, 6002.069679199731, 6033.215681961317, 6038.728257228523, 5653.575981801464, 5704.458076482728, 5718.571107166896, 5733.71331433435, 5778.8266352009505], "value": 5550.61230120516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.3058627352108, 488.1652374439708, 511.7952818872451, 532.7602578839524, 546.5682111132206, 29807.65865536051, 37938.810305948464, 38966.0, 39212.80393598035, 41076.79461602695, 39864.60135398645, 40454.0, 40461.19077618453, 40480.0, 40542.39186412206, 8235.588220588947, 9141.634334626624, 9330.300227482932, 9336.719898403058, 9368.81262374752, 8261.091279959199, 10936.0, 11126.109911207084, 11153.10775137987, 11378.032867206297, 11028.117750579975, 11052.0, 11073.390963497044, 11109.277896936714, 11137.944310278437, 11040.392778397185, 11100.333979961228, 11101.83347249792, 11102.833457498144, 11112.499937502831, 11010.174236932182, 11071.889281107166, 11074.612388566442, 11075.889241107567, 11091.168162387854, 30822.38355232883, 37972.0, 38102.0, 38151.80924095362, 38152.23695526074, 3239.5302681111107, 3286.5727455430642, 3317.369699757063, 3334.416477116495, 3415.1803567143957, 28822.027644254802, 29241.561376579368, 29293.26766830825, 29369.0, 29747.851260743773, 2602.6325363954975, 3107.7043518761575, 3192.457282262021, 3214.61424629046, 3245.675432456759, 363809.0, 503102.0, 504216.0, 511082.0, 511659.4417027928, 54873.45126548763, 56061.439385606434, 56414.71792641011, 56465.15302270469, 56549.151762723595, 58762.41237587655, 59011.704941475014, 59012.40987590155, 59062.40937590655, 59130.0, 12659.303738294482, 14920.253987300808, 15107.39570417171, 15117.244137793066, 15334.386624534895, 10826.458677066115, 11077.335359878272, 12056.156069075256, 12085.697857553632, 12100.273983561014, 11057.391843448688, 11897.643070707893, 14915.030523015968, 15103.32035058425, 15221.923890380698, 6371.235451745728, 6431.163948686641, 6496.967515162489, 6499.967500162469, 6509.544331896816, 901.3870568013814, 941.2281928818303, 983.2478154211891, 996.6511720897628, 1023.2990401574945, 27651.58522622162, 28584.714152858207, 29267.0, 29314.560281595794, 29830.701692983228, 1013.3717095400751, 1016.7102375822855, 1054.3779170289565, 1101.0530943388678, 1127.6617014895498, 11959.521619135137, 14024.649383765487, 14757.541899441341, 14835.851641483663, 14958.0, 591081.0891891113, 624281.0, 631037.844810773, 650941.0, 652283.0, 52466.73766631143, 52742.736286319094, 52749.208761868606, 52753.0, 52784.0, 1234.2471092633486, 1271.491403438595, 1272.9299888506036, 1356.87109724576, 1384.4116250593459, 22006.669899951834, 27652.308692282048, 28948.0, 29842.403151937273, 30633.0, 51495.74252128715, 51971.48028519667, 52173.7391313041, 52192.0, 52297.38513074255, 483056.0, 578491.0, 583369.0, 583999.0, 587114.0644296751, 22165.778342217018, 22744.0, 24216.0, 24349.51300974006, 24720.13479528208, 37549.81225093857, 37787.0, 37898.62101379061, 38006.80996594999, 43546.12907741764, 32764.50853237251, 33833.98498045062, 35078.64921350856, 36914.0, 38034.809825950695, 28950.710492894803, 35014.82492587521, 36587.63412365949, 37238.62761372352, 37917.431238530895, 35836.67061640985, 35859.64140358563, 35981.820090899375, 35986.4602030975, 37219.06952326214, 32486.675133248365, 32495.050296982256, 33263.0, 33658.66341336555, 34442.0, 21178.25876094391, 24097.277081687578, 24366.878165609058, 24576.385590360384, 25149.24552263435], "value": 19085.88051368352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.86167687117313, 371.5448575495018, 382.34809649547526, 392.19012738694573, 399.99601001486263, 14982.32579533921, 16549.420770273042, 19593.608127837433, 20133.697994530095, 20327.796722032774, 11357.829632555518, 11763.764724705523, 11774.234674746136, 11778.29330240184, 11783.646490605273, 4808.663393562452, 5265.631405801595, 5326.467353264681, 5332.200169974496, 5337.332833395825, 3807.8667246646232, 4000.799960002003, 4022.3162062449455, 5164.767585458645, 7008.299170082976, 7215.927840721578, 7479.326860582546, 7500.662470188855, 7583.241675832428, 7598.278163574451, 7453.925460745378, 7519.511231769918, 7541.7360392386, 7542.35889949355, 7552.962235188844, 6715.2277488089, 7113.964430177868, 7209.351158395717, 7254.637268136625, 7292.562446253241, 23080.76919230803, 28213.0, 28407.85796071027, 28531.57202641962, 28749.56875646867, 2485.8135639826905, 2488.7760101590943, 2531.860747658878, 2560.8079394045335, 2608.804339674513, 12827.935860320638, 15072.321745521369, 16165.676686466204, 16669.999800011916, 17098.14509274531, 1890.9243630254773, 1954.9315773947844, 1970.4088773367932, 1984.2063174730079, 2169.349195241437, 122763.38618306941, 133239.0, 139681.3015934924, 140235.0, 143880.5611943888, 20757.792422075887, 20851.061702223436, 20974.790252097588, 21031.8948405257, 21485.355439336843, 34578.30843383118, 34636.0, 34674.653253467644, 34730.0, 34867.302653947285, 10282.177425805918, 10497.580096796195, 10532.05211530966, 10645.78708425827, 10658.946705266579, 6823.0106634537715, 7408.85182296351, 8735.563221838882, 8865.734027979172, 8887.022427532966, 9201.769955751026, 9455.30726256975, 9528.189643967624, 9538.475383853955, 9610.615575377047, 2616.6990796058317, 3513.94729079064, 3608.5358056265754, 3640.927181456409, 3697.7041836653, 823.872299793533, 898.3352319283683, 922.1188774899265, 933.2533972821716, 944.9149576538144, 20322.593548128956, 21121.577568448545, 21156.259530916344, 21174.729516229076, 21258.78741212599, 920.6179435534178, 921.7833809054866, 940.9858852117223, 1007.4710776842217, 1015.7409860485529, 10509.264351495474, 11087.667369978913, 11174.944125279322, 11175.608853690082, 11176.0, 594353.0, 598620.0, 604270.0, 605495.0, 613017.0, 78218.0, 79009.60495197488, 138076.0, 139761.0, 147108.0, 959.640134949394, 990.64336838738, 994.7714572502953, 1012.3217444312328, 1012.4532752313816, 17046.57383565371, 17560.473185804447, 18681.43955681332, 18900.621987559898, 19331.226750929804, 55897.0, 57043.71478142583, 57196.71401642965, 58642.706786467505, 58680.0, 79333.22333718292, 79967.60016199882, 80937.59531202307, 82442.76335854847, 84559.0, 7767.961160194162, 8048.436609437284, 8056.556889371141, 8070.757877263692, 8132.593370331341, 9068.455892646462, 12122.151449398458, 12432.00933298115, 12528.248305101723, 12718.491260349483, 8581.613827377907, 10738.785224295627, 10931.672049838518, 11062.225644205151, 11107.389093599606, 10381.429021403594, 10543.947280263856, 10602.840957385491, 10759.515821787882, 10982.286151400134, 11055.391953442639, 11274.0, 11281.943590281997, 11355.829662555234, 11367.886321137014, 7663.808404789925, 7712.305892469704, 7977.760667179994, 7987.201279872199, 8004.719834805754, 9385.577649005947, 10642.148628109888, 10960.068394186583, 11165.274257173258, 11178.608748693756], "value": 10504.461075389125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.1355700136917, 1498.9881829764909, 1648.6620242850217, 1744.9040302783358, 1832.4319460967101, 7422.962885185567, 7701.22987701231, 7850.175731548191, 8304.958475207623, 8306.252437280651, 7511.586862722548, 7811.492253003565, 8015.839683206347, 8024.95987520063, 8150.592470376472, 2260.8756518391524, 2303.8156947444163, 2304.665823455598, 2312.5143719818857, 2315.351701523576, 1676.8407001334915, 2289.6679981402685, 2318.3392733071078, 2342.543204075206, 2348.4598542335275, 2057.105159255721, 2099.863508871926, 2188.6388745856916, 2277.7836105569945, 2285.3600991722346, 1902.3246747404748, 2253.8985745641403, 2273.45437095096, 2305.250793492113, 2311.6301391777233, 2293.3005433342823, 2315.386422598013, 2326.278853555403, 2327.4297797039835, 2328.941776455585, 7913.1691172426645, 8089.271965523131, 8096.3118134958595, 8121.228483294078, 8140.592970351518, 4947.6289278304275, 5066.493350664941, 5072.898542029138, 5123.180291153435, 5126.5642420394315, 3167.4932010878147, 3271.7382609391193, 3509.350770107538, 3510.8420121094614, 3520.577530696333, 892.2282225874636, 1061.5912873543664, 1069.3476979042778, 1075.9193060520493, 1083.2796190533286, 10242.231832612584, 10494.527746251437, 10495.632652857113, 10587.470626468723, 10704.197185211062, 4410.117976404667, 4509.6392288616835, 4593.002044110823, 4646.512116227815, 4669.34629151919, 9260.675876344296, 9261.490618016074, 9267.860982085274, 9283.303752218475, 9289.34974551775, 5108.795648174031, 5109.693418394908, 5113.079645663742, 5119.769610367543, 5122.308488354024, 4573.862784116482, 4604.309353596987, 4675.462321832964, 4692.389989301437, 4703.294505824086, 3600.6759391654355, 3647.854085836537, 3648.8175591220333, 3671.541057367829, 3698.1679122197293, 1195.8445402097846, 1220.7741567809983, 1221.2733423612935, 1232.1498166265249, 1232.9951089861734, 609.3723464831231, 690.6270613868555, 771.3388808610205, 787.9960600196962, 848.6011574559947, 5306.708131052829, 5356.491133342326, 5422.240886275925, 5594.1608758686525, 5597.776088956396, 868.5961028121953, 877.9692710755093, 892.6340200517757, 924.9398789078689, 927.7216834949488, 3570.589382221026, 3598.5142005829402, 3788.109794198361, 3868.941965870514, 3911.647951684362, 9665.081817227492, 9763.170130538983, 9878.703638890845, 9890.505474726378, 9912.454814985102, 9843.507824608741, 9862.0, 9863.901360986298, 9871.753206169904, 9875.160611348116, 7185.568865868065, 7549.962250188714, 7666.4633475656165, 7736.381089512825, 7737.264959828807, 5299.5760339172, 5355.30381050461, 5447.782088716565, 5500.202470641654, 5819.79630712923, 9058.320625953213, 9060.744768034656, 9066.909330906607, 9155.771105722144, 9208.12522810332, 9178.586963586522, 9310.301727370339, 9328.53357332117, 9344.205742511962, 9392.906070939203, 6819.113515242987, 7055.470839686941, 7060.929390706027, 7067.0, 7080.2919708028785, 7206.747763828241, 7446.032015837906, 7508.962455187689, 7520.586367749826, 7627.237276272328, 6843.863122737617, 6874.793756187322, 6908.965455172692, 6936.618485983117, 6946.583205007716, 6711.832204194934, 6819.5908245505425, 6829.248782634006, 6855.5543889647015, 6856.382925536725, 6340.144080549251, 6469.061986012096, 6477.093206951125, 6479.708413121515, 6489.86427375198, 4614.146382919171, 4698.2952557116705, 4735.17134501454, 4751.952480475151, 4839.177339852304, 4517.728936263835, 4671.995520963009, 4834.323194752667, 4935.876603084952, 4998.525140111684], "value": 4303.853033506096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.6415271825962, 300.42618598476906, 300.9458297506449, 309.76612657443627, 309.87295208964326, 3984.4222587724835, 4659.976700116499, 5185.962807438508, 5269.2886460327845, 5269.841904742854, 4729.952700472994, 5107.648993894981, 5154.484551544843, 5177.948220517794, 5187.766550505227, 3539.699125574329, 3856.479375284343, 3887.494625698655, 3894.49371581694, 3982.721209515335, 3977.264206121862, 4031.798410079499, 4031.9395209071886, 4035.385845661744, 4046.7774272415154, 3441.380551500729, 3729.067733066733, 3995.962059349738, 4005.7796821174825, 4020.7989600520004, 3344.8160351180677, 3629.618890016563, 3775.7734535927657, 3808.9619103808886, 4018.377151541501, 3502.231373156565, 3504.9649503505148, 3527.25400926543, 3544.3620148373284, 3563.518924945125, 5089.592832573385, 5106.897862042739, 5109.259157422153, 5121.436641969381, 5138.3833939927445, 3443.9151667224746, 3985.262726395626, 4000.3599424092295, 4171.561985991488, 4515.5032946376205, 4437.0, 5411.0, 5439.972800136014, 5455.399906010375, 5455.427180146067, 3485.723419985231, 3639.854405823764, 3834.830376735095, 3846.3268927937497, 3881.4371916072296, 4864.683795553277, 5000.799648154836, 5684.317881854204, 5699.059655156894, 5765.423457654201, 3758.774473531597, 3878.8836334909997, 3899.395593682984, 3920.2747491714126, 3924.1170736584613, 3274.9192766387036, 3955.9011024724614, 3970.7617542947514, 3994.500687414073, 4003.4795476587856, 4275.5296917339065, 4523.909521809545, 4547.3179023146795, 4559.0881823634745, 4562.064776720765, 4837.9032419351415, 5436.392723825349, 5475.835724928259, 5501.4223506532035, 5572.959604286941, 1224.302147775777, 1256.7926292161874, 1268.8984881209665, 1274.6112435707198, 1278.4247088810073, 795.5385876191795, 812.6627449608465, 881.9647214111492, 883.6700765348238, 884.6417201033463, 3987.1626958338493, 4366.65066794662, 4533.682642215013, 4545.318202269686, 5088.338515992971, 4580.290055041474, 5492.423295553989, 5628.240187574707, 5634.746436410372, 5651.383114806527, 3965.6490265725415, 5022.694099534147, 5163.035341790305, 5163.638545301793, 5171.3018742469285, 2439.7560243975818, 2474.381404648838, 2495.589991654709, 2765.925555833125, 2773.5285001549787, 4844.394450693663, 5200.76596553156, 5334.0, 5579.832605021856, 5595.888082238333, 4636.768161591907, 5084.898302034013, 5350.571954243651, 5421.241026256248, 5469.179623056573, 4391.253486907233, 4909.0, 5030.949690503121, 5481.862953426196, 5483.259759932358, 4239.80920858556, 4912.873186523338, 5253.947460525345, 5326.36083669962, 5326.680399176062, 4563.726176429424, 4585.610223130938, 5213.661112027706, 5239.135542635422, 5368.758405871823, 4723.417655085447, 5400.405955344988, 5792.536597072309, 5873.913326034697, 5943.346231914573, 3273.1817045738567, 3767.811609419573, 3817.0838998640684, 3824.8007395748114, 3881.7865017424315, 4616.976915115537, 5000.549401152761, 5751.424857514216, 5770.567207459373, 5788.536917046542, 5058.671186372874, 5331.040412725747, 5484.725763711878, 5524.751386187711, 5545.584081193846, 4719.952800472089, 4803.087413391444, 5380.932868265051, 5441.863953401196, 5518.972405137949, 4753.667243292936, 4913.975430122827, 5094.270939817157, 5446.754896029767, 5509.449055094458, 4783.808647654055, 5266.183741520071, 5299.364076310867, 5497.175423686479, 5505.109817345926, 4546.727196368229, 5282.498162674539, 5327.401779466222, 5409.350877894678, 5448.45515448452], "value": 3920.8369001080077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.3844901139963, 721.6536062689909, 726.9527480713754, 749.2806905370844, 759.9202083781202, 14551.854481455182, 15116.244187790622, 15145.697086058271, 15162.014469059503, 15165.165915874622, 13394.12938159019, 13432.126911750729, 13486.662833429169, 13506.594802155927, 13516.932415337935, 652.7454292825802, 677.606987946992, 681.1689738518999, 803.8392321535687, 806.6934564865358, 825.5005721538473, 828.411827602403, 838.3083955736512, 838.4717627894418, 842.540815255684, 846.7383598438344, 890.0698769785557, 893.2541327991136, 893.9106089391074, 894.4454438248296, 679.813051410861, 710.3784188834769, 880.7577916073035, 881.3433991676178, 882.6116508736168, 614.7848253111375, 643.2955913274957, 646.941775240226, 650.9804705858832, 652.4063102576632, 13873.37569809361, 13954.441822327095, 14248.572542823731, 14264.429422823074, 14267.357968891321, 13025.283609401478, 13150.60548183556, 13228.338583070808, 13231.404586793617, 13355.265460399674, 12136.15046946714, 12167.695807604792, 12212.145149839514, 12312.815307770301, 12343.567975120917, 4395.7142785718825, 4449.354843547668, 4568.908621827545, 4583.747893865836, 4597.655175861823, 89377.65933510938, 89621.0, 89659.0, 90412.54793726055, 90459.0, 10098.343607665478, 10103.292769506064, 10372.170226381872, 10464.162866970624, 10768.623098191525, 19715.309964151187, 19954.60090798205, 20005.399838004592, 20102.89948550277, 20333.89833050825, 6052.697365131726, 6069.848253793691, 6100.145979562864, 6124.265088189446, 6224.937750622526, 4150.958490415057, 4165.8958526037095, 4203.327467605169, 4209.663226941837, 4225.091605304813, 3199.6640352762624, 3248.5289633003554, 3255.641879393312, 3268.313654132659, 3307.9173020674675, 618.2025187508065, 625.1778910732372, 627.0750642801922, 635.2948227467507, 644.4972921121532, 570.7060863655221, 606.5147881694627, 612.8958077126899, 622.2346513788066, 624.5003996802631, 6719.0, 6948.513604047769, 7543.170251272356, 8125.309348705308, 8286.129956354616, 474.41409858824323, 563.5801328010658, 611.3611276216365, 611.7247238742494, 622.1414448061736, 3990.960090399059, 4170.436991006236, 4226.788660566959, 4238.894027649272, 4367.934480982788, 74040.62979685067, 98414.5079274599, 114270.86041070952, 118439.0, 120765.79234207545, 60726.0, 80275.19724802794, 83402.16597833944, 84868.57565712255, 92664.53667731753, 56985.0, 57982.42017579854, 58149.0, 58796.706016470496, 76567.19477259963, 9198.356115071882, 9433.103855133751, 9468.810623787624, 9589.904100958902, 9735.756606084904, 41805.79097104495, 53555.46444535505, 53566.857325706536, 53957.0, 56670.0, 69505.30494694988, 71606.64196679191, 71910.64044679953, 72078.63960680373, 75168.62415687887, 10044.2513155795, 12097.516099356279, 12218.87781122213, 12307.569235077088, 12634.620961371174, 12439.315837629018, 13574.59276221715, 13963.650908726957, 14128.78806817919, 14235.857641423454, 12824.358782061046, 12963.546275880677, 13208.405621746851, 13496.190228586316, 13615.863841361459, 12827.358632068546, 12912.16070955385, 13090.80363794563, 13283.335833208494, 13512.93243533776, 12535.310557919402, 12723.86609394173, 12748.002067512492, 12761.93619031899, 12857.49181202305, 10677.786444270916, 10750.677479675622, 10908.290961087503, 11089.833652495057, 11299.774004520028, 10774.892251077388, 10942.72643183895, 11017.889821102008, 11202.0, 11230.270032447865], "value": 7063.960306254812, "unit": "score"}], "name": "dromaeo_css", "value": 7141.5693258884385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 118.0, 181.0, 145.0, 114.0, 112.0, 112.0, 134.0, 119.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 184.0, 186.0, 180.0, 197.0, 258.0, 184.0, 184.0, 181.0], "value": 192.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 89.0, 63.0, 60.0, 59.0, 59.0, 75.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 86.0, 69.0, 68.0, 70.0, 82.0, 68.0, 69.0, 85.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 131.0, 129.0, 84.0, 87.0, 84.0, 88.0, 84.0, 90.0, 84.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 92.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 84.0, 85.0, 88.0, 86.0, 87.0, 87.0, 88.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 83.0, 77.0, 74.0, 72.0, 70.0, 71.0, 74.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 88.0, 87.0, 87.0, 90.0, 97.0, 104.0, 90.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 148.0, 149.0, 148.0, 149.0, 150.0, 151.0, 285.0, 192.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 211.0, 172.0, 173.0, 173.0, 174.0, 177.0, 236.0, 216.0], "value": 188.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1492.6000000000001, "alertThreshold": 2.0}]} 05:13:34 INFO - Return code: 0 05:13:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:34 INFO - # TBPL SUCCESS # 05:13:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:34 INFO - 2016-11-25 05:13:34.325 screenresolution[1653:9870] starting screenresolution argv=screenresolution get 05:13:34 INFO - 2016-11-25 05:13:34.328 screenresolution[1653:9870] Display 0: 1600x1200x32@60 05:13:34 INFO - 2016-11-25 05:13:34.334 screenresolution[1654:9873] starting screenresolution argv=screenresolution list 05:13:34 INFO - Available Modes on Display 0 05:13:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:34 INFO - Intel Iris: 05:13:34 INFO - Chipset Model: Intel Iris 05:13:34 INFO - Type: GPU 05:13:34 INFO - Bus: Built-In 05:13:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:34 INFO - Vendor: Intel (0x8086) 05:13:34 INFO - Device ID: 0x0a2e 05:13:34 INFO - Revision ID: 0x0009 05:13:34 INFO - Displays: 05:13:34 INFO - Display: 05:13:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:34 INFO - Display Serial Number: 1600x1200 60 05:13:34 INFO - Main Display: Yes 05:13:34 INFO - Mirror: Off 05:13:34 INFO - Online: Yes 05:13:34 INFO - Rotation: Supported 05:13:34 INFO - Return code: 0 05:13:34 INFO - Running post-action listener: _resource_record_post_action 05:13:34 INFO - [mozharness: 2016-11-25 13:13:34.568435Z] Finished run-tests step (success) 05:13:34 INFO - Running post-run listener: _resource_record_post_run 05:13:34 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38712320; Write bytes: 693490688; Read time: 376; Write time: 1820 05:13:34 INFO - TinderboxPrint: CPU usage
53.6% 05:13:34 INFO - TinderboxPrint: I/O read bytes / time
38,712,320 / 376 05:13:34 INFO - TinderboxPrint: I/O write bytes / time
693,490,688 / 1,820 05:13:34 INFO - TinderboxPrint: CPU idle
2,254.2 (46.4%) 05:13:34 INFO - TinderboxPrint: CPU system
978.7 (20.1%) 05:13:34 INFO - TinderboxPrint: CPU user
1,628.7 (33.5%) 05:13:34 INFO - TinderboxPrint: Swap in / out
421,908,480 / 0 05:13:34 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 366977536; Write bytes: 366872576; Read time: 27690; Write time: 628 05:13:34 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 37725184; Write bytes: 308083712; Read time: 357; Write time: 1153 05:13:35 INFO - Running post-run listener: _upload_blobber_files 05:13:35 INFO - Blob upload gear active. 05:13:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:35 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 05:13:35 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:35 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:36 INFO - (blobuploader) - INFO - Done attempting. 05:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:37 INFO - (blobuploader) - INFO - Done attempting. 05:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:39 INFO - (blobuploader) - INFO - Done attempting. 05:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:39 INFO - Return code: 0 05:13:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ee25412f406a30bfe1e20c3a8ffc1667145c17cf7b9f3ae2ead680331aedaa8204e374c8f3e28374a196c3b947b3257fdda80908b15e033d327685478801ae16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d293c6356c954668b28bfb936b5ecc0ae6ce7c17f25e42f0b907cbbdf24830dcbacc64a41c415e526415a37ef13397192e521362277e63bbc81cd1aeba170d2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe6592a0e1abf67038292ed77dec137fe9505622610a3dc3339e6ddea5c492d95a1e9c07068e22b49c0a76dcbdab64582f4d10cf4454353a6314b00ea85f22dc"} 05:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:39 INFO - Contents: 05:13:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ee25412f406a30bfe1e20c3a8ffc1667145c17cf7b9f3ae2ead680331aedaa8204e374c8f3e28374a196c3b947b3257fdda80908b15e033d327685478801ae16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d293c6356c954668b28bfb936b5ecc0ae6ce7c17f25e42f0b907cbbdf24830dcbacc64a41c415e526415a37ef13397192e521362277e63bbc81cd1aeba170d2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe6592a0e1abf67038292ed77dec137fe9505622610a3dc3339e6ddea5c492d95a1e9c07068e22b49c0a76dcbdab64582f4d10cf4454353a6314b00ea85f22dc"} 05:13:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:39 INFO - Copying logs to upload dir... 05:13:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.845440 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-25 05:13:40.061494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 05:13:40.064838) ========= 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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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/Cedar/sha512/ee25412f406a30bfe1e20c3a8ffc1667145c17cf7b9f3ae2ead680331aedaa8204e374c8f3e28374a196c3b947b3257fdda80908b15e033d327685478801ae16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d293c6356c954668b28bfb936b5ecc0ae6ce7c17f25e42f0b907cbbdf24830dcbacc64a41c415e526415a37ef13397192e521362277e63bbc81cd1aeba170d2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe6592a0e1abf67038292ed77dec137fe9505622610a3dc3339e6ddea5c492d95a1e9c07068e22b49c0a76dcbdab64582f4d10cf4454353a6314b00ea85f22dc"} build_url:https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/FmnEMtM3SuOZTZFBKFBj-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ee25412f406a30bfe1e20c3a8ffc1667145c17cf7b9f3ae2ead680331aedaa8204e374c8f3e28374a196c3b947b3257fdda80908b15e033d327685478801ae16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d293c6356c954668b28bfb936b5ecc0ae6ce7c17f25e42f0b907cbbdf24830dcbacc64a41c415e526415a37ef13397192e521362277e63bbc81cd1aeba170d2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe6592a0e1abf67038292ed77dec137fe9505622610a3dc3339e6ddea5c492d95a1e9c07068e22b49c0a76dcbdab64582f4d10cf4454353a6314b00ea85f22dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 05:13:40.100076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 05:13:40.100415) ========= 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.Hw1LVi8yVr/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.olLlhUzYEz/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005028 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 05:13:40.151484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 05:13:40.151816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 05:13:40.152157) ========= ========= Total master_lag: 0.19 =========