builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0140 starttime: 1483467786.28 results: success (0) buildid: 20170103084739 builduid: 6453a320796e4292a2ec330409f59c6c revision: b32127935d3835505115e296afd745a302367b7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.277705) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.278300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.278800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.306208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.306678) ========= 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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-03 10:23:06-- 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% 151M=0s 2017-01-03 10:23:06 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.449897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.450232) ========= 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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.020176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:06.499314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 10:23:06.499848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b32127935d3835505115e296afd745a302367b7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b32127935d3835505115e296afd745a302367b7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-03 10:23:06,575 truncating revision to first 12 chars 2017-01-03 10:23:06,575 Setting DEBUG logging. 2017-01-03 10:23:06,575 attempt 1/10 2017-01-03 10:23:06,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b32127935d38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 10:23:07,574 unpacking tar archive at: mozilla-aurora-b32127935d38/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 10:23:07.771324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:07.771655) ========= script_repo_revision: b32127935d3835505115e296afd745a302367b7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:07.772050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:07.772315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 10:23:07.791888) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-03 10:23:07.792168) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:07 INFO - MultiFileLogger online at 20170103 10:23:07 in /builds/slave/test 10:23:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:23:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:23:07 INFO - {'append_to_log': False, 10:23:07 INFO - 'base_work_dir': '/builds/slave/test', 10:23:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:23:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:23:07 INFO - 'branch': 'Mozilla-Aurora', 10:23:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:07 INFO - 'config_files': ('talos/mac_config.py',), 10:23:07 INFO - 'default_actions': ('clobber', 10:23:07 INFO - 'read-buildbot-config', 10:23:07 INFO - 'download-and-extract', 10:23:07 INFO - 'populate-webroot', 10:23:07 INFO - 'create-virtualenv', 10:23:07 INFO - 'install', 10:23:07 INFO - 'run-tests'), 10:23:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:07 INFO - 'download_minidump_stackwalk': True, 10:23:07 INFO - 'download_symbols': 'ondemand', 10:23:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:23:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:23:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:23:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:23:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:07 INFO - 'installer_path': 'installer.exe', 10:23:07 INFO - 'log_level': 'info', 10:23:07 INFO - 'log_name': 'talos', 10:23:07 INFO - 'log_to_console': True, 10:23:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:23:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:23:07 INFO - 'opt_config_files': (), 10:23:07 INFO - 'pip_index': False, 10:23:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:07 INFO - 'cmd': ('bash', 10:23:07 INFO - '-c', 10:23:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:07 INFO - 'enabled': True, 10:23:07 INFO - 'halt_on_failure': False, 10:23:07 INFO - 'name': 'check_screen_resolution'},), 10:23:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:07 INFO - 'cmd': ('bash', 10:23:07 INFO - '-c', 10:23:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:07 INFO - 'enabled': True, 10:23:07 INFO - 'halt_on_failure': False, 10:23:07 INFO - 'name': 'check_screen_resolution'},), 10:23:07 INFO - 'run_cmd_checks_enabled': True, 10:23:07 INFO - 'sps_profile': False, 10:23:07 INFO - 'sps_profile_interval': 0, 10:23:07 INFO - 'suite': 'dromaeojs', 10:23:07 INFO - 'system_bits': '32', 10:23:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:07 INFO - 'title': 't-yosemite-r7-0140', 10:23:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:23:07 INFO - 'use_talos_json': True, 10:23:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:23:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:07 INFO - 'work_dir': 'build'} 10:23:07 INFO - [mozharness: 2017-01-03 18:23:07.991157Z] Running clobber step. 10:23:07 INFO - Running pre-action listener: _resource_record_pre_action 10:23:07 INFO - Running main action method: clobber 10:23:07 INFO - rmtree: /builds/slave/test/build 10:23:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:23:08 INFO - Running post-action listener: _resource_record_post_action 10:23:08 INFO - [mozharness: 2017-01-03 18:23:08.895963Z] Finished clobber step (success) 10:23:08 INFO - [mozharness: 2017-01-03 18:23:08.896153Z] Running read-buildbot-config step. 10:23:08 INFO - Running pre-action listener: _resource_record_pre_action 10:23:08 INFO - Running main action method: read_buildbot_config 10:23:08 INFO - Using buildbot properties: 10:23:08 INFO - { 10:23:08 INFO - "project": "", 10:23:08 INFO - "product": "firefox", 10:23:08 INFO - "script_repo_revision": "production", 10:23:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 10:23:08 INFO - "repository": "", 10:23:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 10:23:08 INFO - "buildid": "20170103084739", 10:23:08 INFO - "pgo_build": "False", 10:23:08 INFO - "basedir": "/builds/slave/test", 10:23:08 INFO - "buildnumber": 10, 10:23:08 INFO - "slavename": "t-yosemite-r7-0140", 10:23:08 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:23:08 INFO - "platform": "yosemite_r7", 10:23:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:23:08 INFO - "branch": "mozilla-aurora", 10:23:08 INFO - "repo_path": "releases/mozilla-aurora", 10:23:08 INFO - "revision": "b32127935d3835505115e296afd745a302367b7f", 10:23:08 INFO - "stage_platform": "macosx64", 10:23:08 INFO - "builduid": "6453a320796e4292a2ec330409f59c6c", 10:23:08 INFO - "slavebuilddir": "test" 10:23:08 INFO - } 10:23:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:23:08 INFO - Running post-action listener: _resource_record_post_action 10:23:08 INFO - [mozharness: 2017-01-03 18:23:08.899583Z] Finished read-buildbot-config step (success) 10:23:08 INFO - [mozharness: 2017-01-03 18:23:08.899713Z] Running download-and-extract step. 10:23:08 INFO - Running pre-action listener: _resource_record_pre_action 10:23:08 INFO - Running main action method: download_and_extract 10:23:08 INFO - mkdir: /builds/slave/test/build/tests 10:23:08 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')]} 10:23:08 INFO - trying https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:23:09 INFO - Downloaded 1199 bytes. 10:23:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:23:09 INFO - Using the following test package requirements: 10:23:09 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:23:09 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:23:09 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:23:09 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'jsshell-mac.zip'], 10:23:09 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:23:09 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:23:09 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:23:09 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:23:09 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:23:09 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:23:09 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:23:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:23:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:23:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:23:09 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:23:10 INFO - Http code: 200 10:23:10 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 10:23:10 INFO - x-amz-cf-id: kOTslPorz_FMXIOXY5QuZGzCm_-ccBIcuixXVePb6S_6nXBJ81Ysqw== 10:23:10 INFO - x-amz-version-id: KqtfbX.tstUaZpwBNJvw3rG1rpmTsFkr 10:23:10 INFO - Expected file size: 16269813 10:23:10 INFO - Obtained file size: 16269813 10:23:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:23:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:23:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:23:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:23:17 INFO - Http code: 200 10:23:17 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:23:17 INFO - x-amz-cf-id: D-8oe0MqwrO1UZZpZ1KnU2O3CTvlv7EQtvxuYO4KY0g8lSAfQYdp2w== 10:23:17 INFO - x-amz-version-id: KqtfbX.tstUaZpwBNJvw3rG1rpmTsFkr 10:23:18 INFO - Expected file size: 16269813 10:23:18 INFO - Obtained file size: 16269813 10:23:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:23:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:23:24 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:23:25 INFO - Http code: 200 10:23:25 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 10:23:25 INFO - x-amz-cf-id: A9IFN6mqGjDxPROlZtDENrgliMsXKwXQ0th1VoIkNjF615M_x2xSXg== 10:23:25 INFO - x-amz-version-id: Uuel9ljD2yyeJNt3jmBqxIScXKd329Pc 10:23:25 INFO - Expected file size: 14409038 10:23:25 INFO - Obtained file size: 14409038 10:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:26 INFO - trying https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:26 INFO - Downloading https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:23:29 INFO - Downloaded 109827227 bytes. 10:23:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:29 INFO - mkdir: /builds/slave/test/properties 10:23:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:23:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:23:29 INFO - Contents: 10:23:29 INFO - build_url:https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:29 INFO - Running post-action listener: _resource_record_post_action 10:23:29 INFO - Running post-action listener: set_extra_try_arguments 10:23:29 INFO - [mozharness: 2017-01-03 18:23:29.723533Z] Finished download-and-extract step (success) 10:23:29 INFO - [mozharness: 2017-01-03 18:23:29.723663Z] Running populate-webroot step. 10:23:29 INFO - Running pre-action listener: _resource_record_pre_action 10:23:29 INFO - Running main action method: populate_webroot 10:23:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:23:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:23:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:23:29 INFO - '--tppagecycles', 10:23:29 INFO - '7'], 10:23:29 INFO - 'tests': ['tsvgm']}}, 10:23:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:23:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:23:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:23:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:23:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['damp', 'tps']}, 10:23:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'tests': ['damp', 'tps']}, 10:23:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['dromaeo_dom']}, 10:23:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:23:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['basic_compositor_video']}, 10:23:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:23:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['a11yr', 10:23:29 INFO - 'ts_paint', 10:23:29 INFO - 'tpaint', 10:23:29 INFO - 'sessionrestore', 10:23:29 INFO - 'sessionrestore_no_auto_restore', 10:23:29 INFO - 'tabpaint']}, 10:23:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['tsvgx', 10:23:29 INFO - 'tsvgr_opacity', 10:23:29 INFO - 'tart', 10:23:29 INFO - 'tscrollx', 10:23:29 INFO - 'cart']}, 10:23:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:23:29 INFO - 'tsvgr_opacity', 10:23:29 INFO - 'tart', 10:23:29 INFO - 'tscrollx', 10:23:29 INFO - 'cart']}, 10:23:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'talos_options': ['--disable-e10s'], 10:23:29 INFO - 'tests': ['tp5o']}, 10:23:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'tests': ['tp5o']}, 10:23:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'talos_options': ['--disable-e10s', 10:23:29 INFO - '--xperf_path', 10:23:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:29 INFO - 'tests': ['tp5n']}, 10:23:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:29 INFO - 'talos_options': ['--xperf_path', 10:23:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:29 INFO - 'tests': ['tp5n']}}, 10:23:29 INFO - 'talos.zip': {'path': '', 10:23:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:23:29 INFO - Running post-action listener: _resource_record_post_action 10:23:29 INFO - [mozharness: 2017-01-03 18:23:29.742644Z] Finished populate-webroot step (success) 10:23:29 INFO - [mozharness: 2017-01-03 18:23:29.742756Z] Running create-virtualenv step. 10:23:29 INFO - Running pre-action listener: _resource_record_pre_action 10:23:29 INFO - Running main action method: create_virtualenv 10:23:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:23:29 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 10:23:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:23:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:23:29 INFO - Using real prefix '/tools/python27' 10:23:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:23:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:23:33 INFO - Installing pip.................done. 10:23:33 INFO - Return code: 0 10:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:23:33 INFO - Reading from file tmpfile_stdout 10:23:33 INFO - Output received: 10:23:33 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) 10:23:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:33 INFO - 'HOME': '/Users/cltbld', 10:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:33 INFO - 'LOGNAME': 'cltbld', 10:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:33 INFO - 'MOZ_NO_REMOTE': '1', 10:23:33 INFO - 'NO_EM_RESTART': '1', 10:23:33 INFO - 'PAGER': '/bin/cat', 10:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:33 INFO - 'PWD': '/builds/slave/test', 10:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:33 INFO - 'SHELL': '/bin/bash', 10:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:33 INFO - 'USER': 'cltbld', 10:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:33 INFO - 'XPC_FLAGS': '0x0', 10:23:33 INFO - 'XPC_SERVICE_NAME': '0', 10:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:33 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 10:23:33 INFO - Cleaning up... 10:23:33 INFO - Return code: 0 10:23:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:33 INFO - 'HOME': '/Users/cltbld', 10:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:33 INFO - 'LOGNAME': 'cltbld', 10:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:33 INFO - 'MOZ_NO_REMOTE': '1', 10:23:33 INFO - 'NO_EM_RESTART': '1', 10:23:33 INFO - 'PAGER': '/bin/cat', 10:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:33 INFO - 'PWD': '/builds/slave/test', 10:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:33 INFO - 'SHELL': '/bin/bash', 10:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:33 INFO - 'USER': 'cltbld', 10:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:33 INFO - 'XPC_FLAGS': '0x0', 10:23:33 INFO - 'XPC_SERVICE_NAME': '0', 10:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:34 INFO - Downloading/unpacking psutil>=3.1.1 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:37 INFO - Installing collected packages: psutil 10:23:37 INFO - Running setup.py install for psutil 10:23:37 INFO - building 'psutil._psutil_osx' extension 10:23:37 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 10:23:37 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 10:23:38 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 10:23:38 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 10:23:38 INFO - building 'psutil._psutil_posix' extension 10:23:38 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 10:23:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:23:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:23:38 INFO - ^ 10:23:38 INFO - 1 warning generated. 10:23:38 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 10:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:38 INFO - Successfully installed psutil 10:23:38 INFO - Cleaning up... 10:23:38 INFO - Return code: 0 10:23:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:23:38 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')]} 10:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:38 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')]} 10:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:38 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:38 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 10:23:38 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 10:23:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:38 INFO - 'HOME': '/Users/cltbld', 10:23:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:38 INFO - 'LOGNAME': 'cltbld', 10:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:38 INFO - 'MOZ_NO_REMOTE': '1', 10:23:38 INFO - 'NO_EM_RESTART': '1', 10:23:38 INFO - 'PAGER': '/bin/cat', 10:23:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:38 INFO - 'PWD': '/builds/slave/test', 10:23:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:38 INFO - 'SHELL': '/bin/bash', 10:23:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:38 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:38 INFO - 'USER': 'cltbld', 10:23:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:38 INFO - 'XPC_FLAGS': '0x0', 10:23:38 INFO - 'XPC_SERVICE_NAME': '0', 10:23:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:23:41 INFO - Installing collected packages: mozsystemmonitor 10:23:41 INFO - Running setup.py install for mozsystemmonitor 10:23:41 INFO - Successfully installed mozsystemmonitor 10:23:41 INFO - Cleaning up... 10:23:41 INFO - Return code: 0 10:23:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:41 INFO - 'HOME': '/Users/cltbld', 10:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:41 INFO - 'LOGNAME': 'cltbld', 10:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:41 INFO - 'MOZ_NO_REMOTE': '1', 10:23:41 INFO - 'NO_EM_RESTART': '1', 10:23:41 INFO - 'PAGER': '/bin/cat', 10:23:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:41 INFO - 'PWD': '/builds/slave/test', 10:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:41 INFO - 'SHELL': '/bin/bash', 10:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:41 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:41 INFO - 'USER': 'cltbld', 10:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:41 INFO - 'XPC_FLAGS': '0x0', 10:23:41 INFO - 'XPC_SERVICE_NAME': '0', 10:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:42 INFO - Downloading/unpacking jsonschema==2.5.1 10:23:42 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 10:23:42 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 10:23:42 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 10:23:42 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 10:23:42 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 10:23:42 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 10:23:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:23:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:23:45 INFO - warning: no files found matching '*.txt' 10:23:45 INFO - no previously-included directories found matching 'build' 10:23:45 INFO - no previously-included directories found matching 'dist' 10:23:45 INFO - no previously-included directories found matching '.git*' 10:23:45 INFO - Installing collected packages: jsonschema, functools32 10:23:45 INFO - Running setup.py install for functools32 10:23:45 INFO - warning: no files found matching '*.txt' 10:23:45 INFO - no previously-included directories found matching 'build' 10:23:45 INFO - no previously-included directories found matching 'dist' 10:23:45 INFO - no previously-included directories found matching '.git*' 10:23:45 INFO - Successfully installed jsonschema functools32 10:23:45 INFO - Cleaning up... 10:23:45 INFO - Return code: 0 10:23:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:45 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:45 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 10:23:45 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 10:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:45 INFO - 'HOME': '/Users/cltbld', 10:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:45 INFO - 'LOGNAME': 'cltbld', 10:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:45 INFO - 'MOZ_NO_REMOTE': '1', 10:23:45 INFO - 'NO_EM_RESTART': '1', 10:23:45 INFO - 'PAGER': '/bin/cat', 10:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:45 INFO - 'PWD': '/builds/slave/test', 10:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:45 INFO - 'SHELL': '/bin/bash', 10:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:45 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:45 INFO - 'USER': 'cltbld', 10:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:45 INFO - 'XPC_FLAGS': '0x0', 10:23:45 INFO - 'XPC_SERVICE_NAME': '0', 10:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:23:45 INFO - Cleaning up... 10:23:45 INFO - Return code: 0 10:23:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:45 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:45 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 10:23:45 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 10:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:45 INFO - 'HOME': '/Users/cltbld', 10:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:45 INFO - 'LOGNAME': 'cltbld', 10:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:45 INFO - 'MOZ_NO_REMOTE': '1', 10:23:45 INFO - 'NO_EM_RESTART': '1', 10:23:45 INFO - 'PAGER': '/bin/cat', 10:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:45 INFO - 'PWD': '/builds/slave/test', 10:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:45 INFO - 'SHELL': '/bin/bash', 10:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:45 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:45 INFO - 'USER': 'cltbld', 10:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:45 INFO - 'XPC_FLAGS': '0x0', 10:23:45 INFO - 'XPC_SERVICE_NAME': '0', 10:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:23:45 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 10:23:45 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 10:23:45 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 10:23:45 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 10:23:45 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 10:23:45 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 10:23:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:23:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:23:48 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 10:23:48 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 10:23:48 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 10:23:48 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 10:23:48 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 10:23:48 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 10:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:23:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:49 INFO - Downloading docopt-0.6.1.tar.gz 10:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:23:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:23:49 INFO - Running setup.py install for blobuploader 10:23:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:23:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:23:50 INFO - Running setup.py install for requests 10:23:50 INFO - Running setup.py install for docopt 10:23:50 INFO - Successfully installed blobuploader requests docopt 10:23:50 INFO - Cleaning up... 10:23:50 INFO - Return code: 0 10:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:50 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:50 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 10:23:50 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 10:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:50 INFO - 'HOME': '/Users/cltbld', 10:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:50 INFO - 'LOGNAME': 'cltbld', 10:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:50 INFO - 'MOZ_NO_REMOTE': '1', 10:23:50 INFO - 'NO_EM_RESTART': '1', 10:23:50 INFO - 'PAGER': '/bin/cat', 10:23:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:50 INFO - 'PWD': '/builds/slave/test', 10:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:50 INFO - 'SHELL': '/bin/bash', 10:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:50 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:50 INFO - 'USER': 'cltbld', 10:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:50 INFO - 'XPC_FLAGS': '0x0', 10:23:50 INFO - 'XPC_SERVICE_NAME': '0', 10:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rOtgYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-tge3TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8vVeEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-jWizB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-NBGMpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-G9f5k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-hWRuOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-kYNecc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-7gp9GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-qvqN27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2Jo3TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-0hsVsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6u3m_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9MrAyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-vxyeUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-dOE8ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-mdkt8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:23:52 INFO - Running setup.py install for manifestparser 10:23:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:23:52 INFO - Running setup.py install for mozcrash 10:23:53 INFO - Running setup.py install for mozdebug 10:23:53 INFO - Running setup.py install for mozdevice 10:23:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Running setup.py install for mozfile 10:23:53 INFO - Running setup.py install for mozhttpd 10:23:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Running setup.py install for mozinfo 10:23:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Running setup.py install for mozInstall 10:23:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:23:53 INFO - Running setup.py install for mozleak 10:23:54 INFO - Running setup.py install for mozlog 10:23:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Running setup.py install for moznetwork 10:23:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Running setup.py install for mozprocess 10:23:54 INFO - Running setup.py install for mozprofile 10:23:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Running setup.py install for mozrunner 10:23:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:23:54 INFO - Running setup.py install for mozscreenshot 10:23:55 INFO - Running setup.py install for moztest 10:23:55 INFO - Running setup.py install for mozversion 10:23:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:23:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:23:55 INFO - Cleaning up... 10:23:55 INFO - Return code: 0 10:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:55 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:23:55 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 10:23:55 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 10:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:55 INFO - 'HOME': '/Users/cltbld', 10:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:55 INFO - 'LOGNAME': 'cltbld', 10:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:55 INFO - 'MOZ_NO_REMOTE': '1', 10:23:55 INFO - 'NO_EM_RESTART': '1', 10:23:55 INFO - 'PAGER': '/bin/cat', 10:23:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:55 INFO - 'PWD': '/builds/slave/test', 10:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:55 INFO - 'SHELL': '/bin/bash', 10:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:23:55 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:55 INFO - 'USER': 'cltbld', 10:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:55 INFO - 'XPC_FLAGS': '0x0', 10:23:55 INFO - 'XPC_SERVICE_NAME': '0', 10:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:55 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DENw3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:55 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)) 10:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:55 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zxERnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:55 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)) 10:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:55 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Hy49Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zj9DAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2oyxE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-vH3dRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yfRgE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3L9tX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZYz7eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-r_Lxk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-HXRFAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-UIHUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:56 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)) 10:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:56 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-bfFQEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:57 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)) 10:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:57 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-66zX4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:57 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)) 10:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:57 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xfaGE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:57 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)) 10:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:57 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MzIKqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:57 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-irteuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:57 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)) 10:23:57 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)) 10:23:57 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)) 10:23:57 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)) 10:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:23:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:00 INFO - Downloading blessings-1.6.tar.gz 10:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:24:00 INFO - Installing collected packages: blessings 10:24:00 INFO - Running setup.py install for blessings 10:24:00 INFO - Successfully installed blessings 10:24:00 INFO - Cleaning up... 10:24:00 INFO - Return code: 0 10:24:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:00 INFO - Reading from file tmpfile_stdout 10:24:00 INFO - Current package versions: 10:24:00 INFO - blessings == 1.6 10:24:00 INFO - blobuploader == 1.2.4 10:24:00 INFO - docopt == 0.6.1 10:24:00 INFO - functools32 == 3.2.3-2 10:24:00 INFO - jsonschema == 2.5.1 10:24:00 INFO - manifestparser == 1.1 10:24:00 INFO - mozInstall == 1.12 10:24:00 INFO - mozcrash == 1.0 10:24:00 INFO - mozdebug == 0.1 10:24:00 INFO - mozdevice == 0.48 10:24:00 INFO - mozfile == 1.2 10:24:00 INFO - mozhttpd == 0.7 10:24:00 INFO - mozinfo == 0.9 10:24:00 INFO - mozleak == 0.1 10:24:00 INFO - mozlog == 3.4 10:24:00 INFO - moznetwork == 0.27 10:24:00 INFO - mozprocess == 0.23 10:24:00 INFO - mozprofile == 0.28 10:24:00 INFO - mozrunner == 6.13 10:24:00 INFO - mozscreenshot == 0.1 10:24:00 INFO - mozsystemmonitor == 0.3 10:24:00 INFO - moztest == 0.8 10:24:00 INFO - mozversion == 1.4 10:24:00 INFO - psutil == 3.1.1 10:24:00 INFO - requests == 1.2.3 10:24:00 INFO - wsgiref == 0.1.2 10:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:00 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')]} 10:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:00 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')]} 10:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:00 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 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:24:00 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 10:24:00 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 10:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:00 INFO - 'HOME': '/Users/cltbld', 10:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:00 INFO - 'LOGNAME': 'cltbld', 10:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:00 INFO - 'MOZ_NO_REMOTE': '1', 10:24:00 INFO - 'NO_EM_RESTART': '1', 10:24:00 INFO - 'PAGER': '/bin/cat', 10:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:00 INFO - 'PWD': '/builds/slave/test', 10:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:00 INFO - 'SHELL': '/bin/bash', 10:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:24:00 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:00 INFO - 'USER': 'cltbld', 10:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:00 INFO - 'XPC_FLAGS': '0x0', 10:24:00 INFO - 'XPC_SERVICE_NAME': '0', 10:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 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)) 10:24:01 INFO - Cleaning up... 10:24:01 INFO - Return code: 0 10:24:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026c2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102638570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca8d8e540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, '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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 10:24: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', 'jsonschema'] in /builds/slave/test/build 10:24: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 jsonschema 10:24:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:24:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:02 INFO - 'HOME': '/Users/cltbld', 10:24:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:02 INFO - 'LOGNAME': 'cltbld', 10:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:02 INFO - 'MOZ_NO_REMOTE': '1', 10:24:02 INFO - 'NO_EM_RESTART': '1', 10:24:02 INFO - 'PAGER': '/bin/cat', 10:24:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:02 INFO - 'PWD': '/builds/slave/test', 10:24:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:02 INFO - 'SHELL': '/bin/bash', 10:24:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:24:02 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:24:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:02 INFO - 'USER': 'cltbld', 10:24:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:02 INFO - 'XPC_FLAGS': '0x0', 10:24:02 INFO - 'XPC_SERVICE_NAME': '0', 10:24:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:24:02 INFO - Cleaning up... 10:24:02 INFO - Return code: 0 10:24:02 INFO - Running post-action listener: _resource_record_post_action 10:24:02 INFO - Running post-action listener: _start_resource_monitoring 10:24:02 INFO - Starting resource monitoring. 10:24:02 INFO - [mozharness: 2017-01-03 18:24:02.310302Z] Finished create-virtualenv step (success) 10:24:02 INFO - [mozharness: 2017-01-03 18:24:02.311293Z] Running install step. 10:24:02 INFO - Running pre-action listener: _resource_record_pre_action 10:24:02 INFO - Running main action method: install 10:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:02 INFO - Reading from file tmpfile_stdout 10:24:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:24:02 INFO - Reading from file tmpfile_stdout 10:24:02 INFO - Output received: 10:24:02 INFO - Usage: mozinstall [options] installer 10:24:02 INFO - Options: 10:24:02 INFO - -h, --help show this help message and exit 10:24:02 INFO - -d DEST, --destination=DEST 10:24:02 INFO - Directory to install application into. [default: 10:24:02 INFO - "/builds/slave/test"] 10:24:02 INFO - --app=APP Application being installed. [default: firefox] 10:24:02 INFO - mkdir: /builds/slave/test/build/application 10:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:24:34 INFO - Reading from file tmpfile_stdout 10:24:34 INFO - Output received: 10:24:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:24:34 INFO - Running post-action listener: _resource_record_post_action 10:24:34 INFO - [mozharness: 2017-01-03 18:24:34.044087Z] Finished install step (success) 10:24:34 INFO - [mozharness: 2017-01-03 18:24:34.044243Z] Running run-tests step. 10:24:34 INFO - Running pre-action listener: _resource_record_pre_action 10:24:34 INFO - Running main action method: run_tests 10:24:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:24:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:24:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:24:34 INFO - 2017-01-03 10:24:34.058 screenresolution[2174:22952] starting screenresolution argv=screenresolution get 10:24:34 INFO - 2017-01-03 10:24:34.061 screenresolution[2174:22952] Display 0: 1600x1200x32@60 10:24:34 INFO - 2017-01-03 10:24:34.067 screenresolution[2175:22954] starting screenresolution argv=screenresolution list 10:24:34 INFO - Available Modes on Display 0 10:24:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:24:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:24:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:24:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:24:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:24:34 INFO - Intel Iris: 10:24:34 INFO - Chipset Model: Intel Iris 10:24:34 INFO - Type: GPU 10:24:34 INFO - Bus: Built-In 10:24:34 INFO - VRAM (Dynamic, Max): 1536 MB 10:24:34 INFO - Vendor: Intel (0x8086) 10:24:34 INFO - Device ID: 0x0a2e 10:24:34 INFO - Revision ID: 0x0009 10:24:34 INFO - Displays: 10:24:34 INFO - Display: 10:24:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:24:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:24:34 INFO - Display Serial Number: 1600x1200 60 10:24:34 INFO - Main Display: Yes 10:24:34 INFO - Mirror: Off 10:24:34 INFO - Online: Yes 10:24:34 INFO - Rotation: Supported 10:24:34 INFO - Return code: 0 10:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:24:34 INFO - Python 2.7.3 10:24:34 INFO - Return code: 0 10:24:34 INFO - grabbing minidump binary from tooltool 10:24:34 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')]} 10:24:34 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 0x1024d6d30>, '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 0x10233cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024ceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:24:34 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 10:24:34 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 10:24:34 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 10:24:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:24:34 INFO - Return code: 0 10:24:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:24:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:24:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:24:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:24:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 10:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --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 10:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCxv36ZSC/Render', 10:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:34 INFO - 'HOME': '/Users/cltbld', 10:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:34 INFO - 'LOGNAME': 'cltbld', 10:24:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:24:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:34 INFO - 'MOZ_NO_REMOTE': '1', 10:24:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:24:34 INFO - 'NO_EM_RESTART': '1', 10:24:34 INFO - 'PAGER': '/bin/cat', 10:24:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:34 INFO - 'PWD': '/builds/slave/test', 10:24:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:34 INFO - 'SHELL': '/bin/bash', 10:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCW1HGdU7U/Listeners', 10:24:34 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:34 INFO - 'USER': 'cltbld', 10:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:34 INFO - 'XPC_FLAGS': '0x0', 10:24:34 INFO - 'XPC_SERVICE_NAME': '0', 10:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 10:24:34 INFO - mozversion application_buildid: 20170103084739 10:24:34 INFO - mozversion application_changeset: b32127935d3835505115e296afd745a302367b7f 10:24:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:24:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:24:34 INFO - mozversion application_name: Firefox 10:24:34 INFO - mozversion application_remotingname: firefox-dev 10:24:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:24:34 INFO - mozversion application_vendor: Mozilla 10:24:34 INFO - mozversion application_version: 52.0a2 10:24:34 INFO - mozversion platform_buildid: 20170103084739 10:24:34 INFO - mozversion platform_changeset: b32127935d3835505115e296afd745a302367b7f 10:24:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:24:34 INFO - mozversion platform_version: 52.0a2 10:24:34 INFO - using testdate: 1483467874 10:24:34 INFO - actual date: 1483467874 10:24:34 INFO - starting webserver on 'localhost:57271' 10:24:34 INFO - SUITE-START | Running 2 tests 10:24:34 INFO - TEST-START | dromaeo_css 10:24:34 INFO - operating with platform_type : mac_ 10:24:34 INFO - Initialising browser for dromaeo_css test... 10:24:34 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpOgrdKR/profile http://localhost:57271/getInfo.html) 10:24:37 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 10:24:37 INFO - PROCESS | 2185 | colorDepth:24 10:24:37 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 10:24:37 INFO - PROCESS | 2185 | __metrics 10:24:37 INFO - PROCESS | 2185 | 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" 10:24:37 INFO - PROCESS | 2185 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:38 INFO - TEST-INFO | 2185: exit 0 10:24:38 INFO - Browser initialized. 10:24:38 INFO - Running cycle 1/1 for dromaeo_css test... 10:24:38 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpOgrdKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:50 INFO - PROCESS | 2187 | RSS: Main: 222773248 10:24:50 INFO - PROCESS | 2187 | 10:25:42 INFO - PROCESS | 2187 | 1483467942174 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] 10:27:54 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57271/tests/dromaeo/cssquery-ext.html) 10:27:56 INFO - PROCESS | 2187 | RSS: Main: 365252608 10:27:56 INFO - PROCESS | 2187 | 10:30:59 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-ext.html (next: http://localhost:57271/tests/dromaeo/cssquery-jquery.html) 10:31:00 INFO - PROCESS | 2187 | RSS: Main: 346046464 10:31:00 INFO - PROCESS | 2187 | 10:34:02 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57271/tests/dromaeo/cssquery-mootools.html) 10:34:03 INFO - PROCESS | 2187 | RSS: Main: 319184896 10:34:03 INFO - PROCESS | 2187 | 10:37:05 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57271/tests/dromaeo/cssquery-prototype.html) 10:37:06 INFO - PROCESS | 2187 | RSS: Main: 318722048 10:37:06 INFO - PROCESS | 2187 | 10:40:09 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57271/tests/dromaeo/cssquery-yui.html) 10:40:10 INFO - PROCESS | 2187 | RSS: Main: 308752384 10:40:10 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-yui.html (next: http://localhost:57271/tests/dromaeo/cssquery-dojo.html) 10:43:13 INFO - PROCESS | 2187 | RSS: Main: 490258432 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | __start_tp_report 10:43:13 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 10:43:13 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 10:43:13 INFO - PROCESS | 2187 | |i|pagename|runs| 10:43:13 INFO - PROCESS | 2187 | |0;dojo.html;3304.206990322322;3304.2400247942974;3314.303996160806;3324.966750332496;3376.561047063883;5668.773249070037;5701.77192912283;5738.655680659163;5792.131180322948;5794.391588883164;5635.859103522414;5721.942780572193;5731.914021289684;5738.7991420300195;5753.510951569111;5181.35233095863;5209.895802083956;5226.320578324831;5228;5263.289455923439;5017.272495488152;5159.1229490986625;5164.741762911858;5181.792728290883;5316.362036555619;5088.160453525183;5280.656757310762;5284.313039304885;5291.735413229342;5323.148296272597;5273.657212281209;5286.233496143057;5290.153575427913;5294.894102117936;5354.43778403266;5025.773840177201;5152.768125434364;5223.947760522384;5225.372955245395;5228.451012643655;5159.7678104485385;5666.263385759866;5682.7442765075675;5769.3076830780155;5787.102999035156;6260.906086408708;6272.56092073555;6316.778912738078;6328.71520781566;6346.6509341986175;6313.311421118517;6349.8412539686415;6352.205974253218;6357.777477788255;6359.459445947054;5606.579506537026;5616.185653080281;5634.014047541664;5637.323521177403;5664.631798933056;6350.33321501245;6355.3326900674765;6363.268224154189;6364.936350636527;6371.139896113966;6005.369436209223;6021.187139736167;6022;6022.126791615191;6024.1566180734735;6119.106526814625;6174.228221472316;6195.256569211633;6197.597156184834;6201.658908760061;6170.012797952396;6236.18929539166;6241.21984751906;6260.092286618415;6264.59280146789;6103.969480152571;6252.249730032425;6265.592736472115;6268.655223962634;6292.905606415908;4164.729292595972;4805.231163013901;4938.654294199443;4939.851804445872;4959.504049595012;4374.737515749065;4385.407969924083;4412.117576484716;4427.977860110679;4458;5779.913301300484;5789.073748200268;5794.188813566104;5797.101449275369;5832.825015249549;6315.179026726496;6327.3988971047675;6341.397567231105;6346.682665866688;6362.872742545216;5627.634203776742;5680.289963754531;5691.174779656926;5736.713164341766;5761;5360.8659783504945;5373.946260537345;5438.945610543923;5466.9179962300595;5476.890462190734;6271.749130034747;6323.336049714806;6331.89191891408;6340.841478963155;6345.809625711236;6116.816495505142;6290.182276304051;6304.747810087545;6343.270523889627;6353.841153971188;6196.721147548461;6244.313125556095;6269.843253918689;6290.591111577733;6352.205974253218;6152.415520525543;6215.533834962305;6233.906491402542;6237.812865614039;6241.875162496815;5494.846082322757;5645.350784659817;6274.780382686584;6277.372262773869;6326.272478665012;5888.3228428731245;5945.762169513344;5949.8215053548465;6046.244219472566;6076.453119219292;6019.939800602113;6079.513638908788;6100.054491553817;6129.778912921978;6147.815565533041;5909;5926.4666180044005;5930.080837470199;5944.227250457586;5955.642661440327;5907.261592300963;6093.451589356979;6119.510439164767;6127.325994140552;6149.7847575334645;5797.188393624981;5850.824475265749;5890.381509941566;5902.911456328245;5992.610480318765 10:43:13 INFO - PROCESS | 2187 | |1;ext.html;434.6848534812261;471.8065593106826;507.72075358552786;515.5591968866619;523.8271370447752;27011.32471688209;29774.702252977462;32521.99999999997;41115.58884411155;41282.587174128246;40412;40948;40957.18085638285;40967.79516102423;43028.92427689309;9280.907190928105;9458.054194580556;9466.337356385056;9467.242620590336;9472.526373681289;9163.633454661838;9168.770780730501;9258.981512033672;9274.350795444321;9363.39137956034;9318.580663870142;9364.812703745954;9375.578098985561;9387.014363491837;9387.671431499899;9278.72163835086;9318.627254909796;9337.813243735087;9356.064393560657;9364.578593963288;9381.592761085823;9462.621495140254;9482.905170948341;9483.478408687519;9486.193673537757;33898.644054237804;34317.485237721456;37738.811305943294;37741.86774396773;37831.24337513234;3032.5299578565136;3173.2066983254185;3235.5470234167237;3354.681305275995;3561.5370001899587;27373.863130684418;27882.721172788217;29042.27394315138;30409.783608655627;30579.23551911198;3129.342838004022;3160.4469217886776;3161.2254997525524;3201.695838895301;3270.051685011344;483470;484662;484746;485134.99999999645;499120;32446.513302300486;33316.83341583276;33376.66623333735;56174.719126404925;56743.716281419154;33601.15997100092;34004.48993265103;34060.14849628779;34061.82969085139;34064.82967585196;13722.588322350346;13847;13850.238236897067;13871.861281387259;13871.930640346936;11656.88343116575;11753.88246117545;11754.588589399329;11759.176857620056;11762.176647634755;6567.868642627216;7591.544507329578;7627.046619172604;7669.769906902802;7689.884651730228;2798.944021119566;3138.4350816853184;3191.69678880506;3192.5530425740417;3226.6128064632394;942.5522876633681;968.0948313327061;969.4910172159532;979.3291595257272;1020.3214862116757;27906.581401278996;28892.277693057422;29121.7087829119;29636.962706305178;29815.40369192604;847.8007668197969;870.4429165334191;944.9952750236205;1036.388530766836;1037.5590374090982;13288.867111328764;14738.55784326472;14746.705065898623;15078.246087695572;15089.773653395208;668428;673556;674963;675914;677760;55029.72485137549;55470;55606.33181004576;55642.443575563724;55756.72121639366;1128.5090985421205;1211.787937111002;1251.4994002399112;1350.9392077356542;1375.6079517337512;29413;29773.255668608457;29990;30324.69675303219;30755.69244307618;53684.92630147453;54830.45169548254;54969.1754623689;55080;55084;520586;521884;526090;828834;833975;39460.60539394684;39995;40121.99695007648;40233;40477.595224047385;43835.68492945217;43992.78003609961;44080.77959610181;44209.11581768411;44344.55655443404;35345.1163720909;35873.744418945214;35935.64064359428;36342.818285908405;36994.63005369912;36050;36357.45463818098;36394.4540831893;36525.63474365223;37340.25319493541;35599;35985.82007089948;36481.90554283376;36527.817360913024;36874.26251474902;30319.242018949702;30774.384512310076;32726.836365818017;32808.34383312368;32904.84833030928;24210.75789242085;24286.14998475045;24419.877900610383;24787;24916.00335986613 10:43:13 INFO - PROCESS | 2187 | |2;jquery.html;346.2296390531067;368.1716138687952;371.3594050263296;379.36077709060237;399.9100202454448;11751.70620734481;15025.549233522997;15056.548303550911;20223.292184773534;20675.172993080298;19397.806021939778;20482.795172048274;20669.689954650694;20860.89569552154;21049.789502104974;4622.976885115578;5711.742971566289;5717.514011309044;5730.656160630355;5837.5913686041995;4699.342092107091;5463.644863083907;5792.449717276873;5827.533797296227;5859.7656093756195;5683.119116536923;5684.857878553028;5713.6000479966415;5807.128930660392;5808.722081142142;5522.171674248874;5748.19525266463;5778.017736984722;5794.072948328248;5799.043157878945;4823.686460380064;5091.719955402451;5097.5667068299235;5102.923456148161;5105.617078719074;24582.385440363956;24916.127935522352;25214.24357269285;25319;25728.485430291475;2311.0293676655847;2374.4894847607848;2417.286900364397;2422.7213870404953;2433.8783060846886;9783.315167938246;9823.852642210373;9954.303198776088;10213.642522511676;10337.431441270726;1792.9282828686967;1799.3612267644928;1826.244209378943;1872.9719054214197;1940.7088936659613;97069.51465242628;118776;121805.39097304545;124636;134997;9453.52732363379;11310.60412885545;11326.15053870963;11697.415129243504;11729.120315976335;14760.852391475948;14765.483208087666;14771.852281477048;14776.48282310114;14791.408343666133;6955.61744104069;8196.631151598192;8483.490990540588;8491;8582.699605513777;8302.128276530877;8307.293880020145;8354.540500272544;8467.280281176047;8477.915220847835;4473.1277400907165;4541.909161816745;4549.27211646135;4618.076384723069;4628.305754136906;1753.6672129181914;1780.8510227338463;1841.5856432302626;1892.9621407571772;1901.372547059467;752.9887051694229;794.2692722695019;813.109644938803;831.846108469935;889.1952782731638;20190.596188076157;21347.25284615031;21350;21435;21539.78460215409;871.2986046232717;921.7326975177258;948.4262021476907;951.5717926932908;954.9570269337758;10668.093212076905;11126.054285385671;11220.66338009861;11231.887681123084;11239.100871930226;584839;585864;587841;601921;609366;123138;127128;128958;128973;129732;939.7509659940122;989.4854675568664;1002.6540843408866;1008.7982403519326;1010.0656892374524;13157;18354.816451835846;19501.414957551297;20022.299219527828;20111.899440502704;51575.9999999985;54473.18290225571;54932;55104.448955511536;57882.13176802436;57273.42726572681;75322.24677753371;76731;77349;81112;3952.6245006724316;8052.396070294869;8143.75568732939;8309.459885107448;8345.45609062301;9149.908500915171;12611.243325400505;12853.742925141632;13116.672083197996;13202.80195797083;9074.863877041718;10915.290506117077;10945.890541094486;11489.253198542068;11589.942050289694;11098.61154859576;11138.108951283715;11141.610043648434;11153.776924461303;11454.370009649549;10441.26911116245;11289.548418063185;11577.594784182513;11758.706032348917;11773.411329433322;7587.58268295249;7943.761687149395;7973.681052757825;8442.915570844212;8534.274586659954;8326.375521835766;10153.49232538385;11115.388653624128;11373.54505819758;11594.884051159717 10:43:13 INFO - PROCESS | 2187 | |3;mootools.html;1456.5411895252998;1492.1345619540668;1638.6394993101515;1773.866959978002;1834.2112891456684;6431.58194717343;8022.598870056503;8471.11053339399;8492.617832197542;8695.91304086959;7428.145763237229;7658.310752032316;7677.23227677232;7988.880166797503;8226.794330141749;2309.861408315502;2353.776391242829;2355.1639168095335;2357.8467399619058;2358.5282943411385;1844.5388652836791;2175.1625624134745;2209.580179765839;2210.0386331945574;2218.6561083032157;2050.097956898967;2126.5321629241544;2137.3587923622927;2267.4218074391006;2332.3119679694532;2065.648839697255;2322.0711715313923;2337.1936681844736;2342.8242881783935;2348.3072493614427;2327.301809457156;2345.4019225097663;2364.692589963294;2368.6920700309024;2372.264597974616;8208.384371172126;8381.994160700693;8400.789980250482;8419.95790021052;8429.873551896726;5069.391672999263;5242.1088414969545;5247.790088396459;5250.842474725764;5254.395744489356;3323.5180898769786;3460.3079384123275;3468.618451970281;3473;3518.964810351915;1004.8392257238806;1058.9099926506256;1097.4951522299752;1098.1324753444849;1101.752105776202;11048.834267485994;11049.392283424408;11062.05972492339;11063.72340691473;11077.556897724082;4233.470816147981;4325.048489332342;4724.2205036169335;4725.763711814396;4789.832355867528;9389.718308450758;9426.340156189139;9457.810843783085;9530.380525265835;9564.426134431957;4478.708883922534;5234.659747116501;5236.607254455931;5238.083335416287;5251.317328747238;3745.3071181830906;4541.72749635023;4650;4653.697509661861;4754.31062495943;3737.7009839212797;3843.1545060086737;3886.7084968627464;3892.922141557153;3910.198409326081;1251.730877861246;1255.3221260519217;1256.9308688022247;1270.2124682696788;1271.8982481401465;768.7463137164722;771.2634434115406;809.461707964209;873.5588527793424;918.3755046568264;5592;5649.12438572022;5796.552566140622;5822.970885145547;5911.674857882772;369.2559492622368;431.6740860650189;438.44098774063326;452.0506935435625;457.1223251357402;3809.5428548573796;3814.1036856338737;3814.48504451901;3899.5710471848074;3906.140649057203;8082.757517274491;10120.139788118093;10304.845427318596;10305.690829274983;10309.381437113798;9806.019398060136;10082.798344033225;10227.07956283938;10234.130098941674;10265.640702575374;7809.960950195326;7917.920820791718;7921.603919803987;7936.206379362017;7945.801354966056;5624.578156638187;5650.717464126695;5696.658200507983;5818.389069147848;5928.970355148197;9215.815683686424;9268.397554158959;9329.393589416666;9407.059294070537;9449.574769135543;9113.908860911306;9612.375195612263;9637.22902167839;9638.662646807328;9643.855342169732;7190.101237345332;7197.100362454693;7213.458990575833;7322.780316590511;7324.487285889936;7671.961640191764;7765.262300081483;7802.180771018961;7853.253940875607;7860.5676687782725;5657.773689052392;7012.894806578008;7061.470389720689;7151.8569628608175;7283.271672832886;6814.4548436124;6993.2657071006815;7001.404880585003;7083.0791997042115;7155.391791697764;6691.197056353269;6705.765298214539;6707.66461676924;6768.120144381199;6786.287439818945;4765.8093676252565;4767.356406885165;4854.95145048545;4937.777799998937;5066.695998240118;4855.616149397405;4876.756162191805;4904.313396124474;4954.281629163823;4979.302897594267 10:43:13 INFO - PROCESS | 2187 | |4;prototype.html;298.3362019506598;299.0982188701065;305.79053348456307;309.7150621428286;312.8685951900202;4760.69055511392;5016.548510634042;5150.27896094547;5198;5222.451642577527;4276.550962148976;4957.5786058185;5108.1060814357525;5112.412072611651;5145.459726728695;3661.212839239556;4009.278329900617;4026.134381108061;4040.8585699500522;4065.959340406602;4010.157866847951;4022.7586344819406;4032.899177520571;4046.8178931947987;4080.551139374681;2810.6205662235643;3460.878869239577;4003.158547068352;4017.5047708493507;4032.4556184914954;3995.900102497432;4016.8995775105564;4029.113595009108;4037.4953130858644;4054.614811592894;3013.5931649227514;3476.096214984097;3503.8598456061727;3520;3523.5067090607336;4019.8995025124314;4261.275583150872;4635.887387027123;4895.586781316487;5123.410807757118;3892.3966785148345;4514.435695538058;4558.247889098295;4591.966807468293;4593.862184134481;5446.863828404282;5455.863603409907;5485.149801780691;5504.752286147133;5519.39286678465;3253.5119732040384;3845.2693988142164;3847.5575308839284;3856.5179352580926;3874.9225015499815;4667.463241727177;4761.357216775726;5652.72813616937;5737.627054241461;5743.195952566644;3484.188222124481;3895.9222214450833;3902.2195560887935;3910.4916360872903;3914.530256369254;3960.7227494075137;3972.64246217836;3974.5627980922077;3998.4202290668272;4004.3192657248337;3810.447485114643;3942.901427464279;4050.2583888928043;4420;4612.377329060534;4807.807687692523;5494.2582751328055;5520.806771762969;5528.889422211533;5540.030494663418;1129.9435028248554;1206.5113628980102;1213.6905089202196;1248.5630029489787;1282.2050328796206;763.7097902796902;826.8883700700449;839.7144970709988;847.7033038436621;876.3252295732251;3871.477350557695;4528;4824.673214865869;4851.902961940741;4876.878078048077;4928.950710492921;5289.799671198946;5375.1131063374105;5383.111786555174;5393.355026716889;3853.5761066282685;4764.760562535603;4776.617870570346;4797.4482934462985;4817.855464336006;2298.609236429811;2738.672896823015;2786.582012698071;2795.9580606290924;2801.389201209313;5369.946300537023;5398.597624057257;5399.433059528771;5400.135978243462;5450.3732070811575;4395;4526.615237704832;5066.594672426197;5078.97460512695;5399.00118478075;4826.372571565674;4938.975305123451;5008.799648014112;5424.50826022839;5427.864303392446;4579.839705610288;4890.975545122252;5124.948750512447;5274.074962638686;5354.973225133849;4744.810207591796;4869.342638743724;5195.610329225247;5226.97386513065;5265.921011184759;4995.775190116527;5010.494752623688;5346.385165705838;5396.568274538106;5413.808962028347;3288.5859080595574;3563.893083207508;3599.3982677709214;3694.649008344203;3698.3342998259495;4923.8276660316715;5069.898602027865;5252.868678283074;5254.13306804373;5277.155655095166;4965.45380008206;5100.974495127501;5110.754670784005;5120.692758434506;5130.48695130484;4188.958110418856;5102.668326558762;5120.4111527174855;5133.460986596354;5147.948520514747;4755.215389460838;5000.574721260258;5007.624428167975;5032.169692000779;5037.92443113361;5208.791648334176;5365.517103460551;5376.8118115865755;5380.76698170255;5514.91727624094;5075.720835354091;5133.281340612392;5375.661587209576;5391.353037635352;5409.729513524387 10:43:13 INFO - PROCESS | 2187 | |5;yui.html;703.3283214530122;778.7897267737708;778.7897267737711;782.7377828427476;803.7146812881427;15626;16198.757018644701;16245.26896289667;16247.675046499078;16768.916155419207;14818.40726370944;14979.026363286379;14982.32579533921;14988.625284367896;14992;634.8476365672228;657.5758635679983;812.3095368936416;839.8488272111017;840.2521755637488;655.3577494055828;658.6607896933083;659.0970370592295;659.515256286629;795.7930937956115;865.6018231613434;868.1362044765435;877.5085951866974;878.7232021913109;879.3097418526459;871.6818361298112;872.4242000279785;872.5768002518773;873.5763154869915;873.724776695339;497.5944605146794;508.6032894342419;647.7214797637014;649.5712829532533;652.5953908576713;13818;14295.78556321656;14358.425662973468;14635.853641463662;14652.853471465256;13786.93106534471;13960.58118256454;13996;14075.366608502642;14126;10708.839367409495;10929.726756831064;11132.61035863749;11404.31574105548;11602.12984026193;3675.2774874321995;3720.2187540616233;3766.4538641897047;3846.365349717293;3856.9614303856883;84750.6099756009;85508;85895.57052214698;86090.13909860884;86486;10632.574697012187;10679.563194985052;10775.407352595526;10820.837687434694;10863.782724345627;21077.473063173544;21103.9448027598;21121.471963200736;21306.573868522853;21386.572268554854;7323.780286591411;7686.269804368576;7903.56530390834;7922.564258965812;7960.920390796018;4046.5346485153996;4163.75017498951;4223.450951376301;4335.761533115646;4347.695661303742;3391.5082313064468;3500.387432199355;3500.754947153726;3501.8949431517094;3670.9082272942856;692.1140939597324;695.3220609905403;695.7043256615918;698.4028655499475;710.7121615745631;558.7569407307834;565.2453973944747;637.3435361577582;638.7732355013903;666.7966270287512;8871.379003469696;9041.276697864156;9046.457212567268;9062.203347489383;9504.90495095054;630.3066626710673;630.7045686289102;633.7591715148214;658.4699317049821;660.9845190467831;4221.303484924953;4482.618977386894;4485.237509623372;4495.073280609645;4584.1977653910435;78079;97029;114121.85878141112;121814.3909280448;122992;81866.59066704629;101542.49228753809;103514;103619;108452.4577377108;90259.09740902638;91580.54209728909;91863;92262.15475690314;94983.0501694988;7652.464327497022;8585.8712119317;8780.560971951249;8851.601677924638;8866.069062748576;53398.73300633472;57231.71384143052;58395;58945.410545895706;60872.69563652154;79199.60400198192;79831;83401.58299208464;83958.58020709857;86653.13346866451;10373.273870828969;11273.661790145981;11447.141464390037;12024.639260822189;12193.451294691582;12100.213486123374;12103.455344509342;12332.445039973401;12340.95101916347;12403.441845116811;11004.724881878017;11641.6507504775;11753.882461175279;11865.703357416134;12168.756624867276;11052.778944421227;11372.20394572372;11706.824397633873;11822.881771182178;12053.457594408097;10815.783684326427;11261;11824.881751182378;11937.28376297425;12121.090918181348;8999.955000224956;9829.459379734184;10057.24570657189;10073.19414446857;10268.58925642966;8556.855506931579;9972.088051310695;10088.19294456427;10090.16745384284;10124.240681948737 10:43:13 INFO - PROCESS | 2187 | __end_tp_report 10:43:13 INFO - PROCESS | 2187 | __start_cc_report 10:43:13 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,1906 10:43:13 INFO - PROCESS | 2187 | __end_cc_report 10:43:13 INFO - PROCESS | 2187 | __startTimestamp1483468993715__endTimestamp 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | ------- Summary: start ------- 10:43:13 INFO - PROCESS | 2187 | Number of tests: 6 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#0] dojo.html Cycles:165 Average:5737.11 Median:5907.26 stddev:656.74 (11.1%) stddev-sans-first:630.41 10:43:13 INFO - PROCESS | 2187 | Values: 3304.2 3304.2 3314.3 3325.0 3376.6 5668.8 5701.8 5738.7 5792.1 5794.4 5635.9 5721.9 5731.9 5738.8 5753.5 5181.4 5209.9 5226.3 5228.0 5263.3 5017.3 5159.1 5164.7 5181.8 5316.4 5088.2 5280.7 5284.3 5291.7 5323.1 5273.7 5286.2 5290.2 5294.9 5354.4 5025.8 5152.8 5223.9 5225.4 5228.5 5159.8 5666.3 5682.7 5769.3 5787.1 6260.9 6272.6 6316.8 6328.7 6346.7 6313.3 6349.8 6352.2 6357.8 6359.5 5606.6 5616.2 5634.0 5637.3 5664.6 6350.3 6355.3 6363.3 6364.9 6371.1 6005.4 6021.2 6022.0 6022.1 6024.2 6119.1 6174.2 6195.3 6197.6 6201.7 6170.0 6236.2 6241.2 6260.1 6264.6 6104.0 6252.2 6265.6 6268.7 6292.9 4164.7 4805.2 4938.7 4939.9 4959.5 4374.7 4385.4 4412.1 4428.0 4458.0 5779.9 5789.1 5794.2 5797.1 5832.8 6315.2 6327.4 6341.4 6346.7 6362.9 5627.6 5680.3 5691.2 5736.7 5761.0 5360.9 5373.9 5438.9 5466.9 5476.9 6271.7 6323.3 6331.9 6340.8 6345.8 6116.8 6290.2 6304.7 6343.3 6353.8 6196.7 6244.3 6269.8 6290.6 6352.2 6152.4 6215.5 6233.9 6237.8 6241.9 5494.8 5645.4 6274.8 6277.4 6326.3 5888.3 5945.8 5949.8 6046.2 6076.5 6019.9 6079.5 6100.1 6129.8 6147.8 5909.0 5926.5 5930.1 5944.2 5955.6 5907.3 6093.5 6119.5 6127.3 6149.8 5797.2 5850.8 5890.4 5902.9 5992.6 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#1] ext.html Cycles:180 Average:70880.24 Median:37539.53 stddev:165276.34 (440.3%) stddev-sans-first:165655.36 10:43:13 INFO - PROCESS | 2187 | Values: 434.7 471.8 507.7 515.6 523.8 27011.3 29774.7 32522.0 41115.6 41282.6 40412.0 40948.0 40957.2 40967.8 43028.9 9280.9 9458.1 9466.3 9467.2 9472.5 9163.6 9168.8 9259.0 9274.4 9363.4 9318.6 9364.8 9375.6 9387.0 9387.7 9278.7 9318.6 9337.8 9356.1 9364.6 9381.6 9462.6 9482.9 9483.5 9486.2 33898.6 34317.5 37738.8 37741.9 37831.2 3032.5 3173.2 3235.5 3354.7 3561.5 27373.9 27882.7 29042.3 30409.8 30579.2 3129.3 3160.4 3161.2 3201.7 3270.1 483470.0 484662.0 484746.0 485135.0 499120.0 32446.5 33316.8 33376.7 56174.7 56743.7 33601.2 34004.5 34060.1 34061.8 34064.8 13722.6 13847.0 13850.2 13871.9 13871.9 11656.9 11753.9 11754.6 11759.2 11762.2 6567.9 7591.5 7627.0 7669.8 7689.9 2798.9 3138.4 3191.7 3192.6 3226.6 942.6 968.1 969.5 979.3 1020.3 27906.6 28892.3 29121.7 29637.0 29815.4 847.8 870.4 945.0 1036.4 1037.6 13288.9 14738.6 14746.7 15078.2 15089.8 668428.0 673556.0 674963.0 675914.0 677760.0 55029.7 55470.0 55606.3 55642.4 55756.7 1128.5 1211.8 1251.5 1350.9 1375.6 29413.0 29773.3 29990.0 30324.7 30755.7 53684.9 54830.5 54969.2 55080.0 55084.0 520586.0 521884.0 526090.0 828834.0 833975.0 39460.6 39995.0 40122.0 40233.0 40477.6 43835.7 43992.8 44080.8 44209.1 44344.6 35345.1 35873.7 35935.6 36342.8 36994.6 36050.0 36357.5 36394.5 36525.6 37340.3 35599.0 35985.8 36481.9 36527.8 36874.3 30319.2 30774.4 32726.8 32808.3 32904.8 24210.8 24286.1 24419.9 24787.0 24916.0 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#2] jquery.html Cycles:180 Average:34647.39 Median:357.20 stddev:99249.81 (27785.5%) stddev-sans-first:99494.82 10:43:13 INFO - PROCESS | 2187 | Values: 346.2 368.2 371.4 379.4 399.9 11751.7 15025.5 15056.5 20223.3 20675.2 19397.8 20482.8 20669.7 20860.9 21049.8 4623.0 5711.7 5717.5 5730.7 5837.6 4699.3 5463.6 5792.4 5827.5 5859.8 5683.1 5684.9 5713.6 5807.1 5808.7 5522.2 5748.2 5778.0 5794.1 5799.0 4823.7 5091.7 5097.6 5102.9 5105.6 24582.4 24916.1 25214.2 25319.0 25728.5 2311.0 2374.5 2417.3 2422.7 2433.9 9783.3 9823.9 9954.3 10213.6 10337.4 1792.9 1799.4 1826.2 1873.0 1940.7 97069.5 118776.0 121805.4 124636.0 134997.0 9453.5 11310.6 11326.2 11697.4 11729.1 14760.9 14765.5 14771.9 14776.5 14791.4 6955.6 8196.6 8483.5 8491.0 8582.7 8302.1 8307.3 8354.5 8467.3 8477.9 4473.1 4541.9 4549.3 4618.1 4628.3 1753.7 1780.9 1841.6 1893.0 1901.4 753.0 794.3 813.1 831.8 889.2 20190.6 21347.3 21350.0 21435.0 21539.8 871.3 921.7 948.4 951.6 955.0 10668.1 11126.1 11220.7 11231.9 11239.1 584839.0 585864.0 587841.0 601921.0 609366.0 123138.0 127128.0 128958.0 128973.0 129732.0 939.8 989.5 1002.7 1008.8 1010.1 13157.0 18354.8 19501.4 20022.3 20111.9 51576.0 54473.2 54932.0 55104.4 57882.1 57273.4 75322.2 76731.0 77349.0 81112.0 3952.6 8052.4 8143.8 8309.5 8345.5 9149.9 12611.2 12853.7 13116.7 13202.8 9074.9 10915.3 10945.9 11489.3 11589.9 11098.6 11138.1 11141.6 11153.8 11454.4 10441.3 11289.5 11577.6 11758.7 11773.4 7587.6 7943.8 7973.7 8442.9 8534.3 8326.4 10153.5 11115.4 11373.5 11594.9 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#3] mootools.html Cycles:180 Average:5426.56 Median:4946.03 stddev:3011.60 (60.9%) stddev-sans-first:3005.27 10:43:13 INFO - PROCESS | 2187 | Values: 1456.5 1492.1 1638.6 1773.9 1834.2 6431.6 8022.6 8471.1 8492.6 8695.9 7428.1 7658.3 7677.2 7988.9 8226.8 2309.9 2353.8 2355.2 2357.8 2358.5 1844.5 2175.2 2209.6 2210.0 2218.7 2050.1 2126.5 2137.4 2267.4 2332.3 2065.6 2322.1 2337.2 2342.8 2348.3 2327.3 2345.4 2364.7 2368.7 2372.3 8208.4 8382.0 8400.8 8420.0 8429.9 5069.4 5242.1 5247.8 5250.8 5254.4 3323.5 3460.3 3468.6 3473.0 3519.0 1004.8 1058.9 1097.5 1098.1 1101.8 11048.8 11049.4 11062.1 11063.7 11077.6 4233.5 4325.0 4724.2 4725.8 4789.8 9389.7 9426.3 9457.8 9530.4 9564.4 4478.7 5234.7 5236.6 5238.1 5251.3 3745.3 4541.7 4650.0 4653.7 4754.3 3737.7 3843.2 3886.7 3892.9 3910.2 1251.7 1255.3 1256.9 1270.2 1271.9 768.7 771.3 809.5 873.6 918.4 5592.0 5649.1 5796.6 5823.0 5911.7 369.3 431.7 438.4 452.1 457.1 3809.5 3814.1 3814.5 3899.6 3906.1 8082.8 10120.1 10304.8 10305.7 10309.4 9806.0 10082.8 10227.1 10234.1 10265.6 7810.0 7917.9 7921.6 7936.2 7945.8 5624.6 5650.7 5696.7 5818.4 5929.0 9215.8 9268.4 9329.4 9407.1 9449.6 9113.9 9612.4 9637.2 9638.7 9643.9 7190.1 7197.1 7213.5 7322.8 7324.5 7672.0 7765.3 7802.2 7853.3 7860.6 5657.8 7012.9 7061.5 7151.9 7283.3 6814.5 6993.3 7001.4 7083.1 7155.4 6691.2 6705.8 6707.7 6768.1 6786.3 4765.8 4767.4 4855.0 4937.8 5066.7 4855.6 4876.8 4904.3 4954.3 4979.3 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#4] prototype.html Cycles:180 Average:4294.74 Median:4821.26 stddev:1286.24 (26.7%) stddev-sans-first:1254.38 10:43:13 INFO - PROCESS | 2187 | Values: 298.3 299.1 305.8 309.7 312.9 4760.7 5016.5 5150.3 5198.0 5222.5 4276.6 4957.6 5108.1 5112.4 5145.5 3661.2 4009.3 4026.1 4040.9 4066.0 4010.2 4022.8 4032.9 4046.8 4080.6 2810.6 3460.9 4003.2 4017.5 4032.5 3995.9 4016.9 4029.1 4037.5 4054.6 3013.6 3476.1 3503.9 3520.0 3523.5 4019.9 4261.3 4635.9 4895.6 5123.4 3892.4 4514.4 4558.2 4592.0 4593.9 5446.9 5455.9 5485.1 5504.8 5519.4 3253.5 3845.3 3847.6 3856.5 3874.9 4667.5 4761.4 5652.7 5737.6 5743.2 3484.2 3895.9 3902.2 3910.5 3914.5 3960.7 3972.6 3974.6 3998.4 4004.3 3810.4 3942.9 4050.3 4420.0 4612.4 4807.8 5494.3 5520.8 5528.9 5540.0 1129.9 1206.5 1213.7 1248.6 1282.2 763.7 826.9 839.7 847.7 876.3 3871.5 4528.0 4824.7 4851.9 4876.9 4929.0 5289.8 5375.1 5383.1 5393.4 3853.6 4764.8 4776.6 4797.4 4817.9 2298.6 2738.7 2786.6 2796.0 2801.4 5369.9 5398.6 5399.4 5400.1 5450.4 4395.0 4526.6 5066.6 5079.0 5399.0 4826.4 4939.0 5008.8 5424.5 5427.9 4579.8 4891.0 5124.9 5274.1 5355.0 4744.8 4869.3 5195.6 5227.0 5265.9 4995.8 5010.5 5346.4 5396.6 5413.8 3288.6 3563.9 3599.4 3694.6 3698.3 4923.8 5069.9 5252.9 5254.1 5277.2 4965.5 5101.0 5110.8 5120.7 5130.5 4189.0 5102.7 5120.4 5133.5 5147.9 4755.2 5000.6 5007.6 5032.2 5037.9 5208.8 5365.5 5376.8 5380.8 5514.9 5075.7 5133.3 5375.7 5391.4 5409.7 10:43:13 INFO - PROCESS | 2187 | 10:43:13 INFO - PROCESS | 2187 | [#5] yui.html Cycles:180 Average:20934.17 Median:4490.16 stddev:31152.37 (693.8%) stddev-sans-first:31202.73 10:43:13 INFO - PROCESS | 2187 | Values: 703.3 778.8 778.8 782.7 803.7 15626.0 16198.8 16245.3 16247.7 16768.9 14818.4 14979.0 14982.3 14988.6 14992.0 634.8 657.6 812.3 839.8 840.3 655.4 658.7 659.1 659.5 795.8 865.6 868.1 877.5 878.7 879.3 871.7 872.4 872.6 873.6 873.7 497.6 508.6 647.7 649.6 652.6 13818.0 14295.8 14358.4 14635.9 14652.9 13786.9 13960.6 13996.0 14075.4 14126.0 10708.8 10929.7 11132.6 11404.3 11602.1 3675.3 3720.2 3766.5 3846.4 3857.0 84750.6 85508.0 85895.6 86090.1 86486.0 10632.6 10679.6 10775.4 10820.8 10863.8 21077.5 21103.9 21121.5 21306.6 21386.6 7323.8 7686.3 7903.6 7922.6 7960.9 4046.5 4163.8 4223.5 4335.8 4347.7 3391.5 3500.4 3500.8 3501.9 3670.9 692.1 695.3 695.7 698.4 710.7 558.8 565.2 637.3 638.8 666.8 8871.4 9041.3 9046.5 9062.2 9504.9 630.3 630.7 633.8 658.5 661.0 4221.3 4482.6 4485.2 4495.1 4584.2 78079.0 97029.0 114121.9 121814.4 122992.0 81866.6 101542.5 103514.0 103619.0 108452.5 90259.1 91580.5 91863.0 92262.2 94983.1 7652.5 8585.9 8780.6 8851.6 8866.1 53398.7 57231.7 58395.0 58945.4 60872.7 79199.6 79831.0 83401.6 83958.6 86653.1 10373.3 11273.7 11447.1 12024.6 12193.5 12100.2 12103.5 12332.4 12341.0 12403.4 11004.7 11641.7 11753.9 11865.7 12168.8 11052.8 11372.2 11706.8 11822.9 12053.5 10815.8 11261.0 11824.9 11937.3 12121.1 9000.0 9829.5 10057.2 10073.2 10268.6 8556.9 9972.1 10088.2 10090.2 10124.2 10:43:13 INFO - PROCESS | 2187 | -------- Summary: end -------- 10:43:13 INFO - PROCESS | 2187 | 10:43:14 INFO - TEST-INFO | 2187: exit 0 10:43:14 INFO - TEST-OK | dromaeo_css | took 1119711ms 10:43:14 INFO - TEST-START | kraken 10:43:14 INFO - operating with platform_type : mac_ 10:43:14 INFO - Initialising browser for kraken test... 10:43:14 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpCzYyOs/profile http://localhost:57271/getInfo.html) 10:43:16 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 10:43:16 INFO - PROCESS | 2190 | colorDepth:24 10:43:16 INFO - PROCESS | 2190 | Browser inner width/height: 1024/689 10:43:16 INFO - PROCESS | 2190 | __metrics 10:43:16 INFO - PROCESS | 2190 | 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" 10:43:16 INFO - PROCESS | 2190 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:17 INFO - TEST-INFO | 2190: exit 0 10:43:17 INFO - Browser initialized. 10:43:17 INFO - Running cycle 1/1 for kraken test... 10:43:17 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpCzYyOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:29 INFO - PROCESS | 2191 | RSS: Main: 222744576 10:43:29 INFO - PROCESS | 2191 | 10:43:32 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-beat-detection) 10:43:33 INFO - PROCESS | 2191 | RSS: Main: 271851520 10:43:33 INFO - PROCESS | 2191 | 10:43:36 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-dft) 10:43:36 INFO - PROCESS | 2191 | RSS: Main: 282857472 10:43:36 INFO - PROCESS | 2191 | 10:43:40 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-fft) 10:43:40 INFO - PROCESS | 2191 | RSS: Main: 379240448 10:43:40 INFO - PROCESS | 2191 | 10:43:42 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-oscillator) 10:43:43 INFO - PROCESS | 2191 | RSS: Main: 283381760 10:43:43 INFO - PROCESS | 2191 | 10:43:45 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:43:45 INFO - PROCESS | 2191 | RSS: Main: 285339648 10:43:45 INFO - PROCESS | 2191 | 10:43:48 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-darkroom) 10:43:49 INFO - PROCESS | 2191 | RSS: Main: 325226496 10:43:49 INFO - PROCESS | 2191 | 10:43:52 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-desaturate) 10:43:52 INFO - PROCESS | 2191 | RSS: Main: 326242304 10:43:52 INFO - PROCESS | 2191 | 10:43:55 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57271/tests/kraken/driver.html?testName=json-parse-financial) 10:43:56 INFO - PROCESS | 2191 | RSS: Main: 322789376 10:43:56 INFO - PROCESS | 2191 | 10:43:57 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:43:58 INFO - PROCESS | 2191 | RSS: Main: 298201088 10:43:58 INFO - PROCESS | 2191 | 10:44:00 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:44:01 INFO - PROCESS | 2191 | RSS: Main: 301015040 10:44:01 INFO - PROCESS | 2191 | 10:44:03 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:44:04 INFO - PROCESS | 2191 | RSS: Main: 303419392 10:44:04 INFO - PROCESS | 2191 | 10:44:06 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:44:07 INFO - PROCESS | 2191 | RSS: Main: 322662400 10:44:07 INFO - PROCESS | 2191 | 10:44:10 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:44:11 INFO - PROCESS | 2191 | RSS: Main: 316014592 10:44:11 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57271/tests/kraken/driver.html?testName=ai-astar) 10:44:13 INFO - PROCESS | 2191 | RSS: Main: 359927808 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | __start_tp_report 10:44:13 INFO - PROCESS | 2191 | _x_x_mozilla_page_load 10:44:13 INFO - PROCESS | 2191 | _x_x_mozilla_page_load_details 10:44:13 INFO - PROCESS | 2191 | |i|pagename|runs| 10:44:13 INFO - PROCESS | 2191 | |0;ai-astar;116;113;115;114;114;115;113;114;113;115 10:44:13 INFO - PROCESS | 2191 | |1;audio-beat-detection;145;109;110;146;114;110;109;117;177;139 10:44:13 INFO - PROCESS | 2191 | |2;audio-dft;187;183;187;182;183;182;185;186;186;184 10:44:13 INFO - PROCESS | 2191 | |3;audio-fft;85;59;58;90;62;58;59;58;82;73 10:44:13 INFO - PROCESS | 2191 | |4;audio-oscillator;89;71;95;70;68;69;92;68;69;94 10:44:13 INFO - PROCESS | 2191 | |5;imaging-gaussian-blur;117;129;91;86;89;87;90;87;90;86 10:44:13 INFO - PROCESS | 2191 | |6;imaging-darkroom;101;98;99;101;98;99;99;100;97;100 10:44:13 INFO - PROCESS | 2191 | |7;imaging-desaturate;84;85;82;79;81;81;85;83;77;120 10:44:13 INFO - PROCESS | 2191 | |8;json-parse-financial;56;54;54;53;58;56;58;57;58;56 10:44:13 INFO - PROCESS | 2191 | |9;json-stringify-tinderbox;66;83;76;75;73;73;72;71;73;73 10:44:13 INFO - PROCESS | 2191 | |10;stanford-crypto-aes;84;85;84;85;93;99;99;82;82;84 10:44:13 INFO - PROCESS | 2191 | |11;stanford-crypto-ccm;177;153;158;129;144;157;157;159;183;153 10:44:13 INFO - PROCESS | 2191 | |12;stanford-crypto-pbkdf2;167;166;165;170;167;167;166;166;165;166 10:44:13 INFO - PROCESS | 2191 | |13;stanford-crypto-sha256-iterative;59;73;86;89;86;73;67;67;66;66 10:44:13 INFO - PROCESS | 2191 | __end_tp_report 10:44:13 INFO - PROCESS | 2191 | __start_cc_report 10:44:13 INFO - PROCESS | 2191 | _x_x_mozilla_cycle_collect,2214 10:44:13 INFO - PROCESS | 2191 | __end_cc_report 10:44:13 INFO - PROCESS | 2191 | __startTimestamp1483469053472__endTimestamp 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | ------- Summary: start ------- 10:44:13 INFO - PROCESS | 2191 | Number of tests: 14 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.03 (0.9%) stddev-sans-first:0.87 10:44:13 INFO - PROCESS | 2191 | Values: 116.0 113.0 115.0 114.0 114.0 115.0 113.0 114.0 113.0 115.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:128.00 stddev:23.14 (18.1%) stddev-sans-first:23.67 10:44:13 INFO - PROCESS | 2191 | Values: 145.0 109.0 110.0 146.0 114.0 110.0 109.0 117.0 177.0 139.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:1.96 (1.1%) stddev-sans-first:1.86 10:44:13 INFO - PROCESS | 2191 | Values: 187.0 183.0 187.0 182.0 183.0 182.0 185.0 186.0 186.0 184.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#3] audio-fft Cycles:10 Average:68.40 Median:67.50 stddev:12.87 (19.1%) stddev-sans-first:12.17 10:44:13 INFO - PROCESS | 2191 | Values: 85.0 59.0 58.0 90.0 62.0 58.0 59.0 58.0 82.0 73.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:80.00 stddev:12.18 (15.2%) stddev-sans-first:12.31 10:44:13 INFO - PROCESS | 2191 | Values: 89.0 71.0 95.0 70.0 68.0 69.0 92.0 68.0 69.0 94.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:88.00 stddev:15.02 (17.1%) stddev-sans-first:13.71 10:44:13 INFO - PROCESS | 2191 | Values: 117.0 129.0 91.0 86.0 89.0 87.0 90.0 87.0 90.0 86.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:98.00 stddev:1.32 (1.3%) stddev-sans-first:1.22 10:44:13 INFO - PROCESS | 2191 | Values: 101.0 98.0 99.0 101.0 98.0 99.0 99.0 100.0 97.0 100.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:82.50 stddev:12.32 (14.9%) stddev-sans-first:13.05 10:44:13 INFO - PROCESS | 2191 | Values: 84.0 85.0 82.0 79.0 81.0 81.0 85.0 83.0 77.0 120.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.83 (3.2%) stddev-sans-first:1.94 10:44:13 INFO - PROCESS | 2191 | Values: 56.0 54.0 54.0 53.0 58.0 56.0 58.0 57.0 58.0 56.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:73.00 stddev:4.28 (5.9%) stddev-sans-first:3.57 10:44:13 INFO - PROCESS | 2191 | Values: 66.0 83.0 76.0 75.0 73.0 73.0 72.0 71.0 73.0 73.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.00 stddev:6.70 (7.9%) stddev-sans-first:6.97 10:44:13 INFO - PROCESS | 2191 | Values: 84.0 85.0 84.0 85.0 93.0 99.0 99.0 82.0 82.0 84.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#11] stanford-crypto-ccm Cycles:10 Average:157.00 Median:157.50 stddev:15.15 (9.6%) stddev-sans-first:14.24 10:44:13 INFO - PROCESS | 2191 | Values: 177.0 153.0 158.0 129.0 144.0 157.0 157.0 159.0 183.0 153.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 10:44:13 INFO - PROCESS | 2191 | Values: 167.0 166.0 165.0 170.0 167.0 167.0 166.0 166.0 165.0 166.0 10:44:13 INFO - PROCESS | 2191 | 10:44:13 INFO - PROCESS | 2191 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:10.33 (14.1%) stddev-sans-first:9.59 10:44:13 INFO - PROCESS | 2191 | Values: 59.0 73.0 86.0 89.0 86.0 73.0 67.0 67.0 66.0 66.0 10:44:13 INFO - PROCESS | 2191 | -------- Summary: end -------- 10:44:13 INFO - PROCESS | 2191 | 10:44:14 INFO - TEST-INFO | 2191: exit 0 10:44:14 INFO - TEST-OK | kraken | took 60194ms 10:44:14 INFO - SUITE-END | took 1179s 10:44:14 INFO - Completed test suite (00:19:39) 10:44:14 INFO - javascript benchmark 10:44:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.206990322322, 3304.2400247942974, 3314.303996160806, 3324.966750332496, 3376.561047063883, 5668.773249070037, 5701.77192912283, 5738.655680659163, 5792.131180322948, 5794.391588883164, 5635.859103522414, 5721.942780572193, 5731.914021289684, 5738.7991420300195, 5753.510951569111, 5181.35233095863, 5209.895802083956, 5226.320578324831, 5228.0, 5263.289455923439, 5017.272495488152, 5159.1229490986625, 5164.741762911858, 5181.792728290883, 5316.362036555619, 5088.160453525183, 5280.656757310762, 5284.313039304885, 5291.735413229342, 5323.148296272597, 5273.657212281209, 5286.233496143057, 5290.153575427913, 5294.894102117936, 5354.43778403266, 5025.773840177201, 5152.768125434364, 5223.947760522384, 5225.372955245395, 5228.451012643655, 5159.7678104485385, 5666.263385759866, 5682.7442765075675, 5769.3076830780155, 5787.102999035156, 6260.906086408708, 6272.56092073555, 6316.778912738078, 6328.71520781566, 6346.6509341986175, 6313.311421118517, 6349.8412539686415, 6352.205974253218, 6357.777477788255, 6359.459445947054, 5606.579506537026, 5616.185653080281, 5634.014047541664, 5637.323521177403, 5664.631798933056, 6350.33321501245, 6355.3326900674765, 6363.268224154189, 6364.936350636527, 6371.139896113966, 6005.369436209223, 6021.187139736167, 6022.0, 6022.126791615191, 6024.1566180734735, 6119.106526814625, 6174.228221472316, 6195.256569211633, 6197.597156184834, 6201.658908760061, 6170.012797952396, 6236.18929539166, 6241.21984751906, 6260.092286618415, 6264.59280146789, 6103.969480152571, 6252.249730032425, 6265.592736472115, 6268.655223962634, 6292.905606415908, 4164.729292595972, 4805.231163013901, 4938.654294199443, 4939.851804445872, 4959.504049595012, 4374.737515749065, 4385.407969924083, 4412.117576484716, 4427.977860110679, 4458.0, 5779.913301300484, 5789.073748200268, 5794.188813566104, 5797.101449275369, 5832.825015249549, 6315.179026726496, 6327.3988971047675, 6341.397567231105, 6346.682665866688, 6362.872742545216, 5627.634203776742, 5680.289963754531, 5691.174779656926, 5736.713164341766, 5761.0, 5360.8659783504945, 5373.946260537345, 5438.945610543923, 5466.9179962300595, 5476.890462190734, 6271.749130034747, 6323.336049714806, 6331.89191891408, 6340.841478963155, 6345.809625711236, 6116.816495505142, 6290.182276304051, 6304.747810087545, 6343.270523889627, 6353.841153971188, 6196.721147548461, 6244.313125556095, 6269.843253918689, 6290.591111577733, 6352.205974253218, 6152.415520525543, 6215.533834962305, 6233.906491402542, 6237.812865614039, 6241.875162496815, 5494.846082322757, 5645.350784659817, 6274.780382686584, 6277.372262773869, 6326.272478665012, 5888.3228428731245, 5945.762169513344, 5949.8215053548465, 6046.244219472566, 6076.453119219292, 6019.939800602113, 6079.513638908788, 6100.054491553817, 6129.778912921978, 6147.815565533041, 5909.0, 5926.4666180044005, 5930.080837470199, 5944.227250457586, 5955.642661440327, 5907.261592300963, 6093.451589356979, 6119.510439164767, 6127.325994140552, 6149.7847575334645, 5797.188393624981, 5850.824475265749, 5890.381509941566, 5902.911456328245, 5992.610480318765], "value": 5693.599316410628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.6848534812261, 471.8065593106826, 507.72075358552786, 515.5591968866619, 523.8271370447752, 27011.32471688209, 29774.702252977462, 32521.99999999997, 41115.58884411155, 41282.587174128246, 40412.0, 40948.0, 40957.18085638285, 40967.79516102423, 43028.92427689309, 9280.907190928105, 9458.054194580556, 9466.337356385056, 9467.242620590336, 9472.526373681289, 9163.633454661838, 9168.770780730501, 9258.981512033672, 9274.350795444321, 9363.39137956034, 9318.580663870142, 9364.812703745954, 9375.578098985561, 9387.014363491837, 9387.671431499899, 9278.72163835086, 9318.627254909796, 9337.813243735087, 9356.064393560657, 9364.578593963288, 9381.592761085823, 9462.621495140254, 9482.905170948341, 9483.478408687519, 9486.193673537757, 33898.644054237804, 34317.485237721456, 37738.811305943294, 37741.86774396773, 37831.24337513234, 3032.5299578565136, 3173.2066983254185, 3235.5470234167237, 3354.681305275995, 3561.5370001899587, 27373.863130684418, 27882.721172788217, 29042.27394315138, 30409.783608655627, 30579.23551911198, 3129.342838004022, 3160.4469217886776, 3161.2254997525524, 3201.695838895301, 3270.051685011344, 483470.0, 484662.0, 484746.0, 485134.99999999645, 499120.0, 32446.513302300486, 33316.83341583276, 33376.66623333735, 56174.719126404925, 56743.716281419154, 33601.15997100092, 34004.48993265103, 34060.14849628779, 34061.82969085139, 34064.82967585196, 13722.588322350346, 13847.0, 13850.238236897067, 13871.861281387259, 13871.930640346936, 11656.88343116575, 11753.88246117545, 11754.588589399329, 11759.176857620056, 11762.176647634755, 6567.868642627216, 7591.544507329578, 7627.046619172604, 7669.769906902802, 7689.884651730228, 2798.944021119566, 3138.4350816853184, 3191.69678880506, 3192.5530425740417, 3226.6128064632394, 942.5522876633681, 968.0948313327061, 969.4910172159532, 979.3291595257272, 1020.3214862116757, 27906.581401278996, 28892.277693057422, 29121.7087829119, 29636.962706305178, 29815.40369192604, 847.8007668197969, 870.4429165334191, 944.9952750236205, 1036.388530766836, 1037.5590374090982, 13288.867111328764, 14738.55784326472, 14746.705065898623, 15078.246087695572, 15089.773653395208, 668428.0, 673556.0, 674963.0, 675914.0, 677760.0, 55029.72485137549, 55470.0, 55606.33181004576, 55642.443575563724, 55756.72121639366, 1128.5090985421205, 1211.787937111002, 1251.4994002399112, 1350.9392077356542, 1375.6079517337512, 29413.0, 29773.255668608457, 29990.0, 30324.69675303219, 30755.69244307618, 53684.92630147453, 54830.45169548254, 54969.1754623689, 55080.0, 55084.0, 520586.0, 521884.0, 526090.0, 828834.0, 833975.0, 39460.60539394684, 39995.0, 40121.99695007648, 40233.0, 40477.595224047385, 43835.68492945217, 43992.78003609961, 44080.77959610181, 44209.11581768411, 44344.55655443404, 35345.1163720909, 35873.744418945214, 35935.64064359428, 36342.818285908405, 36994.63005369912, 36050.0, 36357.45463818098, 36394.4540831893, 36525.63474365223, 37340.25319493541, 35599.0, 35985.82007089948, 36481.90554283376, 36527.817360913024, 36874.26251474902, 30319.242018949702, 30774.384512310076, 32726.836365818017, 32808.34383312368, 32904.84833030928, 24210.75789242085, 24286.14998475045, 24419.877900610383, 24787.0, 24916.00335986613], "value": 18102.97528849127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.2296390531067, 368.1716138687952, 371.3594050263296, 379.36077709060237, 399.9100202454448, 11751.70620734481, 15025.549233522997, 15056.548303550911, 20223.292184773534, 20675.172993080298, 19397.806021939778, 20482.795172048274, 20669.689954650694, 20860.89569552154, 21049.789502104974, 4622.976885115578, 5711.742971566289, 5717.514011309044, 5730.656160630355, 5837.5913686041995, 4699.342092107091, 5463.644863083907, 5792.449717276873, 5827.533797296227, 5859.7656093756195, 5683.119116536923, 5684.857878553028, 5713.6000479966415, 5807.128930660392, 5808.722081142142, 5522.171674248874, 5748.19525266463, 5778.017736984722, 5794.072948328248, 5799.043157878945, 4823.686460380064, 5091.719955402451, 5097.5667068299235, 5102.923456148161, 5105.617078719074, 24582.385440363956, 24916.127935522352, 25214.24357269285, 25319.0, 25728.485430291475, 2311.0293676655847, 2374.4894847607848, 2417.286900364397, 2422.7213870404953, 2433.8783060846886, 9783.315167938246, 9823.852642210373, 9954.303198776088, 10213.642522511676, 10337.431441270726, 1792.9282828686967, 1799.3612267644928, 1826.244209378943, 1872.9719054214197, 1940.7088936659613, 97069.51465242628, 118776.0, 121805.39097304545, 124636.0, 134997.0, 9453.52732363379, 11310.60412885545, 11326.15053870963, 11697.415129243504, 11729.120315976335, 14760.852391475948, 14765.483208087666, 14771.852281477048, 14776.48282310114, 14791.408343666133, 6955.61744104069, 8196.631151598192, 8483.490990540588, 8491.0, 8582.699605513777, 8302.128276530877, 8307.293880020145, 8354.540500272544, 8467.280281176047, 8477.915220847835, 4473.1277400907165, 4541.909161816745, 4549.27211646135, 4618.076384723069, 4628.305754136906, 1753.6672129181914, 1780.8510227338463, 1841.5856432302626, 1892.9621407571772, 1901.372547059467, 752.9887051694229, 794.2692722695019, 813.109644938803, 831.846108469935, 889.1952782731638, 20190.596188076157, 21347.25284615031, 21350.0, 21435.0, 21539.78460215409, 871.2986046232717, 921.7326975177258, 948.4262021476907, 951.5717926932908, 954.9570269337758, 10668.093212076905, 11126.054285385671, 11220.66338009861, 11231.887681123084, 11239.100871930226, 584839.0, 585864.0, 587841.0, 601921.0, 609366.0, 123138.0, 127128.0, 128958.0, 128973.0, 129732.0, 939.7509659940122, 989.4854675568664, 1002.6540843408866, 1008.7982403519326, 1010.0656892374524, 13157.0, 18354.816451835846, 19501.414957551297, 20022.299219527828, 20111.899440502704, 51575.9999999985, 54473.18290225571, 54932.0, 55104.448955511536, 57882.13176802436, 57273.42726572681, 75322.24677753371, 76731.0, 77349.0, 81112.0, 3952.6245006724316, 8052.396070294869, 8143.75568732939, 8309.459885107448, 8345.45609062301, 9149.908500915171, 12611.243325400505, 12853.742925141632, 13116.672083197996, 13202.80195797083, 9074.863877041718, 10915.290506117077, 10945.890541094486, 11489.253198542068, 11589.942050289694, 11098.61154859576, 11138.108951283715, 11141.610043648434, 11153.776924461303, 11454.370009649549, 10441.26911116245, 11289.548418063185, 11577.594784182513, 11758.706032348917, 11773.411329433322, 7587.58268295249, 7943.761687149395, 7973.681052757825, 8442.915570844212, 8534.274586659954, 8326.375521835766, 10153.49232538385, 11115.388653624128, 11373.54505819758, 11594.884051159717], "value": 9331.616987451094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.5411895252998, 1492.1345619540668, 1638.6394993101515, 1773.866959978002, 1834.2112891456684, 6431.58194717343, 8022.598870056503, 8471.11053339399, 8492.617832197542, 8695.91304086959, 7428.145763237229, 7658.310752032316, 7677.23227677232, 7988.880166797503, 8226.794330141749, 2309.861408315502, 2353.776391242829, 2355.1639168095335, 2357.8467399619058, 2358.5282943411385, 1844.5388652836791, 2175.1625624134745, 2209.580179765839, 2210.0386331945574, 2218.6561083032157, 2050.097956898967, 2126.5321629241544, 2137.3587923622927, 2267.4218074391006, 2332.3119679694532, 2065.648839697255, 2322.0711715313923, 2337.1936681844736, 2342.8242881783935, 2348.3072493614427, 2327.301809457156, 2345.4019225097663, 2364.692589963294, 2368.6920700309024, 2372.264597974616, 8208.384371172126, 8381.994160700693, 8400.789980250482, 8419.95790021052, 8429.873551896726, 5069.391672999263, 5242.1088414969545, 5247.790088396459, 5250.842474725764, 5254.395744489356, 3323.5180898769786, 3460.3079384123275, 3468.618451970281, 3473.0, 3518.964810351915, 1004.8392257238806, 1058.9099926506256, 1097.4951522299752, 1098.1324753444849, 1101.752105776202, 11048.834267485994, 11049.392283424408, 11062.05972492339, 11063.72340691473, 11077.556897724082, 4233.470816147981, 4325.048489332342, 4724.2205036169335, 4725.763711814396, 4789.832355867528, 9389.718308450758, 9426.340156189139, 9457.810843783085, 9530.380525265835, 9564.426134431957, 4478.708883922534, 5234.659747116501, 5236.607254455931, 5238.083335416287, 5251.317328747238, 3745.3071181830906, 4541.72749635023, 4650.0, 4653.697509661861, 4754.31062495943, 3737.7009839212797, 3843.1545060086737, 3886.7084968627464, 3892.922141557153, 3910.198409326081, 1251.730877861246, 1255.3221260519217, 1256.9308688022247, 1270.2124682696788, 1271.8982481401465, 768.7463137164722, 771.2634434115406, 809.461707964209, 873.5588527793424, 918.3755046568264, 5592.0, 5649.12438572022, 5796.552566140622, 5822.970885145547, 5911.674857882772, 369.2559492622368, 431.6740860650189, 438.44098774063326, 452.0506935435625, 457.1223251357402, 3809.5428548573796, 3814.1036856338737, 3814.48504451901, 3899.5710471848074, 3906.140649057203, 8082.757517274491, 10120.139788118093, 10304.845427318596, 10305.690829274983, 10309.381437113798, 9806.019398060136, 10082.798344033225, 10227.07956283938, 10234.130098941674, 10265.640702575374, 7809.960950195326, 7917.920820791718, 7921.603919803987, 7936.206379362017, 7945.801354966056, 5624.578156638187, 5650.717464126695, 5696.658200507983, 5818.389069147848, 5928.970355148197, 9215.815683686424, 9268.397554158959, 9329.393589416666, 9407.059294070537, 9449.574769135543, 9113.908860911306, 9612.375195612263, 9637.22902167839, 9638.662646807328, 9643.855342169732, 7190.101237345332, 7197.100362454693, 7213.458990575833, 7322.780316590511, 7324.487285889936, 7671.961640191764, 7765.262300081483, 7802.180771018961, 7853.253940875607, 7860.5676687782725, 5657.773689052392, 7012.894806578008, 7061.470389720689, 7151.8569628608175, 7283.271672832886, 6814.4548436124, 6993.2657071006815, 7001.404880585003, 7083.0791997042115, 7155.391791697764, 6691.197056353269, 6705.765298214539, 6707.66461676924, 6768.120144381199, 6786.287439818945, 4765.8093676252565, 4767.356406885165, 4854.95145048545, 4937.777799998937, 5066.695998240118, 4855.616149397405, 4876.756162191805, 4904.313396124474, 4954.281629163823, 4979.302897594267], "value": 4313.104108505598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.3362019506598, 299.0982188701065, 305.79053348456307, 309.7150621428286, 312.8685951900202, 4760.69055511392, 5016.548510634042, 5150.27896094547, 5198.0, 5222.451642577527, 4276.550962148976, 4957.5786058185, 5108.1060814357525, 5112.412072611651, 5145.459726728695, 3661.212839239556, 4009.278329900617, 4026.134381108061, 4040.8585699500522, 4065.959340406602, 4010.157866847951, 4022.7586344819406, 4032.899177520571, 4046.8178931947987, 4080.551139374681, 2810.6205662235643, 3460.878869239577, 4003.158547068352, 4017.5047708493507, 4032.4556184914954, 3995.900102497432, 4016.8995775105564, 4029.113595009108, 4037.4953130858644, 4054.614811592894, 3013.5931649227514, 3476.096214984097, 3503.8598456061727, 3520.0, 3523.5067090607336, 4019.8995025124314, 4261.275583150872, 4635.887387027123, 4895.586781316487, 5123.410807757118, 3892.3966785148345, 4514.435695538058, 4558.247889098295, 4591.966807468293, 4593.862184134481, 5446.863828404282, 5455.863603409907, 5485.149801780691, 5504.752286147133, 5519.39286678465, 3253.5119732040384, 3845.2693988142164, 3847.5575308839284, 3856.5179352580926, 3874.9225015499815, 4667.463241727177, 4761.357216775726, 5652.72813616937, 5737.627054241461, 5743.195952566644, 3484.188222124481, 3895.9222214450833, 3902.2195560887935, 3910.4916360872903, 3914.530256369254, 3960.7227494075137, 3972.64246217836, 3974.5627980922077, 3998.4202290668272, 4004.3192657248337, 3810.447485114643, 3942.901427464279, 4050.2583888928043, 4420.0, 4612.377329060534, 4807.807687692523, 5494.2582751328055, 5520.806771762969, 5528.889422211533, 5540.030494663418, 1129.9435028248554, 1206.5113628980102, 1213.6905089202196, 1248.5630029489787, 1282.2050328796206, 763.7097902796902, 826.8883700700449, 839.7144970709988, 847.7033038436621, 876.3252295732251, 3871.477350557695, 4528.0, 4824.673214865869, 4851.902961940741, 4876.878078048077, 4928.950710492921, 5289.799671198946, 5375.1131063374105, 5383.111786555174, 5393.355026716889, 3853.5761066282685, 4764.760562535603, 4776.617870570346, 4797.4482934462985, 4817.855464336006, 2298.609236429811, 2738.672896823015, 2786.582012698071, 2795.9580606290924, 2801.389201209313, 5369.946300537023, 5398.597624057257, 5399.433059528771, 5400.135978243462, 5450.3732070811575, 4395.0, 4526.615237704832, 5066.594672426197, 5078.97460512695, 5399.00118478075, 4826.372571565674, 4938.975305123451, 5008.799648014112, 5424.50826022839, 5427.864303392446, 4579.839705610288, 4890.975545122252, 5124.948750512447, 5274.074962638686, 5354.973225133849, 4744.810207591796, 4869.342638743724, 5195.610329225247, 5226.97386513065, 5265.921011184759, 4995.775190116527, 5010.494752623688, 5346.385165705838, 5396.568274538106, 5413.808962028347, 3288.5859080595574, 3563.893083207508, 3599.3982677709214, 3694.649008344203, 3698.3342998259495, 4923.8276660316715, 5069.898602027865, 5252.868678283074, 5254.13306804373, 5277.155655095166, 4965.45380008206, 5100.974495127501, 5110.754670784005, 5120.692758434506, 5130.48695130484, 4188.958110418856, 5102.668326558762, 5120.4111527174855, 5133.460986596354, 5147.948520514747, 4755.215389460838, 5000.574721260258, 5007.624428167975, 5032.169692000779, 5037.92443113361, 5208.791648334176, 5365.517103460551, 5376.8118115865755, 5380.76698170255, 5514.91727624094, 5075.720835354091, 5133.281340612392, 5375.661587209576, 5391.353037635352, 5409.729513524387], "value": 3884.7565172295017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.3283214530122, 778.7897267737708, 778.7897267737711, 782.7377828427476, 803.7146812881427, 15626.0, 16198.757018644701, 16245.26896289667, 16247.675046499078, 16768.916155419207, 14818.40726370944, 14979.026363286379, 14982.32579533921, 14988.625284367896, 14992.0, 634.8476365672228, 657.5758635679983, 812.3095368936416, 839.8488272111017, 840.2521755637488, 655.3577494055828, 658.6607896933083, 659.0970370592295, 659.515256286629, 795.7930937956115, 865.6018231613434, 868.1362044765435, 877.5085951866974, 878.7232021913109, 879.3097418526459, 871.6818361298112, 872.4242000279785, 872.5768002518773, 873.5763154869915, 873.724776695339, 497.5944605146794, 508.6032894342419, 647.7214797637014, 649.5712829532533, 652.5953908576713, 13818.0, 14295.78556321656, 14358.425662973468, 14635.853641463662, 14652.853471465256, 13786.93106534471, 13960.58118256454, 13996.0, 14075.366608502642, 14126.0, 10708.839367409495, 10929.726756831064, 11132.61035863749, 11404.31574105548, 11602.12984026193, 3675.2774874321995, 3720.2187540616233, 3766.4538641897047, 3846.365349717293, 3856.9614303856883, 84750.6099756009, 85508.0, 85895.57052214698, 86090.13909860884, 86486.0, 10632.574697012187, 10679.563194985052, 10775.407352595526, 10820.837687434694, 10863.782724345627, 21077.473063173544, 21103.9448027598, 21121.471963200736, 21306.573868522853, 21386.572268554854, 7323.780286591411, 7686.269804368576, 7903.56530390834, 7922.564258965812, 7960.920390796018, 4046.5346485153996, 4163.75017498951, 4223.450951376301, 4335.761533115646, 4347.695661303742, 3391.5082313064468, 3500.387432199355, 3500.754947153726, 3501.8949431517094, 3670.9082272942856, 692.1140939597324, 695.3220609905403, 695.7043256615918, 698.4028655499475, 710.7121615745631, 558.7569407307834, 565.2453973944747, 637.3435361577582, 638.7732355013903, 666.7966270287512, 8871.379003469696, 9041.276697864156, 9046.457212567268, 9062.203347489383, 9504.90495095054, 630.3066626710673, 630.7045686289102, 633.7591715148214, 658.4699317049821, 660.9845190467831, 4221.303484924953, 4482.618977386894, 4485.237509623372, 4495.073280609645, 4584.1977653910435, 78079.0, 97029.0, 114121.85878141112, 121814.3909280448, 122992.0, 81866.59066704629, 101542.49228753809, 103514.0, 103619.0, 108452.4577377108, 90259.09740902638, 91580.54209728909, 91863.0, 92262.15475690314, 94983.0501694988, 7652.464327497022, 8585.8712119317, 8780.560971951249, 8851.601677924638, 8866.069062748576, 53398.73300633472, 57231.71384143052, 58395.0, 58945.410545895706, 60872.69563652154, 79199.60400198192, 79831.0, 83401.58299208464, 83958.58020709857, 86653.13346866451, 10373.273870828969, 11273.661790145981, 11447.141464390037, 12024.639260822189, 12193.451294691582, 12100.213486123374, 12103.455344509342, 12332.445039973401, 12340.95101916347, 12403.441845116811, 11004.724881878017, 11641.6507504775, 11753.882461175279, 11865.703357416134, 12168.756624867276, 11052.778944421227, 11372.20394572372, 11706.824397633873, 11822.881771182178, 12053.457594408097, 10815.783684326427, 11261.0, 11824.881751182378, 11937.28376297425, 12121.090918181348, 8999.955000224956, 9829.459379734184, 10057.24570657189, 10073.19414446857, 10268.58925642966, 8556.855506931579, 9972.088051310695, 10088.19294456427, 10090.16745384284, 10124.240681948737], "value": 7217.4175728612945, "unit": "score"}], "name": "dromaeo_css", "value": 6986.816012351146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 110.0, 146.0, 114.0, 110.0, 109.0, 117.0, 177.0, 139.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 187.0, 182.0, 183.0, 182.0, 185.0, 186.0, 186.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 58.0, 90.0, 62.0, 58.0, 59.0, 58.0, 82.0, 73.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 95.0, 70.0, 68.0, 69.0, 92.0, 68.0, 69.0, 94.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 129.0, 91.0, 86.0, 89.0, 87.0, 90.0, 87.0, 90.0, 86.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 98.0, 99.0, 101.0, 98.0, 99.0, 99.0, 100.0, 97.0, 100.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 79.0, 81.0, 81.0, 85.0, 83.0, 77.0, 120.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 53.0, 58.0, 56.0, 58.0, 57.0, 58.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 83.0, 76.0, 75.0, 73.0, 73.0, 72.0, 71.0, 73.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 93.0, 99.0, 99.0, 82.0, 82.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 153.0, 158.0, 129.0, 144.0, 157.0, 157.0, 159.0, 183.0, 153.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 170.0, 167.0, 167.0, 166.0, 166.0, 165.0, 166.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 73.0, 86.0, 89.0, 86.0, 73.0, 67.0, 67.0, 66.0, 66.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1467.2000000000003, "alertThreshold": 2.0}]} 10:44:14 INFO - Return code: 0 10:44:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:44:14 INFO - # TBPL SUCCESS # 10:44:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:44:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:44:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:44:14 INFO - 2017-01-03 10:44:14.816 screenresolution[2195:25000] starting screenresolution argv=screenresolution get 10:44:14 INFO - 2017-01-03 10:44:14.819 screenresolution[2195:25000] Display 0: 1600x1200x32@60 10:44:14 INFO - 2017-01-03 10:44:14.825 screenresolution[2196:25004] starting screenresolution argv=screenresolution list 10:44:14 INFO - Available Modes on Display 0 10:44:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:44:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:44:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:44:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:44:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:44:15 INFO - Intel Iris: 10:44:15 INFO - Chipset Model: Intel Iris 10:44:15 INFO - Type: GPU 10:44:15 INFO - Bus: Built-In 10:44:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:44:15 INFO - Vendor: Intel (0x8086) 10:44:15 INFO - Device ID: 0x0a2e 10:44:15 INFO - Revision ID: 0x0009 10:44:15 INFO - Displays: 10:44:15 INFO - Display: 10:44:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:44:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:44:15 INFO - Display Serial Number: 1600x1200 60 10:44:15 INFO - Main Display: Yes 10:44:15 INFO - Mirror: Off 10:44:15 INFO - Online: Yes 10:44:15 INFO - Rotation: Supported 10:44:15 INFO - Return code: 0 10:44:15 INFO - Running post-action listener: _resource_record_post_action 10:44:15 INFO - [mozharness: 2017-01-03 18:44:15.069978Z] Finished run-tests step (success) 10:44:15 INFO - Running post-run listener: _resource_record_post_run 10:44:15 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 299008; Write bytes: 657637888; Read time: 5; Write time: 1807 10:44:15 INFO - TinderboxPrint: CPU usage
53.4% 10:44:15 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 5 10:44:15 INFO - TinderboxPrint: I/O write bytes / time
657,637,888 / 1,807 10:44:15 INFO - TinderboxPrint: CPU idle
2,258.0 (46.6%) 10:44:15 INFO - TinderboxPrint: CPU system
971.8 (20.0%) 10:44:15 INFO - TinderboxPrint: CPU user
1,619.8 (33.4%) 10:44:15 INFO - TinderboxPrint: Swap in / out
348,770,304 / 0 10:44:15 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 340580864; Write bytes: 335169024; Read time: 26648; Write time: 637 10:44:15 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 299008; Write bytes: 305822720; Read time: 5; Write time: 1118 10:44:15 INFO - Running post-run listener: _upload_blobber_files 10:44:15 INFO - Blob upload gear active. 10:44:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:44:15 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 10:44:15 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:44:15 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:44:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:44:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:44:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:44:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:16 INFO - (blobuploader) - INFO - Done attempting. 10:44:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:44:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:44:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:17 INFO - (blobuploader) - INFO - Done attempting. 10:44:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:44:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:44:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:19 INFO - (blobuploader) - INFO - Done attempting. 10:44:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:44:19 INFO - Return code: 0 10:44:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:44:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:44:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9a9fec82362121a06cc86a30558e88829192afc13b830e9f2809d3166c2cada66d63c1df27be238ab5587aa779556b8a1eaa8543a6f10299821a354f833a27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c4132b3650baddf0f6ff3f5668c549c1f6a5da1e8150680f4a296a31e1191175ab0fd02e27470725acae81e8cbedea14c6936c5c02ce5310458e68b690666f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee0e3753b4bd6ad386632276592570f5a11591d6c6dcc2f5bd037cdbaff1a397a4c35d5b294e51ca8b9ca087e856e9725bad38c9e846e09b3b3d2aff58ea9e9"} 10:44:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:44:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:44:19 INFO - Contents: 10:44:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9a9fec82362121a06cc86a30558e88829192afc13b830e9f2809d3166c2cada66d63c1df27be238ab5587aa779556b8a1eaa8543a6f10299821a354f833a27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c4132b3650baddf0f6ff3f5668c549c1f6a5da1e8150680f4a296a31e1191175ab0fd02e27470725acae81e8cbedea14c6936c5c02ce5310458e68b690666f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee0e3753b4bd6ad386632276592570f5a11591d6c6dcc2f5bd037cdbaff1a397a4c35d5b294e51ca8b9ca087e856e9725bad38c9e846e09b3b3d2aff58ea9e9"} 10:44:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:44:19 INFO - Copying logs to upload dir... 10:44:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:44:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.154694 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-03 10:44:20.002335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:20.006290) ========= 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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/Mozilla-Aurora/sha512/0e9a9fec82362121a06cc86a30558e88829192afc13b830e9f2809d3166c2cada66d63c1df27be238ab5587aa779556b8a1eaa8543a6f10299821a354f833a27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c4132b3650baddf0f6ff3f5668c549c1f6a5da1e8150680f4a296a31e1191175ab0fd02e27470725acae81e8cbedea14c6936c5c02ce5310458e68b690666f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee0e3753b4bd6ad386632276592570f5a11591d6c6dcc2f5bd037cdbaff1a397a4c35d5b294e51ca8b9ca087e856e9725bad38c9e846e09b3b3d2aff58ea9e9"} build_url:https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9a9fec82362121a06cc86a30558e88829192afc13b830e9f2809d3166c2cada66d63c1df27be238ab5587aa779556b8a1eaa8543a6f10299821a354f833a27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c4132b3650baddf0f6ff3f5668c549c1f6a5da1e8150680f4a296a31e1191175ab0fd02e27470725acae81e8cbedea14c6936c5c02ce5310458e68b690666f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ee0e3753b4bd6ad386632276592570f5a11591d6c6dcc2f5bd037cdbaff1a397a4c35d5b294e51ca8b9ca087e856e9725bad38c9e846e09b3b3d2aff58ea9e9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:20.046997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:20.047578) ========= 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.rJCxv36ZSC/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.DCW1HGdU7U/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005148 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:20.098210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 10:44:20.098609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 10:44:20.098957) ========= ========= Total master_lag: 0.21 =========