builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0372 starttime: 1493159513.81 results: success (0) buildid: 20170425135825 builduid: 1070cf3b4c5b4063b9f08eef5f6a72c1 revision: 3f0c8da53c5cb015933b10b52ded3f30432b378a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.807237) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.807736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.808039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.836142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.836651) ========= 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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 15:31:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-04-25 15:31:54 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120722 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.983823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:53.984156) ========= 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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.023654 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:54.032624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 15:31:54.032990) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f0c8da53c5cb015933b10b52ded3f30432b378a --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 3f0c8da53c5cb015933b10b52ded3f30432b378a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 15:31:54,256 truncating revision to first 12 chars 2017-04-25 15:31:54,256 Setting DEBUG logging. 2017-04-25 15:31:54,256 attempt 1/10 2017-04-25 15:31:54,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f0c8da53c5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 15:31:55,623 unpacking tar archive at: mozilla-central-3f0c8da53c5c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.629764 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 15:31:55.688517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:55.688847) ========= script_repo_revision: 3f0c8da53c5cb015933b10b52ded3f30432b378a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:55.689883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:55.690176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 15:31:55.711048) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 15:31:55.711715) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:31:56 INFO - MultiFileLogger online at 20170425 15:31:56 in /builds/slave/test 15:31:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:31:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:56 INFO - {'append_to_log': False, 15:31:56 INFO - 'base_work_dir': '/builds/slave/test', 15:31:56 INFO - 'blob_upload_branch': 'Firefox', 15:31:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:56 INFO - 'branch': 'Firefox', 15:31:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:56 INFO - 'config_files': ('talos/mac_config.py',), 15:31:56 INFO - 'default_actions': ('clobber', 15:31:56 INFO - 'read-buildbot-config', 15:31:56 INFO - 'download-and-extract', 15:31:56 INFO - 'populate-webroot', 15:31:56 INFO - 'create-virtualenv', 15:31:56 INFO - 'install', 15:31:56 INFO - 'run-tests'), 15:31:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:56 INFO - 'download_minidump_stackwalk': True, 15:31:56 INFO - 'download_symbols': 'ondemand', 15:31:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:56 INFO - 'gecko_profile': False, 15:31:56 INFO - 'gecko_profile_interval': 0, 15:31:56 INFO - 'installer_path': 'installer.exe', 15:31:56 INFO - 'log_level': 'info', 15:31:56 INFO - 'log_name': 'talos', 15:31:56 INFO - 'log_to_console': True, 15:31:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:31:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:31:56 INFO - 'opt_config_files': (), 15:31:56 INFO - 'pip_index': False, 15:31:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:31:56 INFO - 'cmd': ('bash', 15:31:56 INFO - '-c', 15:31:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:31:56 INFO - 'enabled': True, 15:31:56 INFO - 'halt_on_failure': False, 15:31:56 INFO - 'name': 'check_screen_resolution'},), 15:31:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:31:56 INFO - 'cmd': ('bash', 15:31:56 INFO - '-c', 15:31:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:31:56 INFO - 'enabled': True, 15:31:56 INFO - 'halt_on_failure': False, 15:31:56 INFO - 'name': 'check_screen_resolution'},), 15:31:56 INFO - 'run_cmd_checks_enabled': True, 15:31:56 INFO - 'suite': 'dromaeojs-e10s', 15:31:56 INFO - 'system_bits': '32', 15:31:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:56 INFO - 'title': 't-yosemite-r7-0372', 15:31:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:56 INFO - 'use_talos_json': True, 15:31:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:56 INFO - 'work_dir': 'build'} 15:31:56 INFO - [mozharness: 2017-04-25 22:31:56.053981Z] Running clobber step. 15:31:56 INFO - Running pre-action listener: _resource_record_pre_action 15:31:56 INFO - Running main action method: clobber 15:31:56 INFO - rmtree: /builds/slave/test/build 15:31:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:59 INFO - Running post-action listener: _resource_record_post_action 15:31:59 INFO - [mozharness: 2017-04-25 22:31:59.424536Z] Finished clobber step (success) 15:31:59 INFO - [mozharness: 2017-04-25 22:31:59.424732Z] Running read-buildbot-config step. 15:31:59 INFO - Running pre-action listener: _resource_record_pre_action 15:31:59 INFO - Running main action method: read_buildbot_config 15:31:59 INFO - Using buildbot properties: 15:31:59 INFO - { 15:31:59 INFO - "project": "", 15:31:59 INFO - "product": "firefox", 15:31:59 INFO - "script_repo_revision": "production", 15:31:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:31:59 INFO - "repository": "", 15:31:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:31:59 INFO - "buildid": "20170425135825", 15:31:59 INFO - "pgo_build": "False", 15:31:59 INFO - "basedir": "/builds/slave/test", 15:31:59 INFO - "buildnumber": 46, 15:31:59 INFO - "slavename": "t-yosemite-r7-0372", 15:31:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:31:59 INFO - "platform": "yosemite_r7", 15:31:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:31:59 INFO - "branch": "mozilla-central", 15:31:59 INFO - "repo_path": "mozilla-central", 15:31:59 INFO - "revision": "3f0c8da53c5cb015933b10b52ded3f30432b378a", 15:31:59 INFO - "stage_platform": "macosx64", 15:31:59 INFO - "builduid": "1070cf3b4c5b4063b9f08eef5f6a72c1", 15:31:59 INFO - "slavebuilddir": "test" 15:31:59 INFO - } 15:31:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:31:59 INFO - Running post-action listener: _resource_record_post_action 15:31:59 INFO - [mozharness: 2017-04-25 22:31:59.430444Z] Finished read-buildbot-config step (success) 15:31:59 INFO - [mozharness: 2017-04-25 22:31:59.430624Z] Running download-and-extract step. 15:31:59 INFO - Running pre-action listener: _resource_record_pre_action 15:31:59 INFO - Running main action method: download_and_extract 15:31:59 INFO - mkdir: /builds/slave/test/build/tests 15:31:59 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')]} 15:31:59 INFO - trying https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:31:59 INFO - Downloading https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/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 15:31:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/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 15:31:59 INFO - Downloaded 1325 bytes. 15:31:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:31:59 INFO - Using the following test package requirements: 15:31:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:31:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:32:00 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:32:00 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:32:00 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:32:00 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'jsshell-mac.zip'], 15:32:00 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:32:00 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:32:00 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:32:00 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:32:00 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:32:00 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:32:00 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:32:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:32:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:32:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:00 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:32:01 INFO - Content-Length response header: 52527408 15:32:01 INFO - Bytes received: 52527408 15:32:18 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 15:32:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:32:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:18 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:32:20 INFO - Content-Length response header: 52527408 15:32:20 INFO - Bytes received: 52527408 15:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:32:36 INFO - Content-Length response header: 14408809 15:32:36 INFO - Bytes received: 14408809 15:32:37 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')]} 15:32:37 INFO - trying https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:37 INFO - Downloading https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/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 15:32:39 INFO - Downloaded 71272160 bytes. 15:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:39 INFO - mkdir: /builds/slave/test/properties 15:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:39 INFO - Contents: 15:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:32:39 INFO - Running post-action listener: _resource_record_post_action 15:32:39 INFO - Running post-action listener: set_extra_try_arguments 15:32:39 INFO - [mozharness: 2017-04-25 22:32:39.744123Z] Finished download-and-extract step (success) 15:32:39 INFO - [mozharness: 2017-04-25 22:32:39.744262Z] Running populate-webroot step. 15:32:39 INFO - Running pre-action listener: _resource_record_pre_action 15:32:39 INFO - Running main action method: populate_webroot 15:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:39 INFO - '--tppagecycles', 15:32:39 INFO - '7'], 15:32:39 INFO - 'tests': ['tsvgm']}}, 15:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['damp', 'tps']}, 15:32:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'tests': ['damp', 'tps']}, 15:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['dromaeo_dom']}, 15:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['a11yr', 15:32:39 INFO - 'ts_paint', 15:32:39 INFO - 'tpaint', 15:32:39 INFO - 'sessionrestore', 15:32:39 INFO - 'sessionrestore_no_auto_restore', 15:32:39 INFO - 'tabpaint']}, 15:32:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:32:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:32:39 INFO - 'bloom_basic_ref']}, 15:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tsvgx', 15:32:39 INFO - 'tsvgr_opacity', 15:32:39 INFO - 'tart', 15:32:39 INFO - 'tscrollx', 15:32:39 INFO - 'cart', 15:32:39 INFO - 'tsvg_static']}, 15:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:39 INFO - 'tsvgr_opacity', 15:32:39 INFO - 'tart', 15:32:39 INFO - 'tscrollx', 15:32:39 INFO - 'cart', 15:32:39 INFO - 'tsvg_static']}, 15:32:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s'], 15:32:39 INFO - 'tests': ['tp5o']}, 15:32:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:32:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'talos_options': ['--disable-e10s', 15:32:39 INFO - '--xperf_path', 15:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:39 INFO - 'tests': ['tp5n']}, 15:32:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:32:39 INFO - 'talos_options': ['--xperf_path', 15:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:39 INFO - 'tests': ['tp5n']}}, 15:32:39 INFO - 'talos.zip': {'path': '', 15:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:39 INFO - Running post-action listener: _resource_record_post_action 15:32:39 INFO - [mozharness: 2017-04-25 22:32:39.763784Z] Finished populate-webroot step (success) 15:32:39 INFO - [mozharness: 2017-04-25 22:32:39.763867Z] Running create-virtualenv step. 15:32:39 INFO - Running pre-action listener: _resource_record_pre_action 15:32:39 INFO - Running main action method: create_virtualenv 15:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:39 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 15:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:39 INFO - Using real prefix '/tools/python27' 15:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:43 INFO - Installing pip.................done. 15:32:43 INFO - Return code: 0 15:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:43 INFO - Reading from file tmpfile_stdout 15:32:43 INFO - Output received: 15:32:43 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) 15:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:43 INFO - 'HOME': '/Users/cltbld', 15:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:43 INFO - 'LOGNAME': 'cltbld', 15:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:43 INFO - 'MOZ_NO_REMOTE': '1', 15:32:43 INFO - 'NO_EM_RESTART': '1', 15:32:43 INFO - 'PAGER': '/bin/cat', 15:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:43 INFO - 'PWD': '/builds/slave/test', 15:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:43 INFO - 'SHELL': '/bin/bash', 15:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:43 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:43 INFO - 'USER': 'cltbld', 15:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:43 INFO - 'XPC_FLAGS': '0x0', 15:32:43 INFO - 'XPC_SERVICE_NAME': '0', 15:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:44 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 15:32:44 INFO - Cleaning up... 15:32:44 INFO - Return code: 0 15:32:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:44 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:44 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 15:32:44 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 15:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:44 INFO - 'HOME': '/Users/cltbld', 15:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:44 INFO - 'LOGNAME': 'cltbld', 15:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:44 INFO - 'MOZ_NO_REMOTE': '1', 15:32:44 INFO - 'NO_EM_RESTART': '1', 15:32:44 INFO - 'PAGER': '/bin/cat', 15:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:44 INFO - 'PWD': '/builds/slave/test', 15:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:44 INFO - 'SHELL': '/bin/bash', 15:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:44 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:44 INFO - 'USER': 'cltbld', 15:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:44 INFO - 'XPC_FLAGS': '0x0', 15:32:44 INFO - 'XPC_SERVICE_NAME': '0', 15:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:44 INFO - Downloading/unpacking psutil>=3.1.1 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:47 INFO - Installing collected packages: psutil 15:32:47 INFO - Running setup.py install for psutil 15:32:48 INFO - building 'psutil._psutil_osx' extension 15:32:48 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 15:32:48 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 15:32:48 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 15:32:48 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 15:32:48 INFO - building 'psutil._psutil_posix' extension 15:32:48 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 15:32:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:32:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:32:48 INFO - ^ 15:32:48 INFO - 1 warning generated. 15:32:48 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 15:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:48 INFO - Successfully installed psutil 15:32:48 INFO - Cleaning up... 15:32:48 INFO - Return code: 0 15:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:48 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')]} 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 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')]} 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:48 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 15:32:48 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 15:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:48 INFO - 'HOME': '/Users/cltbld', 15:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:48 INFO - 'LOGNAME': 'cltbld', 15:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:48 INFO - 'MOZ_NO_REMOTE': '1', 15:32:48 INFO - 'NO_EM_RESTART': '1', 15:32:48 INFO - 'PAGER': '/bin/cat', 15:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:48 INFO - 'PWD': '/builds/slave/test', 15:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:48 INFO - 'SHELL': '/bin/bash', 15:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:48 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:48 INFO - 'USER': 'cltbld', 15:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:48 INFO - 'XPC_FLAGS': '0x0', 15:32:48 INFO - 'XPC_SERVICE_NAME': '0', 15:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:51 INFO - Installing collected packages: mozsystemmonitor 15:32:51 INFO - Running setup.py install for mozsystemmonitor 15:32:51 INFO - Successfully installed mozsystemmonitor 15:32:51 INFO - Cleaning up... 15:32:52 INFO - Return code: 0 15:32:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:52 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:52 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 15:32:52 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 15:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:52 INFO - 'HOME': '/Users/cltbld', 15:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:52 INFO - 'LOGNAME': 'cltbld', 15:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:52 INFO - 'MOZ_NO_REMOTE': '1', 15:32:52 INFO - 'NO_EM_RESTART': '1', 15:32:52 INFO - 'PAGER': '/bin/cat', 15:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:52 INFO - 'PWD': '/builds/slave/test', 15:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:52 INFO - 'SHELL': '/bin/bash', 15:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:52 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:52 INFO - 'USER': 'cltbld', 15:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:52 INFO - 'XPC_FLAGS': '0x0', 15:32:52 INFO - 'XPC_SERVICE_NAME': '0', 15:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:56 INFO - warning: no files found matching '*.txt' 15:32:56 INFO - no previously-included directories found matching 'build' 15:32:56 INFO - no previously-included directories found matching 'dist' 15:32:56 INFO - no previously-included directories found matching '.git*' 15:32:56 INFO - Installing collected packages: jsonschema, functools32 15:32:56 INFO - Running setup.py install for functools32 15:32:56 INFO - warning: no files found matching '*.txt' 15:32:56 INFO - no previously-included directories found matching 'build' 15:32:56 INFO - no previously-included directories found matching 'dist' 15:32:56 INFO - no previously-included directories found matching '.git*' 15:32:56 INFO - Successfully installed jsonschema functools32 15:32:56 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:57 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 15:32:57 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 15:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:57 INFO - 'HOME': '/Users/cltbld', 15:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:57 INFO - 'LOGNAME': 'cltbld', 15:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:57 INFO - 'MOZ_NO_REMOTE': '1', 15:32:57 INFO - 'NO_EM_RESTART': '1', 15:32:57 INFO - 'PAGER': '/bin/cat', 15:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:57 INFO - 'PWD': '/builds/slave/test', 15:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:57 INFO - 'SHELL': '/bin/bash', 15:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:57 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:57 INFO - 'USER': 'cltbld', 15:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:57 INFO - 'XPC_FLAGS': '0x0', 15:32:57 INFO - 'XPC_SERVICE_NAME': '0', 15:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:57 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:32:57 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 15:32:57 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 15:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:57 INFO - 'HOME': '/Users/cltbld', 15:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:57 INFO - 'LOGNAME': 'cltbld', 15:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:57 INFO - 'MOZ_NO_REMOTE': '1', 15:32:57 INFO - 'NO_EM_RESTART': '1', 15:32:57 INFO - 'PAGER': '/bin/cat', 15:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:57 INFO - 'PWD': '/builds/slave/test', 15:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:57 INFO - 'SHELL': '/bin/bash', 15:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:32:57 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:57 INFO - 'USER': 'cltbld', 15:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:57 INFO - 'XPC_FLAGS': '0x0', 15:32:57 INFO - 'XPC_SERVICE_NAME': '0', 15:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:00 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 15:33:01 INFO - Downloading docopt-0.6.1.tar.gz 15:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:01 INFO - Running setup.py install for blobuploader 15:33:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:01 INFO - Running setup.py install for requests 15:33:02 INFO - Running setup.py install for docopt 15:33:02 INFO - Successfully installed blobuploader requests docopt 15:33:02 INFO - Cleaning up... 15:33:02 INFO - Return code: 0 15:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:02 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:33:02 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 15:33:02 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 15:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:02 INFO - 'HOME': '/Users/cltbld', 15:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:02 INFO - 'LOGNAME': 'cltbld', 15:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:02 INFO - 'MOZ_NO_REMOTE': '1', 15:33:02 INFO - 'NO_EM_RESTART': '1', 15:33:02 INFO - 'PAGER': '/bin/cat', 15:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:02 INFO - 'PWD': '/builds/slave/test', 15:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:02 INFO - 'SHELL': '/bin/bash', 15:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:33:02 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:02 INFO - 'USER': 'cltbld', 15:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:02 INFO - 'XPC_FLAGS': '0x0', 15:33:02 INFO - 'XPC_SERVICE_NAME': '0', 15:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-5tt2io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-g_d9ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-3rjYMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-Adj3zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-1p9lyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-t70u_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-86IntV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-5G8rB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-x_tOAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-wFxiFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-gjhuzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-g2ve9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:03 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-2Ml84B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:04 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-lYy8WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:04 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-n5ExCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:04 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-L_iNL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:04 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-buGJvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:04 INFO - Running setup.py install for manifestparser 15:33:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:04 INFO - Running setup.py install for mozcrash 15:33:04 INFO - Running setup.py install for mozdebug 15:33:04 INFO - Running setup.py install for mozdevice 15:33:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Running setup.py install for mozfile 15:33:05 INFO - Running setup.py install for mozhttpd 15:33:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Running setup.py install for mozinfo 15:33:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Running setup.py install for mozInstall 15:33:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Running setup.py install for mozleak 15:33:05 INFO - Running setup.py install for mozlog 15:33:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:05 INFO - Running setup.py install for moznetwork 15:33:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:06 INFO - Running setup.py install for mozprocess 15:33:06 INFO - Running setup.py install for mozprofile 15:33:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:06 INFO - Running setup.py install for mozrunner 15:33:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:06 INFO - Running setup.py install for mozscreenshot 15:33:06 INFO - Running setup.py install for moztest 15:33:06 INFO - Running setup.py install for mozversion 15:33:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:07 INFO - Cleaning up... 15:33:07 INFO - Return code: 0 15:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:07 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:33:07 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 15:33:07 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 15:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:07 INFO - 'HOME': '/Users/cltbld', 15:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:07 INFO - 'LOGNAME': 'cltbld', 15:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:07 INFO - 'MOZ_NO_REMOTE': '1', 15:33:07 INFO - 'NO_EM_RESTART': '1', 15:33:07 INFO - 'PAGER': '/bin/cat', 15:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:07 INFO - 'PWD': '/builds/slave/test', 15:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:07 INFO - 'SHELL': '/bin/bash', 15:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:33:07 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:07 INFO - 'USER': 'cltbld', 15:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:07 INFO - 'XPC_FLAGS': '0x0', 15:33:07 INFO - 'XPC_SERVICE_NAME': '0', 15:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-4yQZ_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-__o_MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-yKJtT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-GI9BZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-U9MNzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-iJ0Cgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:07 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)) 15:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-6SmXTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-OzEw6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-KVGfED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-vOQCs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-jTguAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-FDBd3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-IUDHoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-vFDUkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-vNHoYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:08 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)) 15:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:08 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-xBEY7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:09 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)) 15:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:09 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-3uZ88e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:09 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)) 15:33:09 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)) 15:33:09 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)) 15:33:09 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)) 15:33:09 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)) 15:33:09 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)) 15:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:09 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 15:33:09 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 15:33:09 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 15:33:09 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 15:33:09 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 15:33:09 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 15:33:11 INFO - Downloading blessings-1.6.tar.gz 15:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:11 INFO - Installing collected packages: blessings 15:33:11 INFO - Running setup.py install for blessings 15:33:12 INFO - Successfully installed blessings 15:33:12 INFO - Cleaning up... 15:33:12 INFO - Return code: 0 15:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:12 INFO - Reading from file tmpfile_stdout 15:33:12 INFO - Current package versions: 15:33:12 INFO - blessings == 1.6 15:33:12 INFO - blobuploader == 1.2.4 15:33:12 INFO - docopt == 0.6.1 15:33:12 INFO - functools32 == 3.2.3-2 15:33:12 INFO - jsonschema == 2.5.1 15:33:12 INFO - manifestparser == 1.1 15:33:12 INFO - mozInstall == 1.12 15:33:12 INFO - mozcrash == 1.0 15:33:12 INFO - mozdebug == 0.1 15:33:12 INFO - mozdevice == 0.50 15:33:12 INFO - mozfile == 1.2 15:33:12 INFO - mozhttpd == 0.7 15:33:12 INFO - mozinfo == 0.9 15:33:12 INFO - mozleak == 0.1 15:33:12 INFO - mozlog == 3.4 15:33:12 INFO - moznetwork == 0.27 15:33:12 INFO - mozprocess == 0.25 15:33:12 INFO - mozprofile == 0.28 15:33:12 INFO - mozrunner == 6.13 15:33:12 INFO - mozscreenshot == 0.1 15:33:12 INFO - mozsystemmonitor == 0.3 15:33:12 INFO - moztest == 0.8 15:33:12 INFO - mozversion == 1.4 15:33:12 INFO - psutil == 3.1.1 15:33:12 INFO - requests == 1.2.3 15:33:12 INFO - wsgiref == 0.1.2 15:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:12 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')]} 15:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:12 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')]} 15:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:12 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:33:12 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 15:33:12 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 15:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:12 INFO - 'HOME': '/Users/cltbld', 15:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:12 INFO - 'LOGNAME': 'cltbld', 15:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:12 INFO - 'MOZ_NO_REMOTE': '1', 15:33:12 INFO - 'NO_EM_RESTART': '1', 15:33:12 INFO - 'PAGER': '/bin/cat', 15:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:12 INFO - 'PWD': '/builds/slave/test', 15:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:12 INFO - 'SHELL': '/bin/bash', 15:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:33:12 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:12 INFO - 'USER': 'cltbld', 15:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:12 INFO - 'XPC_FLAGS': '0x0', 15:33:12 INFO - 'XPC_SERVICE_NAME': '0', 15:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 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)) 15:33:12 INFO - Cleaning up... 15:33:12 INFO - Return code: 0 15:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:12 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')]} 15:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:12 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')]} 15:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:12 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 0x1070ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb29bd716b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, '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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 15:33:12 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 15:33:12 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 15:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:12 INFO - 'HOME': '/Users/cltbld', 15:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:12 INFO - 'LOGNAME': 'cltbld', 15:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:12 INFO - 'MOZ_NO_REMOTE': '1', 15:33:12 INFO - 'NO_EM_RESTART': '1', 15:33:12 INFO - 'PAGER': '/bin/cat', 15:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:12 INFO - 'PWD': '/builds/slave/test', 15:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:12 INFO - 'SHELL': '/bin/bash', 15:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:33:12 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:12 INFO - 'USER': 'cltbld', 15:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:12 INFO - 'XPC_FLAGS': '0x0', 15:33:12 INFO - 'XPC_SERVICE_NAME': '0', 15:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:12 INFO - Cleaning up... 15:33:13 INFO - Return code: 0 15:33:13 INFO - Running post-action listener: _resource_record_post_action 15:33:13 INFO - Running post-action listener: _start_resource_monitoring 15:33:13 INFO - Starting resource monitoring. 15:33:13 INFO - [mozharness: 2017-04-25 22:33:13.039357Z] Finished create-virtualenv step (success) 15:33:13 INFO - [mozharness: 2017-04-25 22:33:13.040261Z] Running install step. 15:33:13 INFO - Running pre-action listener: _resource_record_pre_action 15:33:13 INFO - Running main action method: install 15:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:13 INFO - Reading from file tmpfile_stdout 15:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:13 INFO - Reading from file tmpfile_stdout 15:33:13 INFO - Output received: 15:33:13 INFO - Usage: mozinstall [options] installer 15:33:13 INFO - Options: 15:33:13 INFO - -h, --help show this help message and exit 15:33:13 INFO - -d DEST, --destination=DEST 15:33:13 INFO - Directory to install application into. [default: 15:33:13 INFO - "/builds/slave/test"] 15:33:13 INFO - --app=APP Application being installed. [default: firefox] 15:33:13 INFO - mkdir: /builds/slave/test/build/application 15:33:13 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'] 15:33:13 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 15:33:33 INFO - Reading from file tmpfile_stdout 15:33:33 INFO - Output received: 15:33:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:33:33 INFO - Running post-action listener: _resource_record_post_action 15:33:33 INFO - [mozharness: 2017-04-25 22:33:33.205528Z] Finished install step (success) 15:33:33 INFO - [mozharness: 2017-04-25 22:33:33.205659Z] Running run-tests step. 15:33:33 INFO - Running pre-action listener: _resource_record_pre_action 15:33:33 INFO - Running main action method: run_tests 15:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:33:33 INFO - 2017-04-25 15:33:33.218 screenresolution[1899:18050] starting screenresolution argv=screenresolution get 15:33:33 INFO - 2017-04-25 15:33:33.221 screenresolution[1899:18050] Display 0: 1600x1200x32@60 15:33:33 INFO - 2017-04-25 15:33:33.226 screenresolution[1900:18054] starting screenresolution argv=screenresolution list 15:33:33 INFO - Available Modes on Display 0 15:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:33:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:33:33 INFO - Intel Iris: 15:33:33 INFO - Chipset Model: Intel Iris 15:33:33 INFO - Type: GPU 15:33:33 INFO - Bus: Built-In 15:33:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:33:33 INFO - Vendor: Intel (0x8086) 15:33:33 INFO - Device ID: 0x0a2e 15:33:33 INFO - Revision ID: 0x0009 15:33:33 INFO - Displays: 15:33:33 INFO - Display: 15:33:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:33:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:33:33 INFO - Display Serial Number: 1600x1200 60 15:33:33 INFO - Main Display: Yes 15:33:33 INFO - Mirror: Off 15:33:33 INFO - Online: Yes 15:33:33 INFO - Rotation: Supported 15:33:33 INFO - Return code: 0 15:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:33 INFO - Python 2.7.3 15:33:33 INFO - Return code: 0 15:33:33 INFO - grabbing minidump binary from tooltool 15:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:33 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 0x106eacd30>, '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 0x106dd2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ea1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:33 INFO - Return code: 0 15:33:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - ENV: RUST_BACKTRACE is now 1 15:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0372 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vwT05vQ7JP/Render', 15:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:33 INFO - 'HOME': '/Users/cltbld', 15:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:33 INFO - 'LOGNAME': 'cltbld', 15:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:33 INFO - 'MOZ_NO_REMOTE': '1', 15:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:33 INFO - 'NO_EM_RESTART': '1', 15:33:33 INFO - 'PAGER': '/bin/cat', 15:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:33 INFO - 'PWD': '/builds/slave/test', 15:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:33 INFO - 'RUST_BACKTRACE': '1', 15:33:33 INFO - 'SHELL': '/bin/bash', 15:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibFUPnDTpt/Listeners', 15:33:33 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 15:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:33 INFO - 'USER': 'cltbld', 15:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:33 INFO - 'XPC_FLAGS': '0x0', 15:33:33 INFO - 'XPC_SERVICE_NAME': '0', 15:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:33:33 INFO - mozversion application_buildid: 20170425135825 15:33:33 INFO - mozversion application_changeset: 3f0c8da53c5cb015933b10b52ded3f30432b378a 15:33:33 INFO - mozversion application_display_name: Nightly 15:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:33 INFO - mozversion application_name: Firefox 15:33:33 INFO - mozversion application_remotingname: firefox 15:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:33:33 INFO - mozversion application_vendor: Mozilla 15:33:33 INFO - mozversion application_version: 55.0a1 15:33:33 INFO - mozversion platform_buildid: 20170425135825 15:33:33 INFO - mozversion platform_changeset: 3f0c8da53c5cb015933b10b52ded3f30432b378a 15:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:33:33 INFO - mozversion platform_version: 55.0a1 15:33:33 INFO - using testdate: 1493159613 15:33:33 INFO - actual date: 1493159613 15:33:33 INFO - starting webserver on 'localhost:56914' 15:33:33 INFO - SUITE-START | Running 2 tests 15:33:33 INFO - TEST-START | dromaeo_css 15:33:33 INFO - operating with platform_type : mac_ 15:33:33 INFO - Initialising browser for dromaeo_css test... 15:33:33 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmptIft8K/profile http://localhost:56914/getInfo.html) 15:33:36 INFO - PID 1910 | 2017-04-25 15:33:36.641 plugin-container[1912:18232] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9837, name = 'com.apple.tsm.portname' 15:33:36 INFO - PID 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:33:36 INFO - PID 1910 | 2017-04-25 15:33:36.644 plugin-container[1912:18232] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c23, name = 'com.apple.CFPasteboardClient' 15:33:36 INFO - PID 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:33:36 INFO - PID 1910 | 2017-04-25 15:33:36.644 plugin-container[1912:18232] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:33:36 INFO - PID 1910 | __metrics Screen width/height:1600/1200 15:33:36 INFO - PID 1910 | colorDepth:24 15:33:36 INFO - PID 1910 | Browser inner width/height: 1024/689 15:33:36 INFO - PID 1910 | __metrics 15:33:36 ERROR - PID 1910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 15:33:37 INFO - TEST-INFO | 1910: exit 0 15:33:37 INFO - Browser initialized. 15:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:37 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmptIft8K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:40 INFO - PID 1913 | 2017-04-25 15:33:40.341 plugin-container[1914:18353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 15:33:40 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:33:40 INFO - PID 1913 | 2017-04-25 15:33:40.341 plugin-container[1914:18353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 15:33:40 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:33:40 INFO - PID 1913 | 2017-04-25 15:33:40.341 plugin-container[1914:18353] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:33:50 INFO - PID 1913 | RSS: Main: 236675072 15:33:50 INFO - PID 1913 | 15:36:53 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56914/tests/dromaeo/cssquery-ext.html) 15:36:55 INFO - PID 1913 | RSS: Main: 250380288 15:36:55 INFO - PID 1913 | 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | A coding exception was thrown and uncaught in a Task. 15:38:38 INFO - PID 1913 | 15:38:38 ERROR - PID 1913 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:38 INFO - PID 1913 | Full stack: 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | A coding exception was thrown and uncaught in a Task. 15:38:38 INFO - PID 1913 | 15:38:38 ERROR - PID 1913 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:38 INFO - PID 1913 | Full stack: 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | A coding exception was thrown and uncaught in a Task. 15:38:38 INFO - PID 1913 | 15:38:38 ERROR - PID 1913 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:38 INFO - PID 1913 | Full stack: 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | ************************* 15:38:38 INFO - PID 1913 | A coding exception was thrown and uncaught in a Task. 15:38:38 INFO - PID 1913 | 15:38:38 ERROR - PID 1913 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:38:38 INFO - PID 1913 | Full stack: 15:38:38 INFO - PID 1913 | ************************* 15:39:57 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-ext.html (next: http://localhost:56914/tests/dromaeo/cssquery-jquery.html) 15:39:57 INFO - PID 1913 | RSS: Main: 255418368 15:39:57 INFO - PID 1913 | 15:42:59 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56914/tests/dromaeo/cssquery-mootools.html) 15:43:00 INFO - PID 1913 | RSS: Main: 267534336 15:43:00 INFO - PID 1913 | 15:46:01 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56914/tests/dromaeo/cssquery-prototype.html) 15:46:02 INFO - PID 1913 | RSS: Main: 260595712 15:46:02 INFO - PID 1913 | 15:49:05 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56914/tests/dromaeo/cssquery-yui.html) 15:49:06 INFO - PID 1913 | RSS: Main: 269119488 15:49:06 INFO - PID 1913 | 15:52:07 INFO - PID 1913 | Cycle 1(1): loaded http://localhost:56914/tests/dromaeo/cssquery-yui.html (next: http://localhost:56914/tests/dromaeo/cssquery-dojo.html) 15:52:08 INFO - PID 1913 | RSS: Main: 263864320 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | __start_tp_report 15:52:08 INFO - PID 1913 | _x_x_mozilla_page_load 15:52:08 INFO - PID 1913 | _x_x_mozilla_page_load_details 15:52:08 INFO - PID 1913 | |i|pagename|runs| 15:52:08 INFO - PID 1913 | |0;dojo.html;3141.780075394723;3536.469529570564;3539.1682954505686;3563.608003119658;3587.9461808072874;4798.904021919559;4825.420949486062;5041.873953151173;5165.251038599406;6177.918864198764;6028.577999540023;6104.542159338056;6121.540884433674;6129.846753831156;6185.257769067707;4969.602431805447;5339;5344.732763361826;5443.1835224716415;5453.536449401806;5435.42927992559;5466.453354664542;5544.667319960795;5558.555315574744;5602.1036634138545;5452.345718513764;5557.499825015748;5568.192612071247;5590.496855283024;5611.9438805612035;5310.4424035476495;5366.436524164946;5398.028354896117;5400;5406.270153529302;5399.865003374908;5405.837824865261;5425.864353391157;5431.891362172774;5492.423295553989;5874.5006674432725;6133.969330153365;6163.137160797492;6201.441870231701;6224.128621992924;6336.58812177207;6427.035944608299;6464.644444555547;6630.336966303379;6648.401643852077;6713.496487763388;6720.596764194115;6720.966395168041;6725.899111513331;6737.764178253787;5309.787608495617;6275.372462753734;6292.276388215368;6293.842653933688;6308.526860485482;6043.821454816269;6399.296077431479;6504.739810407626;6712.765053223114;6827.52207345481;6259.092431597484;6272.8118156455375;6467.126937863422;6469.191351081115;6490.188726409199;6415.422611964946;6536.24833144185;6660.433863121592;6668.099806526154;6670.299618540081;6438.613683178931;6547.607143571306;6552.3447655234095;6557.704903279364;6575.506836987245;5299.973500132552;6339.207599050119;6449.322821103717;6560.704768285344;6609.1408116944485;5233.1365324721755;5240.34495688039;5267.920981185285;5296.1261391870685;5310.522053015247;4703.717776933395;4707.458642256116;4725.291206319011;4727.172744769651;4758.595519380891;6113;6163.506919446433;6199;6208.565400422018;6275.152854364694;6472.741090356333;6631.502637302222;6676.933230667728;6702;6758.256591774901;6236.688165591702;6240.875182496325;6252.280987686383;6259.96870015647;6285.340039295808;5465.906818636288;5780.653160810365;5808.419158084243;5852.180694702745;5880.558958078076;5690.886182276414;6576.44100251484;6744.898826517508;6746.763863264762;6896.034555162181;6702.19573651165;6702.865942681022;6716.966415167893;6723.361280678328;6759.898601520883;6772.55978361405;6835.316468353324;6865.450763938773;6871.381575658214;6872.072270243653;6329.683515824098;6405.679716014274;6413.134226879311;6464.191976003;6582.17722784652;6677.399034086956;6681.69932353055;6697.7655782047395;6701.66491675424;6703;6218.844528886814;6241.937580624317;6485.77299794505;6496.577722448026;6518.608883467007;5147.897042059063;6440.355964403522;6453.612783233021;6459.998700201476;6471.352864713491;4579.107074120648;5357.410684824744;6204.193454850841;6321.273053598895;6340.873182536231;6253.468455181361;6419.422251997343;6429.196350456193;6451.3548645135115;6451.741930322734;4695.9530404695515;6256.499480041677;6266.216722909637;6283.528735344776;6322.49420046386 15:52:08 INFO - PID 1913 | |1;ext.html;744.3152299884106;751.5978951261077;832.3258160889679;1254.310129428814;1274.2927675140293;38196.04509887254;39915.60084399159;39956.60043399565;39960.60039399605;39972.600273997254;40039.799801000954;40223.396649050286;40371;40558.39162412559;40604.79697601508;8292.212239837221;8554;8678.392512524126;8924.598393072294;8967.103289671046;8836.33727470439;8934.910650893473;8947.194752472276;8958.776030599221;8963.327750418712;8871.245944094728;8893.199612034916;8968.013518512958;8972.013078561353;8983.10168983103;7353.448491363142;8894.86657700135;8937.50843703596;8951.462912225223;8959.059298773633;7536.698532058711;8667.133286671346;8744.300455963508;8753.868691969625;8775.561221938942;38287.808560957295;38409.61590384088;38443.80778096119;38480.037999049964;38536.22927541462;3671.504346913159;3675.3016926784094;3722.4416337549583;3726.4596633488263;3733.701303895709;30845.537316940263;31249.687503124904;31321.37357252842;31349.05952821419;31368.686313136805;3168.952465712993;3199.9200019999685;3200.679932006804;3211.1329940916057;3219.4526930421885;180025;255786;280759;299231;303256.48371758;48041.27938080932;48287;48322;48356.7582162094;48456.54630361095;49435;50028.249576256385;50305.24542131871;50390.748046259534;50564;14386.928065359607;14478.927605361905;14485.710285794225;14502.492412765503;14510.85489145095;10146.847797283046;11851.288922664668;11853.051755859511;11863.822042669366;11882.762344753057;11067.667969960914;13566.457341706418;13573.864261357458;13647.249401283025;13680.794788078187;5032.672876263031;5686.947914635723;5860.941390586125;5920.940790592125;5927.555433342516;877.7542288159326;1025.261811495722;1032.9793404131876;1036.8749906351543;1059.5391004912888;24228;24247.66637834936;24382.87808560946;24404.51190976206;24480.755192447847;1047.544318221576;1126.121625132398;1135.4493070860626;1155.67063386936;1186.1756079524648;10101.595936162617;12419.19275247106;12447.502099915902;12463.875361246453;12807.807882881763;326272;326996.3650181734;328100;328841;330473;54430.727846361304;54920.725396373564;54990.450095499335;55125.72437137789;55149;1494.8131483564555;1534.5319677498471;1579.9842001579837;1583.263782341217;1591.5861875912346;24019.879900600386;24035.399115021566;24115.397115072265;24148.637770433106;24174.637380438955;38078.619213807506;38187.045323867125;38219;38354.42468362921;38403;276196;276618.61690691416;277016.61491692415;278078;278219;33932.66067339394;33942.15144621404;34491.655083448844;34513.30973380568;34677.82661086678;44849.77575112104;45716.77141614404;45868.77065614651;45912.31131533097;46129.84675383142;24138;28446.86212551475;29389.971351003467;29614.55578166286;29647.96232131865;25970;30804.075877723702;31481;31496.842515787273;31562.210944726565;37501.6249837509;37710.24579508339;37767;37834.62165378311;37857.43213851739;26345.682715864514;27521.449571008066;31125;32263.092578803673;32923.67076329206;19816.910069945716;20447.262017670368;24489;24881;24965 15:52:08 INFO - PID 1913 | |2;jquery.html;418.34111274742287;420.4156222850237;426.4520091682188;437.3090516983166;443.45012184890743;20131.19475220991;21885.67171492429;22444.88777556112;22511.32466026022;22776.088956441763;19864.205431782746;21938;23691.763082369172;23858.76141238587;23939.640905386434;6213.192285002943;6275.0587411888355;6453.612783232998;6469.514786391016;6479.5788273762055;6131.417515336036;6316.873662526747;6364.745410183587;6374.203224596926;6375.011873159668;6052.636841789506;6214.8135555933395;6255.06174073888;6328.462080723144;6331.55679102463;6002.579819412643;6223.875522489548;6284.434400903895;6290.087937249074;6300;5364.704941228231;5535.944640553583;5571.9721401392735;5614.747336369873;5622.437756224385;27260.727392726018;27282.5907611386;27347.726522734716;27663;27730;2046.2019812273224;2208.492046829222;2273.352094653016;2275.41976795916;2276.3853759484846;17576.29694812206;17762.555936101573;17850.464486065437;18046.729299060524;18215.72676409855;2192.254633424627;2194.5391467791624;2260.095961615367;2260.626996545568;2261.434641339665;146093;146548;146633.53366466306;148548;164261.9655918924;12283.938580307042;12803.935980320224;12893.93553032229;12911.870881291066;12946.935265323613;16736.995780253223;16740.916295418447;16757.581060473585;16775.58061048459;16805.57986050334;7983.042034955726;8616.09530999236;9202.723918282461;9206.90793092074;9357.298202634829;7977;8838.469691818511;8843.734687959372;8992.100789921087;9002.684906028258;7411.85176296471;8137.511749295061;8175.918240817635;8249.422540422112;8250.257476827115;2072.336852207279;2190.5618876224817;2252.538229662915;2253.3690566641367;2402.6756387887763;915.6383228624655;942.7548837302351;942.8397172480695;978.8335982882927;980.5636491761098;21044.263450779148;21045.15819367239;21197.25809596657;21211.257605983716;21282;988.4316518002033;999.5551979369111;1008.5814387029301;1020.2450186861669;1021.3667526133845;7994.560299183485;10847.566097356017;11041.44792760375;11049.39228342449;11061.949114834079;516805.4875061262;522716;530987;531594;534246;105126;129336.35331823469;137162.31418842843;137614;138147;1030.3302853145365;1178.6522975722012;1197.1260979485025;1230.4954968462887;1231.2243286729304;19071.61856762829;19987.300444484372;22592.209272675376;22627.660585090907;22648.433789155402;51595.173258051414;57264.427355727574;59229.703851480466;59712;59885.70057149686;69671.56149534741;71337.28662713307;72229;77975.66073017819;83872.58063709643;8658.220760131619;8996.955015224881;9064.592093355946;9101.453912765255;9435.764105897408;14389.352479138255;14569.053011554215;14571.052881562664;14613.707725845636;14683.045602035834;10164.288499804943;11834.526618935146;12131.393430328271;12322.137450378388;12342;11441.42792860337;11534.480948357177;11597.594084207012;11804;11814.881851181379;12087.939560302142;12228.75542489163;12319.69200769988;12452.190607610839;12490.437930292977;7736.651850666846;8990.910090899008;9078.09219078087;9122.635094596408;9156.633734650539;11924.523019079139;11952;12227.87772122303;12256.938715306367;12359.38203089824 15:52:08 INFO - PID 1913 | |3;mootools.html;1252.361295739173;1504.3531281548937;1504.4659146003162;1524.72685307768;1534.3632392557085;11524.481398337073;12028.278303301808;12075.698107547305;12084.637460876165;12411.62765117048;11971.580994665188;12048.57829975951;12191.634250972464;12207.267563946169;12208.633740987785;2543.198892348909;2583.689957205138;2588.8835002424844;2590.44305474323;2595.42900561877;2491.277529516438;2544.3639090227443;2545.2491515003026;2548.554003049468;2549.821512494126;2522.4576716006054;2562.551553478143;2569.4732579821093;2587.430765231646;2588.9093881714143;2503.3115893129443;2514.3085651445726;2556.3864672478658;2560.6543116679195;2566.5508536006123;2505.523950449427;2529.4182338062164;2545.300042488312;2550.948981020369;2556.3481312265253;12039.217450865666;12046.397680115959;12103.213291136048;12148.635540933787;12154.574589889311;6634.900476492857;6882.174139103289;6882.449404047664;6883.795335816212;6901.585904845675;3422.161570415239;3633.94549081764;4235.713828156945;4237.4279472271155;4418.756968366739;1228.6068458093414;1249.2504497301636;1294.5145570411096;1296.351824087956;1296.6693493159185;15012.849871501363;15525.301361438762;16698.415555455624;16807.41174058902;16883.98696078227;5056.7471626419265;5403.811161544454;5480.6437581557075;5756.136579513023;5756.1653560233535;10318.813336466252;11682.70793230176;11779.941100294614;11790.764184716258;11794.233374830781;6585.6707164641575;6637.269900310962;6715.832104197434;6723.058771771955;6723.159605049369;6133.969330153321;6218.751249949952;6264.154339164245;6334.429901308904;6376.585521941059;3587.65917237862;3893.9610603894166;4249.788810189143;4289.313709806416;4391.5827996340295;1279.6544932868073;1280.2510531339271;1283.2813624370383;1296.5786119511197;1305.9477620895248;802.9197080291924;803.1968031968032;824.3446460064263;827.6978902700591;852.9019162796234;5947.970260148758;6073.210482637229;6103.786367477117;6290.21372328459;6498.545101842826;583.3000399520593;591.7544219149091;592.3602509289957;598.6109029131013;603.2308806272039;3777.58446570877;3860.208657225262;3906.121122747416;3917.5505063126257;3936.645701886844;14128.505502307575;14856.405743770129;15139.924300378649;15143.394264229528;15147.576387777903;14783;14901.403943842124;15186.936914415885;15204.163770992702;15336.923315383576;8410.36922230835;8744.8688269676;8753.824923501494;8830.690925817695;8859.158379953895;6411.51913606472;6458.354164583504;7089.007538944655;7172.569645821268;7221.855562888608;10169;12934.611961641165;13360.532381366605;13585.79621305701;13706.314684265548;13727.245001525012;13749.243791591558;13857.445702172203;14055.016148869481;14233.64415889611;9453.905460945578;9460.668876589287;9463.053694630482;9490.667826626035;9531.904680953101;10699.518521666389;10744.623938162127;10785.029347358775;10786.784264314827;10793.62222322215;8211.425200236165;8318.79203019905;8388.916110838814;8465.534395608302;8501.914980850112;8004.359651228005;8073.5963201838495;8123.6750529978135;8129.959350203211;8153.9184608153155;8208.548529830916;8337.666493340199;8370.539620320696;8371.706990255312;8372.581370931552;5819.359870414166;5868.119782032729;5942.940570594239;5989.041753319448;6019.518438524995;5990.910136348046;6091.847703807441;6189.9690501549;6199;6404.679766011774 15:52:08 INFO - PID 1913 | |4;prototype.html;402.8126920981743;404.9878503644891;408.0533163061698;408.21418768869927;416.7957700726645;5687.744051517681;6118.877622447549;6255.812325630227;6267.592606480582;6279.529035322352;4752.952470475303;5743.452464190826;5986.820395388135;6000.759969601221;6049.939500604993;4635.629149668019;4677.4387073551225;4678.900458392275;4688.765561721917;4691.859244222679;4601.585857272845;4659.650526210531;4664.463586687523;4685.109829132454;4689.7655117244;4591.609713174367;4594.517575654559;4614.169449499089;4619.792109355087;4620.399348084744;3864.3044252034624;3997.180577981536;4560.771961401917;4617.630589552828;4653.906921861544;3483.442649176145;3665.688416484602;4127.195196936598;4155.688323375759;4157.771322577257;5003.524665156804;5865.149553314788;5998.8500287492725;6003.099535069731;6061.818145455643;4635.46692130406;5246.396664383607;5260.210968354739;5269.604779641504;5274.868128296785;5151.639385243035;6280.309165991737;6321.74713011479;6444;6516.641584712839;3841.80903919783;4113.670906327517;4292.957070429287;4305.698601097924;4334.934975975363;6236;6586.476235214138;6846.863062738767;6930.826729331757;6963.895541566881;3701.3522633539023;4266.637335826489;4338.717983331074;4376.824927002885;4377.277749171415;3784.8864534064023;3935.5080614923136;4415;4425.380446737459;4433.179861725591;4438.644908407319;5266.183741520071;5270.604704647167;5287.524122828964;5340.172273297645;6521.934780652227;6553.705083271264;6626;6626.171728533934;6636.734530618721;1485.6063143267043;1510.8291074417414;1513.8259100203397;1515.204517628232;1515.5907904865624;940.6471070252746;985.6845809340942;987.6641941739842;987.8221920054316;991.3754334769194;5666.4900158985065;5763.481286684135;6182.814515564541;6190.50475961922;6228.377162283736;5781.971090144607;6760.492963027793;6836.418904393083;6891.414229790424;6985.825354366079;4997.30037794709;5101.005303965765;5550.944490555124;5927.4665280125;6209.2548894133;3152.2907345847;3516.505485168793;3559.2525569630666;3562.8218589070443;3563.5389490309367;5153.922691159635;6074.757009719562;6082.787102451393;6831.292176955761;6954.860902781916;5501.734601041703;5965.6718880461995;6472.698923549024;6994.230634630187;7051.519180972054;6781.186257649114;6857.108575885203;6974.651267436608;7023.08699869024;7055.823604409726;6722.193336799615;6760.898586521108;6835.248122706597;6861.759838405632;6865.0388945546665;6666.166729158856;6675.899861501985;6683.9639855822425;6717.630530320879;6777.661116944035;5920.822375328747;6711.221526295438;6733.326667333227;6970.490623375479;7012.859742805217;4289.9571004289555;4882.60939124862;4935.56868508143;4964.751762411937;4993.400791904995;5761.48146666802;6007.579469437097;6865.965670171618;6874.381305682513;6874.725010999504;6054.969725151346;6326.9876819708625;6559.278479367361;6581.243157037002;6783.253842077466;6140.4473597376455;6285.994240921614;6337.366263373626;6479.056283115141;6564.9671751640935;5169.508896654812;6337;6411.935880641134;6443.838904027437;6495.772647957488;5525.806596769094;5812.128180772918;6423.454006409321;6524.9673751630935;6616.569922954993;6250.656213908279;6365.586236894587;6426.967865160645;6446.5165112615805;6513.674316284072 15:52:08 INFO - PID 1913 | |5;yui.html;854.9914500854998;865.1867244789897;867.4405008769344;888.928885689145;891.2290868398837;13454.663633409158;16597.423244791742;17299.913500432496;18779;19321.323753668625;18264.817351826478;18652.813471865276;18702.90648546759;18789.718154227663;18843.434696959113;921.824853277875;1015.7612960954189;1033.731229880229;1046.8743750749882;1047.9109275711573;903.7469508537587;1043.2697112021576;1044.4568824211406;1048.2400259811614;1051.3166441812807;1100.9779804403906;1102.8400881872165;1103.3049179017207;1106.5020740666691;1107.374333501569;948.6964171465133;1094.1192340166162;1095.5453486802967;1104.8950349716763;1107.8227483602625;780.8828675698634;791.8297566023333;794.5232860283784;802.3861745764494;804.9816981518384;14244.501442449464;17401.651966960715;17850.107494625347;17865.464036078807;18026.27894884203;17309.221085051202;17511.299548018065;17554.54236406904;17651.205695743723;17898.642027159513;14094.436222551085;14144.646383840383;14162.36269367881;14209.857901420957;14363.49727759534;3505.544279243682;3572;3572.392693242155;3573.5175751273505;3577.928441431183;141122;141507;142241.2887935564;142310;143890;13452.596422107352;13475.932620336836;13479.19124852512;13564.050516463753;13620.455181792617;24817.62773558398;25470.490590188092;25935.74064259371;26017.69911504417;26045.739542604333;7329.633518324063;7505.962470187614;7518.699252029967;7529.4729368943645;7578.658960346797;3857.189990102054;3926.6269704378037;3934.724569280123;3961.801909904551;3961.92076158481;4299.247631664446;4409.977950110229;4435.489918659331;4442.97811503356;4450.933236001462;862.2326129744532;891.772597987509;897.5512243878061;902.7382059202757;906.1934877958622;650.9153810004764;662.8508585568209;665.7303791964263;678.1556961582861;693.0920494152676;10333.638322658671;10845;11692.35692036946;11698.736223146594;11969.162158648985;642.563057121162;654.6170490263154;655.6885479397248;660.8072429265222;680.1633990191992;5267.499587539178;5352.732363381815;5363.946360536423;5415.922333962039;5454.972725136349;87815.56092219625;114185;116045;116717;119870.4006479962;86189.56905215434;99311;101193.48209776859;102188;103607.4819625897;74253.62873185599;76608.85086723704;78348.99999999886;78723;80143;12008.85915837994;12565.183263088236;12639.494420223087;12671.80992285098;12721.427535760728;34253.486197707556;39353.60646393499;40204.99487512836;40259.79870100631;40448.79775601103;61214.857479987986;64993.67503162454;65107.674461627386;68352;69497;16425.507234782977;16961.321547137977;17043.488695339158;17228.224729887435;17243.913780431016;17923.551911202325;18542.721859171852;18632.44102676922;18877.90561047186;18895.43313700591;13894.305284735925;16794.66410671755;16944.66110677755;17099.230534626222;17296;13752.93123534376;16723;17012.404565840137;17240.310387584355;17240.827591724425;16735;16753.32986680519;16782.16089195511;16812.747808782635;16912.32350705958;10665.880082591217;11542.307461552333;11601.883981160081;12070.456829442872;12283.236271838765;11836;12810.871891280967;13274.601761947157;13405.329733513481;14449.699527042616 15:52:08 INFO - PID 1913 | __end_tp_report 15:52:08 INFO - PID 1913 | __start_cc_report 15:52:08 INFO - PID 1913 | _x_x_mozilla_cycle_collect,423 15:52:08 INFO - PID 1913 | __end_cc_report 15:52:08 INFO - PID 1913 | __startTimestamp1493160728107__endTimestamp 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | ------- Summary: start ------- 15:52:08 INFO - PID 1913 | Number of tests: 6 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#0] dojo.html Cycles:165 Average:6014.47 Median:6266.22 stddev:743.53 (11.9%) stddev-sans-first:710.84 15:52:08 INFO - PID 1913 | Values: 3141.8 3536.5 3539.2 3563.6 3587.9 4798.9 4825.4 5041.9 5165.3 6177.9 6028.6 6104.5 6121.5 6129.8 6185.3 4969.6 5339.0 5344.7 5443.2 5453.5 5435.4 5466.5 5544.7 5558.6 5602.1 5452.3 5557.5 5568.2 5590.5 5611.9 5310.4 5366.4 5398.0 5400.0 5406.3 5399.9 5405.8 5425.9 5431.9 5492.4 5874.5 6134.0 6163.1 6201.4 6224.1 6336.6 6427.0 6464.6 6630.3 6648.4 6713.5 6720.6 6721.0 6725.9 6737.8 5309.8 6275.4 6292.3 6293.8 6308.5 6043.8 6399.3 6504.7 6712.8 6827.5 6259.1 6272.8 6467.1 6469.2 6490.2 6415.4 6536.2 6660.4 6668.1 6670.3 6438.6 6547.6 6552.3 6557.7 6575.5 5300.0 6339.2 6449.3 6560.7 6609.1 5233.1 5240.3 5267.9 5296.1 5310.5 4703.7 4707.5 4725.3 4727.2 4758.6 6113.0 6163.5 6199.0 6208.6 6275.2 6472.7 6631.5 6676.9 6702.0 6758.3 6236.7 6240.9 6252.3 6260.0 6285.3 5465.9 5780.7 5808.4 5852.2 5880.6 5690.9 6576.4 6744.9 6746.8 6896.0 6702.2 6702.9 6717.0 6723.4 6759.9 6772.6 6835.3 6865.5 6871.4 6872.1 6329.7 6405.7 6413.1 6464.2 6582.2 6677.4 6681.7 6697.8 6701.7 6703.0 6218.8 6241.9 6485.8 6496.6 6518.6 5147.9 6440.4 6453.6 6460.0 6471.4 4579.1 5357.4 6204.2 6321.3 6340.9 6253.5 6419.4 6429.2 6451.4 6451.7 4696.0 6256.5 6266.2 6283.5 6322.5 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#1] ext.html Cycles:180 Average:44447.88 Median:182202.83 stddev:76616.46 (42.1%) stddev-sans-first:76761.13 15:52:08 INFO - PID 1913 | Values: 744.3 751.6 832.3 1254.3 1274.3 38196.0 39915.6 39956.6 39960.6 39972.6 40039.8 40223.4 40371.0 40558.4 40604.8 8292.2 8554.0 8678.4 8924.6 8967.1 8836.3 8934.9 8947.2 8958.8 8963.3 8871.2 8893.2 8968.0 8972.0 8983.1 7353.4 8894.9 8937.5 8951.5 8959.1 7536.7 8667.1 8744.3 8753.9 8775.6 38287.8 38409.6 38443.8 38480.0 38536.2 3671.5 3675.3 3722.4 3726.5 3733.7 30845.5 31249.7 31321.4 31349.1 31368.7 3169.0 3199.9 3200.7 3211.1 3219.5 180025.0 255786.0 280759.0 299231.0 303256.5 48041.3 48287.0 48322.0 48356.8 48456.5 49435.0 50028.2 50305.2 50390.7 50564.0 14386.9 14478.9 14485.7 14502.5 14510.9 10146.8 11851.3 11853.1 11863.8 11882.8 11067.7 13566.5 13573.9 13647.2 13680.8 5032.7 5686.9 5860.9 5920.9 5927.6 877.8 1025.3 1033.0 1036.9 1059.5 24228.0 24247.7 24382.9 24404.5 24480.8 1047.5 1126.1 1135.4 1155.7 1186.2 10101.6 12419.2 12447.5 12463.9 12807.8 326272.0 326996.4 328100.0 328841.0 330473.0 54430.7 54920.7 54990.5 55125.7 55149.0 1494.8 1534.5 1580.0 1583.3 1591.6 24019.9 24035.4 24115.4 24148.6 24174.6 38078.6 38187.0 38219.0 38354.4 38403.0 276196.0 276618.6 277016.6 278078.0 278219.0 33932.7 33942.2 34491.7 34513.3 34677.8 44849.8 45716.8 45868.8 45912.3 46129.8 24138.0 28446.9 29390.0 29614.6 29648.0 25970.0 30804.1 31481.0 31496.8 31562.2 37501.6 37710.2 37767.0 37834.6 37857.4 26345.7 27521.4 31125.0 32263.1 32923.7 19816.9 20447.3 24489.0 24881.0 24965.0 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#2] jquery.html Cycles:180 Average:34972.82 Median:2275.90 stddev:89614.81 (3937.6%) stddev-sans-first:89828.64 15:52:08 INFO - PID 1913 | Values: 418.3 420.4 426.5 437.3 443.5 20131.2 21885.7 22444.9 22511.3 22776.1 19864.2 21938.0 23691.8 23858.8 23939.6 6213.2 6275.1 6453.6 6469.5 6479.6 6131.4 6316.9 6364.7 6374.2 6375.0 6052.6 6214.8 6255.1 6328.5 6331.6 6002.6 6223.9 6284.4 6290.1 6300.0 5364.7 5535.9 5572.0 5614.7 5622.4 27260.7 27282.6 27347.7 27663.0 27730.0 2046.2 2208.5 2273.4 2275.4 2276.4 17576.3 17762.6 17850.5 18046.7 18215.7 2192.3 2194.5 2260.1 2260.6 2261.4 146093.0 146548.0 146633.5 148548.0 164262.0 12283.9 12803.9 12893.9 12911.9 12946.9 16737.0 16740.9 16757.6 16775.6 16805.6 7983.0 8616.1 9202.7 9206.9 9357.3 7977.0 8838.5 8843.7 8992.1 9002.7 7411.9 8137.5 8175.9 8249.4 8250.3 2072.3 2190.6 2252.5 2253.4 2402.7 915.6 942.8 942.8 978.8 980.6 21044.3 21045.2 21197.3 21211.3 21282.0 988.4 999.6 1008.6 1020.2 1021.4 7994.6 10847.6 11041.4 11049.4 11061.9 516805.5 522716.0 530987.0 531594.0 534246.0 105126.0 129336.4 137162.3 137614.0 138147.0 1030.3 1178.7 1197.1 1230.5 1231.2 19071.6 19987.3 22592.2 22627.7 22648.4 51595.2 57264.4 59229.7 59712.0 59885.7 69671.6 71337.3 72229.0 77975.7 83872.6 8658.2 8997.0 9064.6 9101.5 9435.8 14389.4 14569.1 14571.1 14613.7 14683.0 10164.3 11834.5 12131.4 12322.1 12342.0 11441.4 11534.5 11597.6 11804.0 11814.9 12087.9 12228.8 12319.7 12452.2 12490.4 7736.7 8990.9 9078.1 9122.6 9156.6 11924.5 11952.0 12227.9 12256.9 12359.4 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#3] mootools.html Cycles:180 Average:7080.51 Median:3504.91 stddev:4512.03 (128.7%) stddev-sans-first:4503.43 15:52:08 INFO - PID 1913 | Values: 1252.4 1504.4 1504.5 1524.7 1534.4 11524.5 12028.3 12075.7 12084.6 12411.6 11971.6 12048.6 12191.6 12207.3 12208.6 2543.2 2583.7 2588.9 2590.4 2595.4 2491.3 2544.4 2545.2 2548.6 2549.8 2522.5 2562.6 2569.5 2587.4 2588.9 2503.3 2514.3 2556.4 2560.7 2566.6 2505.5 2529.4 2545.3 2550.9 2556.3 12039.2 12046.4 12103.2 12148.6 12154.6 6634.9 6882.2 6882.4 6883.8 6901.6 3422.2 3633.9 4235.7 4237.4 4418.8 1228.6 1249.3 1294.5 1296.4 1296.7 15012.8 15525.3 16698.4 16807.4 16884.0 5056.7 5403.8 5480.6 5756.1 5756.2 10318.8 11682.7 11779.9 11790.8 11794.2 6585.7 6637.3 6715.8 6723.1 6723.2 6134.0 6218.8 6264.2 6334.4 6376.6 3587.7 3894.0 4249.8 4289.3 4391.6 1279.7 1280.3 1283.3 1296.6 1305.9 802.9 803.2 824.3 827.7 852.9 5948.0 6073.2 6103.8 6290.2 6498.5 583.3 591.8 592.4 598.6 603.2 3777.6 3860.2 3906.1 3917.6 3936.6 14128.5 14856.4 15139.9 15143.4 15147.6 14783.0 14901.4 15186.9 15204.2 15336.9 8410.4 8744.9 8753.8 8830.7 8859.2 6411.5 6458.4 7089.0 7172.6 7221.9 10169.0 12934.6 13360.5 13585.8 13706.3 13727.2 13749.2 13857.4 14055.0 14233.6 9453.9 9460.7 9463.1 9490.7 9531.9 10699.5 10744.6 10785.0 10786.8 10793.6 8211.4 8318.8 8388.9 8465.5 8501.9 8004.4 8073.6 8123.7 8130.0 8153.9 8208.5 8337.7 8370.5 8371.7 8372.6 5819.4 5868.1 5942.9 5989.0 6019.5 5990.9 6091.8 6190.0 6199.0 6404.7 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#4] prototype.html Cycles:180 Average:5258.18 Median:5976.25 stddev:1648.22 (27.6%) stddev-sans-first:1612.05 15:52:08 INFO - PID 1913 | Values: 402.8 405.0 408.1 408.2 416.8 5687.7 6118.9 6255.8 6267.6 6279.5 4753.0 5743.5 5986.8 6000.8 6049.9 4635.6 4677.4 4678.9 4688.8 4691.9 4601.6 4659.7 4664.5 4685.1 4689.8 4591.6 4594.5 4614.2 4619.8 4620.4 3864.3 3997.2 4560.8 4617.6 4653.9 3483.4 3665.7 4127.2 4155.7 4157.8 5003.5 5865.1 5998.9 6003.1 6061.8 4635.5 5246.4 5260.2 5269.6 5274.9 5151.6 6280.3 6321.7 6444.0 6516.6 3841.8 4113.7 4293.0 4305.7 4334.9 6236.0 6586.5 6846.9 6930.8 6963.9 3701.4 4266.6 4338.7 4376.8 4377.3 3784.9 3935.5 4415.0 4425.4 4433.2 4438.6 5266.2 5270.6 5287.5 5340.2 6521.9 6553.7 6626.0 6626.2 6636.7 1485.6 1510.8 1513.8 1515.2 1515.6 940.6 985.7 987.7 987.8 991.4 5666.5 5763.5 6182.8 6190.5 6228.4 5782.0 6760.5 6836.4 6891.4 6985.8 4997.3 5101.0 5550.9 5927.5 6209.3 3152.3 3516.5 3559.3 3562.8 3563.5 5153.9 6074.8 6082.8 6831.3 6954.9 5501.7 5965.7 6472.7 6994.2 7051.5 6781.2 6857.1 6974.7 7023.1 7055.8 6722.2 6760.9 6835.2 6861.8 6865.0 6666.2 6675.9 6684.0 6717.6 6777.7 5920.8 6711.2 6733.3 6970.5 7012.9 4290.0 4882.6 4935.6 4964.8 4993.4 5761.5 6007.6 6866.0 6874.4 6874.7 6055.0 6327.0 6559.3 6581.2 6783.3 6140.4 6286.0 6337.4 6479.1 6565.0 5169.5 6337.0 6411.9 6443.8 6495.8 5525.8 5812.1 6423.5 6525.0 6616.6 6250.7 6365.6 6427.0 6446.5 6513.7 15:52:08 INFO - PID 1913 | 15:52:08 INFO - PID 1913 | [#5] yui.html Cycles:180 Average:22899.78 Median:17911.10 stddev:33385.35 (186.4%) stddev-sans-first:33437.97 15:52:08 INFO - PID 1913 | Values: 855.0 865.2 867.4 888.9 891.2 13454.7 16597.4 17299.9 18779.0 19321.3 18264.8 18652.8 18702.9 18789.7 18843.4 921.8 1015.8 1033.7 1046.9 1047.9 903.7 1043.3 1044.5 1048.2 1051.3 1101.0 1102.8 1103.3 1106.5 1107.4 948.7 1094.1 1095.5 1104.9 1107.8 780.9 791.8 794.5 802.4 805.0 14244.5 17401.7 17850.1 17865.5 18026.3 17309.2 17511.3 17554.5 17651.2 17898.6 14094.4 14144.6 14162.4 14209.9 14363.5 3505.5 3572.0 3572.4 3573.5 3577.9 141122.0 141507.0 142241.3 142310.0 143890.0 13452.6 13475.9 13479.2 13564.1 13620.5 24817.6 25470.5 25935.7 26017.7 26045.7 7329.6 7506.0 7518.7 7529.5 7578.7 3857.2 3926.6 3934.7 3961.8 3961.9 4299.2 4410.0 4435.5 4443.0 4450.9 862.2 891.8 897.6 902.7 906.2 650.9 662.9 665.7 678.2 693.1 10333.6 10845.0 11692.4 11698.7 11969.2 642.6 654.6 655.7 660.8 680.2 5267.5 5352.7 5363.9 5415.9 5455.0 87815.6 114185.0 116045.0 116717.0 119870.4 86189.6 99311.0 101193.5 102188.0 103607.5 74253.6 76608.9 78349.0 78723.0 80143.0 12008.9 12565.2 12639.5 12671.8 12721.4 34253.5 39353.6 40205.0 40259.8 40448.8 61214.9 64993.7 65107.7 68352.0 69497.0 16425.5 16961.3 17043.5 17228.2 17243.9 17923.6 18542.7 18632.4 18877.9 18895.4 13894.3 16794.7 16944.7 17099.2 17296.0 13752.9 16723.0 17012.4 17240.3 17240.8 16735.0 16753.3 16782.2 16812.7 16912.3 10665.9 11542.3 11601.9 12070.5 12283.2 11836.0 12810.9 13274.6 13405.3 14449.7 15:52:08 INFO - PID 1913 | -------- Summary: end -------- 15:52:08 INFO - PID 1913 | 15:52:08 INFO - TEST-INFO | 1913: exit 0 15:52:08 INFO - TEST-OK | dromaeo_css | took 1114963ms 15:52:08 INFO - TEST-START | kraken 15:52:08 INFO - operating with platform_type : mac_ 15:52:08 INFO - Initialising browser for kraken test... 15:52:08 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpN_8NJg/profile http://localhost:56914/getInfo.html) 15:52:11 INFO - PID 1920 | 2017-04-25 15:52:11.789 plugin-container[1921:20500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 15:52:11 INFO - PID 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:11 INFO - PID 1920 | 2017-04-25 15:52:11.796 plugin-container[1921:20500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9813, name = 'com.apple.CFPasteboardClient' 15:52:11 INFO - PID 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:11 INFO - PID 1920 | 2017-04-25 15:52:11.796 plugin-container[1921:20500] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:52:11 INFO - PID 1920 | __metrics Screen width/height:1600/1200 15:52:11 INFO - PID 1920 | colorDepth:24 15:52:11 INFO - PID 1920 | Browser inner width/height: 1024/689 15:52:11 INFO - PID 1920 | __metrics 15:52:12 ERROR - PID 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 15:52:12 INFO - TEST-INFO | 1920: exit 0 15:52:12 INFO - Browser initialized. 15:52:12 INFO - Running cycle 1/1 for kraken test... 15:52:12 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpN_8NJg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:15 INFO - PID 1922 | 2017-04-25 15:52:15.489 plugin-container[1923:20626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 15:52:15 INFO - PID 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:15 INFO - PID 1922 | 2017-04-25 15:52:15.489 plugin-container[1923:20626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 15:52:15 INFO - PID 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:15 INFO - PID 1922 | 2017-04-25 15:52:15.489 plugin-container[1923:20626] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:52:25 INFO - PID 1922 | RSS: Main: 236384256 15:52:25 INFO - PID 1922 | 15:52:27 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56914/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:28 INFO - PID 1922 | RSS: Main: 248475648 15:52:28 INFO - PID 1922 | 15:52:31 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56914/tests/kraken/driver.html?testName=audio-dft) 15:52:32 INFO - PID 1922 | RSS: Main: 256843776 15:52:32 INFO - PID 1922 | 15:52:35 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56914/tests/kraken/driver.html?testName=audio-fft) 15:52:35 INFO - PID 1922 | RSS: Main: 259178496 15:52:35 INFO - PID 1922 | 15:52:37 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56914/tests/kraken/driver.html?testName=audio-oscillator) 15:52:38 INFO - PID 1922 | RSS: Main: 260509696 15:52:38 INFO - PID 1922 | 15:52:40 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:41 INFO - PID 1922 | RSS: Main: 260820992 15:52:41 INFO - PID 1922 | 15:52:43 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56914/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:44 INFO - PID 1922 | RSS: Main: 266350592 15:52:44 INFO - PID 1922 | 15:52:47 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56914/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:48 INFO - PID 1922 | RSS: Main: 269582336 15:52:48 INFO - PID 1922 | 15:52:51 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56914/tests/kraken/driver.html?testName=json-parse-financial) 15:52:51 INFO - PID 1922 | RSS: Main: 268910592 15:52:51 INFO - PID 1922 | 15:52:53 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:53 INFO - PID 1922 | RSS: Main: 268591104 15:52:53 INFO - PID 1922 | 15:52:55 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:56 INFO - PID 1922 | RSS: Main: 268390400 15:52:56 INFO - PID 1922 | 15:52:58 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:59 INFO - PID 1922 | RSS: Main: 267902976 15:52:59 INFO - PID 1922 | 15:53:02 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:02 INFO - PID 1922 | RSS: Main: 268210176 15:53:02 INFO - PID 1922 | 15:53:05 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:06 INFO - PID 1922 | RSS: Main: 268247040 15:53:06 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | Cycle 1(1): loaded http://localhost:56914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56914/tests/kraken/driver.html?testName=ai-astar) 15:53:08 INFO - PID 1922 | RSS: Main: 269967360 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | __start_tp_report 15:53:08 INFO - PID 1922 | _x_x_mozilla_page_load 15:53:08 INFO - PID 1922 | _x_x_mozilla_page_load_details 15:53:08 INFO - PID 1922 | |i|pagename|runs| 15:53:08 INFO - PID 1922 | |0;ai-astar;105;116;114;112;113;114;114;117;116;114 15:53:08 INFO - PID 1922 | |1;audio-beat-detection;148;106;111;149;110;112;108;122;132;111 15:53:08 INFO - PID 1922 | |2;audio-dft;197;195;202;219;215;222;209;197;202;198 15:53:08 INFO - PID 1922 | |3;audio-fft;79;57;78;108;80;63;60;58;71;57 15:53:08 INFO - PID 1922 | |4;audio-oscillator;88;70;82;69;68;68;85;73;70;86 15:53:08 INFO - PID 1922 | |5;imaging-gaussian-blur;89;89;88;88;90;88;87;100;89;96 15:53:08 INFO - PID 1922 | |6;imaging-darkroom;95;97;96;96;97;96;105;105;96;98 15:53:08 INFO - PID 1922 | |7;imaging-desaturate;92;93;90;92;94;93;120;117;89;126 15:53:08 INFO - PID 1922 | |8;json-parse-financial;51;51;50;53;51;51;52;69;73;66 15:53:08 INFO - PID 1922 | |9;json-stringify-tinderbox;58;62;60;60;67;63;58;58;57;58 15:53:08 INFO - PID 1922 | |10;stanford-crypto-aes;82;86;101;71;93;102;99;102;88;96 15:53:08 INFO - PID 1922 | |11;stanford-crypto-ccm;149;158;132;136;165;151;139;142;189;172 15:53:08 INFO - PID 1922 | |12;stanford-crypto-pbkdf2;186;190;187;184;183;184;199;228;208;187 15:53:08 INFO - PID 1922 | |13;stanford-crypto-sha256-iterative;70;89;78;69;66;62;60;59;61;53 15:53:08 INFO - PID 1922 | __end_tp_report 15:53:08 INFO - PID 1922 | __start_cc_report 15:53:08 INFO - PID 1922 | _x_x_mozilla_cycle_collect,1000 15:53:08 INFO - PID 1922 | __end_cc_report 15:53:08 INFO - PID 1922 | __startTimestamp1493160788609__endTimestamp 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | ------- Summary: start ------- 15:53:08 INFO - PID 1922 | Number of tests: 14 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:3.34 (2.9%) stddev-sans-first:1.59 15:53:08 INFO - PID 1922 | Values: 105.0 116.0 114.0 112.0 113.0 114.0 114.0 117.0 116.0 114.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:117.00 stddev:16.43 (14.0%) stddev-sans-first:14.21 15:53:08 INFO - PID 1922 | Values: 148.0 106.0 111.0 149.0 110.0 112.0 108.0 122.0 132.0 111.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#2] audio-dft Cycles:10 Average:205.60 Median:205.50 stddev:9.96 (4.8%) stddev-sans-first:10.06 15:53:08 INFO - PID 1922 | Values: 197.0 195.0 202.0 219.0 215.0 222.0 209.0 197.0 202.0 198.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#3] audio-fft Cycles:10 Average:71.10 Median:67.00 stddev:16.02 (23.9%) stddev-sans-first:16.73 15:53:08 INFO - PID 1922 | Values: 79.0 57.0 78.0 108.0 80.0 63.0 60.0 58.0 71.0 57.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:77.50 stddev:8.29 (10.7%) stddev-sans-first:7.55 15:53:08 INFO - PID 1922 | Values: 88.0 70.0 82.0 69.0 68.0 68.0 85.0 73.0 70.0 86.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:89.00 stddev:4.20 (4.7%) stddev-sans-first:4.42 15:53:08 INFO - PID 1922 | Values: 89.0 89.0 88.0 88.0 90.0 88.0 87.0 100.0 89.0 96.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:96.00 stddev:3.73 (3.9%) stddev-sans-first:3.78 15:53:08 INFO - PID 1922 | Values: 95.0 97.0 96.0 96.0 97.0 96.0 105.0 105.0 96.0 98.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:92.00 stddev:14.32 (15.6%) stddev-sans-first:14.84 15:53:08 INFO - PID 1922 | Values: 92.0 93.0 90.0 92.0 94.0 93.0 120.0 117.0 89.0 126.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:52.50 stddev:8.91 (17.0%) stddev-sans-first:9.21 15:53:08 INFO - PID 1922 | Values: 51.0 51.0 50.0 53.0 51.0 51.0 52.0 69.0 73.0 66.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:3.11 (5.2%) stddev-sans-first:3.20 15:53:08 INFO - PID 1922 | Values: 58.0 62.0 60.0 60.0 67.0 63.0 58.0 58.0 57.0 58.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:87.00 stddev:10.22 (11.7%) stddev-sans-first:10.18 15:53:08 INFO - PID 1922 | Values: 82.0 86.0 101.0 71.0 93.0 102.0 99.0 102.0 88.0 96.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:154.50 stddev:17.93 (11.6%) stddev-sans-first:18.95 15:53:08 INFO - PID 1922 | Values: 149.0 158.0 132.0 136.0 165.0 151.0 139.0 142.0 189.0 172.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:188.50 stddev:14.43 (7.7%) stddev-sans-first:15.04 15:53:08 INFO - PID 1922 | Values: 186.0 190.0 187.0 184.0 183.0 184.0 199.0 228.0 208.0 187.0 15:53:08 INFO - PID 1922 | 15:53:08 INFO - PID 1922 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:10.48 (15.5%) stddev-sans-first:11.05 15:53:08 INFO - PID 1922 | Values: 70.0 89.0 78.0 69.0 66.0 62.0 60.0 59.0 61.0 53.0 15:53:08 INFO - PID 1922 | -------- Summary: end -------- 15:53:08 INFO - PID 1922 | 15:53:09 INFO - TEST-INFO | 1922: exit 0 15:53:09 INFO - TEST-OK | kraken | took 60934ms 15:53:09 INFO - SUITE-END | took 1175s 15:53:09 INFO - Completed test suite (00:19:35) 15:53:09 INFO - javascript benchmark 15:53:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7885.102305779731, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.780075394723, 3536.469529570564, 3539.1682954505686, 3563.608003119658, 3587.9461808072874, 4798.904021919559, 4825.420949486062, 5041.873953151173, 5165.251038599406, 6177.918864198764, 6028.577999540023, 6104.542159338056, 6121.540884433674, 6129.846753831156, 6185.257769067707, 4969.602431805447, 5339.0, 5344.732763361826, 5443.1835224716415, 5453.536449401806, 5435.42927992559, 5466.453354664542, 5544.667319960795, 5558.555315574744, 5602.1036634138545, 5452.345718513764, 5557.499825015748, 5568.192612071247, 5590.496855283024, 5611.9438805612035, 5310.4424035476495, 5366.436524164946, 5398.028354896117, 5400.0, 5406.270153529302, 5399.865003374908, 5405.837824865261, 5425.864353391157, 5431.891362172774, 5492.423295553989, 5874.5006674432725, 6133.969330153365, 6163.137160797492, 6201.441870231701, 6224.128621992924, 6336.58812177207, 6427.035944608299, 6464.644444555547, 6630.336966303379, 6648.401643852077, 6713.496487763388, 6720.596764194115, 6720.966395168041, 6725.899111513331, 6737.764178253787, 5309.787608495617, 6275.372462753734, 6292.276388215368, 6293.842653933688, 6308.526860485482, 6043.821454816269, 6399.296077431479, 6504.739810407626, 6712.765053223114, 6827.52207345481, 6259.092431597484, 6272.8118156455375, 6467.126937863422, 6469.191351081115, 6490.188726409199, 6415.422611964946, 6536.24833144185, 6660.433863121592, 6668.099806526154, 6670.299618540081, 6438.613683178931, 6547.607143571306, 6552.3447655234095, 6557.704903279364, 6575.506836987245, 5299.973500132552, 6339.207599050119, 6449.322821103717, 6560.704768285344, 6609.1408116944485, 5233.1365324721755, 5240.34495688039, 5267.920981185285, 5296.1261391870685, 5310.522053015247, 4703.717776933395, 4707.458642256116, 4725.291206319011, 4727.172744769651, 4758.595519380891, 6113.0, 6163.506919446433, 6199.0, 6208.565400422018, 6275.152854364694, 6472.741090356333, 6631.502637302222, 6676.933230667728, 6702.0, 6758.256591774901, 6236.688165591702, 6240.875182496325, 6252.280987686383, 6259.96870015647, 6285.340039295808, 5465.906818636288, 5780.653160810365, 5808.419158084243, 5852.180694702745, 5880.558958078076, 5690.886182276414, 6576.44100251484, 6744.898826517508, 6746.763863264762, 6896.034555162181, 6702.19573651165, 6702.865942681022, 6716.966415167893, 6723.361280678328, 6759.898601520883, 6772.55978361405, 6835.316468353324, 6865.450763938773, 6871.381575658214, 6872.072270243653, 6329.683515824098, 6405.679716014274, 6413.134226879311, 6464.191976003, 6582.17722784652, 6677.399034086956, 6681.69932353055, 6697.7655782047395, 6701.66491675424, 6703.0, 6218.844528886814, 6241.937580624317, 6485.77299794505, 6496.577722448026, 6518.608883467007, 5147.897042059063, 6440.355964403522, 6453.612783233021, 6459.998700201476, 6471.352864713491, 4579.107074120648, 5357.410684824744, 6204.193454850841, 6321.273053598895, 6340.873182536231, 6253.468455181361, 6419.422251997343, 6429.196350456193, 6451.3548645135115, 6451.741930322734, 4695.9530404695515, 6256.499480041677, 6266.216722909637, 6283.528735344776, 6322.49420046386], "value": 5967.285678247062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3152299884106, 751.5978951261077, 832.3258160889679, 1254.310129428814, 1274.2927675140293, 38196.04509887254, 39915.60084399159, 39956.60043399565, 39960.60039399605, 39972.600273997254, 40039.799801000954, 40223.396649050286, 40371.0, 40558.39162412559, 40604.79697601508, 8292.212239837221, 8554.0, 8678.392512524126, 8924.598393072294, 8967.103289671046, 8836.33727470439, 8934.910650893473, 8947.194752472276, 8958.776030599221, 8963.327750418712, 8871.245944094728, 8893.199612034916, 8968.013518512958, 8972.013078561353, 8983.10168983103, 7353.448491363142, 8894.86657700135, 8937.50843703596, 8951.462912225223, 8959.059298773633, 7536.698532058711, 8667.133286671346, 8744.300455963508, 8753.868691969625, 8775.561221938942, 38287.808560957295, 38409.61590384088, 38443.80778096119, 38480.037999049964, 38536.22927541462, 3671.504346913159, 3675.3016926784094, 3722.4416337549583, 3726.4596633488263, 3733.701303895709, 30845.537316940263, 31249.687503124904, 31321.37357252842, 31349.05952821419, 31368.686313136805, 3168.952465712993, 3199.9200019999685, 3200.679932006804, 3211.1329940916057, 3219.4526930421885, 180025.0, 255786.0, 280759.0, 299231.0, 303256.48371758, 48041.27938080932, 48287.0, 48322.0, 48356.7582162094, 48456.54630361095, 49435.0, 50028.249576256385, 50305.24542131871, 50390.748046259534, 50564.0, 14386.928065359607, 14478.927605361905, 14485.710285794225, 14502.492412765503, 14510.85489145095, 10146.847797283046, 11851.288922664668, 11853.051755859511, 11863.822042669366, 11882.762344753057, 11067.667969960914, 13566.457341706418, 13573.864261357458, 13647.249401283025, 13680.794788078187, 5032.672876263031, 5686.947914635723, 5860.941390586125, 5920.940790592125, 5927.555433342516, 877.7542288159326, 1025.261811495722, 1032.9793404131876, 1036.8749906351543, 1059.5391004912888, 24228.0, 24247.66637834936, 24382.87808560946, 24404.51190976206, 24480.755192447847, 1047.544318221576, 1126.121625132398, 1135.4493070860626, 1155.67063386936, 1186.1756079524648, 10101.595936162617, 12419.19275247106, 12447.502099915902, 12463.875361246453, 12807.807882881763, 326272.0, 326996.3650181734, 328100.0, 328841.0, 330473.0, 54430.727846361304, 54920.725396373564, 54990.450095499335, 55125.72437137789, 55149.0, 1494.8131483564555, 1534.5319677498471, 1579.9842001579837, 1583.263782341217, 1591.5861875912346, 24019.879900600386, 24035.399115021566, 24115.397115072265, 24148.637770433106, 24174.637380438955, 38078.619213807506, 38187.045323867125, 38219.0, 38354.42468362921, 38403.0, 276196.0, 276618.61690691416, 277016.61491692415, 278078.0, 278219.0, 33932.66067339394, 33942.15144621404, 34491.655083448844, 34513.30973380568, 34677.82661086678, 44849.77575112104, 45716.77141614404, 45868.77065614651, 45912.31131533097, 46129.84675383142, 24138.0, 28446.86212551475, 29389.971351003467, 29614.55578166286, 29647.96232131865, 25970.0, 30804.075877723702, 31481.0, 31496.842515787273, 31562.210944726565, 37501.6249837509, 37710.24579508339, 37767.0, 37834.62165378311, 37857.43213851739, 26345.682715864514, 27521.449571008066, 31125.0, 32263.092578803673, 32923.67076329206, 19816.910069945716, 20447.262017670368, 24489.0, 24881.0, 24965.0], "value": 17637.269867683328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.34111274742287, 420.4156222850237, 426.4520091682188, 437.3090516983166, 443.45012184890743, 20131.19475220991, 21885.67171492429, 22444.88777556112, 22511.32466026022, 22776.088956441763, 19864.205431782746, 21938.0, 23691.763082369172, 23858.76141238587, 23939.640905386434, 6213.192285002943, 6275.0587411888355, 6453.612783232998, 6469.514786391016, 6479.5788273762055, 6131.417515336036, 6316.873662526747, 6364.745410183587, 6374.203224596926, 6375.011873159668, 6052.636841789506, 6214.8135555933395, 6255.06174073888, 6328.462080723144, 6331.55679102463, 6002.579819412643, 6223.875522489548, 6284.434400903895, 6290.087937249074, 6300.0, 5364.704941228231, 5535.944640553583, 5571.9721401392735, 5614.747336369873, 5622.437756224385, 27260.727392726018, 27282.5907611386, 27347.726522734716, 27663.0, 27730.0, 2046.2019812273224, 2208.492046829222, 2273.352094653016, 2275.41976795916, 2276.3853759484846, 17576.29694812206, 17762.555936101573, 17850.464486065437, 18046.729299060524, 18215.72676409855, 2192.254633424627, 2194.5391467791624, 2260.095961615367, 2260.626996545568, 2261.434641339665, 146093.0, 146548.0, 146633.53366466306, 148548.0, 164261.9655918924, 12283.938580307042, 12803.935980320224, 12893.93553032229, 12911.870881291066, 12946.935265323613, 16736.995780253223, 16740.916295418447, 16757.581060473585, 16775.58061048459, 16805.57986050334, 7983.042034955726, 8616.09530999236, 9202.723918282461, 9206.90793092074, 9357.298202634829, 7977.0, 8838.469691818511, 8843.734687959372, 8992.100789921087, 9002.684906028258, 7411.85176296471, 8137.511749295061, 8175.918240817635, 8249.422540422112, 8250.257476827115, 2072.336852207279, 2190.5618876224817, 2252.538229662915, 2253.3690566641367, 2402.6756387887763, 915.6383228624655, 942.7548837302351, 942.8397172480695, 978.8335982882927, 980.5636491761098, 21044.263450779148, 21045.15819367239, 21197.25809596657, 21211.257605983716, 21282.0, 988.4316518002033, 999.5551979369111, 1008.5814387029301, 1020.2450186861669, 1021.3667526133845, 7994.560299183485, 10847.566097356017, 11041.44792760375, 11049.39228342449, 11061.949114834079, 516805.4875061262, 522716.0, 530987.0, 531594.0, 534246.0, 105126.0, 129336.35331823469, 137162.31418842843, 137614.0, 138147.0, 1030.3302853145365, 1178.6522975722012, 1197.1260979485025, 1230.4954968462887, 1231.2243286729304, 19071.61856762829, 19987.300444484372, 22592.209272675376, 22627.660585090907, 22648.433789155402, 51595.173258051414, 57264.427355727574, 59229.703851480466, 59712.0, 59885.70057149686, 69671.56149534741, 71337.28662713307, 72229.0, 77975.66073017819, 83872.58063709643, 8658.220760131619, 8996.955015224881, 9064.592093355946, 9101.453912765255, 9435.764105897408, 14389.352479138255, 14569.053011554215, 14571.052881562664, 14613.707725845636, 14683.045602035834, 10164.288499804943, 11834.526618935146, 12131.393430328271, 12322.137450378388, 12342.0, 11441.42792860337, 11534.480948357177, 11597.594084207012, 11804.0, 11814.881851181379, 12087.939560302142, 12228.75542489163, 12319.69200769988, 12452.190607610839, 12490.437930292977, 7736.651850666846, 8990.910090899008, 9078.09219078087, 9122.635094596408, 9156.633734650539, 11924.523019079139, 11952.0, 12227.87772122303, 12256.938715306367, 12359.38203089824], "value": 10576.496182335615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.361295739173, 1504.3531281548937, 1504.4659146003162, 1524.72685307768, 1534.3632392557085, 11524.481398337073, 12028.278303301808, 12075.698107547305, 12084.637460876165, 12411.62765117048, 11971.580994665188, 12048.57829975951, 12191.634250972464, 12207.267563946169, 12208.633740987785, 2543.198892348909, 2583.689957205138, 2588.8835002424844, 2590.44305474323, 2595.42900561877, 2491.277529516438, 2544.3639090227443, 2545.2491515003026, 2548.554003049468, 2549.821512494126, 2522.4576716006054, 2562.551553478143, 2569.4732579821093, 2587.430765231646, 2588.9093881714143, 2503.3115893129443, 2514.3085651445726, 2556.3864672478658, 2560.6543116679195, 2566.5508536006123, 2505.523950449427, 2529.4182338062164, 2545.300042488312, 2550.948981020369, 2556.3481312265253, 12039.217450865666, 12046.397680115959, 12103.213291136048, 12148.635540933787, 12154.574589889311, 6634.900476492857, 6882.174139103289, 6882.449404047664, 6883.795335816212, 6901.585904845675, 3422.161570415239, 3633.94549081764, 4235.713828156945, 4237.4279472271155, 4418.756968366739, 1228.6068458093414, 1249.2504497301636, 1294.5145570411096, 1296.351824087956, 1296.6693493159185, 15012.849871501363, 15525.301361438762, 16698.415555455624, 16807.41174058902, 16883.98696078227, 5056.7471626419265, 5403.811161544454, 5480.6437581557075, 5756.136579513023, 5756.1653560233535, 10318.813336466252, 11682.70793230176, 11779.941100294614, 11790.764184716258, 11794.233374830781, 6585.6707164641575, 6637.269900310962, 6715.832104197434, 6723.058771771955, 6723.159605049369, 6133.969330153321, 6218.751249949952, 6264.154339164245, 6334.429901308904, 6376.585521941059, 3587.65917237862, 3893.9610603894166, 4249.788810189143, 4289.313709806416, 4391.5827996340295, 1279.6544932868073, 1280.2510531339271, 1283.2813624370383, 1296.5786119511197, 1305.9477620895248, 802.9197080291924, 803.1968031968032, 824.3446460064263, 827.6978902700591, 852.9019162796234, 5947.970260148758, 6073.210482637229, 6103.786367477117, 6290.21372328459, 6498.545101842826, 583.3000399520593, 591.7544219149091, 592.3602509289957, 598.6109029131013, 603.2308806272039, 3777.58446570877, 3860.208657225262, 3906.121122747416, 3917.5505063126257, 3936.645701886844, 14128.505502307575, 14856.405743770129, 15139.924300378649, 15143.394264229528, 15147.576387777903, 14783.0, 14901.403943842124, 15186.936914415885, 15204.163770992702, 15336.923315383576, 8410.36922230835, 8744.8688269676, 8753.824923501494, 8830.690925817695, 8859.158379953895, 6411.51913606472, 6458.354164583504, 7089.007538944655, 7172.569645821268, 7221.855562888608, 10169.0, 12934.611961641165, 13360.532381366605, 13585.79621305701, 13706.314684265548, 13727.245001525012, 13749.243791591558, 13857.445702172203, 14055.016148869481, 14233.64415889611, 9453.905460945578, 9460.668876589287, 9463.053694630482, 9490.667826626035, 9531.904680953101, 10699.518521666389, 10744.623938162127, 10785.029347358775, 10786.784264314827, 10793.62222322215, 8211.425200236165, 8318.79203019905, 8388.916110838814, 8465.534395608302, 8501.914980850112, 8004.359651228005, 8073.5963201838495, 8123.6750529978135, 8129.959350203211, 8153.9184608153155, 8208.548529830916, 8337.666493340199, 8370.539620320696, 8371.706990255312, 8372.581370931552, 5819.359870414166, 5868.119782032729, 5942.940570594239, 5989.041753319448, 6019.518438524995, 5990.910136348046, 6091.847703807441, 6189.9690501549, 6199.0, 6404.679766011774], "value": 5312.576855473489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8126920981743, 404.9878503644891, 408.0533163061698, 408.21418768869927, 416.7957700726645, 5687.744051517681, 6118.877622447549, 6255.812325630227, 6267.592606480582, 6279.529035322352, 4752.952470475303, 5743.452464190826, 5986.820395388135, 6000.759969601221, 6049.939500604993, 4635.629149668019, 4677.4387073551225, 4678.900458392275, 4688.765561721917, 4691.859244222679, 4601.585857272845, 4659.650526210531, 4664.463586687523, 4685.109829132454, 4689.7655117244, 4591.609713174367, 4594.517575654559, 4614.169449499089, 4619.792109355087, 4620.399348084744, 3864.3044252034624, 3997.180577981536, 4560.771961401917, 4617.630589552828, 4653.906921861544, 3483.442649176145, 3665.688416484602, 4127.195196936598, 4155.688323375759, 4157.771322577257, 5003.524665156804, 5865.149553314788, 5998.8500287492725, 6003.099535069731, 6061.818145455643, 4635.46692130406, 5246.396664383607, 5260.210968354739, 5269.604779641504, 5274.868128296785, 5151.639385243035, 6280.309165991737, 6321.74713011479, 6444.0, 6516.641584712839, 3841.80903919783, 4113.670906327517, 4292.957070429287, 4305.698601097924, 4334.934975975363, 6236.0, 6586.476235214138, 6846.863062738767, 6930.826729331757, 6963.895541566881, 3701.3522633539023, 4266.637335826489, 4338.717983331074, 4376.824927002885, 4377.277749171415, 3784.8864534064023, 3935.5080614923136, 4415.0, 4425.380446737459, 4433.179861725591, 4438.644908407319, 5266.183741520071, 5270.604704647167, 5287.524122828964, 5340.172273297645, 6521.934780652227, 6553.705083271264, 6626.0, 6626.171728533934, 6636.734530618721, 1485.6063143267043, 1510.8291074417414, 1513.8259100203397, 1515.204517628232, 1515.5907904865624, 940.6471070252746, 985.6845809340942, 987.6641941739842, 987.8221920054316, 991.3754334769194, 5666.4900158985065, 5763.481286684135, 6182.814515564541, 6190.50475961922, 6228.377162283736, 5781.971090144607, 6760.492963027793, 6836.418904393083, 6891.414229790424, 6985.825354366079, 4997.30037794709, 5101.005303965765, 5550.944490555124, 5927.4665280125, 6209.2548894133, 3152.2907345847, 3516.505485168793, 3559.2525569630666, 3562.8218589070443, 3563.5389490309367, 5153.922691159635, 6074.757009719562, 6082.787102451393, 6831.292176955761, 6954.860902781916, 5501.734601041703, 5965.6718880461995, 6472.698923549024, 6994.230634630187, 7051.519180972054, 6781.186257649114, 6857.108575885203, 6974.651267436608, 7023.08699869024, 7055.823604409726, 6722.193336799615, 6760.898586521108, 6835.248122706597, 6861.759838405632, 6865.0388945546665, 6666.166729158856, 6675.899861501985, 6683.9639855822425, 6717.630530320879, 6777.661116944035, 5920.822375328747, 6711.221526295438, 6733.326667333227, 6970.490623375479, 7012.859742805217, 4289.9571004289555, 4882.60939124862, 4935.56868508143, 4964.751762411937, 4993.400791904995, 5761.48146666802, 6007.579469437097, 6865.965670171618, 6874.381305682513, 6874.725010999504, 6054.969725151346, 6326.9876819708625, 6559.278479367361, 6581.243157037002, 6783.253842077466, 6140.4473597376455, 6285.994240921614, 6337.366263373626, 6479.056283115141, 6564.9671751640935, 5169.508896654812, 6337.0, 6411.935880641134, 6443.838904027437, 6495.772647957488, 5525.806596769094, 5812.128180772918, 6423.454006409321, 6524.9673751630935, 6616.569922954993, 6250.656213908279, 6365.586236894587, 6426.967865160645, 6446.5165112615805, 6513.674316284072], "value": 4746.215141786379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.9914500854998, 865.1867244789897, 867.4405008769344, 888.928885689145, 891.2290868398837, 13454.663633409158, 16597.423244791742, 17299.913500432496, 18779.0, 19321.323753668625, 18264.817351826478, 18652.813471865276, 18702.90648546759, 18789.718154227663, 18843.434696959113, 921.824853277875, 1015.7612960954189, 1033.731229880229, 1046.8743750749882, 1047.9109275711573, 903.7469508537587, 1043.2697112021576, 1044.4568824211406, 1048.2400259811614, 1051.3166441812807, 1100.9779804403906, 1102.8400881872165, 1103.3049179017207, 1106.5020740666691, 1107.374333501569, 948.6964171465133, 1094.1192340166162, 1095.5453486802967, 1104.8950349716763, 1107.8227483602625, 780.8828675698634, 791.8297566023333, 794.5232860283784, 802.3861745764494, 804.9816981518384, 14244.501442449464, 17401.651966960715, 17850.107494625347, 17865.464036078807, 18026.27894884203, 17309.221085051202, 17511.299548018065, 17554.54236406904, 17651.205695743723, 17898.642027159513, 14094.436222551085, 14144.646383840383, 14162.36269367881, 14209.857901420957, 14363.49727759534, 3505.544279243682, 3572.0, 3572.392693242155, 3573.5175751273505, 3577.928441431183, 141122.0, 141507.0, 142241.2887935564, 142310.0, 143890.0, 13452.596422107352, 13475.932620336836, 13479.19124852512, 13564.050516463753, 13620.455181792617, 24817.62773558398, 25470.490590188092, 25935.74064259371, 26017.69911504417, 26045.739542604333, 7329.633518324063, 7505.962470187614, 7518.699252029967, 7529.4729368943645, 7578.658960346797, 3857.189990102054, 3926.6269704378037, 3934.724569280123, 3961.801909904551, 3961.92076158481, 4299.247631664446, 4409.977950110229, 4435.489918659331, 4442.97811503356, 4450.933236001462, 862.2326129744532, 891.772597987509, 897.5512243878061, 902.7382059202757, 906.1934877958622, 650.9153810004764, 662.8508585568209, 665.7303791964263, 678.1556961582861, 693.0920494152676, 10333.638322658671, 10845.0, 11692.35692036946, 11698.736223146594, 11969.162158648985, 642.563057121162, 654.6170490263154, 655.6885479397248, 660.8072429265222, 680.1633990191992, 5267.499587539178, 5352.732363381815, 5363.946360536423, 5415.922333962039, 5454.972725136349, 87815.56092219625, 114185.0, 116045.0, 116717.0, 119870.4006479962, 86189.56905215434, 99311.0, 101193.48209776859, 102188.0, 103607.4819625897, 74253.62873185599, 76608.85086723704, 78348.99999999886, 78723.0, 80143.0, 12008.85915837994, 12565.183263088236, 12639.494420223087, 12671.80992285098, 12721.427535760728, 34253.486197707556, 39353.60646393499, 40204.99487512836, 40259.79870100631, 40448.79775601103, 61214.857479987986, 64993.67503162454, 65107.674461627386, 68352.0, 69497.0, 16425.507234782977, 16961.321547137977, 17043.488695339158, 17228.224729887435, 17243.913780431016, 17923.551911202325, 18542.721859171852, 18632.44102676922, 18877.90561047186, 18895.43313700591, 13894.305284735925, 16794.66410671755, 16944.66110677755, 17099.230534626222, 17296.0, 13752.93123534376, 16723.0, 17012.404565840137, 17240.310387584355, 17240.827591724425, 16735.0, 16753.32986680519, 16782.16089195511, 16812.747808782635, 16912.32350705958, 10665.880082591217, 11542.307461552333, 11601.883981160081, 12070.456829442872, 12283.236271838765, 11836.0, 12810.871891280967, 13274.601761947157, 13405.329733513481, 14449.699527042616], "value": 8562.673421986085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 112.0, 113.0, 114.0, 114.0, 117.0, 116.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 106.0, 111.0, 149.0, 110.0, 112.0, 108.0, 122.0, 132.0, 111.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 195.0, 202.0, 219.0, 215.0, 222.0, 209.0, 197.0, 202.0, 198.0], "value": 205.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 78.0, 108.0, 80.0, 63.0, 60.0, 58.0, 71.0, 57.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 82.0, 69.0, 68.0, 68.0, 85.0, 73.0, 70.0, 86.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 90.0, 88.0, 87.0, 100.0, 89.0, 96.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 97.0, 96.0, 105.0, 105.0, 96.0, 98.0], "value": 98.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 90.0, 92.0, 94.0, 93.0, 120.0, 117.0, 89.0, 126.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 53.0, 51.0, 51.0, 52.0, 69.0, 73.0, 66.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 60.0, 60.0, 67.0, 63.0, 58.0, 58.0, 57.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 101.0, 71.0, 93.0, 102.0, 99.0, 102.0, 88.0, 96.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 158.0, 132.0, 136.0, 165.0, 151.0, 139.0, 142.0, 189.0, 172.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 190.0, 187.0, 184.0, 183.0, 184.0, 199.0, 228.0, 208.0, 187.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 89.0, 78.0, 69.0, 66.0, 62.0, 60.0, 59.0, 61.0, 53.0], "value": 66.7, "unit": "score"}]}]} 15:53:09 INFO - Return code: 0 15:53:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:09 ERROR - # TBPL SUCCESS # 15:53:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:09 INFO - 2017-04-25 15:53:09.991 screenresolution[1927:21034] starting screenresolution argv=screenresolution get 15:53:09 INFO - 2017-04-25 15:53:09.994 screenresolution[1927:21034] Display 0: 1600x1200x32@60 15:53:10 INFO - 2017-04-25 15:53:10.001 screenresolution[1928:21038] starting screenresolution argv=screenresolution list 15:53:10 INFO - Available Modes on Display 0 15:53:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:10 INFO - Intel Iris: 15:53:10 INFO - Chipset Model: Intel Iris 15:53:10 INFO - Type: GPU 15:53:10 INFO - Bus: Built-In 15:53:10 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:10 INFO - Vendor: Intel (0x8086) 15:53:10 INFO - Device ID: 0x0a2e 15:53:10 INFO - Revision ID: 0x0009 15:53:10 INFO - Displays: 15:53:10 INFO - Display: 15:53:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:10 INFO - Display Serial Number: 1600x1200 60 15:53:10 INFO - Main Display: Yes 15:53:10 INFO - Mirror: Off 15:53:10 INFO - Online: Yes 15:53:10 INFO - Rotation: Supported 15:53:10 INFO - Return code: 0 15:53:10 INFO - Running post-action listener: _resource_record_post_action 15:53:10 INFO - [mozharness: 2017-04-25 22:53:10.249403Z] Finished run-tests step (success) 15:53:10 INFO - Running post-run listener: _resource_record_post_run 15:53:10 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 1095168; Write bytes: 511297536; Read time: 19; Write time: 1617 15:53:10 INFO - TinderboxPrint: CPU usage
54.2% 15:53:10 INFO - TinderboxPrint: I/O read bytes / time
1,095,168 / 19 15:53:10 INFO - TinderboxPrint: I/O write bytes / time
511,297,536 / 1,617 15:53:10 INFO - TinderboxPrint: CPU idle
2,194.1 (45.8%) 15:53:10 INFO - TinderboxPrint: CPU system
961.0 (20.1%) 15:53:10 INFO - TinderboxPrint: CPU user
1,630.7 (34.1%) 15:53:10 INFO - TinderboxPrint: Swap in / out
210,280,448 / 0 15:53:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207966720; Write bytes: 206854144; Read time: 16017; Write time: 438 15:53:10 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1095168; Write bytes: 297275392; Read time: 19; Write time: 1147 15:53:10 INFO - Running post-run listener: _upload_blobber_files 15:53:10 INFO - Blob upload gear active. 15:53:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:10 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 15:53:10 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'] 15:53:10 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 15:53:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:12 INFO - (blobuploader) - INFO - Done attempting. 15:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:13 INFO - (blobuploader) - INFO - Done attempting. 15:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:53:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:14 INFO - (blobuploader) - INFO - Done attempting. 15:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:16 INFO - (blobuploader) - INFO - Done attempting. 15:53:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:16 INFO - Return code: 0 15:53:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3457bb4eb64053d71be3ff08a7592ef4652351492e47dff0627167c953dca672a02d63ddbe2a57a9aaa086530ac81d5a4b5dd3f590d624c718b749a8215586", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d578bb3403ec71e681757d75bf47c6207abeb8d620e25bbdf16a125b247a2403eb6cadf722307f55c587a755cca99a3caaa22b4dfc8ef3eec0a1727b9a633d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c032f27417ff95035f2cfcfb8e6ae973fe9a9eed70f92a762d83900c93445a3bff2cd802ad1c55571e2edc2c64a7cdc820d0c6fd2e2dbe4e806b5669403424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8082e6faf11d472ad39a5732fd359d0cb6d8a069db5337d34f03f08ff9ec2edb85f66426cc9c8037590d68f60cafa58a8e84e6a3ac71231ac822f3eed24433c5"} 15:53:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:16 INFO - Contents: 15:53:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3457bb4eb64053d71be3ff08a7592ef4652351492e47dff0627167c953dca672a02d63ddbe2a57a9aaa086530ac81d5a4b5dd3f590d624c718b749a8215586", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d578bb3403ec71e681757d75bf47c6207abeb8d620e25bbdf16a125b247a2403eb6cadf722307f55c587a755cca99a3caaa22b4dfc8ef3eec0a1727b9a633d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c032f27417ff95035f2cfcfb8e6ae973fe9a9eed70f92a762d83900c93445a3bff2cd802ad1c55571e2edc2c64a7cdc820d0c6fd2e2dbe4e806b5669403424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8082e6faf11d472ad39a5732fd359d0cb6d8a069db5337d34f03f08ff9ec2edb85f66426cc9c8037590d68f60cafa58a8e84e6a3ac71231ac822f3eed24433c5"} 15:53:16 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:16 INFO - Copying logs to upload dir... 15:53:16 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.076664 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 15:53:16.854621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:16.858418) ========= 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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3457bb4eb64053d71be3ff08a7592ef4652351492e47dff0627167c953dca672a02d63ddbe2a57a9aaa086530ac81d5a4b5dd3f590d624c718b749a8215586", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d578bb3403ec71e681757d75bf47c6207abeb8d620e25bbdf16a125b247a2403eb6cadf722307f55c587a755cca99a3caaa22b4dfc8ef3eec0a1727b9a633d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c032f27417ff95035f2cfcfb8e6ae973fe9a9eed70f92a762d83900c93445a3bff2cd802ad1c55571e2edc2c64a7cdc820d0c6fd2e2dbe4e806b5669403424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8082e6faf11d472ad39a5732fd359d0cb6d8a069db5337d34f03f08ff9ec2edb85f66426cc9c8037590d68f60cafa58a8e84e6a3ac71231ac822f3eed24433c5"} build_url:https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/K1m0Gpa9TlWCiV8vRPUTvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f3457bb4eb64053d71be3ff08a7592ef4652351492e47dff0627167c953dca672a02d63ddbe2a57a9aaa086530ac81d5a4b5dd3f590d624c718b749a8215586", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d578bb3403ec71e681757d75bf47c6207abeb8d620e25bbdf16a125b247a2403eb6cadf722307f55c587a755cca99a3caaa22b4dfc8ef3eec0a1727b9a633d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c032f27417ff95035f2cfcfb8e6ae973fe9a9eed70f92a762d83900c93445a3bff2cd802ad1c55571e2edc2c64a7cdc820d0c6fd2e2dbe4e806b5669403424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8082e6faf11d472ad39a5732fd359d0cb6d8a069db5337d34f03f08ff9ec2edb85f66426cc9c8037590d68f60cafa58a8e84e6a3ac71231ac822f3eed24433c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:16.892971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:16.893313) ========= 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.vwT05vQ7JP/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.ibFUPnDTpt/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 15:53:16.941674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 15:53:16.942046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 15:53:16.942357) ========= ========= Total master_lag: 0.21 =========