builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0364 starttime: 1493776887.63 results: success (0) buildid: 20170502173721 builduid: a47a5a5587484af0ae9922d3739bb968 revision: a748acbebbde373a88868dc02910fb2bc5e6a023 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.632719) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.633210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.633550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.662192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.662583) ========= 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.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:01:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.72M=0.002s 2017-05-02 19:01:27 (7.72 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.813566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.813886) ========= 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.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.021992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:27.862759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 19:01:27.863117) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a748acbebbde373a88868dc02910fb2bc5e6a023 --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 a748acbebbde373a88868dc02910fb2bc5e6a023 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:01:27,953 truncating revision to first 12 chars 2017-05-02 19:01:27,953 Setting DEBUG logging. 2017-05-02 19:01:27,953 attempt 1/10 2017-05-02 19:01:27,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a748acbebbde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 19:01:29,158 unpacking tar archive at: mozilla-central-a748acbebbde/testing/mozharness/ program finished with exit code 0 elapsedTime=1.476084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 19:01:29.363889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:29.364209) ========= script_repo_revision: a748acbebbde373a88868dc02910fb2bc5e6a023 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:29.364616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:29.364894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 19:01:29.386208) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-02 19:01:29.386598) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:01:29 INFO - MultiFileLogger online at 20170502 19:01:29 in /builds/slave/test 19:01:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:01:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:29 INFO - {'append_to_log': False, 19:01:29 INFO - 'base_work_dir': '/builds/slave/test', 19:01:29 INFO - 'blob_upload_branch': 'Firefox', 19:01:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:29 INFO - 'branch': 'Firefox', 19:01:29 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:29 INFO - 'config_files': ('talos/mac_config.py',), 19:01:29 INFO - 'default_actions': ('clobber', 19:01:29 INFO - 'read-buildbot-config', 19:01:29 INFO - 'download-and-extract', 19:01:29 INFO - 'populate-webroot', 19:01:29 INFO - 'create-virtualenv', 19:01:29 INFO - 'install', 19:01:29 INFO - 'run-tests'), 19:01:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:29 INFO - 'download_minidump_stackwalk': True, 19:01:29 INFO - 'download_symbols': 'ondemand', 19:01:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:29 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:29 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:29 INFO - 'gecko_profile': False, 19:01:29 INFO - 'gecko_profile_interval': 0, 19:01:29 INFO - 'installer_path': 'installer.exe', 19:01:29 INFO - 'log_level': 'info', 19:01:29 INFO - 'log_name': 'talos', 19:01:29 INFO - 'log_to_console': True, 19:01:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:01:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:01:29 INFO - 'opt_config_files': (), 19:01:29 INFO - 'pip_index': False, 19:01:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:01:29 INFO - 'cmd': ('bash', 19:01:29 INFO - '-c', 19:01:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:01:29 INFO - 'enabled': True, 19:01:29 INFO - 'halt_on_failure': False, 19:01:29 INFO - 'name': 'check_screen_resolution'},), 19:01:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:01:29 INFO - 'cmd': ('bash', 19:01:29 INFO - '-c', 19:01:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:01:29 INFO - 'enabled': True, 19:01:29 INFO - 'halt_on_failure': False, 19:01:29 INFO - 'name': 'check_screen_resolution'},), 19:01:29 INFO - 'run_cmd_checks_enabled': True, 19:01:29 INFO - 'suite': 'dromaeojs', 19:01:29 INFO - 'system_bits': '32', 19:01:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:29 INFO - 'title': 't-yosemite-r7-0364', 19:01:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:29 INFO - 'use_talos_json': True, 19:01:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:29 INFO - 'work_dir': 'build'} 19:01:29 INFO - [mozharness: 2017-05-03 02:01:29.597471Z] Running clobber step. 19:01:29 INFO - Running pre-action listener: _resource_record_pre_action 19:01:29 INFO - Running main action method: clobber 19:01:29 INFO - rmtree: /builds/slave/test/build 19:01:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2017-05-03 02:01:31.539107Z] Finished clobber step (success) 19:01:31 INFO - [mozharness: 2017-05-03 02:01:31.539244Z] Running read-buildbot-config step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: read_buildbot_config 19:01:31 INFO - Using buildbot properties: 19:01:31 INFO - { 19:01:31 INFO - "project": "", 19:01:31 INFO - "product": "firefox", 19:01:31 INFO - "script_repo_revision": "production", 19:01:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:01:31 INFO - "repository": "", 19:01:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:01:31 INFO - "buildid": "20170502173721", 19:01:31 INFO - "pgo_build": "False", 19:01:31 INFO - "basedir": "/builds/slave/test", 19:01:31 INFO - "buildnumber": 26, 19:01:31 INFO - "slavename": "t-yosemite-r7-0364", 19:01:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:01:31 INFO - "platform": "yosemite_r7", 19:01:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:01:31 INFO - "branch": "mozilla-central", 19:01:31 INFO - "repo_path": "mozilla-central", 19:01:31 INFO - "revision": "a748acbebbde373a88868dc02910fb2bc5e6a023", 19:01:31 INFO - "stage_platform": "macosx64", 19:01:31 INFO - "builduid": "a47a5a5587484af0ae9922d3739bb968", 19:01:31 INFO - "slavebuilddir": "test" 19:01:31 INFO - } 19:01:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2017-05-03 02:01:31.542458Z] Finished read-buildbot-config step (success) 19:01:31 INFO - [mozharness: 2017-05-03 02:01:31.542582Z] Running download-and-extract step. 19:01:31 INFO - Running pre-action listener: _resource_record_pre_action 19:01:31 INFO - Running main action method: download_and_extract 19:01:31 INFO - mkdir: /builds/slave/test/build/tests 19:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:01:31 INFO - trying https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:01:31 INFO - Downloading https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/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 19:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/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 19:01:32 INFO - Downloaded 1325 bytes. 19:01:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:01:32 INFO - Using the following test package requirements: 19:01:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:01:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:01:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:01:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:01:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'jsshell-mac.zip'], 19:01:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:01:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:01:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:01:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:01:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:01:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:01:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:01:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:01:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:01:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:01:32 INFO - Fetch https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:01:34 INFO - Content-Length response header: 52699856 19:01:34 INFO - Bytes received: 52699856 19:01:50 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 19:01:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:01:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:01:50 INFO - Fetch https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:01:53 INFO - Content-Length response header: 52699856 19:01:53 INFO - Bytes received: 52699856 19:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:02:09 INFO - Content-Length response header: 14408811 19:02:09 INFO - Bytes received: 14408811 19:02: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')]} 19:02:09 INFO - trying https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:02:09 INFO - Downloading https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:02:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/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 19:02:11 INFO - Downloaded 71197092 bytes. 19:02:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:02:11 INFO - mkdir: /builds/slave/test/properties 19:02:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:11 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:11 INFO - Contents: 19:02:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:02:12 INFO - Running post-action listener: _resource_record_post_action 19:02:12 INFO - Running post-action listener: set_extra_try_arguments 19:02:12 INFO - [mozharness: 2017-05-03 02:02:12.294122Z] Finished download-and-extract step (success) 19:02:12 INFO - [mozharness: 2017-05-03 02:02:12.294269Z] Running populate-webroot step. 19:02:12 INFO - Running pre-action listener: _resource_record_pre_action 19:02:12 INFO - Running main action method: populate_webroot 19:02:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:12 INFO - '--tppagecycles', 19:02:12 INFO - '7'], 19:02:12 INFO - 'tests': ['tsvgm']}}, 19:02:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:02:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:02:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['damp', 'tps']}, 19:02:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'tests': ['damp', 'tps']}, 19:02:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['dromaeo_dom']}, 19:02:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:02:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:02:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'other-e10s': {'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['a11yr', 19:02:12 INFO - 'ts_paint', 19:02:12 INFO - 'tpaint', 19:02:12 INFO - 'sessionrestore', 19:02:12 INFO - 'sessionrestore_no_auto_restore', 19:02:12 INFO - 'tabpaint']}, 19:02:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:02:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:02:12 INFO - 'bloom_basic_ref']}, 19:02:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['tsvgx', 19:02:12 INFO - 'tsvgr_opacity', 19:02:12 INFO - 'tart', 19:02:12 INFO - 'tscrollx', 19:02:12 INFO - 'cart', 19:02:12 INFO - 'tsvg_static']}, 19:02:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:02:12 INFO - 'tsvgr_opacity', 19:02:12 INFO - 'tart', 19:02:12 INFO - 'tscrollx', 19:02:12 INFO - 'cart', 19:02:12 INFO - 'tsvg_static']}, 19:02:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'talos_options': ['--disable-e10s'], 19:02:12 INFO - 'tests': ['tp5o']}, 19:02:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:02:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'talos_options': ['--disable-e10s', 19:02:12 INFO - '--xperf_path', 19:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:12 INFO - 'tests': ['tp5n']}, 19:02:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:02:12 INFO - 'talos_options': ['--xperf_path', 19:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:12 INFO - 'tests': ['tp5n']}}, 19:02:12 INFO - 'talos.zip': {'path': '', 19:02:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:12 INFO - Running post-action listener: _resource_record_post_action 19:02:12 INFO - [mozharness: 2017-05-03 02:02:12.313604Z] Finished populate-webroot step (success) 19:02:12 INFO - [mozharness: 2017-05-03 02:02:12.313739Z] Running create-virtualenv step. 19:02:12 INFO - Running pre-action listener: _resource_record_pre_action 19:02:12 INFO - Running main action method: create_virtualenv 19:02:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:12 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 19:02:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:12 INFO - Using real prefix '/tools/python27' 19:02:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:16 INFO - Installing pip.................done. 19:02:16 INFO - Return code: 0 19:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:02:16 INFO - Reading from file tmpfile_stdout 19:02:16 INFO - Output received: 19:02:16 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) 19:02:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:16 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:16 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 19:02:16 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 19:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:16 INFO - 'HOME': '/Users/cltbld', 19:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:16 INFO - 'LOGNAME': 'cltbld', 19:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:16 INFO - 'MOZ_NO_REMOTE': '1', 19:02:16 INFO - 'NO_EM_RESTART': '1', 19:02:16 INFO - 'PAGER': '/bin/cat', 19:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:16 INFO - 'PWD': '/builds/slave/test', 19:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:16 INFO - 'SHELL': '/bin/bash', 19:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:16 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:16 INFO - 'USER': 'cltbld', 19:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:16 INFO - 'XPC_FLAGS': '0x0', 19:02:16 INFO - 'XPC_SERVICE_NAME': '0', 19:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:17 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 19:02:17 INFO - Cleaning up... 19:02:17 INFO - Return code: 0 19:02:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:17 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:17 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 19:02:17 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 19:02:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:17 INFO - 'HOME': '/Users/cltbld', 19:02:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:17 INFO - 'LOGNAME': 'cltbld', 19:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:17 INFO - 'MOZ_NO_REMOTE': '1', 19:02:17 INFO - 'NO_EM_RESTART': '1', 19:02:17 INFO - 'PAGER': '/bin/cat', 19:02:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:17 INFO - 'PWD': '/builds/slave/test', 19:02:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:17 INFO - 'SHELL': '/bin/bash', 19:02:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:17 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:17 INFO - 'USER': 'cltbld', 19:02:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:17 INFO - 'XPC_FLAGS': '0x0', 19:02:17 INFO - 'XPC_SERVICE_NAME': '0', 19:02:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:17 INFO - Downloading/unpacking psutil>=3.1.1 19:02:17 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 19:02:17 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 19:02:17 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 19:02:17 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 19:02:17 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 19:02:17 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 19:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:21 INFO - Installing collected packages: psutil 19:02:21 INFO - Running setup.py install for psutil 19:02:21 INFO - building 'psutil._psutil_osx' extension 19:02:21 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 19:02:21 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 19:02:21 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 19:02:22 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 19:02:22 INFO - building 'psutil._psutil_posix' extension 19:02:22 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 19:02:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:02:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:02:22 INFO - ^ 19:02:22 INFO - 1 warning generated. 19:02:22 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 19:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:22 INFO - Successfully installed psutil 19:02:22 INFO - Cleaning up... 19:02:22 INFO - Return code: 0 19:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:02:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:22 INFO - 'HOME': '/Users/cltbld', 19:02:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:22 INFO - 'LOGNAME': 'cltbld', 19:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:22 INFO - 'MOZ_NO_REMOTE': '1', 19:02:22 INFO - 'NO_EM_RESTART': '1', 19:02:22 INFO - 'PAGER': '/bin/cat', 19:02:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:22 INFO - 'PWD': '/builds/slave/test', 19:02:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:22 INFO - 'SHELL': '/bin/bash', 19:02:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:22 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:22 INFO - 'USER': 'cltbld', 19:02:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:22 INFO - 'XPC_FLAGS': '0x0', 19:02:22 INFO - 'XPC_SERVICE_NAME': '0', 19:02:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:02:22 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 19:02:22 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 19:02:22 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 19:02:22 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 19:02:22 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 19:02:22 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 19:02:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:02:25 INFO - Installing collected packages: mozsystemmonitor 19:02:25 INFO - Running setup.py install for mozsystemmonitor 19:02:25 INFO - Successfully installed mozsystemmonitor 19:02:25 INFO - Cleaning up... 19:02:25 INFO - Return code: 0 19:02:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:02:25 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')]} 19:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:25 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')]} 19:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:25 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:25 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 19:02:25 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 19:02:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:25 INFO - 'HOME': '/Users/cltbld', 19:02:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:25 INFO - 'LOGNAME': 'cltbld', 19:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:25 INFO - 'MOZ_NO_REMOTE': '1', 19:02:25 INFO - 'NO_EM_RESTART': '1', 19:02:25 INFO - 'PAGER': '/bin/cat', 19:02:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:25 INFO - 'PWD': '/builds/slave/test', 19:02:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:25 INFO - 'SHELL': '/bin/bash', 19:02:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:25 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:25 INFO - 'USER': 'cltbld', 19:02:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:25 INFO - 'XPC_FLAGS': '0x0', 19:02:25 INFO - 'XPC_SERVICE_NAME': '0', 19:02:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:02:28 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 19:02:28 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 19:02:28 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 19:02:28 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 19:02:28 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 19:02:28 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 19:02:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:28 INFO - warning: no files found matching '*.txt' 19:02:28 INFO - no previously-included directories found matching 'build' 19:02:28 INFO - no previously-included directories found matching 'dist' 19:02:28 INFO - no previously-included directories found matching '.git*' 19:02:28 INFO - Installing collected packages: jsonschema, functools32 19:02:29 INFO - Running setup.py install for functools32 19:02:29 INFO - warning: no files found matching '*.txt' 19:02:29 INFO - no previously-included directories found matching 'build' 19:02:29 INFO - no previously-included directories found matching 'dist' 19:02:29 INFO - no previously-included directories found matching '.git*' 19:02:29 INFO - Successfully installed jsonschema functools32 19:02:29 INFO - Cleaning up... 19:02:29 INFO - Return code: 0 19:02:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:02:29 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')]} 19:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:29 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')]} 19:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:29 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:29 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 19:02:29 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 19:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:29 INFO - 'HOME': '/Users/cltbld', 19:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:29 INFO - 'LOGNAME': 'cltbld', 19:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:29 INFO - 'MOZ_NO_REMOTE': '1', 19:02:29 INFO - 'NO_EM_RESTART': '1', 19:02:29 INFO - 'PAGER': '/bin/cat', 19:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:29 INFO - 'PWD': '/builds/slave/test', 19:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:29 INFO - 'SHELL': '/bin/bash', 19:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:29 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:29 INFO - 'USER': 'cltbld', 19:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:29 INFO - 'XPC_FLAGS': '0x0', 19:02:29 INFO - 'XPC_SERVICE_NAME': '0', 19:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:02:29 INFO - Cleaning up... 19:02:29 INFO - Return code: 0 19:02:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:29 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')]} 19:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:29 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')]} 19:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:29 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:29 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 19:02:29 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 19:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:29 INFO - 'HOME': '/Users/cltbld', 19:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:29 INFO - 'LOGNAME': 'cltbld', 19:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:29 INFO - 'MOZ_NO_REMOTE': '1', 19:02:29 INFO - 'NO_EM_RESTART': '1', 19:02:29 INFO - 'PAGER': '/bin/cat', 19:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:29 INFO - 'PWD': '/builds/slave/test', 19:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:29 INFO - 'SHELL': '/bin/bash', 19:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:29 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:29 INFO - 'USER': 'cltbld', 19:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:29 INFO - 'XPC_FLAGS': '0x0', 19:02:29 INFO - 'XPC_SERVICE_NAME': '0', 19:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:32 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:32 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 19:02:32 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 19:02:32 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 19:02:32 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 19:02:32 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 19:02:32 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 19:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:33 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 19:02:33 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 19:02:33 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 19:02:33 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 19:02:33 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 19:02:33 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 19:02:33 INFO - Downloading docopt-0.6.1.tar.gz 19:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:33 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:33 INFO - Running setup.py install for blobuploader 19:02:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:33 INFO - Running setup.py install for requests 19:02:34 INFO - Running setup.py install for docopt 19:02:34 INFO - Successfully installed blobuploader requests docopt 19:02:34 INFO - Cleaning up... 19:02:34 INFO - Return code: 0 19:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:34 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:34 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 19:02:34 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 19:02:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:34 INFO - 'HOME': '/Users/cltbld', 19:02:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:34 INFO - 'LOGNAME': 'cltbld', 19:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:34 INFO - 'MOZ_NO_REMOTE': '1', 19:02:34 INFO - 'NO_EM_RESTART': '1', 19:02:34 INFO - 'PAGER': '/bin/cat', 19:02:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:34 INFO - 'PWD': '/builds/slave/test', 19:02:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:34 INFO - 'SHELL': '/bin/bash', 19:02:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:34 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:34 INFO - 'USER': 'cltbld', 19:02:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:34 INFO - 'XPC_FLAGS': '0x0', 19:02:34 INFO - 'XPC_SERVICE_NAME': '0', 19:02:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:34 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Bq8BSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-IPYiiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-xKif0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-oS198X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-2PRYg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-43aY6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-l_ZMle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-H35pj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-zXuO1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:35 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-afLPkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-4DbaAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Z6GTAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-xaBm8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-MDflHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-r5ng9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-gE1cOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:36 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-9_47Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:36 INFO - Running setup.py install for manifestparser 19:02:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:36 INFO - Running setup.py install for mozcrash 19:02:37 INFO - Running setup.py install for mozdebug 19:02:37 INFO - Running setup.py install for mozdevice 19:02:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Running setup.py install for mozfile 19:02:37 INFO - Running setup.py install for mozhttpd 19:02:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Running setup.py install for mozinfo 19:02:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Running setup.py install for mozInstall 19:02:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:37 INFO - Running setup.py install for mozleak 19:02:38 INFO - Running setup.py install for mozlog 19:02:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Running setup.py install for moznetwork 19:02:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Running setup.py install for mozprocess 19:02:38 INFO - Running setup.py install for mozprofile 19:02:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Running setup.py install for mozrunner 19:02:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:38 INFO - Running setup.py install for mozscreenshot 19:02:39 INFO - Running setup.py install for moztest 19:02:39 INFO - Running setup.py install for mozversion 19:02:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:39 INFO - Cleaning up... 19:02:39 INFO - Return code: 0 19:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:39 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')]} 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 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')]} 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:39 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 19:02:39 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 19:02:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:39 INFO - 'HOME': '/Users/cltbld', 19:02:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:39 INFO - 'LOGNAME': 'cltbld', 19:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:39 INFO - 'MOZ_NO_REMOTE': '1', 19:02:39 INFO - 'NO_EM_RESTART': '1', 19:02:39 INFO - 'PAGER': '/bin/cat', 19:02:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:39 INFO - 'PWD': '/builds/slave/test', 19:02:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:39 INFO - 'SHELL': '/bin/bash', 19:02:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:39 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:39 INFO - 'USER': 'cltbld', 19:02:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:39 INFO - 'XPC_FLAGS': '0x0', 19:02:39 INFO - 'XPC_SERVICE_NAME': '0', 19:02:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:39 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Xu2W5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:39 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)) 19:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:39 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Sx5AWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:39 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)) 19:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:39 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-zOj8_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:39 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)) 19:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:39 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-PwAWSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-kUrJoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-4wt6td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-z0lxRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-DvR8Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-MBrCtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-lRlNqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-EBwnqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-_DPLNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:40 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)) 19:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:40 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-8obCqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:41 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)) 19:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-uVzHo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:41 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)) 19:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-X2KdWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:41 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)) 19:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-KB_LUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:41 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)) 19:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:41 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-ed8wxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:41 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)) 19:02:41 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)) 19:02:41 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)) 19:02:41 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)) 19:02:41 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)) 19:02:41 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)) 19:02:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:44 INFO - Downloading blessings-1.6.tar.gz 19:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:44 INFO - Installing collected packages: blessings 19:02:44 INFO - Running setup.py install for blessings 19:02:44 INFO - Successfully installed blessings 19:02:44 INFO - Cleaning up... 19:02:44 INFO - Return code: 0 19:02:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:44 INFO - Reading from file tmpfile_stdout 19:02:44 INFO - Current package versions: 19:02:44 INFO - blessings == 1.6 19:02:44 INFO - blobuploader == 1.2.4 19:02:44 INFO - docopt == 0.6.1 19:02:44 INFO - functools32 == 3.2.3-2 19:02:44 INFO - jsonschema == 2.5.1 19:02:44 INFO - manifestparser == 1.1 19:02:44 INFO - mozInstall == 1.12 19:02:44 INFO - mozcrash == 1.0 19:02:44 INFO - mozdebug == 0.1 19:02:44 INFO - mozdevice == 0.50 19:02:44 INFO - mozfile == 1.2 19:02:44 INFO - mozhttpd == 0.7 19:02:44 INFO - mozinfo == 0.9 19:02:44 INFO - mozleak == 0.1 19:02:44 INFO - mozlog == 3.4 19:02:44 INFO - moznetwork == 0.27 19:02:44 INFO - mozprocess == 0.25 19:02:44 INFO - mozprofile == 0.28 19:02:44 INFO - mozrunner == 6.13 19:02:44 INFO - mozscreenshot == 0.1 19:02:44 INFO - mozsystemmonitor == 0.3 19:02:44 INFO - moztest == 0.8 19:02:44 INFO - mozversion == 1.4 19:02:44 INFO - psutil == 3.1.1 19:02:44 INFO - requests == 1.2.3 19:02:44 INFO - wsgiref == 0.1.2 19:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:44 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')]} 19:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 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')]} 19:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 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 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:44 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 19:02:44 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 19:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:44 INFO - 'HOME': '/Users/cltbld', 19:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:44 INFO - 'LOGNAME': 'cltbld', 19:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:44 INFO - 'MOZ_NO_REMOTE': '1', 19:02:44 INFO - 'NO_EM_RESTART': '1', 19:02:44 INFO - 'PAGER': '/bin/cat', 19:02:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:44 INFO - 'PWD': '/builds/slave/test', 19:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:44 INFO - 'SHELL': '/bin/bash', 19:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:44 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:44 INFO - 'USER': 'cltbld', 19:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:44 INFO - 'XPC_FLAGS': '0x0', 19:02:44 INFO - 'XPC_SERVICE_NAME': '0', 19:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 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)) 19:02:45 INFO - Cleaning up... 19:02:45 INFO - Return code: 0 19:02:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e3cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc768c5b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, '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.sWRN7PzdJw/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.XH34nFaGTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 19:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:45 INFO - 'HOME': '/Users/cltbld', 19:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:45 INFO - 'LOGNAME': 'cltbld', 19:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:45 INFO - 'MOZ_NO_REMOTE': '1', 19:02:45 INFO - 'NO_EM_RESTART': '1', 19:02:45 INFO - 'PAGER': '/bin/cat', 19:02:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:45 INFO - 'PWD': '/builds/slave/test', 19:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:45 INFO - 'SHELL': '/bin/bash', 19:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:02:45 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:45 INFO - 'USER': 'cltbld', 19:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:45 INFO - 'XPC_FLAGS': '0x0', 19:02:45 INFO - 'XPC_SERVICE_NAME': '0', 19:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:02:45 INFO - Cleaning up... 19:02:45 INFO - Return code: 0 19:02:45 INFO - Running post-action listener: _resource_record_post_action 19:02:45 INFO - Running post-action listener: _start_resource_monitoring 19:02:45 INFO - Starting resource monitoring. 19:02:45 INFO - [mozharness: 2017-05-03 02:02:45.361038Z] Finished create-virtualenv step (success) 19:02:45 INFO - [mozharness: 2017-05-03 02:02:45.362070Z] Running install step. 19:02:45 INFO - Running pre-action listener: _resource_record_pre_action 19:02:45 INFO - Running main action method: install 19:02:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:45 INFO - Reading from file tmpfile_stdout 19:02:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:45 INFO - Reading from file tmpfile_stdout 19:02:45 INFO - Output received: 19:02:45 INFO - Usage: mozinstall [options] installer 19:02:45 INFO - Options: 19:02:45 INFO - -h, --help show this help message and exit 19:02:45 INFO - -d DEST, --destination=DEST 19:02:45 INFO - Directory to install application into. [default: 19:02:45 INFO - "/builds/slave/test"] 19:02:45 INFO - --app=APP Application being installed. [default: firefox] 19:02:45 INFO - mkdir: /builds/slave/test/build/application 19:02:45 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'] 19:02:45 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 19:03:05 INFO - Reading from file tmpfile_stdout 19:03:05 INFO - Output received: 19:03:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:03:05 INFO - Running post-action listener: _resource_record_post_action 19:03:05 INFO - [mozharness: 2017-05-03 02:03:05.705331Z] Finished install step (success) 19:03:05 INFO - [mozharness: 2017-05-03 02:03:05.705502Z] Running run-tests step. 19:03:05 INFO - Running pre-action listener: _resource_record_pre_action 19:03:05 INFO - Running main action method: run_tests 19:03:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:03:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:03:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:03:05 INFO - 2017-05-02 19:03:05.720 screenresolution[3131:58175] starting screenresolution argv=screenresolution get 19:03:05 INFO - 2017-05-02 19:03:05.723 screenresolution[3131:58175] Display 0: 1600x1200x32@60 19:03:05 INFO - 2017-05-02 19:03:05.729 screenresolution[3132:58177] starting screenresolution argv=screenresolution list 19:03:05 INFO - Available Modes on Display 0 19:03:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:03:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:03:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:03:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:03:05 INFO - Intel Iris: 19:03:05 INFO - Chipset Model: Intel Iris 19:03:05 INFO - Type: GPU 19:03:05 INFO - Bus: Built-In 19:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 19:03:05 INFO - Vendor: Intel (0x8086) 19:03:05 INFO - Device ID: 0x0a2e 19:03:05 INFO - Revision ID: 0x0009 19:03:05 INFO - Displays: 19:03:05 INFO - Display: 19:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:03:05 INFO - Display Serial Number: 1600x1200 60 19:03:05 INFO - Main Display: Yes 19:03:05 INFO - Mirror: Off 19:03:05 INFO - Online: Yes 19:03:05 INFO - Rotation: Supported 19:03:05 INFO - Return code: 0 19:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:05 INFO - Python 2.7.3 19:03:05 INFO - Return code: 0 19:03:05 INFO - grabbing minidump binary from tooltool 19:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:05 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 0x10e1add30>, '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 0x10e0d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:05 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 19:03:05 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 19:03:05 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 19:03:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:06 INFO - Return code: 0 19:03:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:03:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:06 INFO - ENV: RUST_BACKTRACE is now 1 19:03:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:03:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0364 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:03:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWRN7PzdJw/Render', 19:03:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:06 INFO - 'HOME': '/Users/cltbld', 19:03:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:06 INFO - 'LOGNAME': 'cltbld', 19:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:06 INFO - 'MOZ_NO_REMOTE': '1', 19:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:06 INFO - 'NO_EM_RESTART': '1', 19:03:06 INFO - 'PAGER': '/bin/cat', 19:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:06 INFO - 'PWD': '/builds/slave/test', 19:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:06 INFO - 'RUST_BACKTRACE': '1', 19:03:06 INFO - 'SHELL': '/bin/bash', 19:03:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XH34nFaGTf/Listeners', 19:03:06 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 19:03:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:06 INFO - 'USER': 'cltbld', 19:03:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:06 INFO - 'XPC_FLAGS': '0x0', 19:03:06 INFO - 'XPC_SERVICE_NAME': '0', 19:03:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:03:06 INFO - mozversion application_buildid: 20170502173721 19:03:06 INFO - mozversion application_changeset: a748acbebbde373a88868dc02910fb2bc5e6a023 19:03:06 INFO - mozversion application_display_name: Nightly 19:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:06 INFO - mozversion application_name: Firefox 19:03:06 INFO - mozversion application_remotingname: firefox 19:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:03:06 INFO - mozversion application_vendor: Mozilla 19:03:06 INFO - mozversion application_version: 55.0a1 19:03:06 INFO - mozversion platform_buildid: 20170502173721 19:03:06 INFO - mozversion platform_changeset: a748acbebbde373a88868dc02910fb2bc5e6a023 19:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:03:06 INFO - mozversion platform_version: 55.0a1 19:03:06 INFO - using testdate: 1493776986 19:03:06 INFO - actual date: 1493776986 19:03:06 INFO - starting webserver on 'localhost:52089' 19:03:06 INFO - SUITE-START | Running 2 tests 19:03:06 INFO - TEST-START | dromaeo_css 19:03:06 INFO - operating with platform_type : mac_ 19:03:06 INFO - Initialising browser for dromaeo_css test... 19:03:06 INFO - TEST-INFO | started process 3142 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmp7NLrdS/profile http://localhost:52089/getInfo.html) 19:03:08 INFO - PID 3142 | __metrics Screen width/height:1600/1200 19:03:08 INFO - PID 3142 | colorDepth:24 19:03:08 INFO - PID 3142 | Browser inner width/height: 1024/691 19:03:08 INFO - PID 3142 | __metrics 19:03:08 INFO - PID 3142 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:03:08 INFO - PID 3142 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:03:09 INFO - TEST-INFO | 3142: exit 0 19:03:09 INFO - Browser initialized. 19:03:09 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:09 INFO - TEST-INFO | started process 3144 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmp7NLrdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:22 INFO - PID 3144 | RSS: Main: 240971776 19:03:22 INFO - PID 3144 | 19:06:26 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52089/tests/dromaeo/cssquery-ext.html) 19:06:28 INFO - PID 3144 | RSS: Main: 391790592 19:06:28 INFO - PID 3144 | 19:08:11 INFO - PID 3144 | ************************* 19:08:11 INFO - PID 3144 | A coding exception was thrown and uncaught in a Task. 19:08:11 INFO - PID 3144 | 19:08:11 ERROR - PID 3144 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:08:11 INFO - PID 3144 | Full stack: 19:08:11 INFO - PID 3144 | ************************* 19:08:11 INFO - PID 3144 | ************************* 19:08:11 INFO - PID 3144 | A coding exception was thrown and uncaught in a Task. 19:08:11 INFO - PID 3144 | 19:08:11 ERROR - PID 3144 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:08:11 INFO - PID 3144 | Full stack: 19:08:11 INFO - PID 3144 | ************************* 19:08:12 INFO - PID 3144 | ************************* 19:08:12 INFO - PID 3144 | A coding exception was thrown and uncaught in a Task. 19:08:12 INFO - PID 3144 | 19:08:12 ERROR - PID 3144 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:08:12 INFO - PID 3144 | Full stack: 19:08:12 INFO - PID 3144 | ************************* 19:08:12 INFO - PID 3144 | ************************* 19:08:12 INFO - PID 3144 | A coding exception was thrown and uncaught in a Task. 19:08:12 INFO - PID 3144 | 19:08:12 ERROR - PID 3144 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:08:12 INFO - PID 3144 | Full stack: 19:08:12 INFO - PID 3144 | ************************* 19:09:30 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-ext.html (next: http://localhost:52089/tests/dromaeo/cssquery-jquery.html) 19:09:31 INFO - PID 3144 | RSS: Main: 363679744 19:09:31 INFO - PID 3144 | 19:12:33 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52089/tests/dromaeo/cssquery-mootools.html) 19:12:34 INFO - PID 3144 | RSS: Main: 333295616 19:12:34 INFO - PID 3144 | 19:15:36 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52089/tests/dromaeo/cssquery-prototype.html) 19:15:37 INFO - PID 3144 | RSS: Main: 329007104 19:15:37 INFO - PID 3144 | 19:18:40 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52089/tests/dromaeo/cssquery-yui.html) 19:18:41 INFO - PID 3144 | RSS: Main: 334503936 19:18:41 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | Cycle 1(1): loaded http://localhost:52089/tests/dromaeo/cssquery-yui.html (next: http://localhost:52089/tests/dromaeo/cssquery-dojo.html) 19:21:44 INFO - PID 3144 | RSS: Main: 374718464 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | __start_tp_report 19:21:44 INFO - PID 3144 | _x_x_mozilla_page_load 19:21:44 INFO - PID 3144 | _x_x_mozilla_page_load_details 19:21:44 INFO - PID 3144 | |i|pagename|runs| 19:21:44 INFO - PID 3144 | |0;dojo.html;2857.3713782967748;3489.337025965068;3492.947605785915;3557.2885422915424;3564.8217589120536;5984.072468767337;6112.047575716891;6155.47678447332;6161.10663953727;6191.566590338683;6128.7475755747655;6130.509559235262;6163.938360616393;6171.382861713826;6198.411150940653;4889.828855990041;5165.767540460688;5289.127293996486;5347.839564813052;5441.755121019563;5382.515573598375;5389.353277606692;5461.399246082928;5472.534834539049;5473.698946557938;5260.421353651114;5307.124324486455;5324.387695415038;5339.3058902342445;5353.598480114007;5276.657017293864;5309.044372013036;5328.254044433782;5337.70642614656;5338.946610533883;5220.765065572058;5287.206918962148;5290.338707661543;5296.894062118736;5304.045271851065;6038.939610603882;6136.294326152505;6188.907166392508;6208.286047104551;6224.87550248997;6555.115059467006;6564.93435065648;6565.835854103686;6565.967170164166;6570.605763654196;6592.868142637169;6679.966600166968;6681.632510211936;6690.63201523916;6696.430803381719;6103.8902988373275;6190.257169139642;6202.131701561785;6282.497400208018;6300.495960323163;6610.272869984298;6623.9006414903815;6635;6648.933510664928;6674.833129171712;6469.191351081115;6479.060536222221;6481.578697384749;6485.286618471964;6501.609903405811;6646.069550262967;6648.501362397743;6665.400113989765;6665.466762658975;6686.832829179212;6336.936630633727;6377.01156320771;6513.641749703812;6551.0173473979285;6555.3772391622715;6476;6502;6538.8365290868105;6565.146530950946;6570.408663220333;5148.9742551287;5169.06956747789;5179.766910489037;5185.9887321971855;5228.189630607262;4563.566461186182;4662.790174442158;4666.533346665374;4675.462321832964;4703.670743047954;6119.350229749377;6149.985252433388;6154.446099851035;6187.969060154671;6214.223222097238;6546.869062618816;6561.048647946021;6561.311062338481;6562.9827376756675;6571.080048793173;4809.735464549483;6198.349173336825;6200.286966998853;6203.069539569101;6210.813675589649;5622.156676498476;5745.2818397700285;5757.85605359861;5759.308882934075;5764.913526297109;6630.30381809903;6780.72877084911;6876.759313424006;6879.036934829028;6879.2432832389395;5441.727913604224;5626.35296940857;6044.546659000681;6647.302033286435;6657.800265992028;6887.070245516791;6895.034695142785;6895.862082758216;6898.724051038103;6899.827504312432;6368.522360822864;6431.903521447089;6462.289148193601;6560.081588577698;6600.141981542369;4836.951630483791;6607.141071660653;6610;6614.437772789367;6623.138991931018;6330.272018717722;6357.841053973688;6379.553431259767;6387.073874288295;6407.359264073555;6249.78125765596;6356.936430635819;6374.23509178883;6397.552171348148;6407.583507072025;6250.624962502265;6282.623042617458;6298.08677741734;6322.209723784527;6329.5569310149685;6404.935950640434;6446.258680251831;6447.0329450582785;6448.709808058742;6451.645159516272;6219;6273.560850740404;6277.529185311028;6330.303666596578;6334.049892515975 19:21:44 INFO - PID 3144 | |1;ext.html;761.7257787196609;782.5070205770364;797.3262593108823;1126.9211155219139;1138.2942575603117;25036.37409064772;34051.829740851295;34469.138271543256;34542.96371108865;34548.65451345492;36585.53657853689;36964;36975;37034.44448333277;37112.628873711255;5887.88224235515;8126.999999999985;8282.544460054694;8303.667853285891;8315.750527484186;5904.2029326040865;5928.436798504135;5974.5220382369525;5981.910271345933;5983.940160598404;7355.411567074648;8267.545285009322;8286.295664868494;8323.334133269354;8328.250457458827;8234.382421318394;8290.295324897392;8292.668293268262;8302.87545686809;8316.126806685332;5836.212111364954;8115.3507719382305;8179.591020449013;8197.79505512361;8201.056878458994;24896.875515622487;34142.6585734142;34175;34200.48699269513;34200.802971895864;3475.287566048954;3499.3701133795907;3502.3345564342694;3503.334366470388;3506.4740288956605;28998.985035523656;29006.12981610555;29043.273918152005;29069.854650726822;29122.70877291221;2607.8826452809667;3015.909522714322;3079.153232860981;3087.4133914556164;3096.6284045914635;197724;266531.0020349696;269256;269304;269738;47765.5223447768;47861;47955.760221198674;48021;48073.519264806906;49548.75225623849;49692.254616180784;49710;49730.50269497331;49731;13611.319434028457;13723.588292351245;13733.381997810122;13765.587032389045;13776.93111534456;9440.583912413056;11180;11191.440427978569;11196.272242304223;11204.943975280072;10425.843612345821;10470.685879423629;10474.528646210938;12401.379931003414;12430.502779888884;4521.683482156283;5001.774920128603;5193.350831146106;5206.245094461282;5206.683026053445;831.6340810043562;926.1942110364026;966.6423423333412;1031.783325501638;1037.8552984457108;23406.882965585402;23588.882055589613;23620.881895590413;23645.881770591383;23836.52326953451;1091.5251865438559;1093.94530273486;1136.943152842371;1138.6356365962813;1153.3310679805693;8478.533680647624;11672.591459299054;11907.88092119085;12070;12098.395080245953;302541.4872925665;302543;302687.4865625658;303141;303364;50703.74648126809;50896.74551627218;50934;51021.489785102414;51050.744746276774;1473.086686254529;1501.9474318399023;1554.930028148736;1555.5566663500847;1571.1358752685976;23175.07299707993;23276.41808954722;23313.184038558567;23370.83145842667;23382;36671.08322291964;36786.448203276435;36820.81589592142;36891.63108368989;36992.63007369892;267837;267879;267946;268801;269439;32721.18197045093;33686.49470257899;33697.83151084229;33736.66263337335;33791.4931276036;36133;36183.27633447369;36341.27317453583;41802;43055.569444306406;27428.725712742616;27623.447531049667;28788;29952.550711738906;30082.548761768154;24851.25446236616;29028.419431611674;29743.55384669275;29962.700372996864;29968.80124794984;35941;36054;36062.819685901406;36071.09822254465;36188.819055904554;28300.15099547017;28671.283217918884;29627.555586665785;30305.393892122476;30353.392932141676;21520.56958860783;22212.46926571846;22657;22945;23097.769022309563 19:21:44 INFO - PID 3144 | |2;jquery.html;410.7432854465957;421.13036579463426;429.6047636174719;433.1402166699102;443.27745774387745;19009.42971710849;20826;21464.89267553664;21677.783222167775;21699.3490195294;21167.788322116776;22478.55042899141;22621.54756904861;22996.77003229967;23067.769322306773;5976.97011514944;6239.407256310643;6241.06384042395;6251.624902505841;6265.843353916166;5742.511886489653;6030.547708921827;6153.292371377304;6162.260528736558;6162.7534898604;5876.5298776098025;6126.969365153191;6129.601575897553;6138.079288106797;6140.293866205398;6102.237220347457;6243.282022567418;6248.5313601480075;6249.125122482856;6258.123862659231;5237.057329680656;5421.647592906448;5427.592930530186;5567.972160139173;5571.387147413781;27322.907083716826;27627.86186069077;27847;28672.85308587654;28687.426251475063;2184.3992901951933;2264.830137739676;2265.988670056656;2266.7166604174477;2268.319504148765;17712.734308985375;17853.821461785476;17870.91064544682;18211.18049687754;18462.723059154123;2108.177810653831;2140.3792900058966;2167.1656412281386;2168.111074459464;2176.1404245323165;171566;171877.99999999875;172737;172791;172888;12302;12453.315067671365;12534.561290354794;12566.68583285407;12822.42299096543;16789.328426863034;16793;16796.412125575545;16802.411915582896;16830.990140591603;8673.609687564074;9010.59452324647;9050.456972581665;9153.496557689392;9217.907820921839;7085.291470852977;8573.74278771638;8606;8639.481631102153;8806.911930880737;6309.810705678837;6577.2436169841085;7477.289657482531;7777.222277772177;7785.883211751829;1879.8120187981367;2146.724472059622;2148.8940837978867;2153.246363772667;2322.9651555226687;955.9904400956041;963.8650588917557;970.4322971062007;993.6124911284605;1015.096564057989;18957.81042189588;20393.592128157354;20727.58544829095;21335.46661333479;21436.03537840801;1013.8986101389802;1019.7195771162841;1022.7318125524296;1025.7538190834296;1046.7487802927242;9708.757281067888;10195.184385249162;10306.845397319046;11088.002079812693;11114.388708620942;560472;560963;562533;569386;574326.1283693555;108421.45789271004;132193;138445.3077734605;141741;142777;1114.9554017839357;1162.0931222665215;1166.7433164703752;1216.7809794236946;1224.9877501224873;20899.582008360052;21943.341699749035;22183;22275.443113922283;22326;58447.70776146092;58713;58751;59004.40995589989;59753;68102.65948670225;73051;76309;79648.60175699316;82020.58989705013;6764.8985265222045;8812.91187088121;9085.454872707658;9193.034731353111;9286.72139835806;13999.230042347768;14066.648333791738;14078.084924480285;14545.5636330906;14546.709065818835;9591.184749296388;9905.900940990497;11590.13074019435;11827.408629568316;12062.75874482523;11480.598179063692;11490.712732181762;11498.770024599295;11767.470463829319;11847.585334513251;9023;11993.64019079429;12095.334756588472;12220.205686630341;12341.3829308536;8833.205011548991;9078.909210907806;9170.15410857014;9235.676751313671;9347.3456858022;11880.287182769061;11905.047596192111;12075.698107547381;12267.877321226673;12468.688282793002 19:21:44 INFO - PID 3144 | |3;mootools.html;1165.9300441973487;1358.2461733737778;1421.644588852787;1432.9140251584906;1437.5112461763;9713.222942164628;10213.591456341746;11426.885731142696;11747.941260293686;11761.176717629769;9454.385464944773;10112.39325640462;10474.68575942721;11344.43277836109;11404.885951140486;2031.7155598216261;2517.785988191006;2538.70804857441;2539.085929065544;2542.250036239314;1751.9211635476433;2196.1654571262898;2463.963040554393;2557.1433569754063;2560.3727086863746;2496.7628075332814;2500.8499490030567;2524.192258477288;2526.2295000024983;2530.253575195322;2290.267114523345;2316.8494047887;2490.452100537879;2514.522240774247;2516.094206085808;2454.9754502454925;2485.030837973192;2485.478049609584;2489.9004039838383;2496.9750302496923;11254.212205145643;11511.712207194803;11514.942425287903;11559.190856640038;11591.768164636744;6447.129637498924;6668.666566671647;6673.432758215557;6688.5652432592215;6701.3968742812895;3878.26313000529;4173.791310434466;4306.138772245532;4309.482862056573;4316.719413238129;1231.7536492701495;1246.7506498700295;1266.5377137344803;1283.6983308922395;1291.644797680636;13166.934165329112;16313.836861631351;16325.918370408071;16326.020438773592;16345.34618615254;5018.949810501848;5712.485876271156;5854.297484301911;5871.236739223959;5994.7602095916545;13585.252811095286;13607.659808504866;13615.115017523829;13616.18302901829;13617.795733064011;6600.768973086015;6719.630420326929;6742.561733487308;6757.155355580552;6759.628220447824;5246.606504512177;6122.693865306717;6134.110553969649;6148.907766383508;6200.224971878515;3789.3368660484307;4101.302778527657;4191.497020357516;4475.664325175625;4537.364768932286;1379.3034517568765;1401.453433161068;1408.4155075643494;1431.6707157353867;1433.8996270260982;810.3476701255546;819.1399031017407;831.9334453243725;840.9747707568782;869.7738587967174;5177.275181474522;6208.627482351073;6660.467162626978;6685.933140668531;6760.391564759196;887.5163036145316;891.0146380976349;892.4065496444921;972.2125078686287;977.4819345746765;3778.6221377862544;3845.807709614564;3904.8047597620007;3906.648401643866;3923;13984.720305593832;14161.504347347793;14651.92674036623;14868.959172857796;14873.181974991263;14455.638609034859;14666.926665366605;14760.557183284518;14915.254237288093;14917.850821491864;8381.874271885927;8480.98228212606;8586.356023298278;8598.656053757904;8675.6529738811;6016.826718789969;6719.580950857589;6761.830954226184;6836.760713375008;6956.7217311309005;10443.582256709951;12876.22742635445;12979.675508111995;12981.870181298065;13485.325733713471;13272.933635331761;13522.18866867991;13547.696891528267;13581.86418135806;13906.58280251594;9034.774130646787;9122.224610908148;9193.172614464731;9236.815263694823;9278.58246378928;9588.520573971413;9918.40489570628;9926.503674816375;10319.432431216355;10586.258961872594;7861.135275119618;9071.319651026068;9106.180443760093;9113;9343.71968840936;8857.247133993682;8874;8944.597493112695;8957.641694332153;8959.1936725695;8057.556834374166;8195.754127376189;8205.343572514064;8223.54770487605;8231.794205144919;5904.763809447574;5925.288965324189;6019.217501724747;6110.083487476914;6154.076888466766;5692.48767610917;5946.0189068803165;6016.488598469179;6135.693215339126;6155.84610384744 19:21:44 INFO - PID 3144 | |4;prototype.html;331.94607122386424;386.34707344587645;395.0439935356436;395.68543008308393;398.4421809466748;5715.971420142899;6013.098035294703;6060.696920178502;6079.574429789916;6088.39116088391;5413;5604.467575580314;5872.76508939643;5879.85300367491;5974.462298393144;3629.5644522657317;4482.663800214997;4486.2821948488245;4487.679117453094;4509.075639493913;3974.754263840935;4042.43405923171;4392.033752574444;4482.906794311931;4484.641228701696;3553.7867727936277;4388.758618275993;4478.328250762379;4480.932786008212;4490.169318676039;4468.218061839198;4471.843485478025;4483.305087711377;4486.663500237479;4493.876530867283;3943.4282029105907;3968.1666849961543;3979.621935916083;3988.162485877969;4011.4183443400834;4768.642351823592;4951.084049450863;5695.231143795618;5789.8263052108505;5847.970760146172;5372.7045012524295;5381.327334083239;5385.649932754398;5387.680018395479;5397.190421436777;5429.864253393657;5939.4357536034;6356.4279214870885;6379.712912918883;6388.1695379600815;3946.4080387941754;4114.855980040684;4160.188763191179;4166.104287578185;4563.292689633112;5614.550835933115;6385.329540398237;6538.673066346663;6539.5149843059335;6670;4100.91798164035;4193.412922190896;4202.642775364067;4202.936955945664;4203.32746760523;3671.9265614688093;4248.915021699549;4255.446791917031;4264.189803937242;4272.423222864873;4634.328022436728;4739.573438390561;4789.928151077736;4981.825636102719;4989.625778066659;5482.451754824486;6358.841028974312;6362.6500542469685;6368.713407896656;6388.1376014237485;1428.6571222906427;1434.7345741037732;1450;1451.2888684544707;1454.5563603100943;789.8341348316918;809.8176662073321;952.4047470331043;956.53129966316;959.318883592643;5953.910691339634;5957.642541447441;5971.522278217819;5983.132445795422;5993.550483713739;5824.417558244142;5953.2735506702575;6027.8848413043725;6462.353764623594;6538.771143010067;4593.081383723269;5397.3523177218985;5773.8556536086935;5874.001419758566;5964.063717946135;2772.487089888377;2843.175479111076;2971.5097008993707;3333.000099969999;3437.1750779813165;5934.884185802402;6030.5778595497895;6110.905693185577;6688.632125233062;6785.762498312634;6118.78584249558;6657.201135863727;6738.595684258862;6747.696353664097;6764.3573860483175;6195.31851496335;6532.346765323429;6732.091167692397;6763.086983257197;6796.048553202556;5474.562035037108;5760.9918264304415;5775.971120144541;6596.5052621052655;6597.340265973365;5630.831075067755;5940.227770389822;6153.538484613761;6432.742690292336;6575.342465753386;5525.668459892419;6742.764003259862;6772.356626120511;6851.08040878726;6871.793846184622;4201.621854033152;4209;4214.831406743696;4224.239636865394;4231.259529582249;5855.900869391528;6450.41946224842;6518.315576864361;6625.370589793962;6662.267150613332;5309.38942021657;5456.290682211287;6110.633361998294;6187.102870083722;6452.257990331172;5251.711155886463;5499.257600223918;5546.722663866871;6166.2600487939935;6375.713092910737;5748.051571490657;5955.558221129316;6298.771739510935;6299.842503937255;6321.905171422524;6047.78832740852;6391.178514123452;6399.168108145911;6415.101885736094;6425.550211485338;5914.4381283777975;6205.596636218631;6270.592411493239;6279.277883043508;6309.779157729457 19:21:44 INFO - PID 3144 | |5;yui.html;697.3096634332013;824.2540500846736;834.0533494483763;836.698788436163;850.7660393391818;13014.089013769028;18153.636927261447;18216.90891545544;18712.532186695338;18733.344332948367;17382.739258911126;17526.386576469828;18064.909675451636;18080.36718714845;18100.909495452503;959.525035107621;974.6929717139114;977.6578197630844;979.8677178580907;981.1365997921819;660.4980215036559;677.0588881454781;971.3928794503436;1004.2367800471621;1007.5919252702668;1048.5176818663424;1050.9842352364722;1052.6263176572322;1053.0312112856152;1053.8682664666917;1048.3238311289251;1050.7373156710785;1051.2798732867934;1053.0943388685723;1053.1311667873958;506.06883334664025;521.5175962234955;736.4366259811248;775.0002496779205;778.1867947994303;16961.66076678472;17238.482845514656;17254.223559939706;17288.481345559652;17292.827071729374;16841.83158168415;17103.572410689707;17352.392666256746;17471.47585572422;17493.56266093345;13849.930750346184;14092.788608170886;14173.43306267748;14204.715905681931;14233.074850134708;3227.064151396116;3282.146641873106;3287.589051368579;3288.112209703391;3289.7368210543336;126743.366283168;127069.48096747456;128533;129084.35457822651;131192.99999999904;10123.44321062334;10742.838857417146;13286.3356832158;13562.932185339207;13576.796348054788;18797.436076917715;24887.253382398558;25741.74258257431;25756.61365079488;25765.969361225714;6211.875762484725;7899.763007109796;7909.406794490321;7913.643886025143;7922.207779222147;3864.7294689371474;3882.7087968402484;3909.9218015639526;3948;3958.802059896994;4235.9364609530885;4387.934180987288;4394.472663280427;4397.538258482813;4400.119976004812;903.3315346643436;926.6571368593663;941.2705153506088;949.2121539122512;949.3876449690049;530.2682298428222;632.3992207402986;658.4173006888938;670.6412069542771;696.8257935516122;10940.890591094147;11742.647720568397;11876.465559049864;11899.583514577122;12008.579699710468;645.515863102673;659.3801826283278;662.5461558832119;672.2336536348566;680.6630717794724;5302.734863256822;5516.668999860021;5561.165825126263;5626.437356264422;5706.269407806063;69790;79954;101401;104374;104487;89596;90021.54989225011;90041.54979225062;93143.0685693148;93487;61497;61994.0700889478;80886;82119.5894020526;84568.15431845603;9832.31173817826;9963.35238209543;11334.94332528332;12264.693382665148;12378.938105309417;36932.892013239645;37120.25759484741;37272.88181354564;37604.623953761205;38032.80983595064;60848;65810.67094664495;68018.3198168012;68391.97412038923;68619;15480.303386347867;16440.260188291795;17255.137243137542;17262;17286;17609.73585396246;18225.635487289914;18446.446606601825;18591.34930277434;19116.23535058582;16242.350305987628;16933.576660583585;17054.2325595346;17206.913965430595;17326.826731732523;13761.96785241131;16287.267072981507;16965.91517042407;16972.15139243008;17216.483505494856;15969.760453592973;16388;17034.914825425793;17119.914400428417;17220.913895430444;10918.50866710984;11639.941800290944;12114.667386587644;12242.204256723284;12264.562001148635;12730.618081457571;13652;13835.654108646962;13999.720005600035;14028.509002184874 19:21:44 INFO - PID 3144 | __end_tp_report 19:21:44 INFO - PID 3144 | __start_cc_report 19:21:44 INFO - PID 3144 | _x_x_mozilla_cycle_collect,1526 19:21:44 INFO - PID 3144 | __end_cc_report 19:21:44 INFO - PID 3144 | __startTimestamp1493778104299__endTimestamp 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | ------- Summary: start ------- 19:21:44 INFO - PID 3144 | Number of tests: 6 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#0] dojo.html Cycles:165 Average:6034.55 Median:6282.50 stddev:743.23 (11.8%) stddev-sans-first:702.47 19:21:44 INFO - PID 3144 | Values: 2857.4 3489.3 3492.9 3557.3 3564.8 5984.1 6112.0 6155.5 6161.1 6191.6 6128.7 6130.5 6163.9 6171.4 6198.4 4889.8 5165.8 5289.1 5347.8 5441.8 5382.5 5389.4 5461.4 5472.5 5473.7 5260.4 5307.1 5324.4 5339.3 5353.6 5276.7 5309.0 5328.3 5337.7 5338.9 5220.8 5287.2 5290.3 5296.9 5304.0 6038.9 6136.3 6188.9 6208.3 6224.9 6555.1 6564.9 6565.8 6566.0 6570.6 6592.9 6680.0 6681.6 6690.6 6696.4 6103.9 6190.3 6202.1 6282.5 6300.5 6610.3 6623.9 6635.0 6648.9 6674.8 6469.2 6479.1 6481.6 6485.3 6501.6 6646.1 6648.5 6665.4 6665.5 6686.8 6336.9 6377.0 6513.6 6551.0 6555.4 6476.0 6502.0 6538.8 6565.1 6570.4 5149.0 5169.1 5179.8 5186.0 5228.2 4563.6 4662.8 4666.5 4675.5 4703.7 6119.4 6150.0 6154.4 6188.0 6214.2 6546.9 6561.0 6561.3 6563.0 6571.1 4809.7 6198.3 6200.3 6203.1 6210.8 5622.2 5745.3 5757.9 5759.3 5764.9 6630.3 6780.7 6876.8 6879.0 6879.2 5441.7 5626.4 6044.5 6647.3 6657.8 6887.1 6895.0 6895.9 6898.7 6899.8 6368.5 6431.9 6462.3 6560.1 6600.1 4837.0 6607.1 6610.0 6614.4 6623.1 6330.3 6357.8 6379.6 6387.1 6407.4 6249.8 6356.9 6374.2 6397.6 6407.6 6250.6 6282.6 6298.1 6322.2 6329.6 6404.9 6446.3 6447.0 6448.7 6451.6 6219.0 6273.6 6277.5 6330.3 6334.0 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#1] ext.html Cycles:180 Average:41875.66 Median:33692.16 stddev:72510.73 (215.2%) stddev-sans-first:72648.43 19:21:44 INFO - PID 3144 | Values: 761.7 782.5 797.3 1126.9 1138.3 25036.4 34051.8 34469.1 34543.0 34548.7 36585.5 36964.0 36975.0 37034.4 37112.6 5887.9 8127.0 8282.5 8303.7 8315.8 5904.2 5928.4 5974.5 5981.9 5983.9 7355.4 8267.5 8286.3 8323.3 8328.3 8234.4 8290.3 8292.7 8302.9 8316.1 5836.2 8115.4 8179.6 8197.8 8201.1 24896.9 34142.7 34175.0 34200.5 34200.8 3475.3 3499.4 3502.3 3503.3 3506.5 28999.0 29006.1 29043.3 29069.9 29122.7 2607.9 3015.9 3079.2 3087.4 3096.6 197724.0 266531.0 269256.0 269304.0 269738.0 47765.5 47861.0 47955.8 48021.0 48073.5 49548.8 49692.3 49710.0 49730.5 49731.0 13611.3 13723.6 13733.4 13765.6 13776.9 9440.6 11180.0 11191.4 11196.3 11204.9 10425.8 10470.7 10474.5 12401.4 12430.5 4521.7 5001.8 5193.4 5206.2 5206.7 831.6 926.2 966.6 1031.8 1037.9 23406.9 23588.9 23620.9 23645.9 23836.5 1091.5 1093.9 1136.9 1138.6 1153.3 8478.5 11672.6 11907.9 12070.0 12098.4 302541.5 302543.0 302687.5 303141.0 303364.0 50703.7 50896.7 50934.0 51021.5 51050.7 1473.1 1501.9 1554.9 1555.6 1571.1 23175.1 23276.4 23313.2 23370.8 23382.0 36671.1 36786.4 36820.8 36891.6 36992.6 267837.0 267879.0 267946.0 268801.0 269439.0 32721.2 33686.5 33697.8 33736.7 33791.5 36133.0 36183.3 36341.3 41802.0 43055.6 27428.7 27623.4 28788.0 29952.6 30082.5 24851.3 29028.4 29743.6 29962.7 29968.8 35941.0 36054.0 36062.8 36071.1 36188.8 28300.2 28671.3 29627.6 30305.4 30353.4 21520.6 22212.5 22657.0 22945.0 23097.8 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#2] jquery.html Cycles:180 Average:36669.90 Median:2265.41 stddev:96444.95 (4257.3%) stddev-sans-first:96677.08 19:21:44 INFO - PID 3144 | Values: 410.7 421.1 429.6 433.1 443.3 19009.4 20826.0 21464.9 21677.8 21699.3 21167.8 22478.6 22621.5 22996.8 23067.8 5977.0 6239.4 6241.1 6251.6 6265.8 5742.5 6030.5 6153.3 6162.3 6162.8 5876.5 6127.0 6129.6 6138.1 6140.3 6102.2 6243.3 6248.5 6249.1 6258.1 5237.1 5421.6 5427.6 5568.0 5571.4 27322.9 27627.9 27847.0 28672.9 28687.4 2184.4 2264.8 2266.0 2266.7 2268.3 17712.7 17853.8 17870.9 18211.2 18462.7 2108.2 2140.4 2167.2 2168.1 2176.1 171566.0 171878.0 172737.0 172791.0 172888.0 12302.0 12453.3 12534.6 12566.7 12822.4 16789.3 16793.0 16796.4 16802.4 16831.0 8673.6 9010.6 9050.5 9153.5 9217.9 7085.3 8573.7 8606.0 8639.5 8806.9 6309.8 6577.2 7477.3 7777.2 7785.9 1879.8 2146.7 2148.9 2153.2 2323.0 956.0 963.9 970.4 993.6 1015.1 18957.8 20393.6 20727.6 21335.5 21436.0 1013.9 1019.7 1022.7 1025.8 1046.7 9708.8 10195.2 10306.8 11088.0 11114.4 560472.0 560963.0 562533.0 569386.0 574326.1 108421.5 132193.0 138445.3 141741.0 142777.0 1115.0 1162.1 1166.7 1216.8 1225.0 20899.6 21943.3 22183.0 22275.4 22326.0 58447.7 58713.0 58751.0 59004.4 59753.0 68102.7 73051.0 76309.0 79648.6 82020.6 6764.9 8812.9 9085.5 9193.0 9286.7 13999.2 14066.6 14078.1 14545.6 14546.7 9591.2 9905.9 11590.1 11827.4 12062.8 11480.6 11490.7 11498.8 11767.5 11847.6 9023.0 11993.6 12095.3 12220.2 12341.4 8833.2 9078.9 9170.2 9235.7 9347.3 11880.3 11905.0 12075.7 12267.9 12468.7 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#3] mootools.html Cycles:180 Average:6991.88 Median:3914.82 stddev:4406.57 (112.6%) stddev-sans-first:4397.18 19:21:44 INFO - PID 3144 | Values: 1165.9 1358.2 1421.6 1432.9 1437.5 9713.2 10213.6 11426.9 11747.9 11761.2 9454.4 10112.4 10474.7 11344.4 11404.9 2031.7 2517.8 2538.7 2539.1 2542.3 1751.9 2196.2 2464.0 2557.1 2560.4 2496.8 2500.8 2524.2 2526.2 2530.3 2290.3 2316.8 2490.5 2514.5 2516.1 2455.0 2485.0 2485.5 2489.9 2497.0 11254.2 11511.7 11514.9 11559.2 11591.8 6447.1 6668.7 6673.4 6688.6 6701.4 3878.3 4173.8 4306.1 4309.5 4316.7 1231.8 1246.8 1266.5 1283.7 1291.6 13166.9 16313.8 16325.9 16326.0 16345.3 5018.9 5712.5 5854.3 5871.2 5994.8 13585.3 13607.7 13615.1 13616.2 13617.8 6600.8 6719.6 6742.6 6757.2 6759.6 5246.6 6122.7 6134.1 6148.9 6200.2 3789.3 4101.3 4191.5 4475.7 4537.4 1379.3 1401.5 1408.4 1431.7 1433.9 810.3 819.1 831.9 841.0 869.8 5177.3 6208.6 6660.5 6685.9 6760.4 887.5 891.0 892.4 972.2 977.5 3778.6 3845.8 3904.8 3906.6 3923.0 13984.7 14161.5 14651.9 14869.0 14873.2 14455.6 14666.9 14760.6 14915.3 14917.9 8381.9 8481.0 8586.4 8598.7 8675.7 6016.8 6719.6 6761.8 6836.8 6956.7 10443.6 12876.2 12979.7 12981.9 13485.3 13272.9 13522.2 13547.7 13581.9 13906.6 9034.8 9122.2 9193.2 9236.8 9278.6 9588.5 9918.4 9926.5 10319.4 10586.3 7861.1 9071.3 9106.2 9113.0 9343.7 8857.2 8874.0 8944.6 8957.6 8959.2 8057.6 8195.8 8205.3 8223.5 8231.8 5904.8 5925.3 6019.2 6110.1 6154.1 5692.5 5946.0 6016.5 6135.7 6155.8 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#4] prototype.html Cycles:180 Average:5069.96 Median:5767.42 stddev:1596.76 (27.7%) stddev-sans-first:1561.13 19:21:44 INFO - PID 3144 | Values: 331.9 386.3 395.0 395.7 398.4 5716.0 6013.1 6060.7 6079.6 6088.4 5413.0 5604.5 5872.8 5879.9 5974.5 3629.6 4482.7 4486.3 4487.7 4509.1 3974.8 4042.4 4392.0 4482.9 4484.6 3553.8 4388.8 4478.3 4480.9 4490.2 4468.2 4471.8 4483.3 4486.7 4493.9 3943.4 3968.2 3979.6 3988.2 4011.4 4768.6 4951.1 5695.2 5789.8 5848.0 5372.7 5381.3 5385.6 5387.7 5397.2 5429.9 5939.4 6356.4 6379.7 6388.2 3946.4 4114.9 4160.2 4166.1 4563.3 5614.6 6385.3 6538.7 6539.5 6670.0 4100.9 4193.4 4202.6 4202.9 4203.3 3671.9 4248.9 4255.4 4264.2 4272.4 4634.3 4739.6 4789.9 4981.8 4989.6 5482.5 6358.8 6362.7 6368.7 6388.1 1428.7 1434.7 1450.0 1451.3 1454.6 789.8 809.8 952.4 956.5 959.3 5953.9 5957.6 5971.5 5983.1 5993.6 5824.4 5953.3 6027.9 6462.4 6538.8 4593.1 5397.4 5773.9 5874.0 5964.1 2772.5 2843.2 2971.5 3333.0 3437.2 5934.9 6030.6 6110.9 6688.6 6785.8 6118.8 6657.2 6738.6 6747.7 6764.4 6195.3 6532.3 6732.1 6763.1 6796.0 5474.6 5761.0 5776.0 6596.5 6597.3 5630.8 5940.2 6153.5 6432.7 6575.3 5525.7 6742.8 6772.4 6851.1 6871.8 4201.6 4209.0 4214.8 4224.2 4231.3 5855.9 6450.4 6518.3 6625.4 6662.3 5309.4 5456.3 6110.6 6187.1 6452.3 5251.7 5499.3 5546.7 6166.3 6375.7 5748.1 5955.6 6298.8 6299.8 6321.9 6047.8 6391.2 6399.2 6415.1 6425.6 5914.4 6205.6 6270.6 6279.3 6309.8 19:21:44 INFO - PID 3144 | 19:21:44 INFO - PID 3144 | [#5] yui.html Cycles:180 Average:21546.50 Median:18722.94 stddev:30165.25 (161.1%) stddev-sans-first:30209.24 19:21:44 INFO - PID 3144 | Values: 697.3 824.3 834.1 836.7 850.8 13014.1 18153.6 18216.9 18712.5 18733.3 17382.7 17526.4 18064.9 18080.4 18100.9 959.5 974.7 977.7 979.9 981.1 660.5 677.1 971.4 1004.2 1007.6 1048.5 1051.0 1052.6 1053.0 1053.9 1048.3 1050.7 1051.3 1053.1 1053.1 506.1 521.5 736.4 775.0 778.2 16961.7 17238.5 17254.2 17288.5 17292.8 16841.8 17103.6 17352.4 17471.5 17493.6 13849.9 14092.8 14173.4 14204.7 14233.1 3227.1 3282.1 3287.6 3288.1 3289.7 126743.4 127069.5 128533.0 129084.4 131193.0 10123.4 10742.8 13286.3 13562.9 13576.8 18797.4 24887.3 25741.7 25756.6 25766.0 6211.9 7899.8 7909.4 7913.6 7922.2 3864.7 3882.7 3909.9 3948.0 3958.8 4235.9 4387.9 4394.5 4397.5 4400.1 903.3 926.7 941.3 949.2 949.4 530.3 632.4 658.4 670.6 696.8 10940.9 11742.6 11876.5 11899.6 12008.6 645.5 659.4 662.5 672.2 680.7 5302.7 5516.7 5561.2 5626.4 5706.3 69790.0 79954.0 101401.0 104374.0 104487.0 89596.0 90021.5 90041.5 93143.1 93487.0 61497.0 61994.1 80886.0 82119.6 84568.2 9832.3 9963.4 11334.9 12264.7 12378.9 36932.9 37120.3 37272.9 37604.6 38032.8 60848.0 65810.7 68018.3 68392.0 68619.0 15480.3 16440.3 17255.1 17262.0 17286.0 17609.7 18225.6 18446.4 18591.3 19116.2 16242.4 16933.6 17054.2 17206.9 17326.8 13762.0 16287.3 16965.9 16972.2 17216.5 15969.8 16388.0 17034.9 17119.9 17220.9 10918.5 11639.9 12114.7 12242.2 12264.6 12730.6 13652.0 13835.7 13999.7 14028.5 19:21:44 INFO - PID 3144 | -------- Summary: end -------- 19:21:44 INFO - PID 3144 | 19:21:44 INFO - TEST-INFO | 3144: exit 0 19:21:44 INFO - TEST-OK | dromaeo_css | took 1118641ms 19:21:44 INFO - TEST-START | kraken 19:21:44 INFO - operating with platform_type : mac_ 19:21:44 INFO - Initialising browser for kraken test... 19:21:44 INFO - TEST-INFO | started process 3149 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpII2vyc/profile http://localhost:52089/getInfo.html) 19:21:47 INFO - PID 3149 | __metrics Screen width/height:1600/1200 19:21:47 INFO - PID 3149 | colorDepth:24 19:21:47 INFO - PID 3149 | Browser inner width/height: 1024/691 19:21:47 INFO - PID 3149 | __metrics 19:21:48 INFO - PID 3149 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:21:48 INFO - PID 3149 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:21:48 INFO - TEST-INFO | 3149: exit 0 19:21:48 INFO - Browser initialized. 19:21:48 INFO - Running cycle 1/1 for kraken test... 19:21:48 INFO - TEST-INFO | started process 3150 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpII2vyc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:01 INFO - PID 3150 | RSS: Main: 240676864 19:22:01 INFO - PID 3150 | 19:22:03 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52089/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:04 INFO - PID 3150 | RSS: Main: 310689792 19:22:04 INFO - PID 3150 | 19:22:07 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52089/tests/kraken/driver.html?testName=audio-dft) 19:22:07 INFO - PID 3150 | RSS: Main: 293134336 19:22:07 INFO - PID 3150 | 19:22:11 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52089/tests/kraken/driver.html?testName=audio-fft) 19:22:11 INFO - PID 3150 | RSS: Main: 384696320 19:22:11 INFO - PID 3150 | 19:22:14 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52089/tests/kraken/driver.html?testName=audio-oscillator) 19:22:14 INFO - PID 3150 | RSS: Main: 288014336 19:22:14 INFO - PID 3150 | 19:22:16 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:17 INFO - PID 3150 | RSS: Main: 290549760 19:22:17 INFO - PID 3150 | 19:22:20 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52089/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:20 INFO - PID 3150 | RSS: Main: 353714176 19:22:20 INFO - PID 3150 | 19:22:23 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52089/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:24 INFO - PID 3150 | RSS: Main: 375230464 19:22:24 INFO - PID 3150 | 19:22:27 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52089/tests/kraken/driver.html?testName=json-parse-financial) 19:22:28 INFO - PID 3150 | RSS: Main: 369676288 19:22:28 INFO - PID 3150 | 19:22:29 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:30 INFO - PID 3150 | RSS: Main: 314417152 19:22:30 INFO - PID 3150 | 19:22:32 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:32 INFO - PID 3150 | RSS: Main: 332648448 19:22:32 INFO - PID 3150 | 19:22:34 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:35 INFO - PID 3150 | RSS: Main: 316502016 19:22:35 INFO - PID 3150 | 19:22:38 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:39 INFO - PID 3150 | RSS: Main: 333275136 19:22:39 INFO - PID 3150 | 19:22:42 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:43 INFO - PID 3150 | RSS: Main: 344010752 19:22:43 INFO - PID 3150 | 19:22:44 INFO - PID 3150 | Cycle 1(1): loaded http://localhost:52089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52089/tests/kraken/driver.html?testName=ai-astar) 19:22:45 INFO - PID 3150 | RSS: Main: 387010560 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | __start_tp_report 19:22:45 INFO - PID 3150 | _x_x_mozilla_page_load 19:22:45 INFO - PID 3150 | _x_x_mozilla_page_load_details 19:22:45 INFO - PID 3150 | |i|pagename|runs| 19:22:45 INFO - PID 3150 | |0;ai-astar;109;112;116;163;159;110;110;110;111;110 19:22:45 INFO - PID 3150 | |1;audio-beat-detection;146;110;108;147;110;107;110;107;135;109 19:22:45 INFO - PID 3150 | |2;audio-dft;190;184;183;184;187;182;183;186;181;185 19:22:45 INFO - PID 3150 | |3;audio-fft;83;63;60;121;90;50;58;84;105;84 19:22:45 INFO - PID 3150 | |4;audio-oscillator;91;68;90;69;68;67;89;68;68;91 19:22:45 INFO - PID 3150 | |5;imaging-gaussian-blur;90;89;90;91;91;90;90;90;91;90 19:22:45 INFO - PID 3150 | |6;imaging-darkroom;97;96;97;97;96;100;96;96;96;95 19:22:45 INFO - PID 3150 | |7;imaging-desaturate;85;83;83;94;138;77;123;136;93;86 19:22:45 INFO - PID 3150 | |8;json-parse-financial;51;50;49;50;50;49;50;50;50;50 19:22:45 INFO - PID 3150 | |9;json-stringify-tinderbox;54;57;59;67;61;57;57;57;56;56 19:22:45 INFO - PID 3150 | |10;stanford-crypto-aes;83;84;91;94;107;82;82;82;81;81 19:22:45 INFO - PID 3150 | |11;stanford-crypto-ccm;139;137;138;136;134;136;135;136;195;172 19:22:45 INFO - PID 3150 | |12;stanford-crypto-pbkdf2;186;181;185;185;187;186;208;238;230;178 19:22:45 INFO - PID 3150 | |13;stanford-crypto-sha256-iterative;68;69;68;67;68;66;67;69;69;66 19:22:45 INFO - PID 3150 | __end_tp_report 19:22:45 INFO - PID 3150 | __start_cc_report 19:22:45 INFO - PID 3150 | _x_x_mozilla_cycle_collect,2199 19:22:45 INFO - PID 3150 | __end_cc_report 19:22:45 INFO - PID 3150 | __startTimestamp1493778164997__endTimestamp 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | ------- Summary: start ------- 19:22:45 INFO - PID 3150 | Number of tests: 14 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#0] ai-astar Cycles:10 Average:121.00 Median:111.50 stddev:21.19 (19.0%) stddev-sans-first:22.03 19:22:45 INFO - PID 3150 | Values: 109.0 112.0 116.0 163.0 159.0 110.0 110.0 110.0 111.0 110.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:110.00 stddev:16.74 (15.2%) stddev-sans-first:14.60 19:22:45 INFO - PID 3150 | Values: 146.0 110.0 108.0 147.0 110.0 107.0 110.0 107.0 135.0 109.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#2] audio-dft Cycles:10 Average:184.50 Median:184.50 stddev:2.64 (1.4%) stddev-sans-first:1.90 19:22:45 INFO - PID 3150 | Values: 190.0 184.0 183.0 184.0 187.0 182.0 183.0 186.0 181.0 185.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:22.41 (30.7%) stddev-sans-first:23.74 19:22:45 INFO - PID 3150 | Values: 83.0 63.0 60.0 121.0 90.0 50.0 58.0 84.0 105.0 84.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:11.51 (14.6%) stddev-sans-first:11.02 19:22:45 INFO - PID 3150 | Values: 91.0 68.0 90.0 69.0 68.0 67.0 89.0 68.0 68.0 91.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:90.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:22:45 INFO - PID 3150 | Values: 90.0 89.0 90.0 91.0 91.0 90.0 90.0 90.0 91.0 90.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 19:22:45 INFO - PID 3150 | Values: 97.0 96.0 97.0 97.0 96.0 100.0 96.0 96.0 96.0 95.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:84.00 stddev:23.29 (27.7%) stddev-sans-first:24.08 19:22:45 INFO - PID 3150 | Values: 85.0 83.0 83.0 94.0 138.0 77.0 123.0 136.0 93.0 86.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.57 (1.1%) stddev-sans-first:0.44 19:22:45 INFO - PID 3150 | Values: 51.0 50.0 49.0 50.0 50.0 49.0 50.0 50.0 50.0 50.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:57.00 stddev:3.63 (6.4%) stddev-sans-first:3.54 19:22:45 INFO - PID 3150 | Values: 54.0 57.0 59.0 67.0 61.0 57.0 57.0 57.0 56.0 56.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:82.50 stddev:8.41 (10.2%) stddev-sans-first:8.81 19:22:45 INFO - PID 3150 | Values: 83.0 84.0 91.0 94.0 107.0 82.0 82.0 82.0 81.0 81.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:137.50 stddev:20.64 (15.0%) stddev-sans-first:21.75 19:22:45 INFO - PID 3150 | Values: 139.0 137.0 138.0 136.0 134.0 136.0 135.0 136.0 195.0 172.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:186.50 stddev:21.43 (11.5%) stddev-sans-first:22.40 19:22:45 INFO - PID 3150 | Values: 186.0 181.0 185.0 185.0 187.0 186.0 208.0 238.0 230.0 178.0 19:22:45 INFO - PID 3150 | 19:22:45 INFO - PID 3150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 19:22:45 INFO - PID 3150 | Values: 68.0 69.0 68.0 67.0 68.0 66.0 67.0 69.0 69.0 66.0 19:22:45 INFO - PID 3150 | -------- Summary: end -------- 19:22:45 INFO - PID 3150 | 19:22:46 INFO - TEST-INFO | 3150: exit 0 19:22:46 INFO - TEST-OK | kraken | took 61117ms 19:22:46 INFO - SUITE-END | took 1179s 19:22:46 INFO - Completed test suite (00:19:39) 19:22:46 INFO - javascript benchmark 19:22:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7690.247536324754, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2857.3713782967748, 3489.337025965068, 3492.947605785915, 3557.2885422915424, 3564.8217589120536, 5984.072468767337, 6112.047575716891, 6155.47678447332, 6161.10663953727, 6191.566590338683, 6128.7475755747655, 6130.509559235262, 6163.938360616393, 6171.382861713826, 6198.411150940653, 4889.828855990041, 5165.767540460688, 5289.127293996486, 5347.839564813052, 5441.755121019563, 5382.515573598375, 5389.353277606692, 5461.399246082928, 5472.534834539049, 5473.698946557938, 5260.421353651114, 5307.124324486455, 5324.387695415038, 5339.3058902342445, 5353.598480114007, 5276.657017293864, 5309.044372013036, 5328.254044433782, 5337.70642614656, 5338.946610533883, 5220.765065572058, 5287.206918962148, 5290.338707661543, 5296.894062118736, 5304.045271851065, 6038.939610603882, 6136.294326152505, 6188.907166392508, 6208.286047104551, 6224.87550248997, 6555.115059467006, 6564.93435065648, 6565.835854103686, 6565.967170164166, 6570.605763654196, 6592.868142637169, 6679.966600166968, 6681.632510211936, 6690.63201523916, 6696.430803381719, 6103.8902988373275, 6190.257169139642, 6202.131701561785, 6282.497400208018, 6300.495960323163, 6610.272869984298, 6623.9006414903815, 6635.0, 6648.933510664928, 6674.833129171712, 6469.191351081115, 6479.060536222221, 6481.578697384749, 6485.286618471964, 6501.609903405811, 6646.069550262967, 6648.501362397743, 6665.400113989765, 6665.466762658975, 6686.832829179212, 6336.936630633727, 6377.01156320771, 6513.641749703812, 6551.0173473979285, 6555.3772391622715, 6476.0, 6502.0, 6538.8365290868105, 6565.146530950946, 6570.408663220333, 5148.9742551287, 5169.06956747789, 5179.766910489037, 5185.9887321971855, 5228.189630607262, 4563.566461186182, 4662.790174442158, 4666.533346665374, 4675.462321832964, 4703.670743047954, 6119.350229749377, 6149.985252433388, 6154.446099851035, 6187.969060154671, 6214.223222097238, 6546.869062618816, 6561.048647946021, 6561.311062338481, 6562.9827376756675, 6571.080048793173, 4809.735464549483, 6198.349173336825, 6200.286966998853, 6203.069539569101, 6210.813675589649, 5622.156676498476, 5745.2818397700285, 5757.85605359861, 5759.308882934075, 5764.913526297109, 6630.30381809903, 6780.72877084911, 6876.759313424006, 6879.036934829028, 6879.2432832389395, 5441.727913604224, 5626.35296940857, 6044.546659000681, 6647.302033286435, 6657.800265992028, 6887.070245516791, 6895.034695142785, 6895.862082758216, 6898.724051038103, 6899.827504312432, 6368.522360822864, 6431.903521447089, 6462.289148193601, 6560.081588577698, 6600.141981542369, 4836.951630483791, 6607.141071660653, 6610.0, 6614.437772789367, 6623.138991931018, 6330.272018717722, 6357.841053973688, 6379.553431259767, 6387.073874288295, 6407.359264073555, 6249.78125765596, 6356.936430635819, 6374.23509178883, 6397.552171348148, 6407.583507072025, 6250.624962502265, 6282.623042617458, 6298.08677741734, 6322.209723784527, 6329.5569310149685, 6404.935950640434, 6446.258680251831, 6447.0329450582785, 6448.709808058742, 6451.645159516272, 6219.0, 6273.560850740404, 6277.529185311028, 6330.303666596578, 6334.049892515975], "value": 5983.696096168762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.7257787196609, 782.5070205770364, 797.3262593108823, 1126.9211155219139, 1138.2942575603117, 25036.37409064772, 34051.829740851295, 34469.138271543256, 34542.96371108865, 34548.65451345492, 36585.53657853689, 36964.0, 36975.0, 37034.44448333277, 37112.628873711255, 5887.88224235515, 8126.999999999985, 8282.544460054694, 8303.667853285891, 8315.750527484186, 5904.2029326040865, 5928.436798504135, 5974.5220382369525, 5981.910271345933, 5983.940160598404, 7355.411567074648, 8267.545285009322, 8286.295664868494, 8323.334133269354, 8328.250457458827, 8234.382421318394, 8290.295324897392, 8292.668293268262, 8302.87545686809, 8316.126806685332, 5836.212111364954, 8115.3507719382305, 8179.591020449013, 8197.79505512361, 8201.056878458994, 24896.875515622487, 34142.6585734142, 34175.0, 34200.48699269513, 34200.802971895864, 3475.287566048954, 3499.3701133795907, 3502.3345564342694, 3503.334366470388, 3506.4740288956605, 28998.985035523656, 29006.12981610555, 29043.273918152005, 29069.854650726822, 29122.70877291221, 2607.8826452809667, 3015.909522714322, 3079.153232860981, 3087.4133914556164, 3096.6284045914635, 197724.0, 266531.0020349696, 269256.0, 269304.0, 269738.0, 47765.5223447768, 47861.0, 47955.760221198674, 48021.0, 48073.519264806906, 49548.75225623849, 49692.254616180784, 49710.0, 49730.50269497331, 49731.0, 13611.319434028457, 13723.588292351245, 13733.381997810122, 13765.587032389045, 13776.93111534456, 9440.583912413056, 11180.0, 11191.440427978569, 11196.272242304223, 11204.943975280072, 10425.843612345821, 10470.685879423629, 10474.528646210938, 12401.379931003414, 12430.502779888884, 4521.683482156283, 5001.774920128603, 5193.350831146106, 5206.245094461282, 5206.683026053445, 831.6340810043562, 926.1942110364026, 966.6423423333412, 1031.783325501638, 1037.8552984457108, 23406.882965585402, 23588.882055589613, 23620.881895590413, 23645.881770591383, 23836.52326953451, 1091.5251865438559, 1093.94530273486, 1136.943152842371, 1138.6356365962813, 1153.3310679805693, 8478.533680647624, 11672.591459299054, 11907.88092119085, 12070.0, 12098.395080245953, 302541.4872925665, 302543.0, 302687.4865625658, 303141.0, 303364.0, 50703.74648126809, 50896.74551627218, 50934.0, 51021.489785102414, 51050.744746276774, 1473.086686254529, 1501.9474318399023, 1554.930028148736, 1555.5566663500847, 1571.1358752685976, 23175.07299707993, 23276.41808954722, 23313.184038558567, 23370.83145842667, 23382.0, 36671.08322291964, 36786.448203276435, 36820.81589592142, 36891.63108368989, 36992.63007369892, 267837.0, 267879.0, 267946.0, 268801.0, 269439.0, 32721.18197045093, 33686.49470257899, 33697.83151084229, 33736.66263337335, 33791.4931276036, 36133.0, 36183.27633447369, 36341.27317453583, 41802.0, 43055.569444306406, 27428.725712742616, 27623.447531049667, 28788.0, 29952.550711738906, 30082.548761768154, 24851.25446236616, 29028.419431611674, 29743.55384669275, 29962.700372996864, 29968.80124794984, 35941.0, 36054.0, 36062.819685901406, 36071.09822254465, 36188.819055904554, 28300.15099547017, 28671.283217918884, 29627.555586665785, 30305.393892122476, 30353.392932141676, 21520.56958860783, 22212.46926571846, 22657.0, 22945.0, 23097.769022309563], "value": 16388.884525473237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.7432854465957, 421.13036579463426, 429.6047636174719, 433.1402166699102, 443.27745774387745, 19009.42971710849, 20826.0, 21464.89267553664, 21677.783222167775, 21699.3490195294, 21167.788322116776, 22478.55042899141, 22621.54756904861, 22996.77003229967, 23067.769322306773, 5976.97011514944, 6239.407256310643, 6241.06384042395, 6251.624902505841, 6265.843353916166, 5742.511886489653, 6030.547708921827, 6153.292371377304, 6162.260528736558, 6162.7534898604, 5876.5298776098025, 6126.969365153191, 6129.601575897553, 6138.079288106797, 6140.293866205398, 6102.237220347457, 6243.282022567418, 6248.5313601480075, 6249.125122482856, 6258.123862659231, 5237.057329680656, 5421.647592906448, 5427.592930530186, 5567.972160139173, 5571.387147413781, 27322.907083716826, 27627.86186069077, 27847.0, 28672.85308587654, 28687.426251475063, 2184.3992901951933, 2264.830137739676, 2265.988670056656, 2266.7166604174477, 2268.319504148765, 17712.734308985375, 17853.821461785476, 17870.91064544682, 18211.18049687754, 18462.723059154123, 2108.177810653831, 2140.3792900058966, 2167.1656412281386, 2168.111074459464, 2176.1404245323165, 171566.0, 171877.99999999875, 172737.0, 172791.0, 172888.0, 12302.0, 12453.315067671365, 12534.561290354794, 12566.68583285407, 12822.42299096543, 16789.328426863034, 16793.0, 16796.412125575545, 16802.411915582896, 16830.990140591603, 8673.609687564074, 9010.59452324647, 9050.456972581665, 9153.496557689392, 9217.907820921839, 7085.291470852977, 8573.74278771638, 8606.0, 8639.481631102153, 8806.911930880737, 6309.810705678837, 6577.2436169841085, 7477.289657482531, 7777.222277772177, 7785.883211751829, 1879.8120187981367, 2146.724472059622, 2148.8940837978867, 2153.246363772667, 2322.9651555226687, 955.9904400956041, 963.8650588917557, 970.4322971062007, 993.6124911284605, 1015.096564057989, 18957.81042189588, 20393.592128157354, 20727.58544829095, 21335.46661333479, 21436.03537840801, 1013.8986101389802, 1019.7195771162841, 1022.7318125524296, 1025.7538190834296, 1046.7487802927242, 9708.757281067888, 10195.184385249162, 10306.845397319046, 11088.002079812693, 11114.388708620942, 560472.0, 560963.0, 562533.0, 569386.0, 574326.1283693555, 108421.45789271004, 132193.0, 138445.3077734605, 141741.0, 142777.0, 1114.9554017839357, 1162.0931222665215, 1166.7433164703752, 1216.7809794236946, 1224.9877501224873, 20899.582008360052, 21943.341699749035, 22183.0, 22275.443113922283, 22326.0, 58447.70776146092, 58713.0, 58751.0, 59004.40995589989, 59753.0, 68102.65948670225, 73051.0, 76309.0, 79648.60175699316, 82020.58989705013, 6764.8985265222045, 8812.91187088121, 9085.454872707658, 9193.034731353111, 9286.72139835806, 13999.230042347768, 14066.648333791738, 14078.084924480285, 14545.5636330906, 14546.709065818835, 9591.184749296388, 9905.900940990497, 11590.13074019435, 11827.408629568316, 12062.75874482523, 11480.598179063692, 11490.712732181762, 11498.770024599295, 11767.470463829319, 11847.585334513251, 9023.0, 11993.64019079429, 12095.334756588472, 12220.205686630341, 12341.3829308536, 8833.205011548991, 9078.909210907806, 9170.15410857014, 9235.676751313671, 9347.3456858022, 11880.287182769061, 11905.047596192111, 12075.698107547381, 12267.877321226673, 12468.688282793002], "value": 10510.734997296464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1165.9300441973487, 1358.2461733737778, 1421.644588852787, 1432.9140251584906, 1437.5112461763, 9713.222942164628, 10213.591456341746, 11426.885731142696, 11747.941260293686, 11761.176717629769, 9454.385464944773, 10112.39325640462, 10474.68575942721, 11344.43277836109, 11404.885951140486, 2031.7155598216261, 2517.785988191006, 2538.70804857441, 2539.085929065544, 2542.250036239314, 1751.9211635476433, 2196.1654571262898, 2463.963040554393, 2557.1433569754063, 2560.3727086863746, 2496.7628075332814, 2500.8499490030567, 2524.192258477288, 2526.2295000024983, 2530.253575195322, 2290.267114523345, 2316.8494047887, 2490.452100537879, 2514.522240774247, 2516.094206085808, 2454.9754502454925, 2485.030837973192, 2485.478049609584, 2489.9004039838383, 2496.9750302496923, 11254.212205145643, 11511.712207194803, 11514.942425287903, 11559.190856640038, 11591.768164636744, 6447.129637498924, 6668.666566671647, 6673.432758215557, 6688.5652432592215, 6701.3968742812895, 3878.26313000529, 4173.791310434466, 4306.138772245532, 4309.482862056573, 4316.719413238129, 1231.7536492701495, 1246.7506498700295, 1266.5377137344803, 1283.6983308922395, 1291.644797680636, 13166.934165329112, 16313.836861631351, 16325.918370408071, 16326.020438773592, 16345.34618615254, 5018.949810501848, 5712.485876271156, 5854.297484301911, 5871.236739223959, 5994.7602095916545, 13585.252811095286, 13607.659808504866, 13615.115017523829, 13616.18302901829, 13617.795733064011, 6600.768973086015, 6719.630420326929, 6742.561733487308, 6757.155355580552, 6759.628220447824, 5246.606504512177, 6122.693865306717, 6134.110553969649, 6148.907766383508, 6200.224971878515, 3789.3368660484307, 4101.302778527657, 4191.497020357516, 4475.664325175625, 4537.364768932286, 1379.3034517568765, 1401.453433161068, 1408.4155075643494, 1431.6707157353867, 1433.8996270260982, 810.3476701255546, 819.1399031017407, 831.9334453243725, 840.9747707568782, 869.7738587967174, 5177.275181474522, 6208.627482351073, 6660.467162626978, 6685.933140668531, 6760.391564759196, 887.5163036145316, 891.0146380976349, 892.4065496444921, 972.2125078686287, 977.4819345746765, 3778.6221377862544, 3845.807709614564, 3904.8047597620007, 3906.648401643866, 3923.0, 13984.720305593832, 14161.504347347793, 14651.92674036623, 14868.959172857796, 14873.181974991263, 14455.638609034859, 14666.926665366605, 14760.557183284518, 14915.254237288093, 14917.850821491864, 8381.874271885927, 8480.98228212606, 8586.356023298278, 8598.656053757904, 8675.6529738811, 6016.826718789969, 6719.580950857589, 6761.830954226184, 6836.760713375008, 6956.7217311309005, 10443.582256709951, 12876.22742635445, 12979.675508111995, 12981.870181298065, 13485.325733713471, 13272.933635331761, 13522.18866867991, 13547.696891528267, 13581.86418135806, 13906.58280251594, 9034.774130646787, 9122.224610908148, 9193.172614464731, 9236.815263694823, 9278.58246378928, 9588.520573971413, 9918.40489570628, 9926.503674816375, 10319.432431216355, 10586.258961872594, 7861.135275119618, 9071.319651026068, 9106.180443760093, 9113.0, 9343.71968840936, 8857.247133993682, 8874.0, 8944.597493112695, 8957.641694332153, 8959.1936725695, 8057.556834374166, 8195.754127376189, 8205.343572514064, 8223.54770487605, 8231.794205144919, 5904.763809447574, 5925.288965324189, 6019.217501724747, 6110.083487476914, 6154.076888466766, 5692.48767610917, 5946.0189068803165, 6016.488598469179, 6135.693215339126, 6155.84610384744], "value": 5317.213732088881, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.94607122386424, 386.34707344587645, 395.0439935356436, 395.68543008308393, 398.4421809466748, 5715.971420142899, 6013.098035294703, 6060.696920178502, 6079.574429789916, 6088.39116088391, 5413.0, 5604.467575580314, 5872.76508939643, 5879.85300367491, 5974.462298393144, 3629.5644522657317, 4482.663800214997, 4486.2821948488245, 4487.679117453094, 4509.075639493913, 3974.754263840935, 4042.43405923171, 4392.033752574444, 4482.906794311931, 4484.641228701696, 3553.7867727936277, 4388.758618275993, 4478.328250762379, 4480.932786008212, 4490.169318676039, 4468.218061839198, 4471.843485478025, 4483.305087711377, 4486.663500237479, 4493.876530867283, 3943.4282029105907, 3968.1666849961543, 3979.621935916083, 3988.162485877969, 4011.4183443400834, 4768.642351823592, 4951.084049450863, 5695.231143795618, 5789.8263052108505, 5847.970760146172, 5372.7045012524295, 5381.327334083239, 5385.649932754398, 5387.680018395479, 5397.190421436777, 5429.864253393657, 5939.4357536034, 6356.4279214870885, 6379.712912918883, 6388.1695379600815, 3946.4080387941754, 4114.855980040684, 4160.188763191179, 4166.104287578185, 4563.292689633112, 5614.550835933115, 6385.329540398237, 6538.673066346663, 6539.5149843059335, 6670.0, 4100.91798164035, 4193.412922190896, 4202.642775364067, 4202.936955945664, 4203.32746760523, 3671.9265614688093, 4248.915021699549, 4255.446791917031, 4264.189803937242, 4272.423222864873, 4634.328022436728, 4739.573438390561, 4789.928151077736, 4981.825636102719, 4989.625778066659, 5482.451754824486, 6358.841028974312, 6362.6500542469685, 6368.713407896656, 6388.1376014237485, 1428.6571222906427, 1434.7345741037732, 1450.0, 1451.2888684544707, 1454.5563603100943, 789.8341348316918, 809.8176662073321, 952.4047470331043, 956.53129966316, 959.318883592643, 5953.910691339634, 5957.642541447441, 5971.522278217819, 5983.132445795422, 5993.550483713739, 5824.417558244142, 5953.2735506702575, 6027.8848413043725, 6462.353764623594, 6538.771143010067, 4593.081383723269, 5397.3523177218985, 5773.8556536086935, 5874.001419758566, 5964.063717946135, 2772.487089888377, 2843.175479111076, 2971.5097008993707, 3333.000099969999, 3437.1750779813165, 5934.884185802402, 6030.5778595497895, 6110.905693185577, 6688.632125233062, 6785.762498312634, 6118.78584249558, 6657.201135863727, 6738.595684258862, 6747.696353664097, 6764.3573860483175, 6195.31851496335, 6532.346765323429, 6732.091167692397, 6763.086983257197, 6796.048553202556, 5474.562035037108, 5760.9918264304415, 5775.971120144541, 6596.5052621052655, 6597.340265973365, 5630.831075067755, 5940.227770389822, 6153.538484613761, 6432.742690292336, 6575.342465753386, 5525.668459892419, 6742.764003259862, 6772.356626120511, 6851.08040878726, 6871.793846184622, 4201.621854033152, 4209.0, 4214.831406743696, 4224.239636865394, 4231.259529582249, 5855.900869391528, 6450.41946224842, 6518.315576864361, 6625.370589793962, 6662.267150613332, 5309.38942021657, 5456.290682211287, 6110.633361998294, 6187.102870083722, 6452.257990331172, 5251.711155886463, 5499.257600223918, 5546.722663866871, 6166.2600487939935, 6375.713092910737, 5748.051571490657, 5955.558221129316, 6298.771739510935, 6299.842503937255, 6321.905171422524, 6047.78832740852, 6391.178514123452, 6399.168108145911, 6415.101885736094, 6425.550211485338, 5914.4381283777975, 6205.596636218631, 6270.592411493239, 6279.277883043508, 6309.779157729457], "value": 4563.4565517931815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3096634332013, 824.2540500846736, 834.0533494483763, 836.698788436163, 850.7660393391818, 13014.089013769028, 18153.636927261447, 18216.90891545544, 18712.532186695338, 18733.344332948367, 17382.739258911126, 17526.386576469828, 18064.909675451636, 18080.36718714845, 18100.909495452503, 959.525035107621, 974.6929717139114, 977.6578197630844, 979.8677178580907, 981.1365997921819, 660.4980215036559, 677.0588881454781, 971.3928794503436, 1004.2367800471621, 1007.5919252702668, 1048.5176818663424, 1050.9842352364722, 1052.6263176572322, 1053.0312112856152, 1053.8682664666917, 1048.3238311289251, 1050.7373156710785, 1051.2798732867934, 1053.0943388685723, 1053.1311667873958, 506.06883334664025, 521.5175962234955, 736.4366259811248, 775.0002496779205, 778.1867947994303, 16961.66076678472, 17238.482845514656, 17254.223559939706, 17288.481345559652, 17292.827071729374, 16841.83158168415, 17103.572410689707, 17352.392666256746, 17471.47585572422, 17493.56266093345, 13849.930750346184, 14092.788608170886, 14173.43306267748, 14204.715905681931, 14233.074850134708, 3227.064151396116, 3282.146641873106, 3287.589051368579, 3288.112209703391, 3289.7368210543336, 126743.366283168, 127069.48096747456, 128533.0, 129084.35457822651, 131192.99999999904, 10123.44321062334, 10742.838857417146, 13286.3356832158, 13562.932185339207, 13576.796348054788, 18797.436076917715, 24887.253382398558, 25741.74258257431, 25756.61365079488, 25765.969361225714, 6211.875762484725, 7899.763007109796, 7909.406794490321, 7913.643886025143, 7922.207779222147, 3864.7294689371474, 3882.7087968402484, 3909.9218015639526, 3948.0, 3958.802059896994, 4235.9364609530885, 4387.934180987288, 4394.472663280427, 4397.538258482813, 4400.119976004812, 903.3315346643436, 926.6571368593663, 941.2705153506088, 949.2121539122512, 949.3876449690049, 530.2682298428222, 632.3992207402986, 658.4173006888938, 670.6412069542771, 696.8257935516122, 10940.890591094147, 11742.647720568397, 11876.465559049864, 11899.583514577122, 12008.579699710468, 645.515863102673, 659.3801826283278, 662.5461558832119, 672.2336536348566, 680.6630717794724, 5302.734863256822, 5516.668999860021, 5561.165825126263, 5626.437356264422, 5706.269407806063, 69790.0, 79954.0, 101401.0, 104374.0, 104487.0, 89596.0, 90021.54989225011, 90041.54979225062, 93143.0685693148, 93487.0, 61497.0, 61994.0700889478, 80886.0, 82119.5894020526, 84568.15431845603, 9832.31173817826, 9963.35238209543, 11334.94332528332, 12264.693382665148, 12378.938105309417, 36932.892013239645, 37120.25759484741, 37272.88181354564, 37604.623953761205, 38032.80983595064, 60848.0, 65810.67094664495, 68018.3198168012, 68391.97412038923, 68619.0, 15480.303386347867, 16440.260188291795, 17255.137243137542, 17262.0, 17286.0, 17609.73585396246, 18225.635487289914, 18446.446606601825, 18591.34930277434, 19116.23535058582, 16242.350305987628, 16933.576660583585, 17054.2325595346, 17206.913965430595, 17326.826731732523, 13761.96785241131, 16287.267072981507, 16965.91517042407, 16972.15139243008, 17216.483505494856, 15969.760453592973, 16388.0, 17034.914825425793, 17119.914400428417, 17220.913895430444, 10918.50866710984, 11639.941800290944, 12114.667386587644, 12242.204256723284, 12264.562001148635, 12730.618081457571, 13652.0, 13835.654108646962, 13999.720005600035, 14028.509002184874], "value": 8269.532452638634, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 116.0, 163.0, 159.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 108.0, 147.0, 110.0, 107.0, 110.0, 107.0, 135.0, 109.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 184.0, 183.0, 184.0, 187.0, 182.0, 183.0, 186.0, 181.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 63.0, 60.0, 121.0, 90.0, 50.0, 58.0, 84.0, 105.0, 84.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 90.0, 69.0, 68.0, 67.0, 89.0, 68.0, 68.0, 91.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 91.0, 91.0, 90.0, 90.0, 90.0, 91.0, 90.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 100.0, 96.0, 96.0, 96.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 94.0, 138.0, 77.0, 123.0, 136.0, 93.0, 86.0], "value": 99.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 50.0, 49.0, 50.0, 50.0, 50.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 59.0, 67.0, 61.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 91.0, 94.0, 107.0, 82.0, 82.0, 82.0, 81.0, 81.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 138.0, 136.0, 134.0, 136.0, 135.0, 136.0, 195.0, 172.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 185.0, 185.0, 187.0, 186.0, 208.0, 238.0, 230.0, 178.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 66.0, 67.0, 69.0, 69.0, 66.0], "value": 67.7, "unit": "score"}]}]} 19:22:46 INFO - Return code: 0 19:22:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:22:46 ERROR - # TBPL SUCCESS # 19:22:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:22:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:22:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:22:46 INFO - 2017-05-02 19:22:46.334 screenresolution[3155:60290] starting screenresolution argv=screenresolution get 19:22:46 INFO - 2017-05-02 19:22:46.337 screenresolution[3155:60290] Display 0: 1600x1200x32@60 19:22:46 INFO - 2017-05-02 19:22:46.343 screenresolution[3156:60293] starting screenresolution argv=screenresolution list 19:22:46 INFO - Available Modes on Display 0 19:22:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:22:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:22:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:22:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:22:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:22:46 INFO - Intel Iris: 19:22:46 INFO - Chipset Model: Intel Iris 19:22:46 INFO - Type: GPU 19:22:46 INFO - Bus: Built-In 19:22:46 INFO - VRAM (Dynamic, Max): 1536 MB 19:22:46 INFO - Vendor: Intel (0x8086) 19:22:46 INFO - Device ID: 0x0a2e 19:22:46 INFO - Revision ID: 0x0009 19:22:46 INFO - Displays: 19:22:46 INFO - Display: 19:22:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:22:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:22:46 INFO - Display Serial Number: 1600x1200 60 19:22:46 INFO - Main Display: Yes 19:22:46 INFO - Mirror: Off 19:22:46 INFO - Online: Yes 19:22:46 INFO - Rotation: Supported 19:22:46 INFO - Return code: 0 19:22:46 INFO - Running post-action listener: _resource_record_post_action 19:22:46 INFO - [mozharness: 2017-05-03 02:22:46.588415Z] Finished run-tests step (success) 19:22:46 INFO - Running post-run listener: _resource_record_post_run 19:22:46 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 1143296; Write bytes: 505482240; Read time: 5; Write time: 1550 19:22:46 INFO - TinderboxPrint: CPU usage
53.2% 19:22:46 INFO - TinderboxPrint: I/O read bytes / time
1,143,296 / 5 19:22:46 INFO - TinderboxPrint: I/O write bytes / time
505,482,240 / 1,550 19:22:46 INFO - TinderboxPrint: CPU idle
2,249.5 (46.8%) 19:22:46 INFO - TinderboxPrint: CPU system
955.4 (19.9%) 19:22:46 INFO - TinderboxPrint: CPU user
1,596.9 (33.3%) 19:22:46 INFO - TinderboxPrint: Swap in / out
209,440,768 / 0 19:22:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205761024; Write bytes: 206907392; Read time: 15988; Write time: 443 19:22:46 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 242176; Write bytes: 291505152; Read time: 3; Write time: 1077 19:22:47 INFO - Running post-run listener: _upload_blobber_files 19:22:47 INFO - Blob upload gear active. 19:22:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:22:47 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 19:22:47 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'] 19:22:47 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 19:22:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:48 INFO - (blobuploader) - INFO - Done attempting. 19:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:49 INFO - (blobuploader) - INFO - Done attempting. 19:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:51 INFO - (blobuploader) - INFO - Done attempting. 19:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:53 INFO - (blobuploader) - INFO - Done attempting. 19:22:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:53 INFO - Return code: 0 19:22:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:22:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc99618c2d8e8e4b4610822a293e0960e8f3f40d7788d23eca83ab73e4f39b23e3b515521e81ce204cf124dba2e2bdb1b229abcc0cce7e22ee75af5880a992dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49ce776cfa14d4bef9be5d645241b53413599ba08a6a27c36a31d8d6077c6720fc9318d437ab1c1cb38708e82e696d7757deb9ea5c91dc3f4775ded9181f86a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e867a3d12c8b1f8f73fc5991ac49ce3dc51761d8cc1d5f8b46b0caab6705e3dfcc0785bdfe7eff1b969a00882d72c76463d769c26b78d19da970e5b315d255a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013b6046300233dbb182e56d45fbb5fa2e4b1e2db7f18f1db10a462323fdd4c045ccec55c76a2b5b049dd6dc86f732713009ddf2911a55fd56b5d6bdb3f71e4e"} 19:22:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:22:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:22:53 INFO - Contents: 19:22:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc99618c2d8e8e4b4610822a293e0960e8f3f40d7788d23eca83ab73e4f39b23e3b515521e81ce204cf124dba2e2bdb1b229abcc0cce7e22ee75af5880a992dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49ce776cfa14d4bef9be5d645241b53413599ba08a6a27c36a31d8d6077c6720fc9318d437ab1c1cb38708e82e696d7757deb9ea5c91dc3f4775ded9181f86a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e867a3d12c8b1f8f73fc5991ac49ce3dc51761d8cc1d5f8b46b0caab6705e3dfcc0785bdfe7eff1b969a00882d72c76463d769c26b78d19da970e5b315d255a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013b6046300233dbb182e56d45fbb5fa2e4b1e2db7f18f1db10a462323fdd4c045ccec55c76a2b5b049dd6dc86f732713009ddf2911a55fd56b5d6bdb3f71e4e"} 19:22:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:53 INFO - Copying logs to upload dir... 19:22:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:22:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.041619 ========= master_lag: 1.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-05-02 19:22:54.667946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 19:22:54.669263) ========= 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.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc99618c2d8e8e4b4610822a293e0960e8f3f40d7788d23eca83ab73e4f39b23e3b515521e81ce204cf124dba2e2bdb1b229abcc0cce7e22ee75af5880a992dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49ce776cfa14d4bef9be5d645241b53413599ba08a6a27c36a31d8d6077c6720fc9318d437ab1c1cb38708e82e696d7757deb9ea5c91dc3f4775ded9181f86a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e867a3d12c8b1f8f73fc5991ac49ce3dc51761d8cc1d5f8b46b0caab6705e3dfcc0785bdfe7eff1b969a00882d72c76463d769c26b78d19da970e5b315d255a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013b6046300233dbb182e56d45fbb5fa2e4b1e2db7f18f1db10a462323fdd4c045ccec55c76a2b5b049dd6dc86f732713009ddf2911a55fd56b5d6bdb3f71e4e"} build_url:https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/VCOtdwarSxewpzVbgvgx7A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc99618c2d8e8e4b4610822a293e0960e8f3f40d7788d23eca83ab73e4f39b23e3b515521e81ce204cf124dba2e2bdb1b229abcc0cce7e22ee75af5880a992dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f49ce776cfa14d4bef9be5d645241b53413599ba08a6a27c36a31d8d6077c6720fc9318d437ab1c1cb38708e82e696d7757deb9ea5c91dc3f4775ded9181f86a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e867a3d12c8b1f8f73fc5991ac49ce3dc51761d8cc1d5f8b46b0caab6705e3dfcc0785bdfe7eff1b969a00882d72c76463d769c26b78d19da970e5b315d255a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013b6046300233dbb182e56d45fbb5fa2e4b1e2db7f18f1db10a462323fdd4c045ccec55c76a2b5b049dd6dc86f732713009ddf2911a55fd56b5d6bdb3f71e4e"}' ========= master_lag: 0.87 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 19:22:55.554248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 19:22:55.554528) ========= 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.sWRN7PzdJw/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.XH34nFaGTf/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.005182 ========= master_lag: 1.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 19:22:57.098808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 19:22:57.099121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 19:22:57.110002) ========= ========= Total master_lag: 3.73 =========