builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0246 starttime: 1493722493.08 results: success (0) buildid: 20170502020521 builduid: 49c1ac31e280463b96c8898c098a62a7 revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.080968) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.081502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.081775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.109521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.109902) ========= 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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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-05-02 03:54:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-05-02 03:54:53 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087384 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.222358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.222672) ========= 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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.027523 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:53.272534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 03:54:53.272881) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --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 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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-05-02 03:54:53,372 truncating revision to first 12 chars 2017-05-02 03:54:53,372 Setting DEBUG logging. 2017-05-02 03:54:53,373 attempt 1/10 2017-05-02 03:54:53,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48c0fd9c9ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 03:54:55,009 unpacking tar archive at: mozilla-central-48c0fd9c9ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.913045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 03:54:55.210209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:55.210571) ========= script_repo_revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:55.210979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:55.211259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:55.232551) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-05-02 03:54:55.232996) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:54:55 INFO - MultiFileLogger online at 20170502 03:54:55 in /builds/slave/test 03:54:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:54:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:55 INFO - {'append_to_log': False, 03:54:55 INFO - 'base_work_dir': '/builds/slave/test', 03:54:55 INFO - 'blob_upload_branch': 'Firefox', 03:54:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:55 INFO - 'branch': 'Firefox', 03:54:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:55 INFO - 'config_files': ('talos/mac_config.py',), 03:54:55 INFO - 'default_actions': ('clobber', 03:54:55 INFO - 'read-buildbot-config', 03:54:55 INFO - 'download-and-extract', 03:54:55 INFO - 'populate-webroot', 03:54:55 INFO - 'create-virtualenv', 03:54:55 INFO - 'install', 03:54:55 INFO - 'run-tests'), 03:54:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:55 INFO - 'download_minidump_stackwalk': True, 03:54:55 INFO - 'download_symbols': 'ondemand', 03:54:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:55 INFO - 'gecko_profile': False, 03:54:55 INFO - 'gecko_profile_interval': 0, 03:54:55 INFO - 'installer_path': 'installer.exe', 03:54:55 INFO - 'log_level': 'info', 03:54:55 INFO - 'log_name': 'talos', 03:54:55 INFO - 'log_to_console': True, 03:54:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:54:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:54:55 INFO - 'opt_config_files': (), 03:54:55 INFO - 'pip_index': False, 03:54:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:55 INFO - 'cmd': ('bash', 03:54:55 INFO - '-c', 03:54:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:55 INFO - 'enabled': True, 03:54:55 INFO - 'halt_on_failure': False, 03:54:55 INFO - 'name': 'check_screen_resolution'},), 03:54:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:55 INFO - 'cmd': ('bash', 03:54:55 INFO - '-c', 03:54:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:55 INFO - 'enabled': True, 03:54:55 INFO - 'halt_on_failure': False, 03:54:55 INFO - 'name': 'check_screen_resolution'},), 03:54:55 INFO - 'run_cmd_checks_enabled': True, 03:54:55 INFO - 'suite': 'dromaeojs-e10s', 03:54:55 INFO - 'system_bits': '32', 03:54:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:55 INFO - 'title': 't-yosemite-r7-0246', 03:54:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:55 INFO - 'use_talos_json': True, 03:54:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:55 INFO - 'work_dir': 'build'} 03:54:55 INFO - [mozharness: 2017-05-02 10:54:55.437414Z] Running clobber step. 03:54:55 INFO - Running pre-action listener: _resource_record_pre_action 03:54:55 INFO - Running main action method: clobber 03:54:55 INFO - rmtree: /builds/slave/test/build 03:54:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:57 INFO - Running post-action listener: _resource_record_post_action 03:54:57 INFO - [mozharness: 2017-05-02 10:54:57.866736Z] Finished clobber step (success) 03:54:57 INFO - [mozharness: 2017-05-02 10:54:57.866863Z] Running read-buildbot-config step. 03:54:57 INFO - Running pre-action listener: _resource_record_pre_action 03:54:57 INFO - Running main action method: read_buildbot_config 03:54:57 INFO - Using buildbot properties: 03:54:57 INFO - { 03:54:57 INFO - "project": "", 03:54:57 INFO - "product": "firefox", 03:54:57 INFO - "script_repo_revision": "production", 03:54:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:54:57 INFO - "repository": "", 03:54:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:54:57 INFO - "buildid": "20170502020521", 03:54:57 INFO - "pgo_build": "False", 03:54:57 INFO - "basedir": "/builds/slave/test", 03:54:57 INFO - "buildnumber": 56, 03:54:57 INFO - "slavename": "t-yosemite-r7-0246", 03:54:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:54:57 INFO - "platform": "yosemite_r7", 03:54:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:54:57 INFO - "branch": "mozilla-central", 03:54:57 INFO - "repo_path": "mozilla-central", 03:54:57 INFO - "revision": "48c0fd9c9ec5d68061ea7b59358874ae8da72572", 03:54:57 INFO - "stage_platform": "macosx64", 03:54:57 INFO - "builduid": "49c1ac31e280463b96c8898c098a62a7", 03:54:57 INFO - "slavebuilddir": "test" 03:54:57 INFO - } 03:54:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:54:57 INFO - Running post-action listener: _resource_record_post_action 03:54:57 INFO - [mozharness: 2017-05-02 10:54:57.870105Z] Finished read-buildbot-config step (success) 03:54:57 INFO - [mozharness: 2017-05-02 10:54:57.870235Z] Running download-and-extract step. 03:54:57 INFO - Running pre-action listener: _resource_record_pre_action 03:54:57 INFO - Running main action method: download_and_extract 03:54:57 INFO - mkdir: /builds/slave/test/build/tests 03:54: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')]} 03:54:57 INFO - trying https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:54:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:54:59 INFO - Downloaded 1325 bytes. 03:54:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:54:59 INFO - Using the following test package requirements: 03:54:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:54:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:54:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:54:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:54:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'jsshell-mac.zip'], 03:54:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:54:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:54:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:54:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:54:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:54:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:54:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:54:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:54:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:54:59 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:55:00 INFO - Content-Length response header: 52702499 03:55:00 INFO - Bytes received: 52702499 03:55:16 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 03:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:55:18 INFO - Content-Length response header: 52702499 03:55:18 INFO - Bytes received: 52702499 03:55:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:55:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:55:33 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:55:34 INFO - Content-Length response header: 14408811 03:55:34 INFO - Bytes received: 14408811 03:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:34 INFO - trying https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:34 INFO - Downloading https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:55:36 INFO - Downloaded 71249407 bytes. 03:55:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:36 INFO - mkdir: /builds/slave/test/properties 03:55:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:36 INFO - Contents: 03:55:36 INFO - build_url:https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:37 INFO - Running post-action listener: _resource_record_post_action 03:55:37 INFO - Running post-action listener: set_extra_try_arguments 03:55:37 INFO - [mozharness: 2017-05-02 10:55:37.340463Z] Finished download-and-extract step (success) 03:55:37 INFO - [mozharness: 2017-05-02 10:55:37.340607Z] Running populate-webroot step. 03:55:37 INFO - Running pre-action listener: _resource_record_pre_action 03:55:37 INFO - Running main action method: populate_webroot 03:55:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:37 INFO - '--tppagecycles', 03:55:37 INFO - '7'], 03:55:37 INFO - 'tests': ['tsvgm']}}, 03:55:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:55:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['damp', 'tps']}, 03:55:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'tests': ['damp', 'tps']}, 03:55:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['dromaeo_dom']}, 03:55:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:55:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:55:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['a11yr', 03:55:37 INFO - 'ts_paint', 03:55:37 INFO - 'tpaint', 03:55:37 INFO - 'sessionrestore', 03:55:37 INFO - 'sessionrestore_no_auto_restore', 03:55:37 INFO - 'tabpaint']}, 03:55:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:55:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:55:37 INFO - 'bloom_basic_ref']}, 03:55:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['tsvgx', 03:55:37 INFO - 'tsvgr_opacity', 03:55:37 INFO - 'tart', 03:55:37 INFO - 'tscrollx', 03:55:37 INFO - 'cart', 03:55:37 INFO - 'tsvg_static']}, 03:55:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:37 INFO - 'tsvgr_opacity', 03:55:37 INFO - 'tart', 03:55:37 INFO - 'tscrollx', 03:55:37 INFO - 'cart', 03:55:37 INFO - 'tsvg_static']}, 03:55:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'talos_options': ['--disable-e10s'], 03:55:37 INFO - 'tests': ['tp5o']}, 03:55:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:55:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'talos_options': ['--disable-e10s', 03:55:37 INFO - '--xperf_path', 03:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:37 INFO - 'tests': ['tp5n']}, 03:55:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:55:37 INFO - 'talos_options': ['--xperf_path', 03:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:37 INFO - 'tests': ['tp5n']}}, 03:55:37 INFO - 'talos.zip': {'path': '', 03:55:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:37 INFO - Running post-action listener: _resource_record_post_action 03:55:37 INFO - [mozharness: 2017-05-02 10:55:37.359629Z] Finished populate-webroot step (success) 03:55:37 INFO - [mozharness: 2017-05-02 10:55:37.359719Z] Running create-virtualenv step. 03:55:37 INFO - Running pre-action listener: _resource_record_pre_action 03:55:37 INFO - Running main action method: create_virtualenv 03:55:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:37 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 03:55:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:55:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:37 INFO - Using real prefix '/tools/python27' 03:55:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:41 INFO - Installing pip.................done. 03:55:41 INFO - Return code: 0 03:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:55:41 INFO - Reading from file tmpfile_stdout 03:55:41 INFO - Output received: 03:55:41 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) 03:55:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:41 INFO - 'HOME': '/Users/cltbld', 03:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:41 INFO - 'LOGNAME': 'cltbld', 03:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:41 INFO - 'MOZ_NO_REMOTE': '1', 03:55:41 INFO - 'NO_EM_RESTART': '1', 03:55:41 INFO - 'PAGER': '/bin/cat', 03:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:41 INFO - 'PWD': '/builds/slave/test', 03:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:41 INFO - 'SHELL': '/bin/bash', 03:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:41 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:41 INFO - 'USER': 'cltbld', 03:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:41 INFO - 'XPC_FLAGS': '0x0', 03:55:41 INFO - 'XPC_SERVICE_NAME': '0', 03:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:41 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 03:55:41 INFO - Cleaning up... 03:55:41 INFO - Return code: 0 03:55:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:41 INFO - 'HOME': '/Users/cltbld', 03:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:41 INFO - 'LOGNAME': 'cltbld', 03:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:41 INFO - 'MOZ_NO_REMOTE': '1', 03:55:41 INFO - 'NO_EM_RESTART': '1', 03:55:41 INFO - 'PAGER': '/bin/cat', 03:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:41 INFO - 'PWD': '/builds/slave/test', 03:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:41 INFO - 'SHELL': '/bin/bash', 03:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:41 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:41 INFO - 'USER': 'cltbld', 03:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:41 INFO - 'XPC_FLAGS': '0x0', 03:55:41 INFO - 'XPC_SERVICE_NAME': '0', 03:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:41 INFO - Downloading/unpacking psutil>=3.1.1 03:55:41 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 03:55:41 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 03:55:41 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 03:55:41 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 03:55:41 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 03:55:41 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 03:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:45 INFO - Installing collected packages: psutil 03:55:45 INFO - Running setup.py install for psutil 03:55:45 INFO - building 'psutil._psutil_osx' extension 03:55:45 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 03:55:46 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 03:55:46 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 03:55:46 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 03:55:46 INFO - building 'psutil._psutil_posix' extension 03:55:46 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 03:55:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:55:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:55:46 INFO - ^ 03:55:46 INFO - 1 warning generated. 03:55:46 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 03:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:46 INFO - Successfully installed psutil 03:55:46 INFO - Cleaning up... 03:55:46 INFO - Return code: 0 03:55:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55:46 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')]} 03:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 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')]} 03:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:46 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 03:55:46 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 03:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:46 INFO - 'HOME': '/Users/cltbld', 03:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:46 INFO - 'LOGNAME': 'cltbld', 03:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:46 INFO - 'MOZ_NO_REMOTE': '1', 03:55:46 INFO - 'NO_EM_RESTART': '1', 03:55:46 INFO - 'PAGER': '/bin/cat', 03:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:46 INFO - 'PWD': '/builds/slave/test', 03:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:46 INFO - 'SHELL': '/bin/bash', 03:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:46 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:46 INFO - 'USER': 'cltbld', 03:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:46 INFO - 'XPC_FLAGS': '0x0', 03:55:46 INFO - 'XPC_SERVICE_NAME': '0', 03:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55:46 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 03:55:46 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 03:55:46 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 03:55:46 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 03:55:46 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 03:55:46 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 03:55:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:49 INFO - Installing collected packages: mozsystemmonitor 03:55:49 INFO - Running setup.py install for mozsystemmonitor 03:55:49 INFO - Successfully installed mozsystemmonitor 03:55:49 INFO - Cleaning up... 03:55:49 INFO - Return code: 0 03:55:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:49 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')]} 03:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:50 INFO - 'HOME': '/Users/cltbld', 03:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:50 INFO - 'LOGNAME': 'cltbld', 03:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:50 INFO - 'MOZ_NO_REMOTE': '1', 03:55:50 INFO - 'NO_EM_RESTART': '1', 03:55:50 INFO - 'PAGER': '/bin/cat', 03:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:50 INFO - 'PWD': '/builds/slave/test', 03:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:50 INFO - 'SHELL': '/bin/bash', 03:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:50 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:50 INFO - 'USER': 'cltbld', 03:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:50 INFO - 'XPC_FLAGS': '0x0', 03:55:50 INFO - 'XPC_SERVICE_NAME': '0', 03:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:53 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 03:55:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:54 INFO - warning: no files found matching '*.txt' 03:55:54 INFO - no previously-included directories found matching 'build' 03:55:54 INFO - no previously-included directories found matching 'dist' 03:55:54 INFO - no previously-included directories found matching '.git*' 03:55:54 INFO - Installing collected packages: jsonschema, functools32 03:55:54 INFO - Running setup.py install for functools32 03:55:54 INFO - warning: no files found matching '*.txt' 03:55:54 INFO - no previously-included directories found matching 'build' 03:55:54 INFO - no previously-included directories found matching 'dist' 03:55:54 INFO - no previously-included directories found matching '.git*' 03:55:54 INFO - Successfully installed jsonschema functools32 03:55:54 INFO - Cleaning up... 03:55:54 INFO - Return code: 0 03:55:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55:54 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')]} 03:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:54 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')]} 03:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:54 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:54 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 03:55:54 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 03:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:54 INFO - 'HOME': '/Users/cltbld', 03:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:54 INFO - 'LOGNAME': 'cltbld', 03:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:54 INFO - 'MOZ_NO_REMOTE': '1', 03:55:54 INFO - 'NO_EM_RESTART': '1', 03:55:54 INFO - 'PAGER': '/bin/cat', 03:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:54 INFO - 'PWD': '/builds/slave/test', 03:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:54 INFO - 'SHELL': '/bin/bash', 03:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:54 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:54 INFO - 'USER': 'cltbld', 03:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:54 INFO - 'XPC_FLAGS': '0x0', 03:55:54 INFO - 'XPC_SERVICE_NAME': '0', 03:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:54 INFO - Cleaning up... 03:55:54 INFO - Return code: 0 03:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55:54 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')]} 03:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:54 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')]} 03:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:54 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:55:54 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 03:55:54 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 03:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:54 INFO - 'HOME': '/Users/cltbld', 03:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:54 INFO - 'LOGNAME': 'cltbld', 03:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:54 INFO - 'MOZ_NO_REMOTE': '1', 03:55:54 INFO - 'NO_EM_RESTART': '1', 03:55:54 INFO - 'PAGER': '/bin/cat', 03:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:54 INFO - 'PWD': '/builds/slave/test', 03:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:54 INFO - 'SHELL': '/bin/bash', 03:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:55:54 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:54 INFO - 'USER': 'cltbld', 03:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:54 INFO - 'XPC_FLAGS': '0x0', 03:55:54 INFO - 'XPC_SERVICE_NAME': '0', 03:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:59 INFO - Downloading docopt-0.6.1.tar.gz 03:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:59 INFO - Running setup.py install for blobuploader 03:55:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:59 INFO - Running setup.py install for requests 03:55:59 INFO - Running setup.py install for docopt 03:55:59 INFO - Successfully installed blobuploader requests docopt 03:55:59 INFO - Cleaning up... 03:56:00 INFO - Return code: 0 03:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:00 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:56:00 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 03:56:00 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 03:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:00 INFO - 'HOME': '/Users/cltbld', 03:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:00 INFO - 'LOGNAME': 'cltbld', 03:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:00 INFO - 'MOZ_NO_REMOTE': '1', 03:56:00 INFO - 'NO_EM_RESTART': '1', 03:56:00 INFO - 'PAGER': '/bin/cat', 03:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:00 INFO - 'PWD': '/builds/slave/test', 03:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:00 INFO - 'SHELL': '/bin/bash', 03:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:56:00 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:00 INFO - 'USER': 'cltbld', 03:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:00 INFO - 'XPC_FLAGS': '0x0', 03:56:00 INFO - 'XPC_SERVICE_NAME': '0', 03:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-UV7qFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4oeYIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-HbW73A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-hikwmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-3p0IEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-otXc47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:00 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-JZt4Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-PdECrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-qt8qdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xNsJuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YVHnlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-RrRpAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-qMSHUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-k5TbT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ssB_mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-i6dPV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-IjhYrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:02 INFO - Running setup.py install for manifestparser 03:56:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:02 INFO - Running setup.py install for mozcrash 03:56:02 INFO - Running setup.py install for mozdebug 03:56:02 INFO - Running setup.py install for mozdevice 03:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:02 INFO - Running setup.py install for mozfile 03:56:02 INFO - Running setup.py install for mozhttpd 03:56:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:02 INFO - Running setup.py install for mozinfo 03:56:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Running setup.py install for mozInstall 03:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Running setup.py install for mozleak 03:56:03 INFO - Running setup.py install for mozlog 03:56:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Running setup.py install for moznetwork 03:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Running setup.py install for mozprocess 03:56:03 INFO - Running setup.py install for mozprofile 03:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:56:04 INFO - Running setup.py install for mozrunner 03:56:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:56:04 INFO - Running setup.py install for mozscreenshot 03:56:04 INFO - Running setup.py install for moztest 03:56:04 INFO - Running setup.py install for mozversion 03:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:04 INFO - Cleaning up... 03:56:04 INFO - Return code: 0 03:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:04 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')]} 03:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:04 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')]} 03:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:04 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:56:04 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 03:56:04 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 03:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:04 INFO - 'HOME': '/Users/cltbld', 03:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:04 INFO - 'LOGNAME': 'cltbld', 03:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:04 INFO - 'MOZ_NO_REMOTE': '1', 03:56:04 INFO - 'NO_EM_RESTART': '1', 03:56:04 INFO - 'PAGER': '/bin/cat', 03:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:04 INFO - 'PWD': '/builds/slave/test', 03:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:04 INFO - 'SHELL': '/bin/bash', 03:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:56:04 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:04 INFO - 'USER': 'cltbld', 03:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:04 INFO - 'XPC_FLAGS': '0x0', 03:56:04 INFO - 'XPC_SERVICE_NAME': '0', 03:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:04 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-B79A_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-m0QKgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-IEJLgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-_Epu4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YWr5qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-_G2wAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Gn84DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Ub9MN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-5ITFYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-tec5Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:05 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)) 03:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:05 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-hyqFYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-GL5jTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-w_psTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-52iJ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-8TBxB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-MtAwdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:06 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)) 03:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:06 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-i4ZjC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:06 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)) 03:56:06 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)) 03:56:06 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)) 03:56:06 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)) 03:56:06 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)) 03:56:06 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)) 03:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:06 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 03:56:09 INFO - Downloading blessings-1.6.tar.gz 03:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:09 INFO - Installing collected packages: blessings 03:56:09 INFO - Running setup.py install for blessings 03:56:09 INFO - Successfully installed blessings 03:56:09 INFO - Cleaning up... 03:56:09 INFO - Return code: 0 03:56:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:09 INFO - Reading from file tmpfile_stdout 03:56:09 INFO - Current package versions: 03:56:09 INFO - blessings == 1.6 03:56:09 INFO - blobuploader == 1.2.4 03:56:09 INFO - docopt == 0.6.1 03:56:09 INFO - functools32 == 3.2.3-2 03:56:09 INFO - jsonschema == 2.5.1 03:56:09 INFO - manifestparser == 1.1 03:56:09 INFO - mozInstall == 1.12 03:56:09 INFO - mozcrash == 1.0 03:56:09 INFO - mozdebug == 0.1 03:56:09 INFO - mozdevice == 0.50 03:56:09 INFO - mozfile == 1.2 03:56:09 INFO - mozhttpd == 0.7 03:56:09 INFO - mozinfo == 0.9 03:56:09 INFO - mozleak == 0.1 03:56:09 INFO - mozlog == 3.4 03:56:09 INFO - moznetwork == 0.27 03:56:09 INFO - mozprocess == 0.25 03:56:09 INFO - mozprofile == 0.28 03:56:09 INFO - mozrunner == 6.13 03:56:09 INFO - mozscreenshot == 0.1 03:56:09 INFO - mozsystemmonitor == 0.3 03:56:09 INFO - moztest == 0.8 03:56:09 INFO - mozversion == 1.4 03:56:09 INFO - psutil == 3.1.1 03:56:09 INFO - requests == 1.2.3 03:56:09 INFO - wsgiref == 0.1.2 03:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:09 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')]} 03:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 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')]} 03:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:09 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:56:09 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 03:56:09 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 03:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:09 INFO - 'HOME': '/Users/cltbld', 03:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:09 INFO - 'LOGNAME': 'cltbld', 03:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:09 INFO - 'MOZ_NO_REMOTE': '1', 03:56:09 INFO - 'NO_EM_RESTART': '1', 03:56:09 INFO - 'PAGER': '/bin/cat', 03:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:09 INFO - 'PWD': '/builds/slave/test', 03:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:09 INFO - 'SHELL': '/bin/bash', 03:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:56:09 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:09 INFO - 'USER': 'cltbld', 03:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:09 INFO - 'XPC_FLAGS': '0x0', 03:56:09 INFO - 'XPC_SERVICE_NAME': '0', 03:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 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)) 03:56:10 INFO - Cleaning up... 03:56:10 INFO - Return code: 0 03:56:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56:10 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')]} 03:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:10 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')]} 03:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:10 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 0x10a4a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcc1d768c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, '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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 03:56:10 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 03:56:10 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 03:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:10 INFO - 'HOME': '/Users/cltbld', 03:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:10 INFO - 'LOGNAME': 'cltbld', 03:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:10 INFO - 'MOZ_NO_REMOTE': '1', 03:56:10 INFO - 'NO_EM_RESTART': '1', 03:56:10 INFO - 'PAGER': '/bin/cat', 03:56:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:10 INFO - 'PWD': '/builds/slave/test', 03:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:10 INFO - 'SHELL': '/bin/bash', 03:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:56:10 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:10 INFO - 'USER': 'cltbld', 03:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:10 INFO - 'XPC_FLAGS': '0x0', 03:56:10 INFO - 'XPC_SERVICE_NAME': '0', 03:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:56:10 INFO - Cleaning up... 03:56:10 INFO - Return code: 0 03:56:10 INFO - Running post-action listener: _resource_record_post_action 03:56:10 INFO - Running post-action listener: _start_resource_monitoring 03:56:10 INFO - Starting resource monitoring. 03:56:10 INFO - [mozharness: 2017-05-02 10:56:10.532087Z] Finished create-virtualenv step (success) 03:56:10 INFO - [mozharness: 2017-05-02 10:56:10.533048Z] Running install step. 03:56:10 INFO - Running pre-action listener: _resource_record_pre_action 03:56:10 INFO - Running main action method: install 03:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:10 INFO - Reading from file tmpfile_stdout 03:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:10 INFO - Reading from file tmpfile_stdout 03:56:10 INFO - Output received: 03:56:10 INFO - Usage: mozinstall [options] installer 03:56:10 INFO - Options: 03:56:10 INFO - -h, --help show this help message and exit 03:56:10 INFO - -d DEST, --destination=DEST 03:56:10 INFO - Directory to install application into. [default: 03:56:10 INFO - "/builds/slave/test"] 03:56:10 INFO - --app=APP Application being installed. [default: firefox] 03:56:10 INFO - mkdir: /builds/slave/test/build/application 03:56:10 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'] 03:56:10 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 03:56:30 INFO - Reading from file tmpfile_stdout 03:56:30 INFO - Output received: 03:56:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:56:30 INFO - Running post-action listener: _resource_record_post_action 03:56:30 INFO - [mozharness: 2017-05-02 10:56:30.718310Z] Finished install step (success) 03:56:30 INFO - [mozharness: 2017-05-02 10:56:30.718426Z] Running run-tests step. 03:56:30 INFO - Running pre-action listener: _resource_record_pre_action 03:56:30 INFO - Running main action method: run_tests 03:56:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:56:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:56:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:56:30 INFO - 2017-05-02 03:56:30.733 screenresolution[1624:7358] starting screenresolution argv=screenresolution get 03:56:30 INFO - 2017-05-02 03:56:30.735 screenresolution[1624:7358] Display 0: 1600x1200x32@60 03:56:30 INFO - 2017-05-02 03:56:30.741 screenresolution[1625:7361] starting screenresolution argv=screenresolution list 03:56:30 INFO - Available Modes on Display 0 03:56:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:56:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:56:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:56:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:56:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:56:30 INFO - Intel Iris: 03:56:30 INFO - Chipset Model: Intel Iris 03:56:30 INFO - Type: GPU 03:56:30 INFO - Bus: Built-In 03:56:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:56:30 INFO - Vendor: Intel (0x8086) 03:56:30 INFO - Device ID: 0x0a2e 03:56:30 INFO - Revision ID: 0x0009 03:56:30 INFO - Displays: 03:56:30 INFO - Display: 03:56:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:56:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:56:30 INFO - Display Serial Number: 1600x1200 60 03:56:30 INFO - Main Display: Yes 03:56:30 INFO - Mirror: Off 03:56:30 INFO - Online: Yes 03:56:30 INFO - Rotation: Supported 03:56:30 INFO - Return code: 0 03:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:30 INFO - Python 2.7.3 03:56:30 INFO - Return code: 0 03:56:30 INFO - grabbing minidump binary from tooltool 03:56:30 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')]} 03:56:30 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 0x10a281d30>, '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 0x10a1a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a276be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:30 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 03:56:30 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 03:56:30 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 03:56:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:31 INFO - Return code: 0 03:56:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:56:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:31 INFO - ENV: RUST_BACKTRACE is now 1 03:56:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:56:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y6hEqd1CaE/Render', 03:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:31 INFO - 'HOME': '/Users/cltbld', 03:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:31 INFO - 'LOGNAME': 'cltbld', 03:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:31 INFO - 'MOZ_NO_REMOTE': '1', 03:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:31 INFO - 'NO_EM_RESTART': '1', 03:56:31 INFO - 'PAGER': '/bin/cat', 03:56:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:31 INFO - 'PWD': '/builds/slave/test', 03:56:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:31 INFO - 'RUST_BACKTRACE': '1', 03:56:31 INFO - 'SHELL': '/bin/bash', 03:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9b3uylX9IK/Listeners', 03:56:31 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 03:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:31 INFO - 'USER': 'cltbld', 03:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:31 INFO - 'XPC_FLAGS': '0x0', 03:56:31 INFO - 'XPC_SERVICE_NAME': '0', 03:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:56:31 INFO - mozversion application_buildid: 20170502020521 03:56:31 INFO - mozversion application_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 03:56:31 INFO - mozversion application_display_name: Nightly 03:56:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:31 INFO - mozversion application_name: Firefox 03:56:31 INFO - mozversion application_remotingname: firefox 03:56:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:56:31 INFO - mozversion application_vendor: Mozilla 03:56:31 INFO - mozversion application_version: 55.0a1 03:56:31 INFO - mozversion platform_buildid: 20170502020521 03:56:31 INFO - mozversion platform_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 03:56:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:56:31 INFO - mozversion platform_version: 55.0a1 03:56:31 INFO - using testdate: 1493722591 03:56:31 INFO - actual date: 1493722591 03:56:31 INFO - starting webserver on 'localhost:49234' 03:56:31 INFO - SUITE-START | Running 2 tests 03:56:31 INFO - TEST-START | dromaeo_css 03:56:31 INFO - operating with platform_type : mac_ 03:56:31 INFO - Initialising browser for dromaeo_css test... 03:56:31 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpGV2ZP0/profile http://localhost:49234/getInfo.html) 03:56:34 INFO - PID 1635 | 2017-05-02 03:56:34.333 plugin-container[1637:7543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 03:56:34 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:34 INFO - PID 1635 | 2017-05-02 03:56:34.336 plugin-container[1637:7543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 03:56:34 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:34 INFO - PID 1635 | 2017-05-02 03:56:34.336 plugin-container[1637:7543] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:56:34 INFO - PID 1635 | __metrics Screen width/height:1600/1200 03:56:34 INFO - PID 1635 | colorDepth:24 03:56:34 INFO - PID 1635 | Browser inner width/height: 1024/689 03:56:34 INFO - PID 1635 | __metrics 03:56:35 INFO - TEST-INFO | 1635: exit 0 03:56:35 INFO - Browser initialized. 03:56:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:35 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpGV2ZP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:37 INFO - PID 1638 | 2017-05-02 03:56:37.708 plugin-container[1639:7679] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 03:56:37 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:37 INFO - PID 1638 | 2017-05-02 03:56:37.708 plugin-container[1639:7679] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 03:56:37 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:37 INFO - PID 1638 | 2017-05-02 03:56:37.708 plugin-container[1639:7679] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:56:47 INFO - PID 1638 | RSS: Main: 234795008 03:56:47 INFO - PID 1638 | 03:59:51 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 03:59:53 INFO - PID 1638 | RSS: Main: 251576320 03:59:53 INFO - PID 1638 | 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 04:01:35 INFO - PID 1638 | 04:01:35 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:35 INFO - PID 1638 | Full stack: 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 04:01:35 INFO - PID 1638 | 04:01:35 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:35 INFO - PID 1638 | Full stack: 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 04:01:35 INFO - PID 1638 | 04:01:35 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:35 INFO - PID 1638 | Full stack: 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | ************************* 04:01:35 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 04:01:35 INFO - PID 1638 | 04:01:35 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:35 INFO - PID 1638 | Full stack: 04:01:35 INFO - PID 1638 | ************************* 04:02:55 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 04:02:55 INFO - PID 1638 | RSS: Main: 255852544 04:02:55 INFO - PID 1638 | 04:05:57 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 04:05:58 INFO - PID 1638 | RSS: Main: 266235904 04:05:58 INFO - PID 1638 | 04:09:00 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 04:09:00 INFO - PID 1638 | RSS: Main: 259940352 04:09:00 INFO - PID 1638 | 04:12:03 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 04:12:04 INFO - PID 1638 | RSS: Main: 269033472 04:12:04 INFO - PID 1638 | 04:15:05 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 04:15:06 INFO - PID 1638 | RSS: Main: 263667712 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | __start_tp_report 04:15:06 INFO - PID 1638 | _x_x_mozilla_page_load 04:15:06 INFO - PID 1638 | _x_x_mozilla_page_load_details 04:15:06 INFO - PID 1638 | |i|pagename|runs| 04:15:06 INFO - PID 1638 | |0;dojo.html;3586.2648157127774;3606.801625910575;3626.1478552540157;3647.3252448297067;3649.2519033598114;5694.544436445085;6122.001753127739;6148.600340977833;6207.875842483153;6232.40792124748;6141.416565426289;6165.106059621352;6168.321484636686;6195.628262304265;6271.905921411171;5377.0321342158395;5380.973095134538;5411.702356370398;5417.3770016448025;5423.620346575732;4550.613197878168;5453.563714902818;5501.4223506531835;5542.39033706292;5581.190727344532;5303.681779093266;5463.153211252262;5472.452754724535;5517.310336207974;5545.112781954888;4233.280342341809;5399.974004939049;5448.618596698233;5480.3971563128025;5488.91766623501;5356.892862142774;5407.486288802557;5430.239766432663;5434.239206511092;5446.019716451037;6043.365446628085;6261.780837670705;6262.060690896356;6281.528885333572;6300.842478938017;6423.935760642427;6536.640484773336;6711.798646040626;6762.526623136382;6769.1876974763345;6884.173899132086;6891.241963384074;6894;6905.861882762367;6911.75808846688;6372.107904893319;6400.263969643457;6405.807825765234;6410.839729006719;6428;6693.397594216543;6764.188297404343;6840.521163518605;6932.549384290005;7002.7899163025195;6383.39357761012;6454.548181627335;6457.321981191907;6632.403083722392;6718.49611279156;6709.194896612437;6762.69567869447;6841;6850.451963842881;6855.794326170223;5384.892302153935;6038.973374526253;6758.560693554903;6781.593104413751;6785.050092986986;5113.565346945551;6535.509836762262;6570.868582628321;6644.534882558174;6744.898826517606;5351.224072509464;5358.089124848785;5398.433164517748;5404.567634589302;5428.701421421781;4804.279358096243;4840.564349208588;4865.635077369211;4867.123917694778;4884.853454396374;5396.78412863481;5624.85937851557;5731.624410141536;6301.684915754194;6428.967855160694;5929.280508652442;6069.514438844882;6436.3241859605005;6679.833004174838;6910.585364878123;5684.834608905165;6122.112293717386;6298.0552917062805;6335.714892829834;6338.873222535523;6049.909251361233;6062;6062.969685151635;6069.787557435468;6104.603200792023;6764.0868482754195;7005.1471690571;7084.326988936043;7128.85742285141;7131.358177764027;6342.778002769881;6658.400743933069;6816.931830681828;6823.078884350748;6848.486363522856;5503.532199763065;6402.751463464766;7059.223485416497;7083.079199704005;7095.82260443493;6711.697973591103;6725.4619630430425;6768.898466523105;6771.187457505131;6803.387695107464;6584.242812076673;6631.568948018364;6682.164729408824;6777.55945863537;6807.8608286008475;6628.038934354395;6633.800985970429;6637.1703537057865;6646.634435106115;6649.900251496329;4853.514648535118;5381.838544843661;6346.492280617632;6628.801135965929;6638.302978187414;5820.76716931318;5898.056310990221;6270.059491076375;6555.672216389066;6559.901601475886;6360.968195158995;6691.899621505584;6698.330166983263;6719.596824190564;6731.764388246388;6306.117143599808;6336.873262534816;6356.364363563606;6400.551961362846;6404.615723056631 04:15:06 INFO - PID 1638 | |1;ext.html;763.3358977689411;805.1948051948053;829.0465964141239;1200.7178313096422;1265.9683507912296;37738.81130594347;38230.04424889379;38501.22997540048;38576.421353679645;38665.61334386655;38537.22925541487;38924;38984.610153898524;39083.82748517542;39139.41290880639;7813.218678132198;7965.9601701991405;8351.20663536963;8530.317574594017;8541.188587084249;8532.61603227853;8603.139686031378;8611.56942152893;8642.178992995656;8650.48097114172;8570;8638.17937295956;8653.524056176908;8667.133286671346;8674.783130421727;8608.397412181119;8644.697435589724;8645.52449615271;8652.091530389313;8661.826763464727;8335.791605209919;8384.287335576484;8392.118827523083;8401.579921003926;8409.747707568782;28629;37012.81493592542;37118.81440592807;37201.627983720085;37234;3580.8030558319283;3599.4960705501253;3609.386404311247;3609.747317687763;3611.5846677632144;25019.874900625382;30883.845580772177;30894;30942.381152377053;31066.689333106606;3147.5436061770915;3181.9204519886957;3191.1543440988157;3199.936001279985;3204.2630195055035;303767;304836.4758176217;311205;316108.41945790354;317814;47663;47735.283970740464;47755;47875.76062119737;47889.76055119702;48690.02619947581;48766.512334876905;55069;56151.719241404346;56410.153847692316;14447.133172009713;14480;14528.982971191916;14646.487372941896;14652.780208296885;11735.178537502294;11816.822747658793;11817.995470384942;11818.94090529559;11830.585929492427;14116.576502704935;14138.08102473336;14154.64613384653;14162.575122746333;14216.21810800416;6228.47058000066;6243.0256655508165;6279.120923070774;6283.340249273851;6306.148669929593;1020.7142000239945;1030.7526193713454;1040.869891263592;1067.4822710985165;1073.6027669762082;20239.898800505904;21600.567988640138;23796.881015594812;24851.378715532257;24861;1128.5372997071327;1138.3682056458745;1162.3316592959081;1169.92980421175;1177.9411029448493;11739.295642261492;12672.619821405373;12744.61766147017;12767.553135640208;12814.67963300925;318730;319473;320457;323301;323332;38810;53315;53335.46664533305;53488.732556337745;53532.73233633807;1495.0954672423245;1514.3942423030876;1546.590153609272;1549.5738671865327;1561.890667653276;24248.515029698956;24400.51198976046;24475.020999159835;24529.141480048114;24546.01815927343;38475;38475.807620961714;38514.614853851104;38576.80711596536;38688.03279917912;293039;293140;293699;294703;294886;34539.4819077709;35710.8214458926;35753.46369804403;35819.82090089533;35836.462453063745;43195;43913;44764;44839.65481035574;44854.77572612247;30052.398952021274;30839.383212336077;31307.686923130477;31427.37145257128;31814.20464488314;22492.775072249067;26799.598006029537;30656.540151897294;31137.37725245437;31512.52731208988;30415;37725.62274377331;37858.10709464571;37888.81055594704;37916.24167516579;29973;30956;31114;31917.521237180998;32173;24395.02419903184;24484.6327305087;24616.507669846145;24668.259952201464;24744.876275618506 04:15:06 INFO - PID 1638 | |2;jquery.html;427.2738137922792;427.9586373000788;431.32928296498943;449.0928324783936;454.16743440218727;19038;20292.1883124675;20948.790512094874;21091.15635374583;21091.94540272986;21281.467963300925;21485.24801631943;21682.024308906097;21698.566028679455;21903.452413689665;5873.412658734124;6123.724432400552;6160.537959653022;6161.3838616138255;6168.75324987;5910.320313163998;5982.312034116088;6163.229596300463;6207.25512938448;6217.347178546255;6011.489023433013;6173.69131543421;6181.381861813805;6188.319284878659;6200.534959878005;6097.054956481752;6203.348648391944;6224.09750586167;6224.502039836825;6230.719617617218;4738.597219236369;5416.593755468356;5487.204355368489;5519.834404967857;5522.5581953443625;26764;26997.650117494046;27125.86437067802;27252.72747272522;27973.300667483272;2245.932622021342;2320.4662927526597;2322.4077860145553;2322.7212734471805;2325.5813953488364;17476.650466990715;17638.823611763848;17700.645987080316;18131.184096715548;18473;2150.193677370986;2152.9461763455884;2205.2832829330373;2207.896051974013;2212.391592312111;124445;150703;152649;152919;165141.17429412896;12008.699782505333;12575.93712031434;12576.993840492922;12636;12657.810132848015;16128.838711612969;16413;16418.097004664858;16439.26023328953;16444.437778411033;7355.301246381692;9054.049324820799;9123.680671176477;9139.131782480654;9202.90797092034;8553.187447192508;8571.185737354941;8636.697715579925;8838.86741698875;8882.111788821067;7869.527828330319;7973.481723687942;7975.481593696391;8019.318357939524;8027.15714849944;1890.9672102489878;2224.9653910931493;2259.8079163270977;2267.4921177417164;2418.7823095921453;911.7857303533664;975.8682577852042;980.1717548671361;994.1649014827435;1009.9498019021398;17257.741133883002;20511.38465846027;20948.89525552393;21118.683219751714;21208.465513903076;991.3952488981715;1003.3979612232748;1018.954147063384;1036.2176556699644;1041.656253436364;9784.217262618973;10141.543630536496;10183.439910804977;10492.055714985689;10804.370800183558;534471;536640;538216;549716;552339;122002.77997220092;124138;127607;130266.34866825605;132104;1143.3768596115137;1176.4999875053068;1179.5871444994355;1201.7476329970805;1207.836942012817;14051.578452646438;17434.564135896704;17711.734323984892;18312.72530912064;18385.988770617743;49602;54560.454395455534;56540;56614.433855660915;57081.714591426775;74095;74392;75030.24969750232;76116;76290;8058.516489010443;8218.712345067894;8264.297534709376;8298;8592.78518037029;12229.571964981538;12845.935770321088;12877.77661122192;12878.420471078636;13067.803982940073;10873.836892446461;11239.66281011571;11296.661100167008;11311.434428278717;11500.25248358854;9986.450745209084;10022.799544008933;10194.235432342752;10214.897851021395;10296.330738501973;11147.052500537546;11194.160437967023;11490.94254528722;11500.884991149982;11585.131115166228;7832.412569057229;8055.1542088079905;8243.17568243195;8437.662493500437;8445.493270403795;7832.530048197126;10699.465026748787;10844.945775271073;11128.666140015812;11220.214584978972 04:15:06 INFO - PID 1638 | |3;mootools.html;1238.3436778507394;1382.3848387467579;1494.006485687018;1500.722366362223;1501.7897494350786;11372.033377162941;11700.707482312926;11730.648080557597;11886;11900.7619847603;11793;11814;11857;12011.399430028507;12031.157818952677;2526.1158594491917;2572.884220210095;2572.987135064322;2580.780633646142;2587.676540432446;2480.541099896516;2530.835495692774;2536.518061568296;2537.860417677027;2545.643609894607;2504.511620234055;2525.5580273452165;2544.058698281629;2545.707243666974;2567.2939941516047;2456.312232574873;2470.6664600278914;2510.2092840755195;2513.673222481084;2516.5218608464515;2105.599936012168;2176.3035828534876;2423.285130886393;2472.221250306148;2511.1211076123395;11797.292162470194;11809.937105660532;11903.583374581935;11921.284722916653;11942.820857687142;6591.571547849375;6842.897356539606;6865.382115609619;6868.690908909111;6878.105846240007;3950.940735888964;4272.46594175728;4339.045410009793;4348.91302173958;4360.1279744051;1225.5844499602883;1238.2817965579943;1238.9318587477685;1307.6469353274658;1307.7384523095325;16004.839951600568;16438.356164383586;16595.66808663832;16633.918795278267;16642.916785416117;5657.321121465368;5669.659820410789;5829.708514574254;5834.591578589458;5841.853953651193;11714;11716.765664686658;11771;11794.233374830608;11824.40877956116;6606;6678.7662431815625;6680.5323627345615;6681.231658359254;6684.4318232950745;5958.523318134538;6212.47193988507;6268.435840774352;6272.6236425814595;6289.0252010938375;4267.50923643785;4391.8462853799965;4422.513523512411;4451.399061126706;4481.417415735934;1268.5601841909315;1284.293638498822;1291.2446218962014;1303.335298997518;1306.9542566010143;808;808.401782680812;841.2008591837779;842.6376658037103;864.4251572704081;6201.658908759971;6210.037444196157;6370.936290637034;6378.77674281398;6438.6136831790245;584.6608966799246;599.0893841361107;610.6885488400859;613.25489530221;621.7171187109855;3871.090293780959;4008.5590585035625;4032.4354590357375;4049.1699201663587;4157.563455837154;14562.126272423688;15049.699006019819;15090.396384144511;15208.239588020555;15251.084934903942;14392.208428536322;14889.329980150918;14955.700885982436;15165.469208577646;15405.691886162214;8445.113263107409;8634.352423568258;8742.91257087421;8782.736517904474;8805.251553617885;6784.253732089367;6785.355391237825;6791.592504449749;6899.413549848319;6945.513814032969;12953.611391658265;13268.469261229442;13598;13635.181889086687;13820.930895345458;13552.457901683822;13680.726385472433;13717.588472345846;13859.51491697826;14126;9183.173514383738;9512.286578506779;9598.136167744937;9610.942796292542;9654.56554455037;10824.134069274596;10883.727906802076;10911.290766100177;10928.344299342065;10943.069839063768;7444.255574442513;7581.135776409327;7617.42869284817;7620.314171724572;9312.906870931203;8945.105489451003;8965.327600430124;9047.954760226157;9061.68284110053;9101.908980910372;6888.758893438706;8176.386770992318;8195.549244791593;8251.092379838094;8308.33533317321;6017.638941663514;6138.07928810682;6164.229471316085;6183.3816618337805;6224.190855188796;4654.953450465452;6109.6639684817765;6193.566450348612;6201.6899155041165;6281.811545653638 04:15:06 INFO - PID 1638 | |4;prototype.html;332.931290557311;397.3503322068417;399.6443165582632;407.0962463331403;407.7044142996328;5047.939932614151;5120.871978200542;5667.356466624679;5950.910736338948;6097.725602347894;4690.953090469095;4802.207635740107;6153.969230153843;6164.7534098636115;6181.783637572686;3637.5453068366455;3661.8535258589623;3904.8285514345725;4332.74350438374;4461.776911154438;3651.561812582494;4463.018136010072;4469.173202957463;4481.327800829869;4482.484514280851;3405.7105146062613;3617.8371973261264;3650.8904732858055;4299.075698724773;4450.710703804242;3673.3204357194004;4246.936295955563;4393.912121757563;4409.184300904343;4463.352813842007;3467.930641387158;3784.508013958168;3785.1294202333343;3793.2223894101644;3798.392257238856;6002.339742628307;6017.729202185912;6033.607815492023;6073.969630151865;6085.208922840046;4369.737815731035;5175.249588809639;5259.5529380002745;5358.517733404013;5401.972990135064;6529.31442198567;6534.77128300512;6572.76995305162;6617;6618.437432818217;3552.9111772205642;4283.2076065927595;4303.268444364466;4324.6972711910175;4325.978370108161;6744.258131605568;6854.485913556503;6883.483738719616;6965.895511567331;7048;4326.372675962031;4329.653627709776;4344.045179669161;4365.388845561624;4367.978160109243;4378.912421751611;4421.115776844644;4431.534688857688;4437.356583295404;4449.221386257392;5144.6398752087;5227.3465816772905;5269.446708095671;5302.310699609026;5338.199270109437;5483.75323110453;6586.934130658728;6608.603483790988;6649.501287403367;6668.633225172662;1334.5796074236778;1421.175718083509;1493.1862135136378;1517.0821652900058;1517.4613012380667;828.9751307460785;831.6507067031861;878.83302172587;973.5278389980854;997.3118548201718;5222.399424066281;5792.102224155263;6143.941779503827;6147.784827531015;6166.260048794174;5393.7033463159905;6165.475934545524;6654.434373078246;6765.458763298924;6792.8301792454595;6041.033434650522;6071.969640151771;6142.815715528542;6158.692065396713;6185.969070154711;3534.416821224469;3559.18138828071;3559.911002224965;3570.107473131717;3591.2099338145567;6785.626790526469;7089.751858684921;7111.075560177247;7153.561794384991;7182.174049984214;6958.269381714847;7050.871860502295;7128.607926564089;7141.464974837489;7150.3922166615375;7036.542624729376;7051.858962820817;7061.293870612795;7068.187158476841;7160.496295777945;6883.724651013903;6901.723931042702;6908;6912.827179320356;6997.755078572225;5436.429174936575;5527.364353099284;6400.263969643364;6482.800681873869;6636.170478690164;6138.772245550997;6455.870882582416;6669.799906002828;6936.375726184668;7215.963920180366;4357.67317451186;4360.389545463701;4362.672799540111;4365.781710914505;4380.540043295408;5815.82552523425;6548.476121910331;6715.093462382516;6879.415249703631;6917.757878474431;6659.766908158192;6687.799366019027;6701.262861085179;6702.966485167543;6730.697118629576;6591.945288753776;6624.933750662624;6659.866802664016;6709.691610136172;6724.865502690017;6533.18335208099;6581.3418658133805;6592.505562082767;6614.966925165343;6631.237407698177;5760.193572899713;6328.525360597881;6742.561733487504;6768.7292508299115;6806.591604503746;6461.967690161519;6487.458778854915;6495.512836537184;6501.674916254263;6551.868962620625 04:15:06 INFO - PID 1638 | |5;yui.html;825.3809642767924;833.5623797506308;859.1022381611217;867.7873920889381;872.7774417523534;14267.571972840806;14886.925565372158;16166.272517736701;16549.089800060992;16634.999999999985;16845.494635160965;17316.307347706108;17582.560435989108;17665.73501397477;18060.909695451504;982.719924821426;1002.4336250018716;1006.3609607899;1008.0675375277875;1008.3445760255819;998.7902540466511;1001.0790073132736;1002.3434650304063;1002.9648962286321;1003.8644782954317;992.5731935267831;1034.9534270957824;1041.7239431550645;1042.1454407385947;1044.9738756531071;1035.6168217759478;1036.4092467293647;1037.636827110509;1039.7972395382903;1039.8024375368693;760.2169765141913;761.417515600566;761.5621017914666;761.7219714804056;765.0742601452249;16635.584110397216;17006.48980530586;17257.223424945783;17332.82667173337;17562.034088125147;17055.74416383743;17124.400645977457;17399.65200695979;17543.473695789147;17578.91210543939;12604.873951260553;12643.683907902285;12674.049446291565;12765.936170319183;12831;3488.145404375944;3509.12271932017;3511.3855075361967;3511.7015053720465;3511.719062474996;136145;136368;136412;136930.3153484236;139520;13055.608331750063;13311.267880266678;13338.333083345793;13381.598552043455;13462;25410.237692869243;25737.227883163534;26024.089156879418;26175.93826448451;26218.86890565573;7717.8456430871065;7768.805779855549;7782.883256751154;7803.570803605742;7807.453478256468;3863.652271295597;3932.6264004919485;3970.741901776433;4010.8796736097966;4021.617946295097;4215.557366476476;4270.103278311527;4270.551592082787;4296.720713153635;4303.289957157097;828.3580225325421;871.7733389318822;905.9139381758722;911.8601747815231;955.8422860228123;637.0921436952417;653.3825534869503;667.302668711198;678.1489231015045;689.4036658290643;11136.944315278372;11965.820512692317;12003.759924801456;12086.214396064228;12283.201591896499;641.2625480697236;645.2225068792188;652.5856081388353;668.9933100668931;677.529117263507;5364.329458817648;5498;5513.476219759116;5544.029794785896;5579.581531385163;105733.88532229312;106382;106612;108120;108143;97287.05425891443;97369.5131524352;97905.51047244717;98496;100672.49663751635;84736.72894906705;84927.83618539137;85209.57395212984;85489.57255213808;86197;10856.402897840379;11028.779424411307;11155;11241.213115082193;11357.772844543228;37776.244475109794;37819.62180378271;38056;38239.61760382472;38925.02687432837;50409;50682.493175069256;51007.744961274955;51074;51768.18811341585;14281.857181428468;14446.205458699873;14558.199299038655;14565.198914059829;14775.556733298019;15976.281067351765;16044.518664440086;16047.598810029842;16092.67814643724;16226.918865406069;14678;14784;14793.038452500554;14943.626409339418;15106.244687765788;14465;14812.259387030821;14953.40186392532;14977;14988.250587470366;13800;14149.43402263898;14320.713585728436;14429.639259018608;14520.709585808436;9198.586063627019;10622.415767132881;10804.891951080388;10828.566857325619;10949.452527373758;11742.706432338919;11845;11908.52365905354;11965.282083075042;11985.981191598812 04:15:06 INFO - PID 1638 | __end_tp_report 04:15:06 INFO - PID 1638 | __start_cc_report 04:15:06 INFO - PID 1638 | _x_x_mozilla_cycle_collect,415 04:15:06 INFO - PID 1638 | __end_cc_report 04:15:06 INFO - PID 1638 | __startTimestamp1493723706018__endTimestamp 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | ------- Summary: start ------- 04:15:06 INFO - PID 1638 | Number of tests: 6 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6125.19 Median:6342.78 stddev:762.26 (12.0%) stddev-sans-first:738.12 04:15:06 INFO - PID 1638 | Values: 3586.3 3606.8 3626.1 3647.3 3649.3 5694.5 6122.0 6148.6 6207.9 6232.4 6141.4 6165.1 6168.3 6195.6 6271.9 5377.0 5381.0 5411.7 5417.4 5423.6 4550.6 5453.6 5501.4 5542.4 5581.2 5303.7 5463.2 5472.5 5517.3 5545.1 4233.3 5400.0 5448.6 5480.4 5488.9 5356.9 5407.5 5430.2 5434.2 5446.0 6043.4 6261.8 6262.1 6281.5 6300.8 6423.9 6536.6 6711.8 6762.5 6769.2 6884.2 6891.2 6894.0 6905.9 6911.8 6372.1 6400.3 6405.8 6410.8 6428.0 6693.4 6764.2 6840.5 6932.5 7002.8 6383.4 6454.5 6457.3 6632.4 6718.5 6709.2 6762.7 6841.0 6850.5 6855.8 5384.9 6039.0 6758.6 6781.6 6785.1 5113.6 6535.5 6570.9 6644.5 6744.9 5351.2 5358.1 5398.4 5404.6 5428.7 4804.3 4840.6 4865.6 4867.1 4884.9 5396.8 5624.9 5731.6 6301.7 6429.0 5929.3 6069.5 6436.3 6679.8 6910.6 5684.8 6122.1 6298.1 6335.7 6338.9 6049.9 6062.0 6063.0 6069.8 6104.6 6764.1 7005.1 7084.3 7128.9 7131.4 6342.8 6658.4 6816.9 6823.1 6848.5 5503.5 6402.8 7059.2 7083.1 7095.8 6711.7 6725.5 6768.9 6771.2 6803.4 6584.2 6631.6 6682.2 6777.6 6807.9 6628.0 6633.8 6637.2 6646.6 6649.9 4853.5 5381.8 6346.5 6628.8 6638.3 5820.8 5898.1 6270.1 6555.7 6559.9 6361.0 6691.9 6698.3 6719.6 6731.8 6306.1 6336.9 6356.4 6400.6 6404.6 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:45846.98 Median:176315.00 stddev:81003.72 (45.9%) stddev-sans-first:81160.23 04:15:06 INFO - PID 1638 | Values: 763.3 805.2 829.0 1200.7 1266.0 37738.8 38230.0 38501.2 38576.4 38665.6 38537.2 38924.0 38984.6 39083.8 39139.4 7813.2 7966.0 8351.2 8530.3 8541.2 8532.6 8603.1 8611.6 8642.2 8650.5 8570.0 8638.2 8653.5 8667.1 8674.8 8608.4 8644.7 8645.5 8652.1 8661.8 8335.8 8384.3 8392.1 8401.6 8409.7 28629.0 37012.8 37118.8 37201.6 37234.0 3580.8 3599.5 3609.4 3609.7 3611.6 25019.9 30883.8 30894.0 30942.4 31066.7 3147.5 3181.9 3191.2 3199.9 3204.3 303767.0 304836.5 311205.0 316108.4 317814.0 47663.0 47735.3 47755.0 47875.8 47889.8 48690.0 48766.5 55069.0 56151.7 56410.2 14447.1 14480.0 14529.0 14646.5 14652.8 11735.2 11816.8 11818.0 11818.9 11830.6 14116.6 14138.1 14154.6 14162.6 14216.2 6228.5 6243.0 6279.1 6283.3 6306.1 1020.7 1030.8 1040.9 1067.5 1073.6 20239.9 21600.6 23796.9 24851.4 24861.0 1128.5 1138.4 1162.3 1169.9 1177.9 11739.3 12672.6 12744.6 12767.6 12814.7 318730.0 319473.0 320457.0 323301.0 323332.0 38810.0 53315.0 53335.5 53488.7 53532.7 1495.1 1514.4 1546.6 1549.6 1561.9 24248.5 24400.5 24475.0 24529.1 24546.0 38475.0 38475.8 38514.6 38576.8 38688.0 293039.0 293140.0 293699.0 294703.0 294886.0 34539.5 35710.8 35753.5 35819.8 35836.5 43195.0 43913.0 44764.0 44839.7 44854.8 30052.4 30839.4 31307.7 31427.4 31814.2 22492.8 26799.6 30656.5 31137.4 31512.5 30415.0 37725.6 37858.1 37888.8 37916.2 29973.0 30956.0 31114.0 31917.5 32173.0 24395.0 24484.6 24616.5 24668.3 24744.9 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:34736.11 Median:2263.65 stddev:91899.86 (4059.8%) stddev-sans-first:92121.56 04:15:06 INFO - PID 1638 | Values: 427.3 428.0 431.3 449.1 454.2 19038.0 20292.2 20948.8 21091.2 21091.9 21281.5 21485.2 21682.0 21698.6 21903.5 5873.4 6123.7 6160.5 6161.4 6168.8 5910.3 5982.3 6163.2 6207.3 6217.3 6011.5 6173.7 6181.4 6188.3 6200.5 6097.1 6203.3 6224.1 6224.5 6230.7 4738.6 5416.6 5487.2 5519.8 5522.6 26764.0 26997.7 27125.9 27252.7 27973.3 2245.9 2320.5 2322.4 2322.7 2325.6 17476.7 17638.8 17700.6 18131.2 18473.0 2150.2 2152.9 2205.3 2207.9 2212.4 124445.0 150703.0 152649.0 152919.0 165141.2 12008.7 12575.9 12577.0 12636.0 12657.8 16128.8 16413.0 16418.1 16439.3 16444.4 7355.3 9054.0 9123.7 9139.1 9202.9 8553.2 8571.2 8636.7 8838.9 8882.1 7869.5 7973.5 7975.5 8019.3 8027.2 1891.0 2225.0 2259.8 2267.5 2418.8 911.8 975.9 980.2 994.2 1009.9 17257.7 20511.4 20948.9 21118.7 21208.5 991.4 1003.4 1019.0 1036.2 1041.7 9784.2 10141.5 10183.4 10492.1 10804.4 534471.0 536640.0 538216.0 549716.0 552339.0 122002.8 124138.0 127607.0 130266.3 132104.0 1143.4 1176.5 1179.6 1201.7 1207.8 14051.6 17434.6 17711.7 18312.7 18386.0 49602.0 54560.5 56540.0 56614.4 57081.7 74095.0 74392.0 75030.2 76116.0 76290.0 8058.5 8218.7 8264.3 8298.0 8592.8 12229.6 12845.9 12877.8 12878.4 13067.8 10873.8 11239.7 11296.7 11311.4 11500.3 9986.5 10022.8 10194.2 10214.9 10296.3 11147.1 11194.2 11490.9 11500.9 11585.1 7832.4 8055.2 8243.2 8437.7 8445.5 7832.5 10699.5 10844.9 11128.7 11220.2 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7115.33 Median:3911.02 stddev:4529.43 (115.8%) stddev-sans-first:4520.61 04:15:06 INFO - PID 1638 | Values: 1238.3 1382.4 1494.0 1500.7 1501.8 11372.0 11700.7 11730.6 11886.0 11900.8 11793.0 11814.0 11857.0 12011.4 12031.2 2526.1 2572.9 2573.0 2580.8 2587.7 2480.5 2530.8 2536.5 2537.9 2545.6 2504.5 2525.6 2544.1 2545.7 2567.3 2456.3 2470.7 2510.2 2513.7 2516.5 2105.6 2176.3 2423.3 2472.2 2511.1 11797.3 11809.9 11903.6 11921.3 11942.8 6591.6 6842.9 6865.4 6868.7 6878.1 3950.9 4272.5 4339.0 4348.9 4360.1 1225.6 1238.3 1238.9 1307.6 1307.7 16004.8 16438.4 16595.7 16633.9 16642.9 5657.3 5669.7 5829.7 5834.6 5841.9 11714.0 11716.8 11771.0 11794.2 11824.4 6606.0 6678.8 6680.5 6681.2 6684.4 5958.5 6212.5 6268.4 6272.6 6289.0 4267.5 4391.8 4422.5 4451.4 4481.4 1268.6 1284.3 1291.2 1303.3 1307.0 808.0 808.4 841.2 842.6 864.4 6201.7 6210.0 6370.9 6378.8 6438.6 584.7 599.1 610.7 613.3 621.7 3871.1 4008.6 4032.4 4049.2 4157.6 14562.1 15049.7 15090.4 15208.2 15251.1 14392.2 14889.3 14955.7 15165.5 15405.7 8445.1 8634.4 8742.9 8782.7 8805.3 6784.3 6785.4 6791.6 6899.4 6945.5 12953.6 13268.5 13598.0 13635.2 13820.9 13552.5 13680.7 13717.6 13859.5 14126.0 9183.2 9512.3 9598.1 9610.9 9654.6 10824.1 10883.7 10911.3 10928.3 10943.1 7444.3 7581.1 7617.4 7620.3 9312.9 8945.1 8965.3 9048.0 9061.7 9101.9 6888.8 8176.4 8195.5 8251.1 8308.3 6017.6 6138.1 6164.2 6183.4 6224.2 4655.0 6109.7 6193.6 6201.7 6281.8 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5278.45 Median:6091.47 stddev:1745.09 (28.6%) stddev-sans-first:1710.05 04:15:06 INFO - PID 1638 | Values: 332.9 397.4 399.6 407.1 407.7 5047.9 5120.9 5667.4 5950.9 6097.7 4691.0 4802.2 6154.0 6164.8 6181.8 3637.5 3661.9 3904.8 4332.7 4461.8 3651.6 4463.0 4469.2 4481.3 4482.5 3405.7 3617.8 3650.9 4299.1 4450.7 3673.3 4246.9 4393.9 4409.2 4463.4 3467.9 3784.5 3785.1 3793.2 3798.4 6002.3 6017.7 6033.6 6074.0 6085.2 4369.7 5175.2 5259.6 5358.5 5402.0 6529.3 6534.8 6572.8 6617.0 6618.4 3552.9 4283.2 4303.3 4324.7 4326.0 6744.3 6854.5 6883.5 6965.9 7048.0 4326.4 4329.7 4344.0 4365.4 4368.0 4378.9 4421.1 4431.5 4437.4 4449.2 5144.6 5227.3 5269.4 5302.3 5338.2 5483.8 6586.9 6608.6 6649.5 6668.6 1334.6 1421.2 1493.2 1517.1 1517.5 829.0 831.7 878.8 973.5 997.3 5222.4 5792.1 6143.9 6147.8 6166.3 5393.7 6165.5 6654.4 6765.5 6792.8 6041.0 6072.0 6142.8 6158.7 6186.0 3534.4 3559.2 3559.9 3570.1 3591.2 6785.6 7089.8 7111.1 7153.6 7182.2 6958.3 7050.9 7128.6 7141.5 7150.4 7036.5 7051.9 7061.3 7068.2 7160.5 6883.7 6901.7 6908.0 6912.8 6997.8 5436.4 5527.4 6400.3 6482.8 6636.2 6138.8 6455.9 6669.8 6936.4 7216.0 4357.7 4360.4 4362.7 4365.8 4380.5 5815.8 6548.5 6715.1 6879.4 6917.8 6659.8 6687.8 6701.3 6703.0 6730.7 6591.9 6624.9 6659.9 6709.7 6724.9 6533.2 6581.3 6592.5 6615.0 6631.2 5760.2 6328.5 6742.6 6768.7 6806.6 6462.0 6487.5 6495.5 6501.7 6551.9 04:15:06 INFO - PID 1638 | 04:15:06 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:21926.72 Median:17090.07 stddev:32526.30 (190.3%) stddev-sans-first:32578.95 04:15:06 INFO - PID 1638 | Values: 825.4 833.6 859.1 867.8 872.8 14267.6 14886.9 16166.3 16549.1 16635.0 16845.5 17316.3 17582.6 17665.7 18060.9 982.7 1002.4 1006.4 1008.1 1008.3 998.8 1001.1 1002.3 1003.0 1003.9 992.6 1035.0 1041.7 1042.1 1045.0 1035.6 1036.4 1037.6 1039.8 1039.8 760.2 761.4 761.6 761.7 765.1 16635.6 17006.5 17257.2 17332.8 17562.0 17055.7 17124.4 17399.7 17543.5 17578.9 12604.9 12643.7 12674.0 12765.9 12831.0 3488.1 3509.1 3511.4 3511.7 3511.7 136145.0 136368.0 136412.0 136930.3 139520.0 13055.6 13311.3 13338.3 13381.6 13462.0 25410.2 25737.2 26024.1 26175.9 26218.9 7717.8 7768.8 7782.9 7803.6 7807.5 3863.7 3932.6 3970.7 4010.9 4021.6 4215.6 4270.1 4270.6 4296.7 4303.3 828.4 871.8 905.9 911.9 955.8 637.1 653.4 667.3 678.1 689.4 11136.9 11965.8 12003.8 12086.2 12283.2 641.3 645.2 652.6 669.0 677.5 5364.3 5498.0 5513.5 5544.0 5579.6 105733.9 106382.0 106612.0 108120.0 108143.0 97287.1 97369.5 97905.5 98496.0 100672.5 84736.7 84927.8 85209.6 85489.6 86197.0 10856.4 11028.8 11155.0 11241.2 11357.8 37776.2 37819.6 38056.0 38239.6 38925.0 50409.0 50682.5 51007.7 51074.0 51768.2 14281.9 14446.2 14558.2 14565.2 14775.6 15976.3 16044.5 16047.6 16092.7 16226.9 14678.0 14784.0 14793.0 14943.6 15106.2 14465.0 14812.3 14953.4 14977.0 14988.3 13800.0 14149.4 14320.7 14429.6 14520.7 9198.6 10622.4 10804.9 10828.6 10949.5 11742.7 11845.0 11908.5 11965.3 11986.0 04:15:06 INFO - PID 1638 | -------- Summary: end -------- 04:15:06 INFO - PID 1638 | 04:15:06 INFO - TEST-INFO | 1638: exit 0 04:15:06 INFO - TEST-OK | dromaeo_css | took 1115347ms 04:15:06 INFO - TEST-START | kraken 04:15:06 INFO - operating with platform_type : mac_ 04:15:06 INFO - Initialising browser for kraken test... 04:15:06 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpO9n94v/profile http://localhost:49234/getInfo.html) 04:15:09 INFO - PID 1651 | 2017-05-02 04:15:09.536 plugin-container[1652:10107] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:15:09 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:09 INFO - PID 1651 | 2017-05-02 04:15:09.538 plugin-container[1652:10107] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:15:09 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:09 INFO - PID 1651 | 2017-05-02 04:15:09.539 plugin-container[1652:10107] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:15:09 INFO - PID 1651 | __metrics Screen width/height:1600/1200 04:15:09 INFO - PID 1651 | colorDepth:24 04:15:09 INFO - PID 1651 | Browser inner width/height: 1024/689 04:15:09 INFO - PID 1651 | __metrics 04:15:10 INFO - TEST-INFO | 1651: exit 0 04:15:10 INFO - Browser initialized. 04:15:10 INFO - Running cycle 1/1 for kraken test... 04:15:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpO9n94v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:12 INFO - PID 1653 | 2017-05-02 04:15:12.952 plugin-container[1654:10234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9547, name = 'com.apple.tsm.portname' 04:15:12 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:12 INFO - PID 1653 | 2017-05-02 04:15:12.953 plugin-container[1654:10234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 04:15:12 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:15:12 INFO - PID 1653 | 2017-05-02 04:15:12.953 plugin-container[1654:10234] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:15:22 INFO - PID 1653 | RSS: Main: 236253184 04:15:22 INFO - PID 1653 | 04:15:25 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:26 INFO - PID 1653 | RSS: Main: 248872960 04:15:26 INFO - PID 1653 | 04:15:29 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 04:15:29 INFO - PID 1653 | RSS: Main: 257081344 04:15:29 INFO - PID 1653 | 04:15:32 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 04:15:33 INFO - PID 1653 | RSS: Main: 259584000 04:15:33 INFO - PID 1653 | 04:15:35 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 04:15:36 INFO - PID 1653 | RSS: Main: 260468736 04:15:36 INFO - PID 1653 | 04:15:38 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:38 INFO - PID 1653 | RSS: Main: 262352896 04:15:38 INFO - PID 1653 | 04:15:41 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:42 INFO - PID 1653 | RSS: Main: 267583488 04:15:42 INFO - PID 1653 | 04:15:45 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:46 INFO - PID 1653 | RSS: Main: 268128256 04:15:46 INFO - PID 1653 | 04:15:49 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 04:15:49 INFO - PID 1653 | RSS: Main: 268226560 04:15:49 INFO - PID 1653 | 04:15:51 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:52 INFO - PID 1653 | RSS: Main: 267857920 04:15:52 INFO - PID 1653 | 04:15:53 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:54 INFO - PID 1653 | RSS: Main: 268152832 04:15:54 INFO - PID 1653 | 04:15:56 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:57 INFO - PID 1653 | RSS: Main: 267661312 04:15:57 INFO - PID 1653 | 04:16:00 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:01 INFO - PID 1653 | RSS: Main: 267821056 04:16:01 INFO - PID 1653 | 04:16:04 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:04 INFO - PID 1653 | RSS: Main: 268292096 04:16:04 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 04:16:06 INFO - PID 1653 | RSS: Main: 269651968 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | __start_tp_report 04:16:06 INFO - PID 1653 | _x_x_mozilla_page_load 04:16:06 INFO - PID 1653 | _x_x_mozilla_page_load_details 04:16:06 INFO - PID 1653 | |i|pagename|runs| 04:16:06 INFO - PID 1653 | |0;ai-astar;102;117;118;111;114;115;114;114;116;120 04:16:06 INFO - PID 1653 | |1;audio-beat-detection;140;110;113;146;112;110;109;112;134;110 04:16:06 INFO - PID 1653 | |2;audio-dft;201;199;201;220;223;199;191;201;198;200 04:16:06 INFO - PID 1653 | |3;audio-fft;84;66;83;81;75;50;67;80;89;74 04:16:06 INFO - PID 1653 | |4;audio-oscillator;110;61;67;102;101;89;86;69;67;88 04:16:06 INFO - PID 1653 | |5;imaging-gaussian-blur;87;134;107;90;88;91;103;78;77;106 04:16:06 INFO - PID 1653 | |6;imaging-darkroom;135;150;152;95;108;146;146;96;103;97 04:16:06 INFO - PID 1653 | |7;imaging-desaturate;90;90;92;102;94;90;90;95;93;91 04:16:06 INFO - PID 1653 | |8;json-parse-financial;50;51;51;51;51;51;49;51;50;46 04:16:06 INFO - PID 1653 | |9;json-stringify-tinderbox;62;79;82;69;65;62;57;58;59;60 04:16:06 INFO - PID 1653 | |10;stanford-crypto-aes;82;85;82;83;86;85;81;84;85;83 04:16:06 INFO - PID 1653 | |11;stanford-crypto-ccm;147;147;130;142;158;157;141;130;232;150 04:16:06 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;187;186;185;180;244;169;221;235;190;195 04:16:06 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;67;67;65;74;73;85;70;70;65;72 04:16:06 INFO - PID 1653 | __end_tp_report 04:16:06 INFO - PID 1653 | __start_cc_report 04:16:06 INFO - PID 1653 | _x_x_mozilla_cycle_collect,999 04:16:06 INFO - PID 1653 | __end_cc_report 04:16:06 INFO - PID 1653 | __startTimestamp1493723766819__endTimestamp 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | ------- Summary: start ------- 04:16:06 INFO - PID 1653 | Number of tests: 14 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.50 stddev:4.93 (4.3%) stddev-sans-first:2.65 04:16:06 INFO - PID 1653 | Values: 102.0 117.0 118.0 111.0 114.0 115.0 114.0 114.0 116.0 120.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:112.50 stddev:14.41 (12.8%) stddev-sans-first:13.26 04:16:06 INFO - PID 1653 | Values: 140.0 110.0 113.0 146.0 112.0 110.0 109.0 112.0 134.0 110.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:203.30 Median:201.00 stddev:10.06 (5.0%) stddev-sans-first:10.63 04:16:06 INFO - PID 1653 | Values: 201.0 199.0 201.0 220.0 223.0 199.0 191.0 201.0 198.0 200.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:74.90 Median:80.50 stddev:11.42 (14.2%) stddev-sans-first:11.62 04:16:06 INFO - PID 1653 | Values: 84.0 66.0 83.0 81.0 75.0 50.0 67.0 80.0 89.0 74.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:68.00 stddev:17.21 (25.3%) stddev-sans-first:15.47 04:16:06 INFO - PID 1653 | Values: 110.0 61.0 67.0 102.0 101.0 89.0 86.0 69.0 67.0 88.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:82.50 stddev:17.01 (20.6%) stddev-sans-first:17.72 04:16:06 INFO - PID 1653 | Values: 87.0 134.0 107.0 90.0 88.0 91.0 103.0 78.0 77.0 106.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:122.80 Median:151.00 stddev:24.91 (16.5%) stddev-sans-first:26.03 04:16:06 INFO - PID 1653 | Values: 135.0 150.0 152.0 95.0 108.0 146.0 146.0 96.0 103.0 97.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:91.50 stddev:3.74 (4.1%) stddev-sans-first:3.84 04:16:06 INFO - PID 1653 | Values: 90.0 90.0 92.0 102.0 94.0 90.0 90.0 95.0 93.0 91.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:51.00 stddev:1.60 (3.1%) stddev-sans-first:1.69 04:16:06 INFO - PID 1653 | Values: 50.0 51.0 51.0 51.0 51.0 51.0 49.0 51.0 50.0 46.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:63.50 stddev:8.77 (13.8%) stddev-sans-first:9.22 04:16:06 INFO - PID 1653 | Values: 62.0 79.0 82.0 69.0 65.0 62.0 57.0 58.0 59.0 60.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.50 stddev:1.65 (1.9%) stddev-sans-first:1.64 04:16:06 INFO - PID 1653 | Values: 82.0 85.0 82.0 83.0 86.0 85.0 81.0 84.0 85.0 83.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:148.50 stddev:29.22 (19.7%) stddev-sans-first:30.90 04:16:06 INFO - PID 1653 | Values: 147.0 147.0 130.0 142.0 158.0 157.0 141.0 130.0 232.0 150.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.20 Median:192.50 stddev:25.10 (13.0%) stddev-sans-first:26.24 04:16:06 INFO - PID 1653 | Values: 187.0 186.0 185.0 180.0 244.0 169.0 221.0 235.0 190.0 195.0 04:16:06 INFO - PID 1653 | 04:16:06 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:5.92 (8.3%) stddev-sans-first:6.12 04:16:06 INFO - PID 1653 | Values: 67.0 67.0 65.0 74.0 73.0 85.0 70.0 70.0 65.0 72.0 04:16:06 INFO - PID 1653 | -------- Summary: end -------- 04:16:06 INFO - PID 1653 | 04:16:07 INFO - TEST-INFO | 1653: exit 0 04:16:07 INFO - TEST-OK | kraken | took 61198ms 04:16:07 INFO - SUITE-END | took 1176s 04:16:07 INFO - Completed test suite (00:19:36) 04:16:07 INFO - javascript benchmark 04:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7806.769852392037, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3586.2648157127774, 3606.801625910575, 3626.1478552540157, 3647.3252448297067, 3649.2519033598114, 5694.544436445085, 6122.001753127739, 6148.600340977833, 6207.875842483153, 6232.40792124748, 6141.416565426289, 6165.106059621352, 6168.321484636686, 6195.628262304265, 6271.905921411171, 5377.0321342158395, 5380.973095134538, 5411.702356370398, 5417.3770016448025, 5423.620346575732, 4550.613197878168, 5453.563714902818, 5501.4223506531835, 5542.39033706292, 5581.190727344532, 5303.681779093266, 5463.153211252262, 5472.452754724535, 5517.310336207974, 5545.112781954888, 4233.280342341809, 5399.974004939049, 5448.618596698233, 5480.3971563128025, 5488.91766623501, 5356.892862142774, 5407.486288802557, 5430.239766432663, 5434.239206511092, 5446.019716451037, 6043.365446628085, 6261.780837670705, 6262.060690896356, 6281.528885333572, 6300.842478938017, 6423.935760642427, 6536.640484773336, 6711.798646040626, 6762.526623136382, 6769.1876974763345, 6884.173899132086, 6891.241963384074, 6894.0, 6905.861882762367, 6911.75808846688, 6372.107904893319, 6400.263969643457, 6405.807825765234, 6410.839729006719, 6428.0, 6693.397594216543, 6764.188297404343, 6840.521163518605, 6932.549384290005, 7002.7899163025195, 6383.39357761012, 6454.548181627335, 6457.321981191907, 6632.403083722392, 6718.49611279156, 6709.194896612437, 6762.69567869447, 6841.0, 6850.451963842881, 6855.794326170223, 5384.892302153935, 6038.973374526253, 6758.560693554903, 6781.593104413751, 6785.050092986986, 5113.565346945551, 6535.509836762262, 6570.868582628321, 6644.534882558174, 6744.898826517606, 5351.224072509464, 5358.089124848785, 5398.433164517748, 5404.567634589302, 5428.701421421781, 4804.279358096243, 4840.564349208588, 4865.635077369211, 4867.123917694778, 4884.853454396374, 5396.78412863481, 5624.85937851557, 5731.624410141536, 6301.684915754194, 6428.967855160694, 5929.280508652442, 6069.514438844882, 6436.3241859605005, 6679.833004174838, 6910.585364878123, 5684.834608905165, 6122.112293717386, 6298.0552917062805, 6335.714892829834, 6338.873222535523, 6049.909251361233, 6062.0, 6062.969685151635, 6069.787557435468, 6104.603200792023, 6764.0868482754195, 7005.1471690571, 7084.326988936043, 7128.85742285141, 7131.358177764027, 6342.778002769881, 6658.400743933069, 6816.931830681828, 6823.078884350748, 6848.486363522856, 5503.532199763065, 6402.751463464766, 7059.223485416497, 7083.079199704005, 7095.82260443493, 6711.697973591103, 6725.4619630430425, 6768.898466523105, 6771.187457505131, 6803.387695107464, 6584.242812076673, 6631.568948018364, 6682.164729408824, 6777.55945863537, 6807.8608286008475, 6628.038934354395, 6633.800985970429, 6637.1703537057865, 6646.634435106115, 6649.900251496329, 4853.514648535118, 5381.838544843661, 6346.492280617632, 6628.801135965929, 6638.302978187414, 5820.76716931318, 5898.056310990221, 6270.059491076375, 6555.672216389066, 6559.901601475886, 6360.968195158995, 6691.899621505584, 6698.330166983263, 6719.596824190564, 6731.764388246388, 6306.117143599808, 6336.873262534816, 6356.364363563606, 6400.551961362846, 6404.615723056631], "value": 6077.920065868707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.3358977689411, 805.1948051948053, 829.0465964141239, 1200.7178313096422, 1265.9683507912296, 37738.81130594347, 38230.04424889379, 38501.22997540048, 38576.421353679645, 38665.61334386655, 38537.22925541487, 38924.0, 38984.610153898524, 39083.82748517542, 39139.41290880639, 7813.218678132198, 7965.9601701991405, 8351.20663536963, 8530.317574594017, 8541.188587084249, 8532.61603227853, 8603.139686031378, 8611.56942152893, 8642.178992995656, 8650.48097114172, 8570.0, 8638.17937295956, 8653.524056176908, 8667.133286671346, 8674.783130421727, 8608.397412181119, 8644.697435589724, 8645.52449615271, 8652.091530389313, 8661.826763464727, 8335.791605209919, 8384.287335576484, 8392.118827523083, 8401.579921003926, 8409.747707568782, 28629.0, 37012.81493592542, 37118.81440592807, 37201.627983720085, 37234.0, 3580.8030558319283, 3599.4960705501253, 3609.386404311247, 3609.747317687763, 3611.5846677632144, 25019.874900625382, 30883.845580772177, 30894.0, 30942.381152377053, 31066.689333106606, 3147.5436061770915, 3181.9204519886957, 3191.1543440988157, 3199.936001279985, 3204.2630195055035, 303767.0, 304836.4758176217, 311205.0, 316108.41945790354, 317814.0, 47663.0, 47735.283970740464, 47755.0, 47875.76062119737, 47889.76055119702, 48690.02619947581, 48766.512334876905, 55069.0, 56151.719241404346, 56410.153847692316, 14447.133172009713, 14480.0, 14528.982971191916, 14646.487372941896, 14652.780208296885, 11735.178537502294, 11816.822747658793, 11817.995470384942, 11818.94090529559, 11830.585929492427, 14116.576502704935, 14138.08102473336, 14154.64613384653, 14162.575122746333, 14216.21810800416, 6228.47058000066, 6243.0256655508165, 6279.120923070774, 6283.340249273851, 6306.148669929593, 1020.7142000239945, 1030.7526193713454, 1040.869891263592, 1067.4822710985165, 1073.6027669762082, 20239.898800505904, 21600.567988640138, 23796.881015594812, 24851.378715532257, 24861.0, 1128.5372997071327, 1138.3682056458745, 1162.3316592959081, 1169.92980421175, 1177.9411029448493, 11739.295642261492, 12672.619821405373, 12744.61766147017, 12767.553135640208, 12814.67963300925, 318730.0, 319473.0, 320457.0, 323301.0, 323332.0, 38810.0, 53315.0, 53335.46664533305, 53488.732556337745, 53532.73233633807, 1495.0954672423245, 1514.3942423030876, 1546.590153609272, 1549.5738671865327, 1561.890667653276, 24248.515029698956, 24400.51198976046, 24475.020999159835, 24529.141480048114, 24546.01815927343, 38475.0, 38475.807620961714, 38514.614853851104, 38576.80711596536, 38688.03279917912, 293039.0, 293140.0, 293699.0, 294703.0, 294886.0, 34539.4819077709, 35710.8214458926, 35753.46369804403, 35819.82090089533, 35836.462453063745, 43195.0, 43913.0, 44764.0, 44839.65481035574, 44854.77572612247, 30052.398952021274, 30839.383212336077, 31307.686923130477, 31427.37145257128, 31814.20464488314, 22492.775072249067, 26799.598006029537, 30656.540151897294, 31137.37725245437, 31512.52731208988, 30415.0, 37725.62274377331, 37858.10709464571, 37888.81055594704, 37916.24167516579, 29973.0, 30956.0, 31114.0, 31917.521237180998, 32173.0, 24395.02419903184, 24484.6327305087, 24616.507669846145, 24668.259952201464, 24744.876275618506], "value": 17721.194048095163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.2738137922792, 427.9586373000788, 431.32928296498943, 449.0928324783936, 454.16743440218727, 19038.0, 20292.1883124675, 20948.790512094874, 21091.15635374583, 21091.94540272986, 21281.467963300925, 21485.24801631943, 21682.024308906097, 21698.566028679455, 21903.452413689665, 5873.412658734124, 6123.724432400552, 6160.537959653022, 6161.3838616138255, 6168.75324987, 5910.320313163998, 5982.312034116088, 6163.229596300463, 6207.25512938448, 6217.347178546255, 6011.489023433013, 6173.69131543421, 6181.381861813805, 6188.319284878659, 6200.534959878005, 6097.054956481752, 6203.348648391944, 6224.09750586167, 6224.502039836825, 6230.719617617218, 4738.597219236369, 5416.593755468356, 5487.204355368489, 5519.834404967857, 5522.5581953443625, 26764.0, 26997.650117494046, 27125.86437067802, 27252.72747272522, 27973.300667483272, 2245.932622021342, 2320.4662927526597, 2322.4077860145553, 2322.7212734471805, 2325.5813953488364, 17476.650466990715, 17638.823611763848, 17700.645987080316, 18131.184096715548, 18473.0, 2150.193677370986, 2152.9461763455884, 2205.2832829330373, 2207.896051974013, 2212.391592312111, 124445.0, 150703.0, 152649.0, 152919.0, 165141.17429412896, 12008.699782505333, 12575.93712031434, 12576.993840492922, 12636.0, 12657.810132848015, 16128.838711612969, 16413.0, 16418.097004664858, 16439.26023328953, 16444.437778411033, 7355.301246381692, 9054.049324820799, 9123.680671176477, 9139.131782480654, 9202.90797092034, 8553.187447192508, 8571.185737354941, 8636.697715579925, 8838.86741698875, 8882.111788821067, 7869.527828330319, 7973.481723687942, 7975.481593696391, 8019.318357939524, 8027.15714849944, 1890.9672102489878, 2224.9653910931493, 2259.8079163270977, 2267.4921177417164, 2418.7823095921453, 911.7857303533664, 975.8682577852042, 980.1717548671361, 994.1649014827435, 1009.9498019021398, 17257.741133883002, 20511.38465846027, 20948.89525552393, 21118.683219751714, 21208.465513903076, 991.3952488981715, 1003.3979612232748, 1018.954147063384, 1036.2176556699644, 1041.656253436364, 9784.217262618973, 10141.543630536496, 10183.439910804977, 10492.055714985689, 10804.370800183558, 534471.0, 536640.0, 538216.0, 549716.0, 552339.0, 122002.77997220092, 124138.0, 127607.0, 130266.34866825605, 132104.0, 1143.3768596115137, 1176.4999875053068, 1179.5871444994355, 1201.7476329970805, 1207.836942012817, 14051.578452646438, 17434.564135896704, 17711.734323984892, 18312.72530912064, 18385.988770617743, 49602.0, 54560.454395455534, 56540.0, 56614.433855660915, 57081.714591426775, 74095.0, 74392.0, 75030.24969750232, 76116.0, 76290.0, 8058.516489010443, 8218.712345067894, 8264.297534709376, 8298.0, 8592.78518037029, 12229.571964981538, 12845.935770321088, 12877.77661122192, 12878.420471078636, 13067.803982940073, 10873.836892446461, 11239.66281011571, 11296.661100167008, 11311.434428278717, 11500.25248358854, 9986.450745209084, 10022.799544008933, 10194.235432342752, 10214.897851021395, 10296.330738501973, 11147.052500537546, 11194.160437967023, 11490.94254528722, 11500.884991149982, 11585.131115166228, 7832.412569057229, 8055.1542088079905, 8243.17568243195, 8437.662493500437, 8445.493270403795, 7832.530048197126, 10699.465026748787, 10844.945775271073, 11128.666140015812, 11220.214584978972], "value": 10203.62594539886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.3436778507394, 1382.3848387467579, 1494.006485687018, 1500.722366362223, 1501.7897494350786, 11372.033377162941, 11700.707482312926, 11730.648080557597, 11886.0, 11900.7619847603, 11793.0, 11814.0, 11857.0, 12011.399430028507, 12031.157818952677, 2526.1158594491917, 2572.884220210095, 2572.987135064322, 2580.780633646142, 2587.676540432446, 2480.541099896516, 2530.835495692774, 2536.518061568296, 2537.860417677027, 2545.643609894607, 2504.511620234055, 2525.5580273452165, 2544.058698281629, 2545.707243666974, 2567.2939941516047, 2456.312232574873, 2470.6664600278914, 2510.2092840755195, 2513.673222481084, 2516.5218608464515, 2105.599936012168, 2176.3035828534876, 2423.285130886393, 2472.221250306148, 2511.1211076123395, 11797.292162470194, 11809.937105660532, 11903.583374581935, 11921.284722916653, 11942.820857687142, 6591.571547849375, 6842.897356539606, 6865.382115609619, 6868.690908909111, 6878.105846240007, 3950.940735888964, 4272.46594175728, 4339.045410009793, 4348.91302173958, 4360.1279744051, 1225.5844499602883, 1238.2817965579943, 1238.9318587477685, 1307.6469353274658, 1307.7384523095325, 16004.839951600568, 16438.356164383586, 16595.66808663832, 16633.918795278267, 16642.916785416117, 5657.321121465368, 5669.659820410789, 5829.708514574254, 5834.591578589458, 5841.853953651193, 11714.0, 11716.765664686658, 11771.0, 11794.233374830608, 11824.40877956116, 6606.0, 6678.7662431815625, 6680.5323627345615, 6681.231658359254, 6684.4318232950745, 5958.523318134538, 6212.47193988507, 6268.435840774352, 6272.6236425814595, 6289.0252010938375, 4267.50923643785, 4391.8462853799965, 4422.513523512411, 4451.399061126706, 4481.417415735934, 1268.5601841909315, 1284.293638498822, 1291.2446218962014, 1303.335298997518, 1306.9542566010143, 808.0, 808.401782680812, 841.2008591837779, 842.6376658037103, 864.4251572704081, 6201.658908759971, 6210.037444196157, 6370.936290637034, 6378.77674281398, 6438.6136831790245, 584.6608966799246, 599.0893841361107, 610.6885488400859, 613.25489530221, 621.7171187109855, 3871.090293780959, 4008.5590585035625, 4032.4354590357375, 4049.1699201663587, 4157.563455837154, 14562.126272423688, 15049.699006019819, 15090.396384144511, 15208.239588020555, 15251.084934903942, 14392.208428536322, 14889.329980150918, 14955.700885982436, 15165.469208577646, 15405.691886162214, 8445.113263107409, 8634.352423568258, 8742.91257087421, 8782.736517904474, 8805.251553617885, 6784.253732089367, 6785.355391237825, 6791.592504449749, 6899.413549848319, 6945.513814032969, 12953.611391658265, 13268.469261229442, 13598.0, 13635.181889086687, 13820.930895345458, 13552.457901683822, 13680.726385472433, 13717.588472345846, 13859.51491697826, 14126.0, 9183.173514383738, 9512.286578506779, 9598.136167744937, 9610.942796292542, 9654.56554455037, 10824.134069274596, 10883.727906802076, 10911.290766100177, 10928.344299342065, 10943.069839063768, 7444.255574442513, 7581.135776409327, 7617.42869284817, 7620.314171724572, 9312.906870931203, 8945.105489451003, 8965.327600430124, 9047.954760226157, 9061.68284110053, 9101.908980910372, 6888.758893438706, 8176.386770992318, 8195.549244791593, 8251.092379838094, 8308.33533317321, 6017.638941663514, 6138.07928810682, 6164.229471316085, 6183.3816618337805, 6224.190855188796, 4654.953450465452, 6109.6639684817765, 6193.566450348612, 6201.6899155041165, 6281.811545653638], "value": 5332.746289633671, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.931290557311, 397.3503322068417, 399.6443165582632, 407.0962463331403, 407.7044142996328, 5047.939932614151, 5120.871978200542, 5667.356466624679, 5950.910736338948, 6097.725602347894, 4690.953090469095, 4802.207635740107, 6153.969230153843, 6164.7534098636115, 6181.783637572686, 3637.5453068366455, 3661.8535258589623, 3904.8285514345725, 4332.74350438374, 4461.776911154438, 3651.561812582494, 4463.018136010072, 4469.173202957463, 4481.327800829869, 4482.484514280851, 3405.7105146062613, 3617.8371973261264, 3650.8904732858055, 4299.075698724773, 4450.710703804242, 3673.3204357194004, 4246.936295955563, 4393.912121757563, 4409.184300904343, 4463.352813842007, 3467.930641387158, 3784.508013958168, 3785.1294202333343, 3793.2223894101644, 3798.392257238856, 6002.339742628307, 6017.729202185912, 6033.607815492023, 6073.969630151865, 6085.208922840046, 4369.737815731035, 5175.249588809639, 5259.5529380002745, 5358.517733404013, 5401.972990135064, 6529.31442198567, 6534.77128300512, 6572.76995305162, 6617.0, 6618.437432818217, 3552.9111772205642, 4283.2076065927595, 4303.268444364466, 4324.6972711910175, 4325.978370108161, 6744.258131605568, 6854.485913556503, 6883.483738719616, 6965.895511567331, 7048.0, 4326.372675962031, 4329.653627709776, 4344.045179669161, 4365.388845561624, 4367.978160109243, 4378.912421751611, 4421.115776844644, 4431.534688857688, 4437.356583295404, 4449.221386257392, 5144.6398752087, 5227.3465816772905, 5269.446708095671, 5302.310699609026, 5338.199270109437, 5483.75323110453, 6586.934130658728, 6608.603483790988, 6649.501287403367, 6668.633225172662, 1334.5796074236778, 1421.175718083509, 1493.1862135136378, 1517.0821652900058, 1517.4613012380667, 828.9751307460785, 831.6507067031861, 878.83302172587, 973.5278389980854, 997.3118548201718, 5222.399424066281, 5792.102224155263, 6143.941779503827, 6147.784827531015, 6166.260048794174, 5393.7033463159905, 6165.475934545524, 6654.434373078246, 6765.458763298924, 6792.8301792454595, 6041.033434650522, 6071.969640151771, 6142.815715528542, 6158.692065396713, 6185.969070154711, 3534.416821224469, 3559.18138828071, 3559.911002224965, 3570.107473131717, 3591.2099338145567, 6785.626790526469, 7089.751858684921, 7111.075560177247, 7153.561794384991, 7182.174049984214, 6958.269381714847, 7050.871860502295, 7128.607926564089, 7141.464974837489, 7150.3922166615375, 7036.542624729376, 7051.858962820817, 7061.293870612795, 7068.187158476841, 7160.496295777945, 6883.724651013903, 6901.723931042702, 6908.0, 6912.827179320356, 6997.755078572225, 5436.429174936575, 5527.364353099284, 6400.263969643364, 6482.800681873869, 6636.170478690164, 6138.772245550997, 6455.870882582416, 6669.799906002828, 6936.375726184668, 7215.963920180366, 4357.67317451186, 4360.389545463701, 4362.672799540111, 4365.781710914505, 4380.540043295408, 5815.82552523425, 6548.476121910331, 6715.093462382516, 6879.415249703631, 6917.757878474431, 6659.766908158192, 6687.799366019027, 6701.262861085179, 6702.966485167543, 6730.697118629576, 6591.945288753776, 6624.933750662624, 6659.866802664016, 6709.691610136172, 6724.865502690017, 6533.18335208099, 6581.3418658133805, 6592.505562082767, 6614.966925165343, 6631.237407698177, 5760.193572899713, 6328.525360597881, 6742.561733487504, 6768.7292508299115, 6806.591604503746, 6461.967690161519, 6487.458778854915, 6495.512836537184, 6501.674916254263, 6551.868962620625], "value": 4721.549539746664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.3809642767924, 833.5623797506308, 859.1022381611217, 867.7873920889381, 872.7774417523534, 14267.571972840806, 14886.925565372158, 16166.272517736701, 16549.089800060992, 16634.999999999985, 16845.494635160965, 17316.307347706108, 17582.560435989108, 17665.73501397477, 18060.909695451504, 982.719924821426, 1002.4336250018716, 1006.3609607899, 1008.0675375277875, 1008.3445760255819, 998.7902540466511, 1001.0790073132736, 1002.3434650304063, 1002.9648962286321, 1003.8644782954317, 992.5731935267831, 1034.9534270957824, 1041.7239431550645, 1042.1454407385947, 1044.9738756531071, 1035.6168217759478, 1036.4092467293647, 1037.636827110509, 1039.7972395382903, 1039.8024375368693, 760.2169765141913, 761.417515600566, 761.5621017914666, 761.7219714804056, 765.0742601452249, 16635.584110397216, 17006.48980530586, 17257.223424945783, 17332.82667173337, 17562.034088125147, 17055.74416383743, 17124.400645977457, 17399.65200695979, 17543.473695789147, 17578.91210543939, 12604.873951260553, 12643.683907902285, 12674.049446291565, 12765.936170319183, 12831.0, 3488.145404375944, 3509.12271932017, 3511.3855075361967, 3511.7015053720465, 3511.719062474996, 136145.0, 136368.0, 136412.0, 136930.3153484236, 139520.0, 13055.608331750063, 13311.267880266678, 13338.333083345793, 13381.598552043455, 13462.0, 25410.237692869243, 25737.227883163534, 26024.089156879418, 26175.93826448451, 26218.86890565573, 7717.8456430871065, 7768.805779855549, 7782.883256751154, 7803.570803605742, 7807.453478256468, 3863.652271295597, 3932.6264004919485, 3970.741901776433, 4010.8796736097966, 4021.617946295097, 4215.557366476476, 4270.103278311527, 4270.551592082787, 4296.720713153635, 4303.289957157097, 828.3580225325421, 871.7733389318822, 905.9139381758722, 911.8601747815231, 955.8422860228123, 637.0921436952417, 653.3825534869503, 667.302668711198, 678.1489231015045, 689.4036658290643, 11136.944315278372, 11965.820512692317, 12003.759924801456, 12086.214396064228, 12283.201591896499, 641.2625480697236, 645.2225068792188, 652.5856081388353, 668.9933100668931, 677.529117263507, 5364.329458817648, 5498.0, 5513.476219759116, 5544.029794785896, 5579.581531385163, 105733.88532229312, 106382.0, 106612.0, 108120.0, 108143.0, 97287.05425891443, 97369.5131524352, 97905.51047244717, 98496.0, 100672.49663751635, 84736.72894906705, 84927.83618539137, 85209.57395212984, 85489.57255213808, 86197.0, 10856.402897840379, 11028.779424411307, 11155.0, 11241.213115082193, 11357.772844543228, 37776.244475109794, 37819.62180378271, 38056.0, 38239.61760382472, 38925.02687432837, 50409.0, 50682.493175069256, 51007.744961274955, 51074.0, 51768.18811341585, 14281.857181428468, 14446.205458699873, 14558.199299038655, 14565.198914059829, 14775.556733298019, 15976.281067351765, 16044.518664440086, 16047.598810029842, 16092.67814643724, 16226.918865406069, 14678.0, 14784.0, 14793.038452500554, 14943.626409339418, 15106.244687765788, 14465.0, 14812.259387030821, 14953.40186392532, 14977.0, 14988.250587470366, 13800.0, 14149.43402263898, 14320.713585728436, 14429.639259018608, 14520.709585808436, 9198.586063627019, 10622.415767132881, 10804.891951080388, 10828.566857325619, 10949.452527373758, 11742.706432338919, 11845.0, 11908.52365905354, 11965.282083075042, 11985.981191598812], "value": 8180.108135570781, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 117.0, 118.0, 111.0, 114.0, 115.0, 114.0, 114.0, 116.0, 120.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 113.0, 146.0, 112.0, 110.0, 109.0, 112.0, 134.0, 110.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 201.0, 220.0, 223.0, 199.0, 191.0, 201.0, 198.0, 200.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 66.0, 83.0, 81.0, 75.0, 50.0, 67.0, 80.0, 89.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 61.0, 67.0, 102.0, 101.0, 89.0, 86.0, 69.0, 67.0, 88.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 134.0, 107.0, 90.0, 88.0, 91.0, 103.0, 78.0, 77.0, 106.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 150.0, 152.0, 95.0, 108.0, 146.0, 146.0, 96.0, 103.0, 97.0], "value": 122.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 92.0, 102.0, 94.0, 90.0, 90.0, 95.0, 93.0, 91.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 49.0, 51.0, 50.0, 46.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 79.0, 82.0, 69.0, 65.0, 62.0, 57.0, 58.0, 59.0, 60.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 82.0, 83.0, 86.0, 85.0, 81.0, 84.0, 85.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 130.0, 142.0, 158.0, 157.0, 141.0, 130.0, 232.0, 150.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 185.0, 180.0, 244.0, 169.0, 221.0, 235.0, 190.0, 195.0], "value": 199.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 74.0, 73.0, 85.0, 70.0, 70.0, 65.0, 72.0], "value": 70.8, "unit": "score"}]}]} 04:16:08 INFO - Return code: 0 04:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:16:08 ERROR - # TBPL SUCCESS # 04:16:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:16:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:16:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:16:08 INFO - 2017-05-02 04:16:08.164 screenresolution[1659:10631] starting screenresolution argv=screenresolution get 04:16:08 INFO - 2017-05-02 04:16:08.166 screenresolution[1659:10631] Display 0: 1600x1200x32@60 04:16:08 INFO - 2017-05-02 04:16:08.173 screenresolution[1660:10634] starting screenresolution argv=screenresolution list 04:16:08 INFO - Available Modes on Display 0 04:16:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:16:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:16:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:16:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:16:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:16:08 INFO - Intel Iris: 04:16:08 INFO - Chipset Model: Intel Iris 04:16:08 INFO - Type: GPU 04:16:08 INFO - Bus: Built-In 04:16:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:16:08 INFO - Vendor: Intel (0x8086) 04:16:08 INFO - Device ID: 0x0a2e 04:16:08 INFO - Revision ID: 0x0009 04:16:08 INFO - Displays: 04:16:08 INFO - Display: 04:16:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:16:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:16:08 INFO - Display Serial Number: 1600x1200 60 04:16:08 INFO - Main Display: Yes 04:16:08 INFO - Mirror: Off 04:16:08 INFO - Online: Yes 04:16:08 INFO - Rotation: Supported 04:16:08 INFO - Return code: 0 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - [mozharness: 2017-05-02 11:16:08.415672Z] Finished run-tests step (success) 04:16:08 INFO - Running post-run listener: _resource_record_post_run 04:16:08 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39414784; Write bytes: 513194496; Read time: 253; Write time: 1620 04:16:08 INFO - TinderboxPrint: CPU usage
54.0% 04:16:08 INFO - TinderboxPrint: I/O read bytes / time
39,414,784 / 253 04:16:08 INFO - TinderboxPrint: I/O write bytes / time
513,194,496 / 1,620 04:16:08 INFO - TinderboxPrint: CPU idle
2,203.6 (46.0%) 04:16:08 INFO - TinderboxPrint: CPU system
960.4 (20.1%) 04:16:08 INFO - TinderboxPrint: CPU user
1,625.7 (33.9%) 04:16:08 INFO - TinderboxPrint: Swap in / out
248,385,536 / 0 04:16:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208069120; Write bytes: 205911552; Read time: 16052; Write time: 432 04:16:08 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35335168; Write bytes: 300057600; Read time: 226; Write time: 1159 04:16:08 INFO - Running post-run listener: _upload_blobber_files 04:16:08 INFO - Blob upload gear active. 04:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:16:08 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'] 04:16:08 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 04:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:10 INFO - (blobuploader) - INFO - Done attempting. 04:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:11 INFO - (blobuploader) - INFO - Done attempting. 04:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:12 INFO - (blobuploader) - INFO - Done attempting. 04:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:14 INFO - (blobuploader) - INFO - Done attempting. 04:16:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:14 INFO - Return code: 0 04:16:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce57c58b66c73ddb659c51ea09592b8ffccf7b826be118160abacb4a130132c55d92b32984805fc663657d996ad90e4bdb87c93f8283295a3efba3885d139bba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603e4238022e17c6d515ba85de0881d9a6291d07e291023d4c742a20546b155c6be8d21fab68ec2563dde28467e931402c6282bf20e68ee1472be55ebac7cd26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a029f419f20cad323ced28ec4743d947a8df68a6b45a589a0dabacde5d557719d2e0465a42229768cc6102a3fe5e90b03f39c9575fa3e87041133be7b1ec660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/533ef9670d2b6e8d2e625b1fc9924d553064bf7c1f56ca1387311a1b5243b16135d84860be641c1b91e4f6c93178700dc4327055728e477196e9a9c342cc423a"} 04:16:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:14 INFO - Contents: 04:16:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce57c58b66c73ddb659c51ea09592b8ffccf7b826be118160abacb4a130132c55d92b32984805fc663657d996ad90e4bdb87c93f8283295a3efba3885d139bba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603e4238022e17c6d515ba85de0881d9a6291d07e291023d4c742a20546b155c6be8d21fab68ec2563dde28467e931402c6282bf20e68ee1472be55ebac7cd26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a029f419f20cad323ced28ec4743d947a8df68a6b45a589a0dabacde5d557719d2e0465a42229768cc6102a3fe5e90b03f39c9575fa3e87041133be7b1ec660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/533ef9670d2b6e8d2e625b1fc9924d553064bf7c1f56ca1387311a1b5243b16135d84860be641c1b91e4f6c93178700dc4327055728e477196e9a9c342cc423a"} 04:16:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:14 INFO - Copying logs to upload dir... 04:16:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.407045 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-05-02 04:16:14.679847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:16:14.683321) ========= 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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce57c58b66c73ddb659c51ea09592b8ffccf7b826be118160abacb4a130132c55d92b32984805fc663657d996ad90e4bdb87c93f8283295a3efba3885d139bba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603e4238022e17c6d515ba85de0881d9a6291d07e291023d4c742a20546b155c6be8d21fab68ec2563dde28467e931402c6282bf20e68ee1472be55ebac7cd26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a029f419f20cad323ced28ec4743d947a8df68a6b45a589a0dabacde5d557719d2e0465a42229768cc6102a3fe5e90b03f39c9575fa3e87041133be7b1ec660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/533ef9670d2b6e8d2e625b1fc9924d553064bf7c1f56ca1387311a1b5243b16135d84860be641c1b91e4f6c93178700dc4327055728e477196e9a9c342cc423a"} build_url:https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce57c58b66c73ddb659c51ea09592b8ffccf7b826be118160abacb4a130132c55d92b32984805fc663657d996ad90e4bdb87c93f8283295a3efba3885d139bba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/603e4238022e17c6d515ba85de0881d9a6291d07e291023d4c742a20546b155c6be8d21fab68ec2563dde28467e931402c6282bf20e68ee1472be55ebac7cd26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a029f419f20cad323ced28ec4743d947a8df68a6b45a589a0dabacde5d557719d2e0465a42229768cc6102a3fe5e90b03f39c9575fa3e87041133be7b1ec660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/533ef9670d2b6e8d2e625b1fc9924d553064bf7c1f56ca1387311a1b5243b16135d84860be641c1b91e4f6c93178700dc4327055728e477196e9a9c342cc423a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:16:14.718511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:16:14.718826) ========= 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.Y6hEqd1CaE/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.9b3uylX9IK/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.004456 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:16:14.766882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:16:14.767195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:16:14.767498) ========= ========= Total master_lag: 0.18 =========