builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0366 starttime: 1492533595.98 results: success (0) buildid: 20170418075121 builduid: a1f8cc69819c4f29bebc9fbcca2a4ef2 revision: 722fdbff1efc308a22060e75b603311d23541bb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:55.983974) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:55.984453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:55.984736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:56.009739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:56.010131) ========= 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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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-04-18 09:39:56-- 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% 12.1M=0.001s 2017-04-18 09:39:56 (12.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:56.161586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:56.161978) ========= 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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.021326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:56.211437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 09:39:56.211812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 722fdbff1efc308a22060e75b603311d23541bb5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 722fdbff1efc308a22060e75b603311d23541bb5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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-04-18 09:39:56,307 truncating revision to first 12 chars 2017-04-18 09:39:56,307 Setting DEBUG logging. 2017-04-18 09:39:56,307 attempt 1/10 2017-04-18 09:39:56,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/722fdbff1efc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 09:39:57,304 unpacking tar archive at: mozilla-central-722fdbff1efc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263796 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 09:39:57.548181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:57.548597) ========= script_repo_revision: 722fdbff1efc308a22060e75b603311d23541bb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:57.549192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:57.549487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 09:39:57.570785) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-18 09:39:57.571197) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:39:57 INFO - MultiFileLogger online at 20170418 09:39:57 in /builds/slave/test 09:39:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:39:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:57 INFO - {'append_to_log': False, 09:39:57 INFO - 'base_work_dir': '/builds/slave/test', 09:39:57 INFO - 'blob_upload_branch': 'Firefox', 09:39:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:57 INFO - 'branch': 'Firefox', 09:39:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:57 INFO - 'config_files': ('talos/mac_config.py',), 09:39:57 INFO - 'default_actions': ('clobber', 09:39:57 INFO - 'read-buildbot-config', 09:39:57 INFO - 'download-and-extract', 09:39:57 INFO - 'populate-webroot', 09:39:57 INFO - 'create-virtualenv', 09:39:57 INFO - 'install', 09:39:57 INFO - 'run-tests'), 09:39:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:57 INFO - 'download_minidump_stackwalk': True, 09:39:57 INFO - 'download_symbols': 'ondemand', 09:39:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:57 INFO - 'gecko_profile': False, 09:39:57 INFO - 'gecko_profile_interval': 0, 09:39:57 INFO - 'installer_path': 'installer.exe', 09:39:57 INFO - 'log_level': 'info', 09:39:57 INFO - 'log_name': 'talos', 09:39:57 INFO - 'log_to_console': True, 09:39:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:39:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:39:57 INFO - 'opt_config_files': (), 09:39:57 INFO - 'pip_index': False, 09:39:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:57 INFO - 'cmd': ('bash', 09:39:57 INFO - '-c', 09:39:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:57 INFO - 'enabled': True, 09:39:57 INFO - 'halt_on_failure': False, 09:39:57 INFO - 'name': 'check_screen_resolution'},), 09:39:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:57 INFO - 'cmd': ('bash', 09:39:57 INFO - '-c', 09:39:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:57 INFO - 'enabled': True, 09:39:57 INFO - 'halt_on_failure': False, 09:39:57 INFO - 'name': 'check_screen_resolution'},), 09:39:57 INFO - 'run_cmd_checks_enabled': True, 09:39:57 INFO - 'suite': 'dromaeojs', 09:39:57 INFO - 'system_bits': '32', 09:39:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:57 INFO - 'title': 't-yosemite-r7-0366', 09:39:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:57 INFO - 'use_talos_json': True, 09:39:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:57 INFO - 'work_dir': 'build'} 09:39:57 INFO - [mozharness: 2017-04-18 16:39:57.782284Z] Running clobber step. 09:39:57 INFO - Running pre-action listener: _resource_record_pre_action 09:39:57 INFO - Running main action method: clobber 09:39:57 INFO - rmtree: /builds/slave/test/build 09:39:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:57 INFO - Running post-action listener: _resource_record_post_action 09:39:57 INFO - [mozharness: 2017-04-18 16:39:57.946294Z] Finished clobber step (success) 09:39:57 INFO - [mozharness: 2017-04-18 16:39:57.946457Z] Running read-buildbot-config step. 09:39:57 INFO - Running pre-action listener: _resource_record_pre_action 09:39:57 INFO - Running main action method: read_buildbot_config 09:39:57 INFO - Using buildbot properties: 09:39:57 INFO - { 09:39:57 INFO - "project": "", 09:39:57 INFO - "product": "firefox", 09:39:57 INFO - "script_repo_revision": "production", 09:39:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:39:57 INFO - "repository": "", 09:39:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:39:57 INFO - "buildid": "20170418075121", 09:39:57 INFO - "pgo_build": "False", 09:39:57 INFO - "basedir": "/builds/slave/test", 09:39:57 INFO - "buildnumber": 19, 09:39:57 INFO - "slavename": "t-yosemite-r7-0366", 09:39:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:39:57 INFO - "platform": "yosemite_r7", 09:39:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:39:57 INFO - "branch": "mozilla-central", 09:39:57 INFO - "repo_path": "mozilla-central", 09:39:57 INFO - "revision": "722fdbff1efc308a22060e75b603311d23541bb5", 09:39:57 INFO - "stage_platform": "macosx64", 09:39:57 INFO - "builduid": "a1f8cc69819c4f29bebc9fbcca2a4ef2", 09:39:57 INFO - "slavebuilddir": "test" 09:39:57 INFO - } 09:39:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:39:57 INFO - Running post-action listener: _resource_record_post_action 09:39:57 INFO - [mozharness: 2017-04-18 16:39:57.950072Z] Finished read-buildbot-config step (success) 09:39:57 INFO - [mozharness: 2017-04-18 16:39:57.950192Z] Running download-and-extract step. 09:39:57 INFO - Running pre-action listener: _resource_record_pre_action 09:39:57 INFO - Running main action method: download_and_extract 09:39:57 INFO - mkdir: /builds/slave/test/build/tests 09:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:57 INFO - trying https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:39:57 INFO - Downloading https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:39:59 INFO - Downloaded 1325 bytes. 09:39:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:39:59 INFO - Using the following test package requirements: 09:39:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:39:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:39:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:39:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:39:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'jsshell-mac.zip'], 09:39:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:39:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:39:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:39:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:39:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:39:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:39:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:39:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:39:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:39:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:39:59 INFO - Fetch https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:40:01 INFO - Expected file size: 52631927 09:40:01 INFO - Obtained file size: 52631927 09:40:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:40:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:40:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:40:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:40:19 INFO - Expected file size: 52631927 09:40:19 INFO - Obtained file size: 52631927 09:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:40:35 INFO - Expected file size: 14408802 09:40:35 INFO - Obtained file size: 14408802 09:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:36 INFO - trying https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:40:36 INFO - Downloading https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:40:38 INFO - Downloaded 71390474 bytes. 09:40:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:40:38 INFO - mkdir: /builds/slave/test/properties 09:40:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:38 INFO - Contents: 09:40:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:40:38 INFO - Running post-action listener: _resource_record_post_action 09:40:38 INFO - Running post-action listener: set_extra_try_arguments 09:40:38 INFO - [mozharness: 2017-04-18 16:40:38.856245Z] Finished download-and-extract step (success) 09:40:38 INFO - [mozharness: 2017-04-18 16:40:38.856369Z] Running populate-webroot step. 09:40:38 INFO - Running pre-action listener: _resource_record_pre_action 09:40:38 INFO - Running main action method: populate_webroot 09:40:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:38 INFO - '--tppagecycles', 09:40:38 INFO - '7'], 09:40:38 INFO - 'tests': ['tsvgm']}}, 09:40:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:40:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:40:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:40:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['damp', 'tps']}, 09:40:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'tests': ['damp', 'tps']}, 09:40:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['dromaeo_dom']}, 09:40:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:40:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:40:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['a11yr', 09:40:38 INFO - 'ts_paint', 09:40:38 INFO - 'tpaint', 09:40:38 INFO - 'sessionrestore', 09:40:38 INFO - 'sessionrestore_no_auto_restore', 09:40:38 INFO - 'tabpaint']}, 09:40:38 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:40:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:40:38 INFO - 'bloom_basic_ref']}, 09:40:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['tsvgx', 09:40:38 INFO - 'tsvgr_opacity', 09:40:38 INFO - 'tart', 09:40:38 INFO - 'tscrollx', 09:40:38 INFO - 'cart', 09:40:38 INFO - 'tsvg_static']}, 09:40:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:40:38 INFO - 'tsvgr_opacity', 09:40:38 INFO - 'tart', 09:40:38 INFO - 'tscrollx', 09:40:38 INFO - 'cart', 09:40:38 INFO - 'tsvg_static']}, 09:40:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'talos_options': ['--disable-e10s'], 09:40:38 INFO - 'tests': ['tp5o']}, 09:40:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:40:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'talos_options': ['--disable-e10s', 09:40:38 INFO - '--xperf_path', 09:40:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:38 INFO - 'tests': ['tp5n']}, 09:40:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:40:38 INFO - 'talos_options': ['--xperf_path', 09:40:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:38 INFO - 'tests': ['tp5n']}}, 09:40:38 INFO - 'talos.zip': {'path': '', 09:40:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:38 INFO - Running post-action listener: _resource_record_post_action 09:40:38 INFO - [mozharness: 2017-04-18 16:40:38.875895Z] Finished populate-webroot step (success) 09:40:38 INFO - [mozharness: 2017-04-18 16:40:38.876034Z] Running create-virtualenv step. 09:40:38 INFO - Running pre-action listener: _resource_record_pre_action 09:40:38 INFO - Running main action method: create_virtualenv 09:40:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:40:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:38 INFO - Using real prefix '/tools/python27' 09:40:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:42 INFO - Installing pip.................done. 09:40:42 INFO - Return code: 0 09:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:40:42 INFO - Reading from file tmpfile_stdout 09:40:42 INFO - Output received: 09:40:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:40:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:42 INFO - 'HOME': '/Users/cltbld', 09:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:42 INFO - 'LOGNAME': 'cltbld', 09:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:42 INFO - 'MOZ_NO_REMOTE': '1', 09:40:42 INFO - 'NO_EM_RESTART': '1', 09:40:42 INFO - 'PAGER': '/bin/cat', 09:40:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:42 INFO - 'PWD': '/builds/slave/test', 09:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:42 INFO - 'SHELL': '/bin/bash', 09:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:42 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:42 INFO - 'USER': 'cltbld', 09:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:42 INFO - 'XPC_FLAGS': '0x0', 09:40:42 INFO - 'XPC_SERVICE_NAME': '0', 09:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:40:43 INFO - Cleaning up... 09:40:43 INFO - Return code: 0 09:40:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:43 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:43 INFO - 'HOME': '/Users/cltbld', 09:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:43 INFO - 'LOGNAME': 'cltbld', 09:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:43 INFO - 'MOZ_NO_REMOTE': '1', 09:40:43 INFO - 'NO_EM_RESTART': '1', 09:40:43 INFO - 'PAGER': '/bin/cat', 09:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:43 INFO - 'PWD': '/builds/slave/test', 09:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:43 INFO - 'SHELL': '/bin/bash', 09:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:43 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:43 INFO - 'USER': 'cltbld', 09:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:43 INFO - 'XPC_FLAGS': '0x0', 09:40:43 INFO - 'XPC_SERVICE_NAME': '0', 09:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:43 INFO - Downloading/unpacking psutil>=3.1.1 09:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:47 INFO - Installing collected packages: psutil 09:40:47 INFO - Running setup.py install for psutil 09:40:47 INFO - building 'psutil._psutil_osx' extension 09:40:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:40:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:40:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:40:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:40:47 INFO - building 'psutil._psutil_posix' extension 09:40:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:40:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:40:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:40:47 INFO - ^ 09:40:47 INFO - 1 warning generated. 09:40:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:47 INFO - Successfully installed psutil 09:40:47 INFO - Cleaning up... 09:40:47 INFO - Return code: 0 09:40:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:47 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:40:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:47 INFO - 'HOME': '/Users/cltbld', 09:40:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:47 INFO - 'LOGNAME': 'cltbld', 09:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:47 INFO - 'MOZ_NO_REMOTE': '1', 09:40:47 INFO - 'NO_EM_RESTART': '1', 09:40:47 INFO - 'PAGER': '/bin/cat', 09:40:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:47 INFO - 'PWD': '/builds/slave/test', 09:40:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:47 INFO - 'SHELL': '/bin/bash', 09:40:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:47 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:47 INFO - 'USER': 'cltbld', 09:40:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:47 INFO - 'XPC_FLAGS': '0x0', 09:40:47 INFO - 'XPC_SERVICE_NAME': '0', 09:40:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:50 INFO - Installing collected packages: mozsystemmonitor 09:40:50 INFO - Running setup.py install for mozsystemmonitor 09:40:51 INFO - Successfully installed mozsystemmonitor 09:40:51 INFO - Cleaning up... 09:40:51 INFO - Return code: 0 09:40:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:51 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:40:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:51 INFO - 'HOME': '/Users/cltbld', 09:40:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:51 INFO - 'LOGNAME': 'cltbld', 09:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:51 INFO - 'MOZ_NO_REMOTE': '1', 09:40:51 INFO - 'NO_EM_RESTART': '1', 09:40:51 INFO - 'PAGER': '/bin/cat', 09:40:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:51 INFO - 'PWD': '/builds/slave/test', 09:40:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:51 INFO - 'SHELL': '/bin/bash', 09:40:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:51 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:51 INFO - 'USER': 'cltbld', 09:40:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:51 INFO - 'XPC_FLAGS': '0x0', 09:40:51 INFO - 'XPC_SERVICE_NAME': '0', 09:40:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:52 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:55 INFO - warning: no files found matching '*.txt' 09:40:55 INFO - no previously-included directories found matching 'build' 09:40:55 INFO - no previously-included directories found matching 'dist' 09:40:55 INFO - no previously-included directories found matching '.git*' 09:40:55 INFO - Installing collected packages: jsonschema, functools32 09:40:55 INFO - Running setup.py install for functools32 09:40:55 INFO - warning: no files found matching '*.txt' 09:40:55 INFO - no previously-included directories found matching 'build' 09:40:55 INFO - no previously-included directories found matching 'dist' 09:40:55 INFO - no previously-included directories found matching '.git*' 09:40:55 INFO - Successfully installed jsonschema functools32 09:40:55 INFO - Cleaning up... 09:40:55 INFO - Return code: 0 09:40:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:55 INFO - 'HOME': '/Users/cltbld', 09:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:55 INFO - 'LOGNAME': 'cltbld', 09:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:55 INFO - 'MOZ_NO_REMOTE': '1', 09:40:55 INFO - 'NO_EM_RESTART': '1', 09:40:55 INFO - 'PAGER': '/bin/cat', 09:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:55 INFO - 'PWD': '/builds/slave/test', 09:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:55 INFO - 'SHELL': '/bin/bash', 09:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:55 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:55 INFO - 'USER': 'cltbld', 09:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:55 INFO - 'XPC_FLAGS': '0x0', 09:40:55 INFO - 'XPC_SERVICE_NAME': '0', 09:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:56 INFO - Cleaning up... 09:40:56 INFO - Return code: 0 09:40:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:56 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:56 INFO - 'HOME': '/Users/cltbld', 09:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:56 INFO - 'LOGNAME': 'cltbld', 09:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:56 INFO - 'MOZ_NO_REMOTE': '1', 09:40:56 INFO - 'NO_EM_RESTART': '1', 09:40:56 INFO - 'PAGER': '/bin/cat', 09:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:56 INFO - 'PWD': '/builds/slave/test', 09:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:56 INFO - 'SHELL': '/bin/bash', 09:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:40:56 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:56 INFO - 'USER': 'cltbld', 09:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:56 INFO - 'XPC_FLAGS': '0x0', 09:40:56 INFO - 'XPC_SERVICE_NAME': '0', 09:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:00 INFO - Downloading docopt-0.6.1.tar.gz 09:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:41:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:41:00 INFO - Running setup.py install for blobuploader 09:41:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:41:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:41:00 INFO - Running setup.py install for requests 09:41:01 INFO - Running setup.py install for docopt 09:41:01 INFO - Successfully installed blobuploader requests docopt 09:41:01 INFO - Cleaning up... 09:41:01 INFO - Return code: 0 09:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41: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')]} 09:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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')]} 09:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:01 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:01 INFO - 'HOME': '/Users/cltbld', 09:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:01 INFO - 'LOGNAME': 'cltbld', 09:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:01 INFO - 'MOZ_NO_REMOTE': '1', 09:41:01 INFO - 'NO_EM_RESTART': '1', 09:41:01 INFO - 'PAGER': '/bin/cat', 09:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:01 INFO - 'PWD': '/builds/slave/test', 09:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:01 INFO - 'SHELL': '/bin/bash', 09:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:41:01 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:01 INFO - 'USER': 'cltbld', 09:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:01 INFO - 'XPC_FLAGS': '0x0', 09:41:01 INFO - 'XPC_SERVICE_NAME': '0', 09:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:01 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0iryve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:01 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-hQ6efu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:01 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Ne4g1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:01 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-qWZ4pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:01 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-ixqJR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-al6e9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-r2fHuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0OKwLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-wTv_qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-DazG97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Cgjdsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-JrpJxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Y8DQ_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-jnlxE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:02 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-7xLPwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:03 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-6gXX2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:03 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-mniLUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:41:03 INFO - Running setup.py install for manifestparser 09:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:41:03 INFO - Running setup.py install for mozcrash 09:41:03 INFO - Running setup.py install for mozdebug 09:41:03 INFO - Running setup.py install for mozdevice 09:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:41:03 INFO - Running setup.py install for mozfile 09:41:04 INFO - Running setup.py install for mozhttpd 09:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozinfo 09:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozInstall 09:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozleak 09:41:04 INFO - Running setup.py install for mozlog 09:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for moznetwork 09:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozprocess 09:41:05 INFO - Running setup.py install for mozprofile 09:41:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozrunner 09:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozscreenshot 09:41:05 INFO - Running setup.py install for moztest 09:41:05 INFO - Running setup.py install for mozversion 09:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:05 INFO - Cleaning up... 09:41:05 INFO - Return code: 0 09:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:05 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:05 INFO - 'HOME': '/Users/cltbld', 09:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:05 INFO - 'LOGNAME': 'cltbld', 09:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:05 INFO - 'MOZ_NO_REMOTE': '1', 09:41:05 INFO - 'NO_EM_RESTART': '1', 09:41:05 INFO - 'PAGER': '/bin/cat', 09:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:05 INFO - 'PWD': '/builds/slave/test', 09:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:05 INFO - 'SHELL': '/bin/bash', 09:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:41:05 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:05 INFO - 'USER': 'cltbld', 09:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:05 INFO - 'XPC_FLAGS': '0x0', 09:41:05 INFO - 'XPC_SERVICE_NAME': '0', 09:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-KTGGvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-fZfgio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Y4Mpwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-RsO3Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-6IXERR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-kf8xe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-8Q4cVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0gxSeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:06 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-wtJNnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-vo5PG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-vaGDkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-u6MNBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-krFYyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-v1RVgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-PTT2Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Aptm9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:07 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-9lCAgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:41:07 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:07 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:10 INFO - Downloading blessings-1.6.tar.gz 09:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:41:10 INFO - Installing collected packages: blessings 09:41:10 INFO - Running setup.py install for blessings 09:41:10 INFO - Successfully installed blessings 09:41:10 INFO - Cleaning up... 09:41:10 INFO - Return code: 0 09:41:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:11 INFO - Reading from file tmpfile_stdout 09:41:11 INFO - Current package versions: 09:41:11 INFO - blessings == 1.6 09:41:11 INFO - blobuploader == 1.2.4 09:41:11 INFO - docopt == 0.6.1 09:41:11 INFO - functools32 == 3.2.3-2 09:41:11 INFO - jsonschema == 2.5.1 09:41:11 INFO - manifestparser == 1.1 09:41:11 INFO - mozInstall == 1.12 09:41:11 INFO - mozcrash == 1.0 09:41:11 INFO - mozdebug == 0.1 09:41:11 INFO - mozdevice == 0.50 09:41:11 INFO - mozfile == 1.2 09:41:11 INFO - mozhttpd == 0.7 09:41:11 INFO - mozinfo == 0.9 09:41:11 INFO - mozleak == 0.1 09:41:11 INFO - mozlog == 3.4 09:41:11 INFO - moznetwork == 0.27 09:41:11 INFO - mozprocess == 0.25 09:41:11 INFO - mozprofile == 0.28 09:41:11 INFO - mozrunner == 6.13 09:41:11 INFO - mozscreenshot == 0.1 09:41:11 INFO - mozsystemmonitor == 0.3 09:41:11 INFO - moztest == 0.8 09:41:11 INFO - mozversion == 1.4 09:41:11 INFO - psutil == 3.1.1 09:41:11 INFO - requests == 1.2.3 09:41:11 INFO - wsgiref == 0.1.2 09:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:11 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:11 INFO - 'HOME': '/Users/cltbld', 09:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:11 INFO - 'LOGNAME': 'cltbld', 09:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:11 INFO - 'MOZ_NO_REMOTE': '1', 09:41:11 INFO - 'NO_EM_RESTART': '1', 09:41:11 INFO - 'PAGER': '/bin/cat', 09:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:11 INFO - 'PWD': '/builds/slave/test', 09:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:11 INFO - 'SHELL': '/bin/bash', 09:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:41:11 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:11 INFO - 'USER': 'cltbld', 09:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:11 INFO - 'XPC_FLAGS': '0x0', 09:41:11 INFO - 'XPC_SERVICE_NAME': '0', 09:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:41:11 INFO - Cleaning up... 09:41:11 INFO - Return code: 0 09:41:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:11 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 0x10c95cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c95f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce29d83a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, '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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:11 INFO - 'HOME': '/Users/cltbld', 09:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:11 INFO - 'LOGNAME': 'cltbld', 09:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:11 INFO - 'MOZ_NO_REMOTE': '1', 09:41:11 INFO - 'NO_EM_RESTART': '1', 09:41:11 INFO - 'PAGER': '/bin/cat', 09:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:11 INFO - 'PWD': '/builds/slave/test', 09:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:11 INFO - 'SHELL': '/bin/bash', 09:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:41:11 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:11 INFO - 'USER': 'cltbld', 09:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:11 INFO - 'XPC_FLAGS': '0x0', 09:41:11 INFO - 'XPC_SERVICE_NAME': '0', 09:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:41:11 INFO - Cleaning up... 09:41:11 INFO - Return code: 0 09:41:11 INFO - Running post-action listener: _resource_record_post_action 09:41:11 INFO - Running post-action listener: _start_resource_monitoring 09:41:11 INFO - Starting resource monitoring. 09:41:11 INFO - [mozharness: 2017-04-18 16:41:11.738151Z] Finished create-virtualenv step (success) 09:41:11 INFO - [mozharness: 2017-04-18 16:41:11.739099Z] Running install step. 09:41:11 INFO - Running pre-action listener: _resource_record_pre_action 09:41:11 INFO - Running main action method: install 09:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:11 INFO - Reading from file tmpfile_stdout 09:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:41:12 INFO - Reading from file tmpfile_stdout 09:41:12 INFO - Output received: 09:41:12 INFO - Usage: mozinstall [options] installer 09:41:12 INFO - Options: 09:41:12 INFO - -h, --help show this help message and exit 09:41:12 INFO - -d DEST, --destination=DEST 09:41:12 INFO - Directory to install application into. [default: 09:41:12 INFO - "/builds/slave/test"] 09:41:12 INFO - --app=APP Application being installed. [default: firefox] 09:41:12 INFO - mkdir: /builds/slave/test/build/application 09:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:41:31 INFO - Reading from file tmpfile_stdout 09:41:31 INFO - Output received: 09:41:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:41:31 INFO - Running post-action listener: _resource_record_post_action 09:41:31 INFO - [mozharness: 2017-04-18 16:41:31.975318Z] Finished install step (success) 09:41:31 INFO - [mozharness: 2017-04-18 16:41:31.975452Z] Running run-tests step. 09:41:31 INFO - Running pre-action listener: _resource_record_pre_action 09:41:31 INFO - Running main action method: run_tests 09:41:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:31 INFO - 2017-04-18 09:41:31.990 screenresolution[2636:31684] starting screenresolution argv=screenresolution get 09:41:31 INFO - 2017-04-18 09:41:31.992 screenresolution[2636:31684] Display 0: 1600x1200x32@60 09:41:31 INFO - 2017-04-18 09:41:31.998 screenresolution[2637:31687] starting screenresolution argv=screenresolution list 09:41:32 INFO - Available Modes on Display 0 09:41:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:32 INFO - Intel Iris: 09:41:32 INFO - Chipset Model: Intel Iris 09:41:32 INFO - Type: GPU 09:41:32 INFO - Bus: Built-In 09:41:32 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:32 INFO - Vendor: Intel (0x8086) 09:41:32 INFO - Device ID: 0x0a2e 09:41:32 INFO - Revision ID: 0x0009 09:41:32 INFO - Displays: 09:41:32 INFO - Display: 09:41:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:32 INFO - Display Serial Number: 1600x1200 60 09:41:32 INFO - Main Display: Yes 09:41:32 INFO - Mirror: Off 09:41:32 INFO - Online: Yes 09:41:32 INFO - Rotation: Supported 09:41:32 INFO - Return code: 0 09:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:41:32 INFO - Python 2.7.3 09:41:32 INFO - Return code: 0 09:41:32 INFO - grabbing minidump binary from tooltool 09:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:32 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 0x10c73ad30>, '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 0x10c660db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c72fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:41:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:41:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:41:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:41:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:41:32 INFO - Return code: 0 09:41:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:41:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:41:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:41:32 INFO - ENV: RUST_BACKTRACE is now 1 09:41:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:41:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0366 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OrcGDZUvx/Render', 09:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:32 INFO - 'HOME': '/Users/cltbld', 09:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:32 INFO - 'LOGNAME': 'cltbld', 09:41:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:41:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:32 INFO - 'MOZ_NO_REMOTE': '1', 09:41:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:41:32 INFO - 'NO_EM_RESTART': '1', 09:41:32 INFO - 'PAGER': '/bin/cat', 09:41:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:32 INFO - 'PWD': '/builds/slave/test', 09:41:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:32 INFO - 'RUST_BACKTRACE': '1', 09:41:32 INFO - 'SHELL': '/bin/bash', 09:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Sp6pYxqBy/Listeners', 09:41:32 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 09:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:32 INFO - 'USER': 'cltbld', 09:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:32 INFO - 'XPC_FLAGS': '0x0', 09:41:32 INFO - 'XPC_SERVICE_NAME': '0', 09:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:41:32 INFO - mozversion application_buildid: 20170418075121 09:41:32 INFO - mozversion application_changeset: 722fdbff1efc308a22060e75b603311d23541bb5 09:41:32 INFO - mozversion application_display_name: Nightly 09:41:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:41:32 INFO - mozversion application_name: Firefox 09:41:32 INFO - mozversion application_remotingname: firefox 09:41:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:41:32 INFO - mozversion application_vendor: Mozilla 09:41:32 INFO - mozversion application_version: 55.0a1 09:41:32 INFO - mozversion platform_buildid: 20170418075121 09:41:32 INFO - mozversion platform_changeset: 722fdbff1efc308a22060e75b603311d23541bb5 09:41:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:41:32 INFO - mozversion platform_version: 55.0a1 09:41:32 INFO - using testdate: 1492533692 09:41:32 INFO - actual date: 1492533692 09:41:32 INFO - starting webserver on 'localhost:57807' 09:41:32 INFO - SUITE-START | Running 2 tests 09:41:32 INFO - TEST-START | dromaeo_css 09:41:32 INFO - operating with platform_type : mac_ 09:41:32 INFO - Initialising browser for dromaeo_css test... 09:41:32 INFO - TEST-INFO | started process 2647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpnBHQhz/profile http://localhost:57807/getInfo.html) 09:41:35 INFO - PID 2647 | __metrics Screen width/height:1600/1200 09:41:35 INFO - PID 2647 | colorDepth:24 09:41:35 INFO - PID 2647 | Browser inner width/height: 1024/689 09:41:35 INFO - PID 2647 | __metrics 09:41:35 INFO - PID 2647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:41:35 INFO - PID 2647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:36 INFO - TEST-INFO | 2647: exit 0 09:41:36 INFO - Browser initialized. 09:41:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:36 INFO - TEST-INFO | started process 2648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpnBHQhz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:48 INFO - PID 2648 | RSS: Main: 241164288 09:41:48 INFO - PID 2648 | 09:44:53 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57807/tests/dromaeo/cssquery-ext.html) 09:44:55 INFO - PID 2648 | RSS: Main: 390893568 09:44:55 INFO - PID 2648 | 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | A coding exception was thrown and uncaught in a Task. 09:46:37 INFO - PID 2648 | 09:46:37 ERROR - PID 2648 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:46:37 INFO - PID 2648 | Full stack: 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | A coding exception was thrown and uncaught in a Task. 09:46:37 INFO - PID 2648 | 09:46:37 ERROR - PID 2648 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:46:37 INFO - PID 2648 | Full stack: 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | A coding exception was thrown and uncaught in a Task. 09:46:37 INFO - PID 2648 | 09:46:37 ERROR - PID 2648 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:46:37 INFO - PID 2648 | Full stack: 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | ************************* 09:46:37 INFO - PID 2648 | A coding exception was thrown and uncaught in a Task. 09:46:37 INFO - PID 2648 | 09:46:37 ERROR - PID 2648 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:46:37 INFO - PID 2648 | Full stack: 09:46:37 INFO - PID 2648 | ************************* 09:47:57 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-ext.html (next: http://localhost:57807/tests/dromaeo/cssquery-jquery.html) 09:47:58 INFO - PID 2648 | RSS: Main: 367181824 09:47:58 INFO - PID 2648 | 09:51:00 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57807/tests/dromaeo/cssquery-mootools.html) 09:51:00 INFO - PID 2648 | RSS: Main: 357097472 09:51:00 INFO - PID 2648 | 09:54:03 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57807/tests/dromaeo/cssquery-prototype.html) 09:54:03 INFO - PID 2648 | RSS: Main: 329400320 09:54:03 INFO - PID 2648 | 09:57:07 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57807/tests/dromaeo/cssquery-yui.html) 09:57:07 INFO - PID 2648 | RSS: Main: 335892480 09:57:07 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | Cycle 1(1): loaded http://localhost:57807/tests/dromaeo/cssquery-yui.html (next: http://localhost:57807/tests/dromaeo/cssquery-dojo.html) 10:00:10 INFO - PID 2648 | RSS: Main: 375984128 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | __start_tp_report 10:00:10 INFO - PID 2648 | _x_x_mozilla_page_load 10:00:10 INFO - PID 2648 | _x_x_mozilla_page_load_details 10:00:10 INFO - PID 2648 | |i|pagename|runs| 10:00:10 INFO - PID 2648 | |0;dojo.html;3472.1666799968016;3484.45990871415;3499.1077275294797;3512.157082300248;3539.522164507791;5943.970280148593;6115.357887421812;6157.353477884825;6215.627062376255;6222.906656400152;6107.583301036486;6131.5295901672125;6217.253929528451;6222.12890195373;6230.657313847737;5155.561777248939;5323.281357016792;5356.062689029423;5373.086575282192;5403.324584426947;4479.686421950465;5459.890802183954;5461.672299662033;5471.917921231185;5503.3395992480955;5260.000599886048;5311.49540793624;5322.840314790563;5327.760250788685;5403.567714582824;5294.311739473844;5328.120860058086;5329.0674132027125;5332.813351532678;5344.946550534522;4326.264535029052;5361.544268737162;5383.43473935235;5393.703346315951;5420.945790542083;6147.661878596676;6148.985417406123;6159.230096237926;6176.660283684396;6179.5674302798825;6275.623462592213;6544.4110030097045;6585.703643336014;6592.637404942726;6597.142371491724;6509.739610415578;6520.967395163041;6575.671216439159;6659.833504162435;6690.7323707051655;6170.907436388457;6247.843803904939;6270.905936410957;6275.843103922439;6292.2134733158355;6779.93220067793;6791.252962174157;6791.898121528181;6793.66031698423;6799.150106236721;6276.717547710364;6330.987042073339;6346.809595712136;6365.745370185141;6441.806745797634;6494.870102598016;6537.771178008747;6662.367075127855;6669.266380698119;6692;6557.082008518812;6577.572457790228;6604.075429439882;6605;6612.603243805291;6562.868742625121;6564;6572.34276572339;6579;6600.53796234259;5126.38483381989;5216.426193118754;5220.843374698765;5234.869128271824;5315.229291752674;4689.859304220879;4693.601043911238;4699.78850951708;4743.003969166513;4758.666893317504;6202.968985155046;6237.875242495215;6248.187735594343;6256.874862502725;6259.78090766821;6397.072424498515;6482.448991835652;6590.340965903467;6691.966540167268;6731.091302674175;6210.4100110489435;6232.345603711636;6247.656378899204;6252.187215661935;6258.874822503524;5828.5337173026055;5832.854178645568;5840.29916410025;5846.883062338729;5876.7355469004;5727.396244444449;6530.967345163243;6553.868922621617;6781.525293229427;6787.796366109024;6254.874902502015;6536.803895883131;6593.340665933561;6719.395254427125;6723.462123030244;6793.72825086991;6799.320067993359;6803.183617965876;6815.250322464624;6827.965860170866;6470.838229044311;6555.082288479522;6567.770128045496;6575;6580.407763301326;6443;6540;6554.606723596599;6597.208334999831;6709.832254193684;6436.195475565554;6464.709088091141;6469.7412103515335;6470;6474.5791523550815;4666.976665116653;6245.469135123565;6292.590981586182;6311.65285909261;6324.146240257506;6298.149749783721;6303.936960630518;6315.08431277453;6325.082862984934;6329.208848893888;6190.288116866618;6346.777862774781;6347.587406818542;6468.062130991074;6472.029195620695;6238.126662267196;6245.250569931455;6289.96855015722;6320.715567799368;6320.810375688737 10:00:10 INFO - PID 2648 | |1;ext.html;757.4357103957552;795.2524626850761;817.3297895725506;1145.3700464744388;1165.7260543772206;28420.863165473384;28667.713322866766;28671.426571468583;37827.62172378275;38200.23599528015;40360.596394036125;40642.7967860161;40661.186776264454;40707;40755.18489630213;8419.989601247844;8557.058723540405;8586.09845966174;8594.570271486433;8597.828043439127;5998.730057147439;6162.22972128484;6175.50595952325;8360.205780450848;8468.957655211716;6190.226221722285;6239.15771370866;8484.151584841527;8670.826583468326;8709.825803483927;8674;8738.432001919919;8749.16882896124;8764.912350876537;8772.298216142724;8407.70573029941;8500.744977650618;8519.062903080656;8526;8527.488350698915;26759.788825341082;27053.45893082147;27068;27084.86457567719;27182;3501.719862411001;3575.570931488212;3582.8387722552548;3583.480395342661;3592.2276710507103;30932.381352373053;31235.531467028013;31243.37513249745;31282.843585781924;31305.217369565715;3098.070578826343;3154.558361829346;3164.3671265746943;3170.651228364878;3187.378461200067;267453;271072;271571;271572;271937;49639.75180124076;49654.75172624186;49657;49722.502774971785;49809.50190498048;52882.06768984683;52942;53034.73482632639;53077.67305817308;53090.73454632702;14593.708125837424;14758.966872318835;14773;14775.26123693811;14800.481983130754;11960.102992275613;12002.339871306987;12006.87993120075;12009.519619215309;12056.87943120575;11303.604373846876;12939;13095.541656042184;13182.231731336335;13234.139780914209;4721.739213972087;5798.217240672539;5864.706764661835;5873.706314684248;5875.647461152259;980.8970058143792;998.1017084623752;1034.8085604163102;1053.7997780421695;1079.7030816525362;24202.87898560531;24448.87775561111;24480.26559203227;24495.38761530976;24551.63172552413;905.7328088213993;1127.3799410324289;1165.8018136916744;1170.8770579089244;1173.7828501727208;11526.308421494738;11965.341906195243;12515.812262816065;12548;12608.81086783699;289126;289746;289840;291945;292674;54624.54189561479;54676.726616366665;54791.45208547863;54802.72598637061;54952;1501.8948673592743;1548.256836718359;1562.8359022302723;1572.9528114156594;1579.4156162219822;18081.457556273333;23877;23881.402964926016;23936.281911542683;24023.27930162098;38805;39134.21731565296;39147;39226.6077339223;39237.41143882901;271268.93096603174;271945;272583;272977;273521;34041;34080.48879266763;34150.63397464074;34169.97490075302;34186.461609227146;45491;45790.084198315184;46446.53553464422;46522;46537.30194047024;28857.422851542433;29526.852365738036;30266;30883.764649414672;31468.52797207998;31250.843745781127;31563.36873262476;31638.367232654757;32064.83967580147;32133.196670083435;36759.08102297464;36813.81593092017;37014.44478332773;37408.81295593505;37519.62480375161;31098.067057988297;31280.21799455032;31517.684823151474;32313.030609080826;32342.676573233966;24042.75957240405;24164.87917560401;24175.506460360306;24428.75571244265;24772.25683229506 10:00:10 INFO - PID 2648 | |2;jquery.html;361.43238434163703;438.3709377043941;444.34459172720244;445.7303331484452;461.506188378435;19971.301004464847;21325.786742132575;21591.812450315225;22081.33755987319;22231.221907233252;21965.780342196573;22367.88160591972;22634.66048009281;22708.318750437513;22750.74870882105;6125.479334256594;6227.190465239512;6253.937460625404;6337.746490140412;6341.8097457076365;6091.263989762919;6292.716827742763;6305.432511074003;6311.495080393557;6318.336574659664;6014.752033901688;6228.408301211378;6267.686615669221;6283.842903927415;6290.2451705795365;6116.541259405562;6224.533160012995;6278.937210627881;6284.24589049317;6285.0886621440095;5490.286262785852;5606.271184745998;5606.6636001839615;5613.494785469327;5625.212470254168;21142.78857211439;26716.33209169767;26725.599116013276;26727.599086013724;26830;1880.6614809334314;2224.0547767198877;2224.5773303072365;2229.710137682107;2230.9330720078424;17490.737638935425;17614.735778963324;17811.376601819004;18104.63790724178;18287.72568411475;1912;2118.2374345235703;2145.442185031887;2208.5582883423217;2208.8785116818567;150843;151431.5567398398;152990.23504882405;154183;155983;11411.543538258542;11650.941745291218;11720;12271.877281227253;12279.815802762965;14719.497685393295;15250.161241131844;15251;15265.771013434807;15310.387584496719;8969.237614802814;9000.624765712857;9063.954680226689;9081.727548173434;9232.215261702697;6970.79087627372;8670.306375489945;8677.783055423539;8684.175003374668;8830.558472076498;7725.961370193113;7868.960655196802;7908.841823163504;7921.603919803987;7929.920700793034;1737.3658614605831;2131.680247962818;2148.7528934172456;2170.4573856535867;2328.895199716017;944.3908678902206;959.3428501476371;978.5351957819978;1002.1832206751474;1026.440589878518;19455.90272048659;20507.17971281132;20955.8952205238;21155.8942205288;21216;982.9901700982898;983.9704808855746;1014.8579198912158;1020.2195320579763;1022.9232807539464;10698.197635177237;10899;10915.890841091488;10994.945025274823;11016.17378696601;538523;541889;565741;567427;577212;130894;131091;131990;132474.33762831124;134971;1156.6125348008343;1160.4081918221768;1179.3454632678774;1183.1836033137108;1183.408295852074;17183.14084295805;17724.291028359235;18253;18339.63320733551;18479.630407392047;57230.427695724175;57520.71239643775;58560;58784;58922.82154356975;61208.081878770965;64318.678406607665;71038.93441598484;77996.27013054516;80038;8335.749927502186;8566.100559441169;8733.344999124964;9080.637904314406;9262.629494820132;12232.204906681038;12327.198732082386;12767.489300427878;14332.785008225093;14344.784828227794;11909.344986025852;11998.04015678761;12190.268583884641;12287.385630718607;12308.076894232789;10616.575336986434;11236;11387;11786.410679466164;11833.230839995716;11966.521339146684;11977.520899163936;12223;12310.81533777012;12339.93830030844;8966.910330896868;8969.327300452362;9038.954805225932;9044.909550904407;9062.728118156467;11758.647240582795;11869.050475962074;12155.574554890536;12158.392080395768;12191.695207619881 10:00:10 INFO - PID 2648 | |3;mootools.html;1358.5856313824283;1460.9707805843884;1488.032778693849;1488.0773920169497;1488.5608745420104;11518.136139789518;12035.157538972275;12038.51845926164;12039.036877049826;12040.51837926484;11413.828792568098;11729.882701172986;11940.164188506786;11953.820692689616;11953.983911367544;2531.9113831015966;2576.896924123033;2579.703334116582;2588.5987671910884;2594.8572828494425;2109.6308146074375;2418.3349578865864;2519.748025197484;2549.6940367155967;2564.5512035393826;2201.1745595401726;2234.6089434349005;2461.889214985321;2557.6163575463643;2564.269183282765;2500.549901017816;2521.747825217482;2532.227670560478;2534.341071321451;2537.035926347985;2516.4967006598754;2522.066835270943;2527.7093134289607;2528.2288901884917;2528.6207068939807;11731.648050558497;11961.700957476045;11969.521219151311;11980.161388702794;11984.58053968107;6631.2705602384185;6900.551464154814;6912.930870691329;6913.41235994936;6921.688524016431;4005.2990726622725;4185.686073544496;4304.655627549789;4342.913141737147;4352.064306174156;1087.456271864068;1226.5400474821943;1227.5580790915262;1285.7492788906168;1300.4473098932915;16682.66634667312;16796.32814687411;16815.327386904508;16815.991040537607;16823.242954067096;5487.8444894186005;5565.132233097958;5613.494785469327;5640.435956404409;5731.369549349568;12513.998880089572;12516.68708282282;12528.185667931555;12534.623961280993;12540.749185016248;6740.730370785113;6756.391924726799;6759.290274521104;6760.594364338155;6764.661766911635;6036.426539478743;6211.937880621226;6277.905831412532;6282.748690052438;6323.747050117944;4229.175310814362;4352.521222665504;4388.407564978751;4405.31717583775;4429.335599660012;1257.4215860703996;1286.4468278640088;1292.8125421813784;1306.6929271621161;1309.5809341010975;672.0617183305824;701.3372363116806;788.6805843633338;813.8657121574873;827.2885318625977;5986.730597123053;6650.168728908887;6748.662566871637;6906.343897329745;6926.549774264657;583.5781506747034;595.8986972214648;610.5573459242103;613.2395829171795;708.9184743754431;4006.6561061779184;4239.724417912826;4304.923769057736;4362.214801335726;4368.978155109204;14820.481283155037;15562;15582.376704931676;15586;15595.688086238439;15084.849151508344;15223.695526089416;15274.38902443912;15488.922555387151;15499.767503487457;8575.742727718178;8693.347998900108;8794.42836215644;8805.735827925173;8869.290456763443;6640.667966601747;6676.265610782712;6704.832379190364;6790.354916282945;6816.659167041727;13586.864131358956;13684.110532815335;13698.726025479635;14023.228722420365;14034.719305614035;13788.241646709528;13910.72178556403;14217.146971181763;14297.285135742963;14379.28103594837;9234.630614775602;9534.380265282734;9552.044795520393;9554.235661146953;9582.425054496753;10895.673129806119;10919.181061420584;10966.287191332538;10996.065334446661;11026.0076593107;9319.18249982531;9326.906730932875;9334.39326443779;9447.763805904908;9563.139317461184;9113.635454581743;9150.267978561566;9168.404053736485;9195.540222988957;9207.815843682954;8173.959130204311;8321.459105158145;8321.750347489586;8332.125126861834;8337.08292087882;5998.4601385875485;6007.729652165575;6122.877542449215;6165.32181460048;6237.7232310207355;6094.603850749687;6118.663473508822;6214.130021797043;6247.875042499034;6357.1735674362035 10:00:10 INFO - PID 2648 | |4;prototype.html;317.5252996769829;403.7355532126458;407.78183671735616;416.7374554030962;419.8467559340842;5113.002964421939;5694.715264236782;5889.676067816268;5908.615939963899;5973.551983601236;5633.746481408336;5639.812072412642;5753.942460575393;5870.383609720971;5925.4963328117055;4464.397306363632;4481.708688935225;4484.663650226246;4487.035287413206;4524.68327217095;4480.775961201944;4500.189965806154;4501.122281155176;4516;4525.728456292616;4262.232798096342;4447.466304043519;4462.219111655463;4468.776561171945;4497.235469970113;4414.470263568376;4416.608768237995;4421.93873470368;4434.135343607998;4434.290513517822;3914;3920.5687374388795;3944.625260600267;3946.48695669564;3983.6215559521797;5466;5672.659640421588;5727.971360143214;5750.367459579443;5790.276215473066;4261.573842615745;5356.705381204032;5384.6499977501335;5389.946100538984;5392.004958165465;5710;5737.540996720252;6312.305646378894;6319.399657032574;6331.33520980295;3679.4480827875764;4399.134138677461;4493.370928070073;4531.184386810372;4559.635229181657;5344.6258761887075;5364.390682795185;6322.652254126021;6532.6733663316645;6594.505412094064;4476.843310484118;4477.70894891831;4482.731036137842;4483.170613436525;4494.303382975644;4554.675087186372;4672.6261899047995;4676.976615116902;4712.926312422524;4725.5510726480925;4530.142641517028;4655.51117132703;5204.9219261711105;5393.514583687487;5423.83728488146;6219.564630475914;6230.816144932448;6232.127502149703;6246.968765156145;6255.749770009149;1587.9364825407085;1611.73406387947;1615.3215649427268;1619.1661294433377;1626.2600516764844;1044.1177205261542;1056.8995945385177;1076.5950434682657;1092.4373947417087;1132.5356603792407;5195.740212989335;5562.666240025531;5939.792107276311;5944.5838791284195;5977.402259773988;6189.84525386869;6477.805665830033;6504.934950650433;6510.772122975768;6514.9674251629385;4956.603471722254;5530.059889818741;5763.884722305615;5790.7973220937065;5905.254056863493;3333.8166400848186;3342.5988881334397;3369.685822529216;3383.2218589724007;3404.7276217903004;6032.969835150796;6048.939510604838;6323.557350985387;6631.933680663132;6643.169603799525;6271.560990730696;6629.204495460575;6630.535862489676;6683.732650693918;6688.86622267552;5810.883782324415;6409.929694643934;6586.242582103119;6633.900491492632;6636.933630663631;5870.7945221917025;6243.43809057187;6473.158489396348;6479.611223326616;6480.416762491398;5464.207689885024;5745.693956892486;5782.5663075268685;6169.81490555284;6329.30377658448;5534.1975413564005;5738.569607279387;6581;6696.296888826603;6717;3924.7252692311263;4087.6321131098343;4635;4725.432948046257;4745.434006777686;5276.445973172915;5649.802256920988;5931.042755890459;6370.426661600478;6541.6402097885075;5792.4497172768515;6250.687465626609;6280.560360774702;6285.2457705075685;6287.151234583455;4524.615407690251;5402.891942161056;6237.563370564017;6277.843053923689;6317.9052314214405;5361.785528578969;5368.758405871667;5781.161731548986;6166.537509686881;6227.626342419469;4739.952600473951;5474.795544980098;5663.461971112738;5718.942810571841;6337.7817763782305;5299.629025968299;6015.736695294037;6115.785947491817;6169.784057557964;6174.228221472316 10:00:10 INFO - PID 2648 | |5;yui.html;704.9189343225524;793.8729803231485;868.7784614923197;871.6992637540051;882.63370701159;13692.178469291837;18044.368447104353;18177.727334089966;18754.718679219823;18768.249270029217;17486.300547978066;17766.46700598984;18092.185851636674;18177.81822181778;18187.27250909962;960.2749923807515;990.866233058535;994.607130183577;994.6866736977865;997.1723469520317;668.7191379620571;688.9001094841245;694.4826104552116;1009.1623952119724;1011.2264117949775;749.9400047996147;752.1801236652049;1003.0922015575879;1052.715766742979;1065.8081545321838;1033.447105798398;1035.4305132177271;1035.9637412690558;1037.1339931157493;1037.3931250218632;776.281939206232;776.7009701264997;776.7592046465613;777.0752804163028;780.4575819805237;15075.773863392058;15229.61925951849;15965.44120955761;16609.169541522875;16796;16693.499195024167;16783.412580559743;17049.48851534456;17201.569960750956;17442.912785436118;13848.169109853341;13969.231692256923;14081;14164.929175354056;14287.499937502138;3397.3205358928312;3428.639992800745;3428.7257019438384;3432.2792213635166;3432.5880894292845;107639.46180269126;107899;108005;108049;108307;11363.54545818158;11771.411429428666;11809.291442513477;12052.216605920763;12052.33712145823;19702.70445943312;24720.629190562155;25321.493570128496;25624.23127306184;25694.229173124837;7618.733344332922;7851.097123830833;7855.293023627901;7856.096548896836;7860.371170306362;3599.208174201671;3690.760100593453;3746.587875333711;3749.362608356586;3753.530808648919;4380.4305440292555;4495.033567782943;4506.053728716941;4506.143832671847;4514.525974772667;793.3137835772015;953.0612346838359;953.7997020625608;970.4710932541782;971.820213260549;634.0742515926706;637.3817397124782;638.2851206648584;647.3106141958799;670.7451168555917;9092.590833412512;10751.08615767653;11012.17408694351;11499.597514086967;11888.227265227733;635.9173307470091;645.7901182115831;646.7703965092325;667.6561570791047;687.656171914043;5083.110455670243;5269.578433725293;5355.651882627617;5425.133556343318;5472.890542189134;103642;104855;105266.47366763117;105752.88494230072;108136.4593177029;86096.56951715202;90728.5463572678;92636.53681731682;95960.0403995965;96289.03710962941;61875.6906215466;77462.61268693733;77523.61238193772;77562.6121869387;78043.60978195073;10494.265401422133;10529.36823790575;10872.673819785103;12413.317267550372;12690.682732931751;39534.80232598819;39558.208835822545;39638;41138.588614113476;41497.96255093526;70054.94917576342;71823.64088179526;72441.82674519773;72951;73052.63473682597;16167.191640418167;16419.014859108014;16441.588960276087;16518.83481165173;16750.162491875115;17717.91141044338;17857;17946.730799037763;17950.19224134891;18032.008239546427;16572.41996530164;16638.084905330325;16709.16454177262;16737.246823893198;16881.07154106536;15683.843161568238;15900.204989750697;16076.276567554254;16169.110698911672;16270.267837947084;15631.76552351693;15720.371185152466;15748.370065197263;15898.205089745697;16021.279042443351;11762.647120586396;11902.880971190523;12079.214851034654;12188.75622487563;12194.634160975185;12475;12566.497340106658;12583.182093163916;12593.559225427067;12753.171043882117 10:00:10 INFO - PID 2648 | __end_tp_report 10:00:10 INFO - PID 2648 | __start_cc_report 10:00:10 INFO - PID 2648 | _x_x_mozilla_cycle_collect,1590 10:00:10 INFO - PID 2648 | __end_cc_report 10:00:10 INFO - PID 2648 | __startTimestamp1492534810628__endTimestamp 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | ------- Summary: start ------- 10:00:10 INFO - PID 2648 | Number of tests: 6 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#0] dojo.html Cycles:165 Average:6057.37 Median:6276.72 stddev:728.16 (11.6%) stddev-sans-first:701.58 10:00:10 INFO - PID 2648 | Values: 3472.2 3484.5 3499.1 3512.2 3539.5 5944.0 6115.4 6157.4 6215.6 6222.9 6107.6 6131.5 6217.3 6222.1 6230.7 5155.6 5323.3 5356.1 5373.1 5403.3 4479.7 5459.9 5461.7 5471.9 5503.3 5260.0 5311.5 5322.8 5327.8 5403.6 5294.3 5328.1 5329.1 5332.8 5344.9 4326.3 5361.5 5383.4 5393.7 5420.9 6147.7 6149.0 6159.2 6176.7 6179.6 6275.6 6544.4 6585.7 6592.6 6597.1 6509.7 6521.0 6575.7 6659.8 6690.7 6170.9 6247.8 6270.9 6275.8 6292.2 6779.9 6791.3 6791.9 6793.7 6799.2 6276.7 6331.0 6346.8 6365.7 6441.8 6494.9 6537.8 6662.4 6669.3 6692.0 6557.1 6577.6 6604.1 6605.0 6612.6 6562.9 6564.0 6572.3 6579.0 6600.5 5126.4 5216.4 5220.8 5234.9 5315.2 4689.9 4693.6 4699.8 4743.0 4758.7 6203.0 6237.9 6248.2 6256.9 6259.8 6397.1 6482.4 6590.3 6692.0 6731.1 6210.4 6232.3 6247.7 6252.2 6258.9 5828.5 5832.9 5840.3 5846.9 5876.7 5727.4 6531.0 6553.9 6781.5 6787.8 6254.9 6536.8 6593.3 6719.4 6723.5 6793.7 6799.3 6803.2 6815.3 6828.0 6470.8 6555.1 6567.8 6575.0 6580.4 6443.0 6540.0 6554.6 6597.2 6709.8 6436.2 6464.7 6469.7 6470.0 6474.6 4667.0 6245.5 6292.6 6311.7 6324.1 6298.1 6303.9 6315.1 6325.1 6329.2 6190.3 6346.8 6347.6 6468.1 6472.0 6238.1 6245.3 6290.0 6320.7 6320.8 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#1] ext.html Cycles:180 Average:43149.08 Median:3167.51 stddev:72773.81 (2297.5%) stddev-sans-first:72908.36 10:00:10 INFO - PID 2648 | Values: 757.4 795.3 817.3 1145.4 1165.7 28420.9 28667.7 28671.4 37827.6 38200.2 40360.6 40642.8 40661.2 40707.0 40755.2 8420.0 8557.1 8586.1 8594.6 8597.8 5998.7 6162.2 6175.5 8360.2 8469.0 6190.2 6239.2 8484.2 8670.8 8709.8 8674.0 8738.4 8749.2 8764.9 8772.3 8407.7 8500.7 8519.1 8526.0 8527.5 26759.8 27053.5 27068.0 27084.9 27182.0 3501.7 3575.6 3582.8 3583.5 3592.2 30932.4 31235.5 31243.4 31282.8 31305.2 3098.1 3154.6 3164.4 3170.7 3187.4 267453.0 271072.0 271571.0 271572.0 271937.0 49639.8 49654.8 49657.0 49722.5 49809.5 52882.1 52942.0 53034.7 53077.7 53090.7 14593.7 14759.0 14773.0 14775.3 14800.5 11960.1 12002.3 12006.9 12009.5 12056.9 11303.6 12939.0 13095.5 13182.2 13234.1 4721.7 5798.2 5864.7 5873.7 5875.6 980.9 998.1 1034.8 1053.8 1079.7 24202.9 24448.9 24480.3 24495.4 24551.6 905.7 1127.4 1165.8 1170.9 1173.8 11526.3 11965.3 12515.8 12548.0 12608.8 289126.0 289746.0 289840.0 291945.0 292674.0 54624.5 54676.7 54791.5 54802.7 54952.0 1501.9 1548.3 1562.8 1573.0 1579.4 18081.5 23877.0 23881.4 23936.3 24023.3 38805.0 39134.2 39147.0 39226.6 39237.4 271268.9 271945.0 272583.0 272977.0 273521.0 34041.0 34080.5 34150.6 34170.0 34186.5 45491.0 45790.1 46446.5 46522.0 46537.3 28857.4 29526.9 30266.0 30883.8 31468.5 31250.8 31563.4 31638.4 32064.8 32133.2 36759.1 36813.8 37014.4 37408.8 37519.6 31098.1 31280.2 31517.7 32313.0 32342.7 24042.8 24164.9 24175.5 24428.8 24772.3 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#2] jquery.html Cycles:180 Average:35589.14 Median:22156.28 stddev:94558.32 (426.8%) stddev-sans-first:94786.58 10:00:10 INFO - PID 2648 | Values: 361.4 438.4 444.3 445.7 461.5 19971.3 21325.8 21591.8 22081.3 22231.2 21965.8 22367.9 22634.7 22708.3 22750.7 6125.5 6227.2 6253.9 6337.7 6341.8 6091.3 6292.7 6305.4 6311.5 6318.3 6014.8 6228.4 6267.7 6283.8 6290.2 6116.5 6224.5 6278.9 6284.2 6285.1 5490.3 5606.3 5606.7 5613.5 5625.2 21142.8 26716.3 26725.6 26727.6 26830.0 1880.7 2224.1 2224.6 2229.7 2230.9 17490.7 17614.7 17811.4 18104.6 18287.7 1912.0 2118.2 2145.4 2208.6 2208.9 150843.0 151431.6 152990.2 154183.0 155983.0 11411.5 11650.9 11720.0 12271.9 12279.8 14719.5 15250.2 15251.0 15265.8 15310.4 8969.2 9000.6 9064.0 9081.7 9232.2 6970.8 8670.3 8677.8 8684.2 8830.6 7726.0 7869.0 7908.8 7921.6 7929.9 1737.4 2131.7 2148.8 2170.5 2328.9 944.4 959.3 978.5 1002.2 1026.4 19455.9 20507.2 20955.9 21155.9 21216.0 983.0 984.0 1014.9 1020.2 1022.9 10698.2 10899.0 10915.9 10994.9 11016.2 538523.0 541889.0 565741.0 567427.0 577212.0 130894.0 131091.0 131990.0 132474.3 134971.0 1156.6 1160.4 1179.3 1183.2 1183.4 17183.1 17724.3 18253.0 18339.6 18479.6 57230.4 57520.7 58560.0 58784.0 58922.8 61208.1 64318.7 71038.9 77996.3 80038.0 8335.7 8566.1 8733.3 9080.6 9262.6 12232.2 12327.2 12767.5 14332.8 14344.8 11909.3 11998.0 12190.3 12287.4 12308.1 10616.6 11236.0 11387.0 11786.4 11833.2 11966.5 11977.5 12223.0 12310.8 12339.9 8966.9 8969.3 9039.0 9044.9 9062.7 11758.6 11869.1 12155.6 12158.4 12191.7 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#3] mootools.html Cycles:180 Average:7263.97 Median:4005.98 stddev:4651.51 (116.1%) stddev-sans-first:4643.40 10:00:10 INFO - PID 2648 | Values: 1358.6 1461.0 1488.0 1488.1 1488.6 11518.1 12035.2 12038.5 12039.0 12040.5 11413.8 11729.9 11940.2 11953.8 11954.0 2531.9 2576.9 2579.7 2588.6 2594.9 2109.6 2418.3 2519.7 2549.7 2564.6 2201.2 2234.6 2461.9 2557.6 2564.3 2500.5 2521.7 2532.2 2534.3 2537.0 2516.5 2522.1 2527.7 2528.2 2528.6 11731.6 11961.7 11969.5 11980.2 11984.6 6631.3 6900.6 6912.9 6913.4 6921.7 4005.3 4185.7 4304.7 4342.9 4352.1 1087.5 1226.5 1227.6 1285.7 1300.4 16682.7 16796.3 16815.3 16816.0 16823.2 5487.8 5565.1 5613.5 5640.4 5731.4 12514.0 12516.7 12528.2 12534.6 12540.7 6740.7 6756.4 6759.3 6760.6 6764.7 6036.4 6211.9 6277.9 6282.7 6323.7 4229.2 4352.5 4388.4 4405.3 4429.3 1257.4 1286.4 1292.8 1306.7 1309.6 672.1 701.3 788.7 813.9 827.3 5986.7 6650.2 6748.7 6906.3 6926.5 583.6 595.9 610.6 613.2 708.9 4006.7 4239.7 4304.9 4362.2 4369.0 14820.5 15562.0 15582.4 15586.0 15595.7 15084.8 15223.7 15274.4 15488.9 15499.8 8575.7 8693.3 8794.4 8805.7 8869.3 6640.7 6676.3 6704.8 6790.4 6816.7 13586.9 13684.1 13698.7 14023.2 14034.7 13788.2 13910.7 14217.1 14297.3 14379.3 9234.6 9534.4 9552.0 9554.2 9582.4 10895.7 10919.2 10966.3 10996.1 11026.0 9319.2 9326.9 9334.4 9447.8 9563.1 9113.6 9150.3 9168.4 9195.5 9207.8 8174.0 8321.5 8321.8 8332.1 8337.1 5998.5 6007.7 6122.9 6165.3 6237.7 6094.6 6118.7 6214.1 6247.9 6357.2 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#4] prototype.html Cycles:180 Average:5072.61 Median:5532.13 stddev:1500.42 (27.1%) stddev-sans-first:1461.56 10:00:10 INFO - PID 2648 | Values: 317.5 403.7 407.8 416.7 419.8 5113.0 5694.7 5889.7 5908.6 5973.6 5633.7 5639.8 5753.9 5870.4 5925.5 4464.4 4481.7 4484.7 4487.0 4524.7 4480.8 4500.2 4501.1 4516.0 4525.7 4262.2 4447.5 4462.2 4468.8 4497.2 4414.5 4416.6 4421.9 4434.1 4434.3 3914.0 3920.6 3944.6 3946.5 3983.6 5466.0 5672.7 5728.0 5750.4 5790.3 4261.6 5356.7 5384.6 5389.9 5392.0 5710.0 5737.5 6312.3 6319.4 6331.3 3679.4 4399.1 4493.4 4531.2 4559.6 5344.6 5364.4 6322.7 6532.7 6594.5 4476.8 4477.7 4482.7 4483.2 4494.3 4554.7 4672.6 4677.0 4712.9 4725.6 4530.1 4655.5 5204.9 5393.5 5423.8 6219.6 6230.8 6232.1 6247.0 6255.7 1587.9 1611.7 1615.3 1619.2 1626.3 1044.1 1056.9 1076.6 1092.4 1132.5 5195.7 5562.7 5939.8 5944.6 5977.4 6189.8 6477.8 6504.9 6510.8 6515.0 4956.6 5530.1 5763.9 5790.8 5905.3 3333.8 3342.6 3369.7 3383.2 3404.7 6033.0 6048.9 6323.6 6631.9 6643.2 6271.6 6629.2 6630.5 6683.7 6688.9 5810.9 6409.9 6586.2 6633.9 6636.9 5870.8 6243.4 6473.2 6479.6 6480.4 5464.2 5745.7 5782.6 6169.8 6329.3 5534.2 5738.6 6581.0 6696.3 6717.0 3924.7 4087.6 4635.0 4725.4 4745.4 5276.4 5649.8 5931.0 6370.4 6541.6 5792.4 6250.7 6280.6 6285.2 6287.2 4524.6 5402.9 6237.6 6277.8 6317.9 5361.8 5368.8 5781.2 6166.5 6227.6 4740.0 5474.8 5663.5 5718.9 6337.8 5299.6 6015.7 6115.8 6169.8 6174.2 10:00:10 INFO - PID 2648 | 10:00:10 INFO - PID 2648 | [#5] yui.html Cycles:180 Average:21479.82 Median:18182.55 stddev:29574.60 (162.7%) stddev-sans-first:29616.43 10:00:10 INFO - PID 2648 | Values: 704.9 793.9 868.8 871.7 882.6 13692.2 18044.4 18177.7 18754.7 18768.2 17486.3 17766.5 18092.2 18177.8 18187.3 960.3 990.9 994.6 994.7 997.2 668.7 688.9 694.5 1009.2 1011.2 749.9 752.2 1003.1 1052.7 1065.8 1033.4 1035.4 1036.0 1037.1 1037.4 776.3 776.7 776.8 777.1 780.5 15075.8 15229.6 15965.4 16609.2 16796.0 16693.5 16783.4 17049.5 17201.6 17442.9 13848.2 13969.2 14081.0 14164.9 14287.5 3397.3 3428.6 3428.7 3432.3 3432.6 107639.5 107899.0 108005.0 108049.0 108307.0 11363.5 11771.4 11809.3 12052.2 12052.3 19702.7 24720.6 25321.5 25624.2 25694.2 7618.7 7851.1 7855.3 7856.1 7860.4 3599.2 3690.8 3746.6 3749.4 3753.5 4380.4 4495.0 4506.1 4506.1 4514.5 793.3 953.1 953.8 970.5 971.8 634.1 637.4 638.3 647.3 670.7 9092.6 10751.1 11012.2 11499.6 11888.2 635.9 645.8 646.8 667.7 687.7 5083.1 5269.6 5355.7 5425.1 5472.9 103642.0 104855.0 105266.5 105752.9 108136.5 86096.6 90728.5 92636.5 95960.0 96289.0 61875.7 77462.6 77523.6 77562.6 78043.6 10494.3 10529.4 10872.7 12413.3 12690.7 39534.8 39558.2 39638.0 41138.6 41498.0 70054.9 71823.6 72441.8 72951.0 73052.6 16167.2 16419.0 16441.6 16518.8 16750.2 17717.9 17857.0 17946.7 17950.2 18032.0 16572.4 16638.1 16709.2 16737.2 16881.1 15683.8 15900.2 16076.3 16169.1 16270.3 15631.8 15720.4 15748.4 15898.2 16021.3 11762.6 11902.9 12079.2 12188.8 12194.6 12475.0 12566.5 12583.2 12593.6 12753.2 10:00:10 INFO - PID 2648 | -------- Summary: end -------- 10:00:10 INFO - PID 2648 | 10:00:11 INFO - TEST-INFO | 2648: exit 0 10:00:11 INFO - TEST-OK | dromaeo_css | took 1118790ms 10:00:11 INFO - TEST-START | kraken 10:00:11 INFO - operating with platform_type : mac_ 10:00:11 INFO - Initialising browser for kraken test... 10:00:11 INFO - TEST-INFO | started process 2652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpv3tQYY/profile http://localhost:57807/getInfo.html) 10:00:14 INFO - PID 2652 | __metrics Screen width/height:1600/1200 10:00:14 INFO - PID 2652 | colorDepth:24 10:00:14 INFO - PID 2652 | Browser inner width/height: 1024/689 10:00:14 INFO - PID 2652 | __metrics 10:00:14 INFO - PID 2652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:00:14 INFO - PID 2652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:15 INFO - TEST-INFO | 2652: exit 0 10:00:15 INFO - Browser initialized. 10:00:15 INFO - Running cycle 1/1 for kraken test... 10:00:15 INFO - TEST-INFO | started process 2653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpv3tQYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:27 INFO - PID 2653 | RSS: Main: 241164288 10:00:27 INFO - PID 2653 | 10:00:29 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57807/tests/kraken/driver.html?testName=audio-beat-detection) 10:00:30 INFO - PID 2653 | RSS: Main: 312283136 10:00:30 INFO - PID 2653 | 10:00:33 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57807/tests/kraken/driver.html?testName=audio-dft) 10:00:34 INFO - PID 2653 | RSS: Main: 293597184 10:00:34 INFO - PID 2653 | 10:00:37 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57807/tests/kraken/driver.html?testName=audio-fft) 10:00:38 INFO - PID 2653 | RSS: Main: 384503808 10:00:38 INFO - PID 2653 | 10:00:39 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57807/tests/kraken/driver.html?testName=audio-oscillator) 10:00:40 INFO - PID 2653 | RSS: Main: 288051200 10:00:40 INFO - PID 2653 | 10:00:42 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:43 INFO - PID 2653 | RSS: Main: 290893824 10:00:43 INFO - PID 2653 | 10:00:46 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57807/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:46 INFO - PID 2653 | RSS: Main: 354877440 10:00:46 INFO - PID 2653 | 10:00:49 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57807/tests/kraken/driver.html?testName=imaging-desaturate) 10:00:50 INFO - PID 2653 | RSS: Main: 366051328 10:00:50 INFO - PID 2653 | 10:00:53 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57807/tests/kraken/driver.html?testName=json-parse-financial) 10:00:53 INFO - PID 2653 | RSS: Main: 366034944 10:00:53 INFO - PID 2653 | 10:00:55 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:56 INFO - PID 2653 | RSS: Main: 312889344 10:00:56 INFO - PID 2653 | 10:00:57 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:58 INFO - PID 2653 | RSS: Main: 332800000 10:00:58 INFO - PID 2653 | 10:01:00 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:01:01 INFO - PID 2653 | RSS: Main: 315965440 10:01:01 INFO - PID 2653 | 10:01:04 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:01:04 INFO - PID 2653 | RSS: Main: 350986240 10:01:04 INFO - PID 2653 | 10:01:08 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:01:08 INFO - PID 2653 | RSS: Main: 341864448 10:01:08 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | Cycle 1(1): loaded http://localhost:57807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57807/tests/kraken/driver.html?testName=ai-astar) 10:01:10 INFO - PID 2653 | RSS: Main: 384442368 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | __start_tp_report 10:01:10 INFO - PID 2653 | _x_x_mozilla_page_load 10:01:10 INFO - PID 2653 | _x_x_mozilla_page_load_details 10:01:10 INFO - PID 2653 | |i|pagename|runs| 10:01:10 INFO - PID 2653 | |0;ai-astar;112;111;110;111;111;111;112;111;111;110 10:01:10 INFO - PID 2653 | |1;audio-beat-detection;140;109;110;151;112;110;110;110;139;109 10:01:10 INFO - PID 2653 | |2;audio-dft;185;186;180;185;186;186;183;183;185;180 10:01:10 INFO - PID 2653 | |3;audio-fft;79;60;59;88;60;60;58;58;82;60 10:01:10 INFO - PID 2653 | |4;audio-oscillator;86;70;86;70;69;69;90;68;69;90 10:01:10 INFO - PID 2653 | |5;imaging-gaussian-blur;88;88;87;87;88;87;87;87;88;87 10:01:10 INFO - PID 2653 | |6;imaging-darkroom;96;96;96;113;152;96;93;96;95;95 10:01:10 INFO - PID 2653 | |7;imaging-desaturate;86;86;86;83;83;86;125;141;87;83 10:01:10 INFO - PID 2653 | |8;json-parse-financial;48;48;49;54;59;80;77;56;51;49 10:01:10 INFO - PID 2653 | |9;json-stringify-tinderbox;54;60;60;57;65;62;58;58;58;58 10:01:10 INFO - PID 2653 | |10;stanford-crypto-aes;83;83;83;83;85;83;82;82;83;82 10:01:10 INFO - PID 2653 | |11;stanford-crypto-ccm;138;138;140;138;135;144;136;134;188;137 10:01:10 INFO - PID 2653 | |12;stanford-crypto-pbkdf2;190;186;195;229;196;186;186;181;193;233 10:01:10 INFO - PID 2653 | |13;stanford-crypto-sha256-iterative;69;67;66;65;67;72;87;63;67;97 10:01:10 INFO - PID 2653 | __end_tp_report 10:01:10 INFO - PID 2653 | __start_cc_report 10:01:10 INFO - PID 2653 | _x_x_mozilla_cycle_collect,2203 10:01:10 INFO - PID 2653 | __end_cc_report 10:01:10 INFO - PID 2653 | __startTimestamp1492534870883__endTimestamp 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | ------- Summary: start ------- 10:01:10 INFO - PID 2653 | Number of tests: 14 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:01:10 INFO - PID 2653 | Values: 112.0 111.0 110.0 111.0 111.0 111.0 112.0 111.0 111.0 110.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:111.00 stddev:16.42 (14.8%) stddev-sans-first:15.75 10:01:10 INFO - PID 2653 | Values: 140.0 109.0 110.0 151.0 112.0 110.0 110.0 110.0 139.0 109.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:2.33 (1.3%) stddev-sans-first:2.44 10:01:10 INFO - PID 2653 | Values: 185.0 186.0 180.0 185.0 186.0 186.0 183.0 183.0 185.0 180.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:11.47 10:01:10 INFO - PID 2653 | Values: 79.0 60.0 59.0 88.0 60.0 60.0 58.0 58.0 82.0 60.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:9.83 (12.6%) stddev-sans-first:9.84 10:01:10 INFO - PID 2653 | Values: 86.0 70.0 86.0 70.0 69.0 69.0 90.0 68.0 69.0 90.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 10:01:10 INFO - PID 2653 | Values: 88.0 88.0 87.0 87.0 88.0 87.0 87.0 87.0 88.0 87.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:96.00 stddev:18.18 (18.9%) stddev-sans-first:19.11 10:01:10 INFO - PID 2653 | Values: 96.0 96.0 96.0 113.0 152.0 96.0 93.0 96.0 95.0 95.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:86.00 stddev:20.64 (24.0%) stddev-sans-first:21.66 10:01:10 INFO - PID 2653 | Values: 86.0 86.0 86.0 83.0 83.0 86.0 125.0 141.0 87.0 83.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:55.00 stddev:11.87 (21.6%) stddev-sans-first:12.13 10:01:10 INFO - PID 2653 | Values: 48.0 48.0 49.0 54.0 59.0 80.0 77.0 56.0 51.0 49.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:2.98 (5.1%) stddev-sans-first:2.55 10:01:10 INFO - PID 2653 | Values: 54.0 60.0 60.0 57.0 65.0 62.0 58.0 58.0 58.0 58.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 10:01:10 INFO - PID 2653 | Values: 83.0 83.0 83.0 83.0 85.0 83.0 82.0 82.0 83.0 82.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:138.00 stddev:16.12 (11.7%) stddev-sans-first:17.01 10:01:10 INFO - PID 2653 | Values: 138.0 138.0 140.0 138.0 135.0 144.0 136.0 134.0 188.0 137.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.50 Median:194.00 stddev:18.28 (9.4%) stddev-sans-first:19.18 10:01:10 INFO - PID 2653 | Values: 190.0 186.0 195.0 229.0 196.0 186.0 186.0 181.0 193.0 233.0 10:01:10 INFO - PID 2653 | 10:01:10 INFO - PID 2653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:68.00 stddev:11.06 (16.3%) stddev-sans-first:11.67 10:01:10 INFO - PID 2653 | Values: 69.0 67.0 66.0 65.0 67.0 72.0 87.0 63.0 67.0 97.0 10:01:10 INFO - PID 2653 | -------- Summary: end -------- 10:01:10 INFO - PID 2653 | 10:01:12 INFO - TEST-INFO | 2653: exit 0 10:01:12 INFO - TEST-OK | kraken | took 60699ms 10:01:12 INFO - SUITE-END | took 1179s 10:01:12 INFO - Completed test suite (00:19:39) 10:01:12 INFO - javascript benchmark 10:01:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7772.6590638553935, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3472.1666799968016, 3484.45990871415, 3499.1077275294797, 3512.157082300248, 3539.522164507791, 5943.970280148593, 6115.357887421812, 6157.353477884825, 6215.627062376255, 6222.906656400152, 6107.583301036486, 6131.5295901672125, 6217.253929528451, 6222.12890195373, 6230.657313847737, 5155.561777248939, 5323.281357016792, 5356.062689029423, 5373.086575282192, 5403.324584426947, 4479.686421950465, 5459.890802183954, 5461.672299662033, 5471.917921231185, 5503.3395992480955, 5260.000599886048, 5311.49540793624, 5322.840314790563, 5327.760250788685, 5403.567714582824, 5294.311739473844, 5328.120860058086, 5329.0674132027125, 5332.813351532678, 5344.946550534522, 4326.264535029052, 5361.544268737162, 5383.43473935235, 5393.703346315951, 5420.945790542083, 6147.661878596676, 6148.985417406123, 6159.230096237926, 6176.660283684396, 6179.5674302798825, 6275.623462592213, 6544.4110030097045, 6585.703643336014, 6592.637404942726, 6597.142371491724, 6509.739610415578, 6520.967395163041, 6575.671216439159, 6659.833504162435, 6690.7323707051655, 6170.907436388457, 6247.843803904939, 6270.905936410957, 6275.843103922439, 6292.2134733158355, 6779.93220067793, 6791.252962174157, 6791.898121528181, 6793.66031698423, 6799.150106236721, 6276.717547710364, 6330.987042073339, 6346.809595712136, 6365.745370185141, 6441.806745797634, 6494.870102598016, 6537.771178008747, 6662.367075127855, 6669.266380698119, 6692.0, 6557.082008518812, 6577.572457790228, 6604.075429439882, 6605.0, 6612.603243805291, 6562.868742625121, 6564.0, 6572.34276572339, 6579.0, 6600.53796234259, 5126.38483381989, 5216.426193118754, 5220.843374698765, 5234.869128271824, 5315.229291752674, 4689.859304220879, 4693.601043911238, 4699.78850951708, 4743.003969166513, 4758.666893317504, 6202.968985155046, 6237.875242495215, 6248.187735594343, 6256.874862502725, 6259.78090766821, 6397.072424498515, 6482.448991835652, 6590.340965903467, 6691.966540167268, 6731.091302674175, 6210.4100110489435, 6232.345603711636, 6247.656378899204, 6252.187215661935, 6258.874822503524, 5828.5337173026055, 5832.854178645568, 5840.29916410025, 5846.883062338729, 5876.7355469004, 5727.396244444449, 6530.967345163243, 6553.868922621617, 6781.525293229427, 6787.796366109024, 6254.874902502015, 6536.803895883131, 6593.340665933561, 6719.395254427125, 6723.462123030244, 6793.72825086991, 6799.320067993359, 6803.183617965876, 6815.250322464624, 6827.965860170866, 6470.838229044311, 6555.082288479522, 6567.770128045496, 6575.0, 6580.407763301326, 6443.0, 6540.0, 6554.606723596599, 6597.208334999831, 6709.832254193684, 6436.195475565554, 6464.709088091141, 6469.7412103515335, 6470.0, 6474.5791523550815, 4666.976665116653, 6245.469135123565, 6292.590981586182, 6311.65285909261, 6324.146240257506, 6298.149749783721, 6303.936960630518, 6315.08431277453, 6325.082862984934, 6329.208848893888, 6190.288116866618, 6346.777862774781, 6347.587406818542, 6468.062130991074, 6472.029195620695, 6238.126662267196, 6245.250569931455, 6289.96855015722, 6320.715567799368, 6320.810375688737], "value": 6008.769380283186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.4357103957552, 795.2524626850761, 817.3297895725506, 1145.3700464744388, 1165.7260543772206, 28420.863165473384, 28667.713322866766, 28671.426571468583, 37827.62172378275, 38200.23599528015, 40360.596394036125, 40642.7967860161, 40661.186776264454, 40707.0, 40755.18489630213, 8419.989601247844, 8557.058723540405, 8586.09845966174, 8594.570271486433, 8597.828043439127, 5998.730057147439, 6162.22972128484, 6175.50595952325, 8360.205780450848, 8468.957655211716, 6190.226221722285, 6239.15771370866, 8484.151584841527, 8670.826583468326, 8709.825803483927, 8674.0, 8738.432001919919, 8749.16882896124, 8764.912350876537, 8772.298216142724, 8407.70573029941, 8500.744977650618, 8519.062903080656, 8526.0, 8527.488350698915, 26759.788825341082, 27053.45893082147, 27068.0, 27084.86457567719, 27182.0, 3501.719862411001, 3575.570931488212, 3582.8387722552548, 3583.480395342661, 3592.2276710507103, 30932.381352373053, 31235.531467028013, 31243.37513249745, 31282.843585781924, 31305.217369565715, 3098.070578826343, 3154.558361829346, 3164.3671265746943, 3170.651228364878, 3187.378461200067, 267453.0, 271072.0, 271571.0, 271572.0, 271937.0, 49639.75180124076, 49654.75172624186, 49657.0, 49722.502774971785, 49809.50190498048, 52882.06768984683, 52942.0, 53034.73482632639, 53077.67305817308, 53090.73454632702, 14593.708125837424, 14758.966872318835, 14773.0, 14775.26123693811, 14800.481983130754, 11960.102992275613, 12002.339871306987, 12006.87993120075, 12009.519619215309, 12056.87943120575, 11303.604373846876, 12939.0, 13095.541656042184, 13182.231731336335, 13234.139780914209, 4721.739213972087, 5798.217240672539, 5864.706764661835, 5873.706314684248, 5875.647461152259, 980.8970058143792, 998.1017084623752, 1034.8085604163102, 1053.7997780421695, 1079.7030816525362, 24202.87898560531, 24448.87775561111, 24480.26559203227, 24495.38761530976, 24551.63172552413, 905.7328088213993, 1127.3799410324289, 1165.8018136916744, 1170.8770579089244, 1173.7828501727208, 11526.308421494738, 11965.341906195243, 12515.812262816065, 12548.0, 12608.81086783699, 289126.0, 289746.0, 289840.0, 291945.0, 292674.0, 54624.54189561479, 54676.726616366665, 54791.45208547863, 54802.72598637061, 54952.0, 1501.8948673592743, 1548.256836718359, 1562.8359022302723, 1572.9528114156594, 1579.4156162219822, 18081.457556273333, 23877.0, 23881.402964926016, 23936.281911542683, 24023.27930162098, 38805.0, 39134.21731565296, 39147.0, 39226.6077339223, 39237.41143882901, 271268.93096603174, 271945.0, 272583.0, 272977.0, 273521.0, 34041.0, 34080.48879266763, 34150.63397464074, 34169.97490075302, 34186.461609227146, 45491.0, 45790.084198315184, 46446.53553464422, 46522.0, 46537.30194047024, 28857.422851542433, 29526.852365738036, 30266.0, 30883.764649414672, 31468.52797207998, 31250.843745781127, 31563.36873262476, 31638.367232654757, 32064.83967580147, 32133.196670083435, 36759.08102297464, 36813.81593092017, 37014.44478332773, 37408.81295593505, 37519.62480375161, 31098.067057988297, 31280.21799455032, 31517.684823151474, 32313.030609080826, 32342.676573233966, 24042.75957240405, 24164.87917560401, 24175.506460360306, 24428.75571244265, 24772.25683229506], "value": 17229.986010388704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.43238434163703, 438.3709377043941, 444.34459172720244, 445.7303331484452, 461.506188378435, 19971.301004464847, 21325.786742132575, 21591.812450315225, 22081.33755987319, 22231.221907233252, 21965.780342196573, 22367.88160591972, 22634.66048009281, 22708.318750437513, 22750.74870882105, 6125.479334256594, 6227.190465239512, 6253.937460625404, 6337.746490140412, 6341.8097457076365, 6091.263989762919, 6292.716827742763, 6305.432511074003, 6311.495080393557, 6318.336574659664, 6014.752033901688, 6228.408301211378, 6267.686615669221, 6283.842903927415, 6290.2451705795365, 6116.541259405562, 6224.533160012995, 6278.937210627881, 6284.24589049317, 6285.0886621440095, 5490.286262785852, 5606.271184745998, 5606.6636001839615, 5613.494785469327, 5625.212470254168, 21142.78857211439, 26716.33209169767, 26725.599116013276, 26727.599086013724, 26830.0, 1880.6614809334314, 2224.0547767198877, 2224.5773303072365, 2229.710137682107, 2230.9330720078424, 17490.737638935425, 17614.735778963324, 17811.376601819004, 18104.63790724178, 18287.72568411475, 1912.0, 2118.2374345235703, 2145.442185031887, 2208.5582883423217, 2208.8785116818567, 150843.0, 151431.5567398398, 152990.23504882405, 154183.0, 155983.0, 11411.543538258542, 11650.941745291218, 11720.0, 12271.877281227253, 12279.815802762965, 14719.497685393295, 15250.161241131844, 15251.0, 15265.771013434807, 15310.387584496719, 8969.237614802814, 9000.624765712857, 9063.954680226689, 9081.727548173434, 9232.215261702697, 6970.79087627372, 8670.306375489945, 8677.783055423539, 8684.175003374668, 8830.558472076498, 7725.961370193113, 7868.960655196802, 7908.841823163504, 7921.603919803987, 7929.920700793034, 1737.3658614605831, 2131.680247962818, 2148.7528934172456, 2170.4573856535867, 2328.895199716017, 944.3908678902206, 959.3428501476371, 978.5351957819978, 1002.1832206751474, 1026.440589878518, 19455.90272048659, 20507.17971281132, 20955.8952205238, 21155.8942205288, 21216.0, 982.9901700982898, 983.9704808855746, 1014.8579198912158, 1020.2195320579763, 1022.9232807539464, 10698.197635177237, 10899.0, 10915.890841091488, 10994.945025274823, 11016.17378696601, 538523.0, 541889.0, 565741.0, 567427.0, 577212.0, 130894.0, 131091.0, 131990.0, 132474.33762831124, 134971.0, 1156.6125348008343, 1160.4081918221768, 1179.3454632678774, 1183.1836033137108, 1183.408295852074, 17183.14084295805, 17724.291028359235, 18253.0, 18339.63320733551, 18479.630407392047, 57230.427695724175, 57520.71239643775, 58560.0, 58784.0, 58922.82154356975, 61208.081878770965, 64318.678406607665, 71038.93441598484, 77996.27013054516, 80038.0, 8335.749927502186, 8566.100559441169, 8733.344999124964, 9080.637904314406, 9262.629494820132, 12232.204906681038, 12327.198732082386, 12767.489300427878, 14332.785008225093, 14344.784828227794, 11909.344986025852, 11998.04015678761, 12190.268583884641, 12287.385630718607, 12308.076894232789, 10616.575336986434, 11236.0, 11387.0, 11786.410679466164, 11833.230839995716, 11966.521339146684, 11977.520899163936, 12223.0, 12310.81533777012, 12339.93830030844, 8966.910330896868, 8969.327300452362, 9038.954805225932, 9044.909550904407, 9062.728118156467, 11758.647240582795, 11869.050475962074, 12155.574554890536, 12158.392080395768, 12191.695207619881], "value": 10383.715928327527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.5856313824283, 1460.9707805843884, 1488.032778693849, 1488.0773920169497, 1488.5608745420104, 11518.136139789518, 12035.157538972275, 12038.51845926164, 12039.036877049826, 12040.51837926484, 11413.828792568098, 11729.882701172986, 11940.164188506786, 11953.820692689616, 11953.983911367544, 2531.9113831015966, 2576.896924123033, 2579.703334116582, 2588.5987671910884, 2594.8572828494425, 2109.6308146074375, 2418.3349578865864, 2519.748025197484, 2549.6940367155967, 2564.5512035393826, 2201.1745595401726, 2234.6089434349005, 2461.889214985321, 2557.6163575463643, 2564.269183282765, 2500.549901017816, 2521.747825217482, 2532.227670560478, 2534.341071321451, 2537.035926347985, 2516.4967006598754, 2522.066835270943, 2527.7093134289607, 2528.2288901884917, 2528.6207068939807, 11731.648050558497, 11961.700957476045, 11969.521219151311, 11980.161388702794, 11984.58053968107, 6631.2705602384185, 6900.551464154814, 6912.930870691329, 6913.41235994936, 6921.688524016431, 4005.2990726622725, 4185.686073544496, 4304.655627549789, 4342.913141737147, 4352.064306174156, 1087.456271864068, 1226.5400474821943, 1227.5580790915262, 1285.7492788906168, 1300.4473098932915, 16682.66634667312, 16796.32814687411, 16815.327386904508, 16815.991040537607, 16823.242954067096, 5487.8444894186005, 5565.132233097958, 5613.494785469327, 5640.435956404409, 5731.369549349568, 12513.998880089572, 12516.68708282282, 12528.185667931555, 12534.623961280993, 12540.749185016248, 6740.730370785113, 6756.391924726799, 6759.290274521104, 6760.594364338155, 6764.661766911635, 6036.426539478743, 6211.937880621226, 6277.905831412532, 6282.748690052438, 6323.747050117944, 4229.175310814362, 4352.521222665504, 4388.407564978751, 4405.31717583775, 4429.335599660012, 1257.4215860703996, 1286.4468278640088, 1292.8125421813784, 1306.6929271621161, 1309.5809341010975, 672.0617183305824, 701.3372363116806, 788.6805843633338, 813.8657121574873, 827.2885318625977, 5986.730597123053, 6650.168728908887, 6748.662566871637, 6906.343897329745, 6926.549774264657, 583.5781506747034, 595.8986972214648, 610.5573459242103, 613.2395829171795, 708.9184743754431, 4006.6561061779184, 4239.724417912826, 4304.923769057736, 4362.214801335726, 4368.978155109204, 14820.481283155037, 15562.0, 15582.376704931676, 15586.0, 15595.688086238439, 15084.849151508344, 15223.695526089416, 15274.38902443912, 15488.922555387151, 15499.767503487457, 8575.742727718178, 8693.347998900108, 8794.42836215644, 8805.735827925173, 8869.290456763443, 6640.667966601747, 6676.265610782712, 6704.832379190364, 6790.354916282945, 6816.659167041727, 13586.864131358956, 13684.110532815335, 13698.726025479635, 14023.228722420365, 14034.719305614035, 13788.241646709528, 13910.72178556403, 14217.146971181763, 14297.285135742963, 14379.28103594837, 9234.630614775602, 9534.380265282734, 9552.044795520393, 9554.235661146953, 9582.425054496753, 10895.673129806119, 10919.181061420584, 10966.287191332538, 10996.065334446661, 11026.0076593107, 9319.18249982531, 9326.906730932875, 9334.39326443779, 9447.763805904908, 9563.139317461184, 9113.635454581743, 9150.267978561566, 9168.404053736485, 9195.540222988957, 9207.815843682954, 8173.959130204311, 8321.459105158145, 8321.750347489586, 8332.125126861834, 8337.08292087882, 5998.4601385875485, 6007.729652165575, 6122.877542449215, 6165.32181460048, 6237.7232310207355, 6094.603850749687, 6118.663473508822, 6214.130021797043, 6247.875042499034, 6357.1735674362035], "value": 5404.589295674667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.5252996769829, 403.7355532126458, 407.78183671735616, 416.7374554030962, 419.8467559340842, 5113.002964421939, 5694.715264236782, 5889.676067816268, 5908.615939963899, 5973.551983601236, 5633.746481408336, 5639.812072412642, 5753.942460575393, 5870.383609720971, 5925.4963328117055, 4464.397306363632, 4481.708688935225, 4484.663650226246, 4487.035287413206, 4524.68327217095, 4480.775961201944, 4500.189965806154, 4501.122281155176, 4516.0, 4525.728456292616, 4262.232798096342, 4447.466304043519, 4462.219111655463, 4468.776561171945, 4497.235469970113, 4414.470263568376, 4416.608768237995, 4421.93873470368, 4434.135343607998, 4434.290513517822, 3914.0, 3920.5687374388795, 3944.625260600267, 3946.48695669564, 3983.6215559521797, 5466.0, 5672.659640421588, 5727.971360143214, 5750.367459579443, 5790.276215473066, 4261.573842615745, 5356.705381204032, 5384.6499977501335, 5389.946100538984, 5392.004958165465, 5710.0, 5737.540996720252, 6312.305646378894, 6319.399657032574, 6331.33520980295, 3679.4480827875764, 4399.134138677461, 4493.370928070073, 4531.184386810372, 4559.635229181657, 5344.6258761887075, 5364.390682795185, 6322.652254126021, 6532.6733663316645, 6594.505412094064, 4476.843310484118, 4477.70894891831, 4482.731036137842, 4483.170613436525, 4494.303382975644, 4554.675087186372, 4672.6261899047995, 4676.976615116902, 4712.926312422524, 4725.5510726480925, 4530.142641517028, 4655.51117132703, 5204.9219261711105, 5393.514583687487, 5423.83728488146, 6219.564630475914, 6230.816144932448, 6232.127502149703, 6246.968765156145, 6255.749770009149, 1587.9364825407085, 1611.73406387947, 1615.3215649427268, 1619.1661294433377, 1626.2600516764844, 1044.1177205261542, 1056.8995945385177, 1076.5950434682657, 1092.4373947417087, 1132.5356603792407, 5195.740212989335, 5562.666240025531, 5939.792107276311, 5944.5838791284195, 5977.402259773988, 6189.84525386869, 6477.805665830033, 6504.934950650433, 6510.772122975768, 6514.9674251629385, 4956.603471722254, 5530.059889818741, 5763.884722305615, 5790.7973220937065, 5905.254056863493, 3333.8166400848186, 3342.5988881334397, 3369.685822529216, 3383.2218589724007, 3404.7276217903004, 6032.969835150796, 6048.939510604838, 6323.557350985387, 6631.933680663132, 6643.169603799525, 6271.560990730696, 6629.204495460575, 6630.535862489676, 6683.732650693918, 6688.86622267552, 5810.883782324415, 6409.929694643934, 6586.242582103119, 6633.900491492632, 6636.933630663631, 5870.7945221917025, 6243.43809057187, 6473.158489396348, 6479.611223326616, 6480.416762491398, 5464.207689885024, 5745.693956892486, 5782.5663075268685, 6169.81490555284, 6329.30377658448, 5534.1975413564005, 5738.569607279387, 6581.0, 6696.296888826603, 6717.0, 3924.7252692311263, 4087.6321131098343, 4635.0, 4725.432948046257, 4745.434006777686, 5276.445973172915, 5649.802256920988, 5931.042755890459, 6370.426661600478, 6541.6402097885075, 5792.4497172768515, 6250.687465626609, 6280.560360774702, 6285.2457705075685, 6287.151234583455, 4524.615407690251, 5402.891942161056, 6237.563370564017, 6277.843053923689, 6317.9052314214405, 5361.785528578969, 5368.758405871667, 5781.161731548986, 6166.537509686881, 6227.626342419469, 4739.952600473951, 5474.795544980098, 5663.461971112738, 5718.942810571841, 6337.7817763782305, 5299.629025968299, 6015.736695294037, 6115.785947491817, 6169.784057557964, 6174.228221472316], "value": 4619.412971601942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.9189343225524, 793.8729803231485, 868.7784614923197, 871.6992637540051, 882.63370701159, 13692.178469291837, 18044.368447104353, 18177.727334089966, 18754.718679219823, 18768.249270029217, 17486.300547978066, 17766.46700598984, 18092.185851636674, 18177.81822181778, 18187.27250909962, 960.2749923807515, 990.866233058535, 994.607130183577, 994.6866736977865, 997.1723469520317, 668.7191379620571, 688.9001094841245, 694.4826104552116, 1009.1623952119724, 1011.2264117949775, 749.9400047996147, 752.1801236652049, 1003.0922015575879, 1052.715766742979, 1065.8081545321838, 1033.447105798398, 1035.4305132177271, 1035.9637412690558, 1037.1339931157493, 1037.3931250218632, 776.281939206232, 776.7009701264997, 776.7592046465613, 777.0752804163028, 780.4575819805237, 15075.773863392058, 15229.61925951849, 15965.44120955761, 16609.169541522875, 16796.0, 16693.499195024167, 16783.412580559743, 17049.48851534456, 17201.569960750956, 17442.912785436118, 13848.169109853341, 13969.231692256923, 14081.0, 14164.929175354056, 14287.499937502138, 3397.3205358928312, 3428.639992800745, 3428.7257019438384, 3432.2792213635166, 3432.5880894292845, 107639.46180269126, 107899.0, 108005.0, 108049.0, 108307.0, 11363.54545818158, 11771.411429428666, 11809.291442513477, 12052.216605920763, 12052.33712145823, 19702.70445943312, 24720.629190562155, 25321.493570128496, 25624.23127306184, 25694.229173124837, 7618.733344332922, 7851.097123830833, 7855.293023627901, 7856.096548896836, 7860.371170306362, 3599.208174201671, 3690.760100593453, 3746.587875333711, 3749.362608356586, 3753.530808648919, 4380.4305440292555, 4495.033567782943, 4506.053728716941, 4506.143832671847, 4514.525974772667, 793.3137835772015, 953.0612346838359, 953.7997020625608, 970.4710932541782, 971.820213260549, 634.0742515926706, 637.3817397124782, 638.2851206648584, 647.3106141958799, 670.7451168555917, 9092.590833412512, 10751.08615767653, 11012.17408694351, 11499.597514086967, 11888.227265227733, 635.9173307470091, 645.7901182115831, 646.7703965092325, 667.6561570791047, 687.656171914043, 5083.110455670243, 5269.578433725293, 5355.651882627617, 5425.133556343318, 5472.890542189134, 103642.0, 104855.0, 105266.47366763117, 105752.88494230072, 108136.4593177029, 86096.56951715202, 90728.5463572678, 92636.53681731682, 95960.0403995965, 96289.03710962941, 61875.6906215466, 77462.61268693733, 77523.61238193772, 77562.6121869387, 78043.60978195073, 10494.265401422133, 10529.36823790575, 10872.673819785103, 12413.317267550372, 12690.682732931751, 39534.80232598819, 39558.208835822545, 39638.0, 41138.588614113476, 41497.96255093526, 70054.94917576342, 71823.64088179526, 72441.82674519773, 72951.0, 73052.63473682597, 16167.191640418167, 16419.014859108014, 16441.588960276087, 16518.83481165173, 16750.162491875115, 17717.91141044338, 17857.0, 17946.730799037763, 17950.19224134891, 18032.008239546427, 16572.41996530164, 16638.084905330325, 16709.16454177262, 16737.246823893198, 16881.07154106536, 15683.843161568238, 15900.204989750697, 16076.276567554254, 16169.110698911672, 16270.267837947084, 15631.76552351693, 15720.371185152466, 15748.370065197263, 15898.205089745697, 16021.279042443351, 11762.647120586396, 11902.880971190523, 12079.214851034654, 12188.75622487563, 12194.634160975185, 12475.0, 12566.497340106658, 12583.182093163916, 12593.559225427067, 12753.171043882117], "value": 8215.115560809845, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 110.0, 151.0, 112.0, 110.0, 110.0, 110.0, 139.0, 109.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 180.0, 185.0, 186.0, 186.0, 183.0, 183.0, 185.0, 180.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 88.0, 60.0, 60.0, 58.0, 58.0, 82.0, 60.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 86.0, 70.0, 69.0, 69.0, 90.0, 68.0, 69.0, 90.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 113.0, 152.0, 96.0, 93.0, 96.0, 95.0, 95.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 83.0, 83.0, 86.0, 125.0, 141.0, 87.0, 83.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 54.0, 59.0, 80.0, 77.0, 56.0, 51.0, 49.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 60.0, 57.0, 65.0, 62.0, 58.0, 58.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 85.0, 83.0, 82.0, 82.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 138.0, 135.0, 144.0, 136.0, 134.0, 188.0, 137.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 186.0, 195.0, 229.0, 196.0, 186.0, 186.0, 181.0, 193.0, 233.0], "value": 197.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 65.0, 67.0, 72.0, 87.0, 63.0, 67.0, 97.0], "value": 72.0, "unit": "score"}]}]} 10:01:12 INFO - Return code: 0 10:01:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:01:12 ERROR - # TBPL SUCCESS # 10:01:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:01:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:01:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:01:12 INFO - 2017-04-18 10:01:12.665 screenresolution[2658:33915] starting screenresolution argv=screenresolution get 10:01:12 INFO - 2017-04-18 10:01:12.667 screenresolution[2658:33915] Display 0: 1600x1200x32@60 10:01:12 INFO - 2017-04-18 10:01:12.673 screenresolution[2659:33918] starting screenresolution argv=screenresolution list 10:01:12 INFO - Available Modes on Display 0 10:01:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:01:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:01:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:01:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:01:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:01:12 INFO - Intel Iris: 10:01:12 INFO - Chipset Model: Intel Iris 10:01:12 INFO - Type: GPU 10:01:12 INFO - Bus: Built-In 10:01:12 INFO - VRAM (Dynamic, Max): 1536 MB 10:01:12 INFO - Vendor: Intel (0x8086) 10:01:12 INFO - Device ID: 0x0a2e 10:01:12 INFO - Revision ID: 0x0009 10:01:12 INFO - Displays: 10:01:12 INFO - Display: 10:01:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:01:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:01:12 INFO - Display Serial Number: 1600x1200 60 10:01:12 INFO - Main Display: Yes 10:01:12 INFO - Mirror: Off 10:01:12 INFO - Online: Yes 10:01:12 INFO - Rotation: Supported 10:01:12 INFO - Return code: 0 10:01:12 INFO - Running post-action listener: _resource_record_post_action 10:01:12 INFO - [mozharness: 2017-04-18 17:01:12.913177Z] Finished run-tests step (success) 10:01:12 INFO - Running post-run listener: _resource_record_post_run 10:01:12 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 1126912; Write bytes: 515658752; Read time: 6; Write time: 1597 10:01:12 INFO - TinderboxPrint: CPU usage
53.2% 10:01:12 INFO - TinderboxPrint: I/O read bytes / time
1,126,912 / 6 10:01:12 INFO - TinderboxPrint: I/O write bytes / time
515,658,752 / 1,597 10:01:12 INFO - TinderboxPrint: CPU idle
2,248.6 (46.8%) 10:01:12 INFO - TinderboxPrint: CPU system
952.9 (19.8%) 10:01:12 INFO - TinderboxPrint: CPU user
1,600.1 (33.3%) 10:01:12 INFO - TinderboxPrint: Swap in / out
209,256,448 / 0 10:01:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207841792; Write bytes: 207091712; Read time: 16050; Write time: 441 10:01:12 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 225792; Write bytes: 301505536; Read time: 3; Write time: 1125 10:01:13 INFO - Running post-run listener: _upload_blobber_files 10:01:13 INFO - Blob upload gear active. 10:01:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:01:13 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:01:13 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:01:13 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:01:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:15 INFO - (blobuploader) - INFO - Done attempting. 10:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:15 INFO - (blobuploader) - INFO - Done attempting. 10:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:16 INFO - (blobuploader) - INFO - Done attempting. 10:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:18 INFO - (blobuploader) - INFO - Done attempting. 10:01:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:01:18 INFO - Return code: 0 10:01:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:01:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:01:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c222e958ac781d0d40414ebd013ed114cc82147e26a0a00811d23c8c17c21345f22b08e6e2365046e6f55108e97ae78f3100421004f432f754f0db51ac7cd550", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/370cbac831f25493ac0d4d8b5fa8e0f4022e10f855014248bee29441128a9bc10d71855c073c4db988571c4f44256389987a76b23bb46761ccbd28b1eb5ca248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32cefc5089c26c35692bc56ad96d94c2dae8a082ccc8ab6c5fd2d189bd62d021d114826f14cd9467cda22ddd986cbcdb668d0daf16d625c3babfd8966cd9b23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c1732cadff3a64af4794641585b7aee1d4b8b18f7aecdf8f4b8019afe1cc8ab07ece9b1d1f477552066b2d4361766b0efa6d68bccdd0ddb4a8fc4ef9e39307"} 10:01:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:01:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:01:18 INFO - Contents: 10:01:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c222e958ac781d0d40414ebd013ed114cc82147e26a0a00811d23c8c17c21345f22b08e6e2365046e6f55108e97ae78f3100421004f432f754f0db51ac7cd550", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/370cbac831f25493ac0d4d8b5fa8e0f4022e10f855014248bee29441128a9bc10d71855c073c4db988571c4f44256389987a76b23bb46761ccbd28b1eb5ca248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32cefc5089c26c35692bc56ad96d94c2dae8a082ccc8ab6c5fd2d189bd62d021d114826f14cd9467cda22ddd986cbcdb668d0daf16d625c3babfd8966cd9b23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c1732cadff3a64af4794641585b7aee1d4b8b18f7aecdf8f4b8019afe1cc8ab07ece9b1d1f477552066b2d4361766b0efa6d68bccdd0ddb4a8fc4ef9e39307"} 10:01:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:01:18 INFO - Copying logs to upload dir... 10:01:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:01:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.256801 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-18 10:01:18.866710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 10:01:18.870735) ========= 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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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/Firefox/sha512/c222e958ac781d0d40414ebd013ed114cc82147e26a0a00811d23c8c17c21345f22b08e6e2365046e6f55108e97ae78f3100421004f432f754f0db51ac7cd550", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/370cbac831f25493ac0d4d8b5fa8e0f4022e10f855014248bee29441128a9bc10d71855c073c4db988571c4f44256389987a76b23bb46761ccbd28b1eb5ca248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32cefc5089c26c35692bc56ad96d94c2dae8a082ccc8ab6c5fd2d189bd62d021d114826f14cd9467cda22ddd986cbcdb668d0daf16d625c3babfd8966cd9b23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c1732cadff3a64af4794641585b7aee1d4b8b18f7aecdf8f4b8019afe1cc8ab07ece9b1d1f477552066b2d4361766b0efa6d68bccdd0ddb4a8fc4ef9e39307"} build_url:https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010825 build_url: 'https://queue.taskcluster.net/v1/task/RDANkd-vRH6h0ECg74j6Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c222e958ac781d0d40414ebd013ed114cc82147e26a0a00811d23c8c17c21345f22b08e6e2365046e6f55108e97ae78f3100421004f432f754f0db51ac7cd550", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/370cbac831f25493ac0d4d8b5fa8e0f4022e10f855014248bee29441128a9bc10d71855c073c4db988571c4f44256389987a76b23bb46761ccbd28b1eb5ca248", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b32cefc5089c26c35692bc56ad96d94c2dae8a082ccc8ab6c5fd2d189bd62d021d114826f14cd9467cda22ddd986cbcdb668d0daf16d625c3babfd8966cd9b23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c1732cadff3a64af4794641585b7aee1d4b8b18f7aecdf8f4b8019afe1cc8ab07ece9b1d1f477552066b2d4361766b0efa6d68bccdd0ddb4a8fc4ef9e39307"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 10:01:18.905228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 10:01:18.905639) ========= 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.9OrcGDZUvx/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.4Sp6pYxqBy/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 10:01:18.954509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 10:01:18.954880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 10:01:18.955244) ========= ========= Total master_lag: 0.23 =========