builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0131 starttime: 1493120893.79 results: success (0) buildid: 20170425030221 builduid: b33fc7c5d4b64958a0102d88156ab255 revision: a30dc237c3a600a5231f2974fc2b85dfb5513414 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:13.793346) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:13.793756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:13.794085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:13.821225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:13.821618) ========= 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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:48:13-- 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% 50.7M=0s 2017-04-25 04:48:13 (50.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162221 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:14.009126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:14.009448) ========= 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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.028090 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:14.060671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 04:48:14.061038) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a30dc237c3a600a5231f2974fc2b85dfb5513414 --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 a30dc237c3a600a5231f2974fc2b85dfb5513414 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:48:14,163 truncating revision to first 12 chars 2017-04-25 04:48:14,163 Setting DEBUG logging. 2017-04-25 04:48:14,163 attempt 1/10 2017-04-25 04:48:14,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a30dc237c3a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 04:48:15,894 unpacking tar archive at: mozilla-central-a30dc237c3a6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.009921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 04:48:16.095688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:16.096042) ========= script_repo_revision: a30dc237c3a600a5231f2974fc2b85dfb5513414 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:16.096484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:16.096765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:16.117495) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 04:48:16.117823) ========= /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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:48:16 INFO - MultiFileLogger online at 20170425 04:48:16 in /builds/slave/test 04:48:16 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 04:48:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:16 INFO - {'append_to_log': False, 04:48:16 INFO - 'base_work_dir': '/builds/slave/test', 04:48:16 INFO - 'blob_upload_branch': 'Firefox', 04:48:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:16 INFO - 'branch': 'Firefox', 04:48:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:16 INFO - 'config_files': ('talos/mac_config.py',), 04:48:16 INFO - 'default_actions': ('clobber', 04:48:16 INFO - 'read-buildbot-config', 04:48:16 INFO - 'download-and-extract', 04:48:16 INFO - 'populate-webroot', 04:48:16 INFO - 'create-virtualenv', 04:48:16 INFO - 'install', 04:48:16 INFO - 'run-tests'), 04:48:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:16 INFO - 'download_minidump_stackwalk': True, 04:48:16 INFO - 'download_symbols': 'ondemand', 04:48:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:16 INFO - 'gecko_profile': False, 04:48:16 INFO - 'gecko_profile_interval': 0, 04:48:16 INFO - 'installer_path': 'installer.exe', 04:48:16 INFO - 'log_level': 'info', 04:48:16 INFO - 'log_name': 'talos', 04:48:16 INFO - 'log_to_console': True, 04:48:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:16 INFO - 'opt_config_files': (), 04:48:16 INFO - 'pip_index': False, 04:48:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:16 INFO - 'cmd': ('bash', 04:48:16 INFO - '-c', 04:48:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:16 INFO - 'enabled': True, 04:48:16 INFO - 'halt_on_failure': False, 04:48:16 INFO - 'name': 'check_screen_resolution'},), 04:48:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:16 INFO - 'cmd': ('bash', 04:48:16 INFO - '-c', 04:48:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:16 INFO - 'enabled': True, 04:48:16 INFO - 'halt_on_failure': False, 04:48:16 INFO - 'name': 'check_screen_resolution'},), 04:48:16 INFO - 'run_cmd_checks_enabled': True, 04:48:16 INFO - 'suite': 'dromaeojs-e10s', 04:48:16 INFO - 'system_bits': '32', 04:48:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:16 INFO - 'title': 't-yosemite-r7-0131', 04:48:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:16 INFO - 'use_talos_json': True, 04:48:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:16 INFO - 'work_dir': 'build'} 04:48:16 INFO - [mozharness: 2017-04-25 11:48:16.330197Z] Running clobber step. 04:48:16 INFO - Running pre-action listener: _resource_record_pre_action 04:48:16 INFO - Running main action method: clobber 04:48:16 INFO - rmtree: /builds/slave/test/build 04:48:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:18 INFO - Running post-action listener: _resource_record_post_action 04:48:18 INFO - [mozharness: 2017-04-25 11:48:18.861429Z] Finished clobber step (success) 04:48:18 INFO - [mozharness: 2017-04-25 11:48:18.861563Z] Running read-buildbot-config step. 04:48:18 INFO - Running pre-action listener: _resource_record_pre_action 04:48:18 INFO - Running main action method: read_buildbot_config 04:48:18 INFO - Using buildbot properties: 04:48:18 INFO - { 04:48:18 INFO - "project": "", 04:48:18 INFO - "product": "firefox", 04:48:18 INFO - "script_repo_revision": "production", 04:48:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:48:18 INFO - "repository": "", 04:48:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:48:18 INFO - "buildid": "20170425030221", 04:48:18 INFO - "stage_platform": "macosx64", 04:48:18 INFO - "basedir": "/builds/slave/test", 04:48:18 INFO - "nightly_build": "True", 04:48:18 INFO - "buildnumber": 45, 04:48:18 INFO - "slavename": "t-yosemite-r7-0131", 04:48:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:48:18 INFO - "platform": "yosemite_r7", 04:48:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:18 INFO - "branch": "mozilla-central", 04:48:18 INFO - "repo_path": "mozilla-central", 04:48:18 INFO - "revision": "a30dc237c3a600a5231f2974fc2b85dfb5513414", 04:48:18 INFO - "pgo_build": "False", 04:48:18 INFO - "builduid": "b33fc7c5d4b64958a0102d88156ab255", 04:48:18 INFO - "slavebuilddir": "test" 04:48:18 INFO - } 04:48:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:48:18 INFO - Running post-action listener: _resource_record_post_action 04:48:18 INFO - [mozharness: 2017-04-25 11:48:18.865019Z] Finished read-buildbot-config step (success) 04:48:18 INFO - [mozharness: 2017-04-25 11:48:18.865147Z] Running download-and-extract step. 04:48:18 INFO - Running pre-action listener: _resource_record_pre_action 04:48:18 INFO - Running main action method: download_and_extract 04:48:18 INFO - mkdir: /builds/slave/test/build/tests 04:48:18 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')]} 04:48:18 INFO - trying https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/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 04:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/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 04:48:20 INFO - Downloaded 1325 bytes. 04:48:20 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:20 INFO - Using the following test package requirements: 04:48:20 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:48:20 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:20 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:20 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:48:20 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'jsshell-mac.zip'], 04:48:20 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:48:20 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:20 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:48:20 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:48:20 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:48:20 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:20 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:20 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:20 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:48:21 INFO - Content-Length response header: 52530772 04:48:21 INFO - Bytes received: 52530772 04:48:38 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 04:48:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:38 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:48:39 INFO - Content-Length response header: 52530772 04:48:39 INFO - Bytes received: 52530772 04:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:48:56 INFO - Content-Length response header: 14408822 04:48:56 INFO - Bytes received: 14408822 04:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:56 INFO - trying https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/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 04:48:58 INFO - Downloaded 71189263 bytes. 04:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:48:58 INFO - mkdir: /builds/slave/test/properties 04:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:58 INFO - Contents: 04:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:48:59 INFO - Running post-action listener: _resource_record_post_action 04:48:59 INFO - Running post-action listener: set_extra_try_arguments 04:48:59 INFO - [mozharness: 2017-04-25 11:48:59.397946Z] Finished download-and-extract step (success) 04:48:59 INFO - [mozharness: 2017-04-25 11:48:59.398099Z] Running populate-webroot step. 04:48:59 INFO - Running pre-action listener: _resource_record_pre_action 04:48:59 INFO - Running main action method: populate_webroot 04:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:59 INFO - '--tppagecycles', 04:48:59 INFO - '7'], 04:48:59 INFO - 'tests': ['tsvgm']}}, 04:48:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['damp', 'tps']}, 04:48:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'tests': ['damp', 'tps']}, 04:48:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['dromaeo_dom']}, 04:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:48:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:48:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['a11yr', 04:48:59 INFO - 'ts_paint', 04:48:59 INFO - 'tpaint', 04:48:59 INFO - 'sessionrestore', 04:48:59 INFO - 'sessionrestore_no_auto_restore', 04:48:59 INFO - 'tabpaint']}, 04:48:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:48:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:48:59 INFO - 'bloom_basic_ref']}, 04:48:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['tsvgx', 04:48:59 INFO - 'tsvgr_opacity', 04:48:59 INFO - 'tart', 04:48:59 INFO - 'tscrollx', 04:48:59 INFO - 'cart', 04:48:59 INFO - 'tsvg_static']}, 04:48:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:59 INFO - 'tsvgr_opacity', 04:48:59 INFO - 'tart', 04:48:59 INFO - 'tscrollx', 04:48:59 INFO - 'cart', 04:48:59 INFO - 'tsvg_static']}, 04:48:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'talos_options': ['--disable-e10s'], 04:48:59 INFO - 'tests': ['tp5o']}, 04:48:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:48:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'talos_options': ['--disable-e10s', 04:48:59 INFO - '--xperf_path', 04:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:59 INFO - 'tests': ['tp5n']}, 04:48:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:48:59 INFO - 'talos_options': ['--xperf_path', 04:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:59 INFO - 'tests': ['tp5n']}}, 04:48:59 INFO - 'talos.zip': {'path': '', 04:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:59 INFO - Running post-action listener: _resource_record_post_action 04:48:59 INFO - [mozharness: 2017-04-25 11:48:59.416774Z] Finished populate-webroot step (success) 04:48:59 INFO - [mozharness: 2017-04-25 11:48:59.416884Z] Running create-virtualenv step. 04:48:59 INFO - Running pre-action listener: _resource_record_pre_action 04:48:59 INFO - Running main action method: create_virtualenv 04:48:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:59 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 04:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:59 INFO - Using real prefix '/tools/python27' 04:48:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:03 INFO - Installing pip.................done. 04:49:03 INFO - Return code: 0 04:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:03 INFO - Reading from file tmpfile_stdout 04:49:03 INFO - Output received: 04:49:03 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) 04:49:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:03 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')]} 04:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:03 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')]} 04:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:03 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:03 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 04:49:03 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 04:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:03 INFO - 'HOME': '/Users/cltbld', 04:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:03 INFO - 'LOGNAME': 'cltbld', 04:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:03 INFO - 'MOZ_NO_REMOTE': '1', 04:49:03 INFO - 'NO_EM_RESTART': '1', 04:49:03 INFO - 'PAGER': '/bin/cat', 04:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:03 INFO - 'PWD': '/builds/slave/test', 04:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:03 INFO - 'SHELL': '/bin/bash', 04:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:03 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:03 INFO - 'USER': 'cltbld', 04:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:03 INFO - 'XPC_FLAGS': '0x0', 04:49:03 INFO - 'XPC_SERVICE_NAME': '0', 04:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:03 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 04:49:03 INFO - Cleaning up... 04:49:03 INFO - Return code: 0 04:49:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:03 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')]} 04:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:03 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')]} 04:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:03 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:03 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 04:49:03 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 04:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:03 INFO - 'HOME': '/Users/cltbld', 04:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:03 INFO - 'LOGNAME': 'cltbld', 04:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:03 INFO - 'MOZ_NO_REMOTE': '1', 04:49:03 INFO - 'NO_EM_RESTART': '1', 04:49:03 INFO - 'PAGER': '/bin/cat', 04:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:03 INFO - 'PWD': '/builds/slave/test', 04:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:03 INFO - 'SHELL': '/bin/bash', 04:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:03 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:03 INFO - 'USER': 'cltbld', 04:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:03 INFO - 'XPC_FLAGS': '0x0', 04:49:03 INFO - 'XPC_SERVICE_NAME': '0', 04:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:03 INFO - Downloading/unpacking psutil>=3.1.1 04:49:03 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 04:49:03 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 04:49:03 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 04:49:03 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 04:49:03 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 04:49:03 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 04:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:07 INFO - Installing collected packages: psutil 04:49:07 INFO - Running setup.py install for psutil 04:49:07 INFO - building 'psutil._psutil_osx' extension 04:49:07 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 04:49:08 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 04:49:08 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 04:49:08 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 04:49:08 INFO - building 'psutil._psutil_posix' extension 04:49:08 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 04:49:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:08 INFO - ^ 04:49:08 INFO - 1 warning generated. 04:49:08 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 04:49:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:08 INFO - Successfully installed psutil 04:49:08 INFO - Cleaning up... 04:49:08 INFO - Return code: 0 04:49:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:08 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:08 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 04:49:08 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 04:49:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:08 INFO - 'HOME': '/Users/cltbld', 04:49:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:08 INFO - 'LOGNAME': 'cltbld', 04:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:08 INFO - 'MOZ_NO_REMOTE': '1', 04:49:08 INFO - 'NO_EM_RESTART': '1', 04:49:08 INFO - 'PAGER': '/bin/cat', 04:49:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:08 INFO - 'PWD': '/builds/slave/test', 04:49:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:08 INFO - 'SHELL': '/bin/bash', 04:49:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:08 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:08 INFO - 'USER': 'cltbld', 04:49:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:08 INFO - 'XPC_FLAGS': '0x0', 04:49:08 INFO - 'XPC_SERVICE_NAME': '0', 04:49:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:08 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 04:49:08 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 04:49:08 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 04:49:08 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 04:49:08 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 04:49:08 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 04:49:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:11 INFO - Installing collected packages: mozsystemmonitor 04:49:11 INFO - Running setup.py install for mozsystemmonitor 04:49:11 INFO - Successfully installed mozsystemmonitor 04:49:11 INFO - Cleaning up... 04:49:11 INFO - Return code: 0 04:49:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49: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==2.5.1'] in /builds/slave/test/build 04:49: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==2.5.1 04:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:12 INFO - 'HOME': '/Users/cltbld', 04:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:12 INFO - 'LOGNAME': 'cltbld', 04:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:12 INFO - 'MOZ_NO_REMOTE': '1', 04:49:12 INFO - 'NO_EM_RESTART': '1', 04:49:12 INFO - 'PAGER': '/bin/cat', 04:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:12 INFO - 'PWD': '/builds/slave/test', 04:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:12 INFO - 'SHELL': '/bin/bash', 04:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:12 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:12 INFO - 'USER': 'cltbld', 04:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:12 INFO - 'XPC_FLAGS': '0x0', 04:49:12 INFO - 'XPC_SERVICE_NAME': '0', 04:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:12 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 04:49:12 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 04:49:12 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 04:49:12 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 04:49:12 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 04:49:12 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 04:49:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:15 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 04:49:15 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 04:49:15 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 04:49:15 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 04:49:15 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 04:49:15 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 04:49:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:16 INFO - warning: no files found matching '*.txt' 04:49:16 INFO - no previously-included directories found matching 'build' 04:49:16 INFO - no previously-included directories found matching 'dist' 04:49:16 INFO - no previously-included directories found matching '.git*' 04:49:16 INFO - Installing collected packages: jsonschema, functools32 04:49:16 INFO - Running setup.py install for functools32 04:49:16 INFO - warning: no files found matching '*.txt' 04:49:16 INFO - no previously-included directories found matching 'build' 04:49:16 INFO - no previously-included directories found matching 'dist' 04:49:16 INFO - no previously-included directories found matching '.git*' 04:49:16 INFO - Successfully installed jsonschema functools32 04:49:16 INFO - Cleaning up... 04:49:16 INFO - Return code: 0 04:49:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:16 INFO - 'HOME': '/Users/cltbld', 04:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:16 INFO - 'LOGNAME': 'cltbld', 04:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:16 INFO - 'MOZ_NO_REMOTE': '1', 04:49:16 INFO - 'NO_EM_RESTART': '1', 04:49:16 INFO - 'PAGER': '/bin/cat', 04:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:16 INFO - 'PWD': '/builds/slave/test', 04:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:16 INFO - 'SHELL': '/bin/bash', 04:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:16 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:16 INFO - 'USER': 'cltbld', 04:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:16 INFO - 'XPC_FLAGS': '0x0', 04:49:16 INFO - 'XPC_SERVICE_NAME': '0', 04:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:16 INFO - Cleaning up... 04:49:16 INFO - Return code: 0 04:49:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:16 INFO - 'HOME': '/Users/cltbld', 04:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:16 INFO - 'LOGNAME': 'cltbld', 04:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:16 INFO - 'MOZ_NO_REMOTE': '1', 04:49:16 INFO - 'NO_EM_RESTART': '1', 04:49:16 INFO - 'PAGER': '/bin/cat', 04:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:16 INFO - 'PWD': '/builds/slave/test', 04:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:16 INFO - 'SHELL': '/bin/bash', 04:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:16 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:16 INFO - 'USER': 'cltbld', 04:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:16 INFO - 'XPC_FLAGS': '0x0', 04:49:16 INFO - 'XPC_SERVICE_NAME': '0', 04:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:19 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 04:49:19 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 04:49:19 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 04:49:19 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 04:49:19 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 04:49:19 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 04:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:20 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 04:49:20 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 04:49:20 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 04:49:20 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 04:49:20 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 04:49:20 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 04:49:21 INFO - Downloading docopt-0.6.1.tar.gz 04:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:21 INFO - Running setup.py install for blobuploader 04:49:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:21 INFO - Running setup.py install for requests 04:49:22 INFO - Running setup.py install for docopt 04:49:22 INFO - Successfully installed blobuploader requests docopt 04:49:22 INFO - Cleaning up... 04:49:22 INFO - Return code: 0 04:49:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:22 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:22 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 04:49:22 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 04:49:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:22 INFO - 'HOME': '/Users/cltbld', 04:49:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:22 INFO - 'LOGNAME': 'cltbld', 04:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:22 INFO - 'MOZ_NO_REMOTE': '1', 04:49:22 INFO - 'NO_EM_RESTART': '1', 04:49:22 INFO - 'PAGER': '/bin/cat', 04:49:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:22 INFO - 'PWD': '/builds/slave/test', 04:49:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:22 INFO - 'SHELL': '/bin/bash', 04:49:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:22 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:22 INFO - 'USER': 'cltbld', 04:49:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:22 INFO - 'XPC_FLAGS': '0x0', 04:49:22 INFO - 'XPC_SERVICE_NAME': '0', 04:49:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:22 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-4KEx4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:22 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8asLBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:22 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-L4p67s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:22 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-RvS6xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:22 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ZTSneI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1OLUDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Wgqss8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-sMJa4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-c3JeYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jmtpHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KNK7SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-IAcn35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-UhsAMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-WMJXlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-6ScLXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-VWrKHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-mOuC1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:24 INFO - Running setup.py install for manifestparser 04:49:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:24 INFO - Running setup.py install for mozcrash 04:49:24 INFO - Running setup.py install for mozdebug 04:49:24 INFO - Running setup.py install for mozdevice 04:49:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:24 INFO - Running setup.py install for mozfile 04:49:24 INFO - Running setup.py install for mozhttpd 04:49:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for mozinfo 04:49:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for mozInstall 04:49:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for mozleak 04:49:25 INFO - Running setup.py install for mozlog 04:49:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for moznetwork 04:49:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:25 INFO - Running setup.py install for mozprocess 04:49:26 INFO - Running setup.py install for mozprofile 04:49:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozrunner 04:49:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Running setup.py install for mozscreenshot 04:49:26 INFO - Running setup.py install for moztest 04:49:26 INFO - Running setup.py install for mozversion 04:49:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:26 INFO - Cleaning up... 04:49:26 INFO - Return code: 0 04:49:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:26 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 04:49:26 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 04:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:26 INFO - 'HOME': '/Users/cltbld', 04:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:26 INFO - 'LOGNAME': 'cltbld', 04:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:26 INFO - 'MOZ_NO_REMOTE': '1', 04:49:26 INFO - 'NO_EM_RESTART': '1', 04:49:26 INFO - 'PAGER': '/bin/cat', 04:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:26 INFO - 'PWD': '/builds/slave/test', 04:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:26 INFO - 'SHELL': '/bin/bash', 04:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:26 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:26 INFO - 'USER': 'cltbld', 04:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:26 INFO - 'XPC_FLAGS': '0x0', 04:49:26 INFO - 'XPC_SERVICE_NAME': '0', 04:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-D5S3vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-w__TVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-vJSbfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-pZWNMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-CRh3P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-IGxQM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-iO4Pfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-xy_OWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-9RTR4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:27 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)) 04:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-kLcoCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-mmQXta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YhJeFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BVNhMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-uUA5AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-21Zyp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8LTWcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:28 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)) 04:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-vKuPjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 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)) 04:49:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:31 INFO - Downloading blessings-1.6.tar.gz 04:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:31 INFO - Installing collected packages: blessings 04:49:31 INFO - Running setup.py install for blessings 04:49:31 INFO - Successfully installed blessings 04:49:31 INFO - Cleaning up... 04:49:31 INFO - Return code: 0 04:49:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:32 INFO - Reading from file tmpfile_stdout 04:49:32 INFO - Current package versions: 04:49:32 INFO - blessings == 1.6 04:49:32 INFO - blobuploader == 1.2.4 04:49:32 INFO - docopt == 0.6.1 04:49:32 INFO - functools32 == 3.2.3-2 04:49:32 INFO - jsonschema == 2.5.1 04:49:32 INFO - manifestparser == 1.1 04:49:32 INFO - mozInstall == 1.12 04:49:32 INFO - mozcrash == 1.0 04:49:32 INFO - mozdebug == 0.1 04:49:32 INFO - mozdevice == 0.50 04:49:32 INFO - mozfile == 1.2 04:49:32 INFO - mozhttpd == 0.7 04:49:32 INFO - mozinfo == 0.9 04:49:32 INFO - mozleak == 0.1 04:49:32 INFO - mozlog == 3.4 04:49:32 INFO - moznetwork == 0.27 04:49:32 INFO - mozprocess == 0.25 04:49:32 INFO - mozprofile == 0.28 04:49:32 INFO - mozrunner == 6.13 04:49:32 INFO - mozscreenshot == 0.1 04:49:32 INFO - mozsystemmonitor == 0.3 04:49:32 INFO - moztest == 0.8 04:49:32 INFO - mozversion == 1.4 04:49:32 INFO - psutil == 3.1.1 04:49:32 INFO - requests == 1.2.3 04:49:32 INFO - wsgiref == 0.1.2 04:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:32 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 04:49:32 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 04:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:32 INFO - 'HOME': '/Users/cltbld', 04:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:32 INFO - 'LOGNAME': 'cltbld', 04:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:32 INFO - 'MOZ_NO_REMOTE': '1', 04:49:32 INFO - 'NO_EM_RESTART': '1', 04:49:32 INFO - 'PAGER': '/bin/cat', 04:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:32 INFO - 'PWD': '/builds/slave/test', 04:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:32 INFO - 'SHELL': '/bin/bash', 04:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:32 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:32 INFO - 'USER': 'cltbld', 04:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:32 INFO - 'XPC_FLAGS': '0x0', 04:49:32 INFO - 'XPC_SERVICE_NAME': '0', 04:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 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)) 04:49:32 INFO - Cleaning up... 04:49:32 INFO - Return code: 0 04:49:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:32 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 0x1006d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5eadb0b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, '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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 04:49:32 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 04:49:32 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 04:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:32 INFO - 'HOME': '/Users/cltbld', 04:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:32 INFO - 'LOGNAME': 'cltbld', 04:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:32 INFO - 'MOZ_NO_REMOTE': '1', 04:49:32 INFO - 'NO_EM_RESTART': '1', 04:49:32 INFO - 'PAGER': '/bin/cat', 04:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:32 INFO - 'PWD': '/builds/slave/test', 04:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:32 INFO - 'SHELL': '/bin/bash', 04:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:32 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:32 INFO - 'USER': 'cltbld', 04:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:32 INFO - 'XPC_FLAGS': '0x0', 04:49:32 INFO - 'XPC_SERVICE_NAME': '0', 04:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:32 INFO - Cleaning up... 04:49:32 INFO - Return code: 0 04:49:32 INFO - Running post-action listener: _resource_record_post_action 04:49:32 INFO - Running post-action listener: _start_resource_monitoring 04:49:32 INFO - Starting resource monitoring. 04:49:32 INFO - [mozharness: 2017-04-25 11:49:32.720624Z] Finished create-virtualenv step (success) 04:49:32 INFO - [mozharness: 2017-04-25 11:49:32.721577Z] Running install step. 04:49:32 INFO - Running pre-action listener: _resource_record_pre_action 04:49:32 INFO - Running main action method: install 04:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:32 INFO - Reading from file tmpfile_stdout 04:49:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:33 INFO - Reading from file tmpfile_stdout 04:49:33 INFO - Output received: 04:49:33 INFO - Usage: mozinstall [options] installer 04:49:33 INFO - Options: 04:49:33 INFO - -h, --help show this help message and exit 04:49:33 INFO - -d DEST, --destination=DEST 04:49:33 INFO - Directory to install application into. [default: 04:49:33 INFO - "/builds/slave/test"] 04:49:33 INFO - --app=APP Application being installed. [default: firefox] 04:49:33 INFO - mkdir: /builds/slave/test/build/application 04:49:33 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'] 04:49:33 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 04:49:53 INFO - Reading from file tmpfile_stdout 04:49:53 INFO - Output received: 04:49:53 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:49:53 INFO - Running post-action listener: _resource_record_post_action 04:49:53 INFO - [mozharness: 2017-04-25 11:49:53.415723Z] Finished install step (success) 04:49:53 INFO - [mozharness: 2017-04-25 11:49:53.415863Z] Running run-tests step. 04:49:53 INFO - Running pre-action listener: _resource_record_pre_action 04:49:53 INFO - Running main action method: run_tests 04:49:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:49:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:49:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:49:53 INFO - 2017-04-25 04:49:53.430 screenresolution[1625:7425] starting screenresolution argv=screenresolution get 04:49:53 INFO - 2017-04-25 04:49:53.433 screenresolution[1625:7425] Display 0: 1600x1200x32@60 04:49:53 INFO - 2017-04-25 04:49:53.438 screenresolution[1626:7428] starting screenresolution argv=screenresolution list 04:49:53 INFO - Available Modes on Display 0 04:49:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:49:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:49:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:49:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:49:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:49:53 INFO - Intel Iris: 04:49:53 INFO - Chipset Model: Intel Iris 04:49:53 INFO - Type: GPU 04:49:53 INFO - Bus: Built-In 04:49:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:49:53 INFO - Vendor: Intel (0x8086) 04:49:53 INFO - Device ID: 0x0a2e 04:49:53 INFO - Revision ID: 0x0009 04:49:53 INFO - Displays: 04:49:53 INFO - Display: 04:49:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:49:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:49:53 INFO - Display Serial Number: 1600x1200 60 04:49:53 INFO - Main Display: Yes 04:49:53 INFO - Mirror: Off 04:49:53 INFO - Online: Yes 04:49:53 INFO - Rotation: Supported 04:49:53 INFO - Return code: 0 04:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:53 INFO - Python 2.7.3 04:49:53 INFO - Return code: 0 04:49:53 INFO - grabbing minidump binary from tooltool 04:49:53 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')]} 04:49:53 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 0x1004b5d30>, '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 0x1003dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004aabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:53 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 04:49:53 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 04:49:53 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 04:49:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:53 INFO - Return code: 0 04:49:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:49:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:53 INFO - ENV: RUST_BACKTRACE is now 1 04:49:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:49:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:53 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 04:49:53 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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 04:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DA4OfwZFYb/Render', 04:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:53 INFO - 'HOME': '/Users/cltbld', 04:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:53 INFO - 'LOGNAME': 'cltbld', 04:49:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:53 INFO - 'MOZ_NO_REMOTE': '1', 04:49:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:53 INFO - 'NO_EM_RESTART': '1', 04:49:53 INFO - 'PAGER': '/bin/cat', 04:49:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:53 INFO - 'PWD': '/builds/slave/test', 04:49:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:53 INFO - 'RUST_BACKTRACE': '1', 04:49:53 INFO - 'SHELL': '/bin/bash', 04:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cAw5LITJ5i/Listeners', 04:49:53 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 04:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:53 INFO - 'USER': 'cltbld', 04:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:53 INFO - 'XPC_FLAGS': '0x0', 04:49:53 INFO - 'XPC_SERVICE_NAME': '0', 04:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:53 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 04:49:54 INFO - mozversion application_buildid: 20170425030221 04:49:54 INFO - mozversion application_changeset: a30dc237c3a600a5231f2974fc2b85dfb5513414 04:49:54 INFO - mozversion application_display_name: Nightly 04:49:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:54 INFO - mozversion application_name: Firefox 04:49:54 INFO - mozversion application_remotingname: firefox 04:49:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:49:54 INFO - mozversion application_vendor: Mozilla 04:49:54 INFO - mozversion application_version: 55.0a1 04:49:54 INFO - mozversion platform_buildid: 20170425030221 04:49:54 INFO - mozversion platform_changeset: a30dc237c3a600a5231f2974fc2b85dfb5513414 04:49:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:49:54 INFO - mozversion platform_version: 55.0a1 04:49:54 INFO - using testdate: 1493120994 04:49:54 INFO - actual date: 1493120994 04:49:54 INFO - starting webserver on 'localhost:49240' 04:49:54 INFO - SUITE-START | Running 2 tests 04:49:54 INFO - TEST-START | dromaeo_css 04:49:54 INFO - operating with platform_type : mac_ 04:49:54 INFO - Initialising browser for dromaeo_css test... 04:49:54 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpiFQr11/profile http://localhost:49240/getInfo.html) 04:49:57 INFO - PID 1636 | 2017-04-25 04:49:57.368 plugin-container[1639:7626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 04:49:57 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:57 INFO - PID 1636 | 2017-04-25 04:49:57.368 plugin-container[1639:7626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f1b, name = 'com.apple.CFPasteboardClient' 04:49:57 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:57 INFO - PID 1636 | 2017-04-25 04:49:57.368 plugin-container[1639:7626] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:49:57 INFO - PID 1636 | __metrics Screen width/height:1600/1200 04:49:57 INFO - PID 1636 | colorDepth:24 04:49:57 INFO - PID 1636 | Browser inner width/height: 1024/689 04:49:57 INFO - PID 1636 | __metrics 04:49:57 ERROR - PID 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 04:49:58 INFO - TEST-INFO | 1636: exit 0 04:49:58 INFO - Browser initialized. 04:49:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:58 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpiFQr11/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:00 INFO - PID 1640 | 2017-04-25 04:50:00.735 plugin-container[1641:7751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:50:00 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:00 INFO - PID 1640 | 2017-04-25 04:50:00.735 plugin-container[1641:7751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 04:50:00 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:00 INFO - PID 1640 | 2017-04-25 04:50:00.735 plugin-container[1641:7751] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:10 INFO - PID 1640 | RSS: Main: 236388352 04:50:10 INFO - PID 1640 | 04:53:14 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 04:53:16 INFO - PID 1640 | RSS: Main: 254619648 04:53:16 INFO - PID 1640 | 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:54:59 INFO - PID 1640 | 04:54:59 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:59 INFO - PID 1640 | Full stack: 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:54:59 INFO - PID 1640 | 04:54:59 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:59 INFO - PID 1640 | Full stack: 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:54:59 INFO - PID 1640 | 04:54:59 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:59 INFO - PID 1640 | Full stack: 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | ************************* 04:54:59 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:54:59 INFO - PID 1640 | 04:54:59 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:59 INFO - PID 1640 | Full stack: 04:54:59 INFO - PID 1640 | ************************* 04:56:18 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 04:56:18 INFO - PID 1640 | RSS: Main: 257159168 04:56:18 INFO - PID 1640 | 04:59:20 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 04:59:21 INFO - PID 1640 | RSS: Main: 267874304 04:59:21 INFO - PID 1640 | 05:02:23 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:02:23 INFO - PID 1640 | RSS: Main: 260599808 05:02:23 INFO - PID 1640 | 05:05:26 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:05:27 INFO - PID 1640 | RSS: Main: 269713408 05:05:27 INFO - PID 1640 | 05:08:28 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:08:29 INFO - PID 1640 | RSS: Main: 264425472 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | __start_tp_report 05:08:29 INFO - PID 1640 | _x_x_mozilla_page_load 05:08:29 INFO - PID 1640 | _x_x_mozilla_page_load_details 05:08:29 INFO - PID 1640 | |i|pagename|runs| 05:08:29 INFO - PID 1640 | |0;dojo.html;3222.7099561039504;3606.513120728701;3614.0964758810296;3641.9635803641954;3653.689436397906;5049.823256186034;5619.831405057855;5620.437956204382;6136.171616831726;6258.092576576394;6141;6159.722812473438;6191.133241346215;6247.5001999840015;6258.561900666944;5456.154296084113;5466.535344495723;5469.398366179717;5474.479924407175;5475.67145971241;5399.83800485986;5421.403645598981;5561.721913904288;5562.972185139069;5617.269754931853;4360.280553708634;5360.490753378423;5473.562115030828;5500.889982200333;5524.861878453051;5378.569714422837;5409.918851217235;5447.264619276426;5461.590380721462;5518.310211223597;5391.78432862685;5401.7299135043095;5409.891802163974;5421.349438067457;5429.891402171974;6116.908246376263;6117.694115294217;6285.9057114143325;6314.116023756677;6314.400131987454;6426.678666066725;6582.76960306387;6650.767223147167;6658.3674550917585;6659.167604049494;6830.180378354579;6863.313668633146;6865.897011544831;6871.381575658214;6878;6283.151774510383;6330.715117819663;6360.491160707133;6385.584936979081;6387.265464471552;5958.255218097738;6194.101855230966;6821.317868213139;6824.965875170692;6926.792196234121;6271.937280627135;6353.650549219838;6360.872782544416;6524.412802847766;6608.768693095719;6623.370779775913;6650.035744816974;6702.765403210864;6733.8653226935185;6747.662616869137;5320.882614650889;6640.83397915056;6646.53474256807;6651.634160121143;6658.933410665928;6320.4311611955145;6398.2641996170105;6411;6618.338166183439;6677.265500794909;5271.367435907716;5293.285406470154;5324.094903866275;5332.466753324714;5353.4646535346155;4731.124741922756;4734.621230301567;4735.644826638016;4741.028089241697;4756.881077973009;5119.3088932994315;6183.258009038944;6190.442860142519;6311.305756366796;6345.746170153142;5667.404922483162;6708.731650734014;6764.83087922796;6768.9661551691925;6795.456363490909;5310.522053015247;6342.39747224013;6363.140975968185;6379.393957574023;6381.425671689571;5667.886642267132;5892.234009578728;5922.822315330547;5971.731272092767;5995.070764031582;5563.944360556505;6751.4261287790105;6774.661266936732;6862.553933994274;6871.828204294733;6752.054712340178;6757.358050985148;6801.489888258499;6804.6257455840405;6826.010228516738;6836.794896152925;6871.03805467225;6934.306569343025;6936.306369363023;6941.201761797256;5781.554611347163;6333.493320534254;6417.743290268337;6567.704453299518;6620;6395.264544577433;6812.046313516211;6814.114165158498;6828.283030281749;6832.760853370109;6199;6319.52603554726;6562.5406221564035;6572.178477690289;6575.835604109936;5462.781488740406;6518.120053792867;6522;6524.641144737085;6641.435477984425;6266.655333956676;6307.621542707452;6318;6349.682515874096;6370.426661600478;5634.85912852182;6559.672016399066;6560.40956313934;6580.934190658032;6600.570962887397;6365.267994180728;6370.617762934239;6378.649174295273;6384.106225128393;6387.712552935222 05:08:29 INFO - PID 1640 | |1;ext.html;706.6749295324151;818.1082619944259;1085.6471646714815;1138.379583127195;1263.9178453400534;36329.636703632954;37464.25071498568;37485.625143748555;37534.43698344524;37535.30808648915;37190.88427347177;37198.44202336967;37429.25141497175;37550.06124846874;37578.060548486304;7888.763337099882;8032.1164671886045;8071.475354101994;8457.281131103864;8683.435576687527;8506.532140732257;8549.102344253857;8599.48403095813;8638.784030399258;8667.21995020448;8572.185642363966;8620.137986201393;8632.309415246766;8656.220940115389;8656.913430865674;8552.914470855274;8603.526806025666;8640.697575584856;8645.351598630128;8668;8480.618372173267;8525.95737021311;8540.359473039547;8551;8551.914480855174;33170.33659326824;36667.16664166781;37679.81160094209;37829.62170378288;38089.619103809164;3500.527428797105;3528.012156596157;3529.94705079424;3534.7172226222096;3538.0800991742076;30591.541126883116;30608.387832243232;30776.537402076574;30788.692113078807;30997.22506937322;3152.2277042124824;3192.5211218317204;3198.3603279343993;3202;3207.6471588125287;308436;310666;310857;311009;312960;39754;40487.98780030523;48589;49768.25347619789;50220.74889625602;49011.75494122578;49051.26423103656;49253.75373123112;49296.75351623291;49316.50683493191;13827.861721382858;13847.792283115761;14010.229437380838;14025.71948561023;14036.087654302437;11208.551657933755;11240.100791936626;11263.098952083814;11263.943680281545;11264.94367528157;13379.989502362085;13394.665133371744;13514.918806495456;13618.38717257706;13689.247091410069;5898;5948.702564871739;5961.970190149108;5964.343922168558;5968.462838344483;992.5880759484877;997.3218211616171;1017.725214192164;1019.8062368150028;1049.7323182588543;23993.760062399502;24877.62683559748;25057.498850022897;25079.24762257135;25198.496030079663;1102.3165637304921;1108.0913650806262;1136.732867776072;1145.6219447582278;1147.9827802582968;11006.009459148554;12678.366081695878;12786.041046921331;12831.35843207836;12879.356032198353;331580;331864;332362;332596.0884693804;332599;49053.754731226116;54156.45843541593;55812.441875581535;56422.717886410304;56786.7160664194;1507.3367718203956;1514.6592016796133;1551.7517197248385;1557.4548907882152;1558.5480210738986;20188.697169542174;23178.884105579364;24374.756252437248;24567;24718.382040449134;38906.416403754534;38947.610523895535;39096.80451597724;39144.6085539141;39237.41143882787;281023;282230;282845;282937;283328;27890.721092789623;34847.65152348545;35127.12182195466;35201.94394168179;35606.821965890005;45241.54758452505;45460;46135.53864461312;46135.76932115452;46219.613411597704;29964.850175748983;30913.072607821803;30944.381112378076;31499.685003149676;31810.840945795124;30678.589586385875;31023.68976310208;31090.75636974496;31109.688903111586;31229.487377422694;37459;37651;37694.246115078095;37822;37828.81085594554;29491.705082949753;29884.252893677833;30132;30335.69664303417;30433;24884.751152488967;24944.875275623504;24968.126115585867;25063.87468062648;25154.496910062062 05:08:29 INFO - PID 1640 | |2;jquery.html;347.260335485416;355.9626239244878;417.5469615467219;417.6846480906915;451.09780439121755;18414.631707365843;21436.89281553592;22163.113475461003;22177.889110554446;23356.41608959777;22755;23059.385842990956;23153.305400838002;23164;23243;6090.269167699882;6349.650769207692;6381.553291269613;6393.0730044143575;6401.679916004205;5985.4912332451795;6149.16986206863;6158.07628855673;6218.875622487548;6230.719617617196;6169.660668663244;6208.161898143738;6214.471769899541;6218.160548325964;6230.781922632709;6003.879922401549;6179.2893817210925;6229.25248970122;6295.937040629627;6298.338674439209;5386.218998245272;5519.779208831682;5627.324721033461;5643.943560564424;5645.520130788888;27147.72852271472;27343.45313093727;27503.587446188325;27668.72331276702;27785.027524036763;2227.9888600557056;2281.840271181018;2291.713535808024;2296.3455415206586;2299.3331933739196;14917.701645967129;14960.700785984329;15313.540593782205;17870.642587148315;18376.816231837645;2193.5064610462678;2208.7349518057777;2215.878126703031;2227.721534808149;2232.598132336179;169907.1504642469;170698;171809;172228;173142.26857731387;12911.870881291256;12999.09006369564;13083.215007099605;13182.868171318356;13239.602811915658;16820.6635867282;16839.915800421164;16845;16880.324787008627;16885.40901068457;8795.956020219857;9079.50062746542;9134.22359099484;9278.907210927804;9288.024757400512;8672.392932494791;8680.392372533988;8686.174813392718;8859.158379953895;8878.378513504122;7940;8089.393295502743;8109.959450202711;8129.9187008129165;8137.471064380797;2183.639699449605;2192.397090800043;2192.539566690981;2193.484531135182;2392.892319845611;870.5386145342978;966.7244835221928;982.8820541534918;994.7015895231401;997.2670087485692;21406.143754249966;21451.463713406978;21524.677129843065;21582.35252942414;21921;997.0677416615488;997.6159178716247;1014.9340292880939;1018.6842078955399;1028.876534815812;9552.42685438876;10903.618373356894;11288.661340159808;11296.322220666787;11340.376279304717;554665;560943;566873;572512;578250;135351.32324338314;142793;144008.27995859954;145805;147337.2633136849;1079.8002369561657;1197.91588612306;1249.6376050945123;1253.8244645749785;1254.0406588959454;19677.901610491856;20426.285080022128;22433.43916402103;22848.77151228533;23064;59699.701501492214;60024.19806415564;60063.69968150131;60472.697636513294;60825.69587152036;61872;82133.9466513318;82331.17668823474;83181.58409208157;83779;8196.688529835197;8926.73219803381;9173.312001599774;9203.35576509638;9305.813883722152;14197.929010354883;14460.27698615044;14511.346989385293;14561.199134047305;14712.926435367755;11855.58505452305;11957.461914213707;12202;12215.083868709704;12268.631941041784;10490.108340791117;11213.60752373663;11500.94249528747;11708.824367634323;11720.589779357682;12061.51753929833;12073;12334.938325308674;12371.876281237073;12374.876251237733;8904.643814247358;8909.465432074096;9231.399959002643;9264.629414823332;9309.906900931175;10070.295079344376;12123.81814272769;12228.44971976281;12261.816072758736;12322.32227227511 05:08:29 INFO - PID 1640 | |3;mootools.html;1143.6854864912148;1208.7340785027293;1432.7119261295327;1433.6344232220786;1440.3878351700525;11355.261907975975;11531.769364612703;11887.643370698872;11999.580014699488;12021.098417618681;11578.884211157885;11691;11766.117541184403;11781.29312241266;11886.108541859352;2497.2508247525716;2540.060177734241;2563.628273900283;2564.269183282765;2567.4351642638685;2372.181597348912;2423.2245681381964;2425.842320249187;2429.53838770633;2436.062116085302;2500.174942269056;2502.5245203411296;2535.2014115553543;2542.83471574348;2550.7831834294107;2495.1142344467726;2509.29739672891;2524.1670248817845;2524.7096583892903;2537.112010796225;2441.340837973737;2478.95042099157;2493.5760920643534;2493.912713055034;2552.387427017521;11796.646100616996;11945.641630751092;12034.33811140387;12044.277343359427;12057.758844823054;6595.835104122388;6864.347886950732;6876.965615171892;6877.1747390312985;6887;4113.177364527077;4441.444819397575;4501.932471012938;4512.954870451319;4536.319552067183;1265.7721610110177;1273.2424207596466;1302.6417735122916;1316.6971596532755;1317.308413083139;14560.417583296761;15118;16223.269952852032;16689.415870444474;16844.747328789956;5202.479752024768;5727.455891690282;5892.499137573354;5902.763889444374;5908.438698323653;12234.81647775284;12368.75262494745;12379.504819807107;12411.379431028412;12420.875791241971;6612.437942774822;6636.435902948207;6652.06871038055;6664.500162487736;6668.466522678271;6073.605215660968;6094.177286066413;6226.25284965807;6236.064590311489;6244.594101383395;3629.073462217871;4451.310046942729;4490.687296042541;4520.706154099973;4578.153041687298;1284.6767829135817;1306.3729409883308;1309.5154792726753;1319.9604011879467;1322.6693326668333;791.5092642561533;793.8291020744356;814.8085199978001;815.9143289954469;843.725789118539;5927.851803704942;6085.604435711664;6096.512279017668;6281.623102613767;6357.141785858942;576.2221001647742;588.808637192914;597.6951754605183;608.1121562518683;609.1411110334407;3881.573026967031;4032.415299781574;4193.6645068394455;4212.789360531961;4330.17726631939;13856.861431385758;15057.397704091933;15191.848081519265;15221.391144354102;15234;14470.782938255934;15085.54743357701;15091;15127.16800575979;15219.162946037854;7559.433042521723;8438.662453501915;8633.870491942625;8663.78340541479;8688.435251708619;5972.910406343822;6852.211995620568;7078.787636370917;7109.75115870942;7176.497645164788;12545.874541254836;12808.551700690432;12863.970882329204;12870.678233043875;12964.675883102998;11258.493367798304;11612.767744645229;13653.044286900218;13752.106113102616;13791.241481718602;9567.330286879851;9821.754456138653;9833.016698330395;9855.901440985499;9872.654457093968;8106.959465202636;10846.349219046882;10865.348079115278;10966.780664386508;10973.067289280181;9203.355765096647;9240.214581760625;9310.581023853807;9335.53322333867;9338.859917101114;7371.631418429164;7595.354394876276;9036.141566551167;9068.911730592108;9296.256299495888;6797.456203503807;8270.917290827014;8355.582220889053;8362.749117526484;8372.037215720271;6013.9699301503215;6059.272887253558;6134.969325153345;6200.7519699211525;6258.280297765815;6055.091736239423;6141.539319798328;6185.103160041859;6290.025046117859;6310.968445157745 05:08:29 INFO - PID 1640 | |4;prototype.html;340.5776836722464;373.66556931546285;385.5200275656808;398.2671883733931;411.31926661375417;4671.743054132022;6176.444120029197;6253.1245625612455;6305.684715764216;6320.74717011319;6039.1545183674325;6169.290531588868;6189.969050154743;6200.720967556459;6215.254169499666;4405.273129933557;4549.7725113744345;4551.381651586979;4551.476580193271;4590.301588412292;4123.567025462328;4435.512093669694;4530.66020048496;4547;4549.203889319372;4504.8873778155485;4511.35335602506;4536.500984891659;4537.909241815161;4541.72749635023;3364.831758412082;3573.821308934556;4283.593058659422;4419.226635338803;4491.955080449186;3228.6287076986214;3862.1889403225077;3866.3427217372832;3877.243937432202;3880.5835869907564;6027.246594175728;6031.366706495843;6043.244594425697;6076.817695469143;6076.96961515194;4867.862317030531;5028.044671512437;5138.332016837825;5172.948270517322;5363.326121606712;5439.456054394568;5734.713264336767;6627.502937279675;6655.633940133291;6669.866602667968;4256.574342565749;4422.71252368595;4441.71128876622;4443.888902777424;4467.620252278561;5529.811245380989;5941.257342832103;6972.442204623669;7025.630002149583;7054.365107140331;3803.2773772983046;4421.42521472213;4470.307102399133;4473.7986790594505;4506.377704026548;3670.8531658733887;4215.683823713233;4336.848210312624;4590.97704511482;4604.700694454849;5166.354205724285;5230.947690523046;5370.3287089113865;5426.647267927572;5428.185772134211;6126.019836826086;6580.1246644706025;6642.402183803384;6646.767363142267;6664;1523.6495606010458;1561.242797243336;1561.461295852929;1568.4118455579157;1572.771948067524;853.6116067189414;906.3429013964954;924.2513564013171;989.4805227255748;1016.7915577306634;5538.972305138448;5783.826485205451;6230.7507699691505;6246.031865060922;6254.812355629248;6551.934480655228;6584.703688334036;6625.370589793962;6806.659667016629;6809.829754256183;6217.098520714471;6229.7508099676415;6254.6247225166635;6255.437010669061;6266.342034086355;3108.8601012954473;3212.8594349006235;3555.8933232002564;3577.821108944542;3603.1352475405715;6145.754169833246;7000.894986575206;7055.294470553006;7059.3763434410375;7077.398421134261;6176.598521096114;6747.730090796412;6902.344277293649;7031.08595882532;7048.330408611174;6544.9672751635935;7001.92998070023;7029.402500787388;7158.606276654626;7160;6673.731990921709;6845.520813543203;6928.1986683461655;6935.930640693528;6939.653017349011;5083.364579427572;6368.554201206057;6650.467962562887;6816.909294512854;6822.829429264308;6914.27400123;7158.713651453883;7159.355657990805;7183.988483224705;7214.098237720285;3851.326017946904;4507.323901414814;4519.435070616173;4526.841560545365;4529.932051019303;5992.790252341147;6917.827054323682;6970.721171153097;6972.372486476242;7003.4397248219;6542.54202205841;6555.934440655532;6627.966860165861;6642.701078451385;6723.596584204964;5447.291852059207;5772;6522.923717586545;6670;6687.732490700318;6280.152179455898;6477.093206951125;6566.343365663395;6598.1422415085735;6645.1361323027695;5517.586181036519;6650.273387910934;6663.200415950117;6714.697838597177;6768;5427.538659214011;6076.936536106252;6109.327973922954;6438.227412710317;6521.217453905561 05:08:29 INFO - PID 1640 | |5;yui.html;798.7084714079361;817.8650522663753;828.300086426969;847.0936098374738;852.9892077887704;16048.598785030366;16531;16542;18494.260229590833;18989.62020759584;17608.503277221418;17745.37891173809;17885.7317140243;17979.19093640786;18403.44789656309;730.8867125595541;950.8906475755308;952.7237101240667;955.2024059909949;957.042957042957;972.6012334942675;985.5170966226533;986.4623780039859;987.0179171724144;987.8765154355706;1007.4459047523869;1019.6329321444274;1019.9286049976505;1020.2246292817475;1020.2959957629212;990.4750482244386;1015.3907655406771;1016.3749294184097;1017.2421545948242;1020.5305559442666;715.5599306426562;722.4112348436008;735.1325435985535;750.1972889008763;751.3913729878816;16470.011799292082;16532.586685332844;16745.581360465963;16752.078635675156;16765.329386824513;16545.420910268083;16927.984320940785;16967.660646787117;17230.569235769082;17304.394346197947;13665.521706740315;13781.448742050306;13953.232572208524;14069.085509441853;14092.506762263374;3461.3769521486124;3534.8762793302367;3538.964610353915;3539.292141571696;3540.2388486475274;94562;113988.78258000623;119833;131329;132845;12303.938480307721;12757.362131893367;13258.40337184829;13455.596332110052;13583.728325433436;24998.00007999696;25468.981240750163;25470.617940730903;25902.740972590032;25949.870250648626;7879.0151231096115;7979.202079791974;7997.040355157418;8001.5599142046585;8006.519608823489;3848.942265866014;3932.134930315326;3962.3264045111823;4016;4060.451839001697;3431.553897993245;4233.491980962304;4284.357346398003;4364.083542456056;4380.4305440292555;930.50683137937;958.9664361747306;967.9032096790405;969.5152423788106;971.2569884038575;571.2659232885804;642.3512252624789;652.324843786688;656.5338609587246;676.4689718570899;9388.436693798394;10849.945750271198;11180.552777888955;11427.542898284142;12361.62915112548;558.9189567512769;657.8486948001986;670.165643773505;675.5271310082961;688.683205725362;4048.473698419187;5300.549453296436;5451.454854514517;5474.753636086386;5538.47384498472;76557.46885062268;87030.82422939477;89293;98721.50639246758;99725;62807;83988;84545.73181402285;85313.57343213244;85584;68837.62324753476;69203.65398173078;69572.652136739;69830;70601.64699176574;9188.862167067633;9809.577611246472;10457.58169673235;12267.75464490723;12474.812877807022;27422.45155096927;39339.60660393474;39588;39978;40462.78611641655;60957.47606309878;62935;72383.63808180926;73489;74318.62840685979;14460.421583136556;15596.532104036896;15894.602634933757;16012.919935400249;16016.119113448873;17588.648227035133;17599.736003959693;17705.911470442566;17912.462626121236;17931.820681793535;16147.596310092342;16287;16402.343906243615;16449.917750411172;16465.01209927408;15839;16231.107289099213;16298.67402651964;16298.837011629732;17130.40043598468;16130.354785808437;16305.836941630907;16633.168341583114;16831.495055148363;16858.241379137722;11697.824532631847;11738.647840564796;11829.171957963204;11842.348670823187;12177.69555761113;12439.315837629018;13240.668983275495;13339.132956357806;13648.86351136476;13844.961627877748 05:08:29 INFO - PID 1640 | __end_tp_report 05:08:29 INFO - PID 1640 | __start_cc_report 05:08:29 INFO - PID 1640 | _x_x_mozilla_cycle_collect,417 05:08:29 INFO - PID 1640 | __end_cc_report 05:08:29 INFO - PID 1640 | __startTimestamp1493122109158__endTimestamp 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | ------- Summary: start ------- 05:08:29 INFO - PID 1640 | Number of tests: 6 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6091.06 Median:6333.49 stddev:740.05 (11.7%) stddev-sans-first:707.28 05:08:29 INFO - PID 1640 | Values: 3222.7 3606.5 3614.1 3642.0 3653.7 5049.8 5619.8 5620.4 6136.2 6258.1 6141.0 6159.7 6191.1 6247.5 6258.6 5456.2 5466.5 5469.4 5474.5 5475.7 5399.8 5421.4 5561.7 5563.0 5617.3 4360.3 5360.5 5473.6 5500.9 5524.9 5378.6 5409.9 5447.3 5461.6 5518.3 5391.8 5401.7 5409.9 5421.3 5429.9 6116.9 6117.7 6285.9 6314.1 6314.4 6426.7 6582.8 6650.8 6658.4 6659.2 6830.2 6863.3 6865.9 6871.4 6878.0 6283.2 6330.7 6360.5 6385.6 6387.3 5958.3 6194.1 6821.3 6825.0 6926.8 6271.9 6353.7 6360.9 6524.4 6608.8 6623.4 6650.0 6702.8 6733.9 6747.7 5320.9 6640.8 6646.5 6651.6 6658.9 6320.4 6398.3 6411.0 6618.3 6677.3 5271.4 5293.3 5324.1 5332.5 5353.5 4731.1 4734.6 4735.6 4741.0 4756.9 5119.3 6183.3 6190.4 6311.3 6345.7 5667.4 6708.7 6764.8 6769.0 6795.5 5310.5 6342.4 6363.1 6379.4 6381.4 5667.9 5892.2 5922.8 5971.7 5995.1 5563.9 6751.4 6774.7 6862.6 6871.8 6752.1 6757.4 6801.5 6804.6 6826.0 6836.8 6871.0 6934.3 6936.3 6941.2 5781.6 6333.5 6417.7 6567.7 6620.0 6395.3 6812.0 6814.1 6828.3 6832.8 6199.0 6319.5 6562.5 6572.2 6575.8 5462.8 6518.1 6522.0 6524.6 6641.4 6266.7 6307.6 6318.0 6349.7 6370.4 5634.9 6559.7 6560.4 6580.9 6600.6 6365.3 6370.6 6378.6 6384.1 6387.7 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:45826.23 Median:332479.04 stddev:81128.53 (24.4%) stddev-sans-first:81285.38 05:08:29 INFO - PID 1640 | Values: 706.7 818.1 1085.6 1138.4 1263.9 36329.6 37464.3 37485.6 37534.4 37535.3 37190.9 37198.4 37429.3 37550.1 37578.1 7888.8 8032.1 8071.5 8457.3 8683.4 8506.5 8549.1 8599.5 8638.8 8667.2 8572.2 8620.1 8632.3 8656.2 8656.9 8552.9 8603.5 8640.7 8645.4 8668.0 8480.6 8526.0 8540.4 8551.0 8551.9 33170.3 36667.2 37679.8 37829.6 38089.6 3500.5 3528.0 3529.9 3534.7 3538.1 30591.5 30608.4 30776.5 30788.7 30997.2 3152.2 3192.5 3198.4 3202.0 3207.6 308436.0 310666.0 310857.0 311009.0 312960.0 39754.0 40488.0 48589.0 49768.3 50220.7 49011.8 49051.3 49253.8 49296.8 49316.5 13827.9 13847.8 14010.2 14025.7 14036.1 11208.6 11240.1 11263.1 11263.9 11264.9 13380.0 13394.7 13514.9 13618.4 13689.2 5898.0 5948.7 5962.0 5964.3 5968.5 992.6 997.3 1017.7 1019.8 1049.7 23993.8 24877.6 25057.5 25079.2 25198.5 1102.3 1108.1 1136.7 1145.6 1148.0 11006.0 12678.4 12786.0 12831.4 12879.4 331580.0 331864.0 332362.0 332596.1 332599.0 49053.8 54156.5 55812.4 56422.7 56786.7 1507.3 1514.7 1551.8 1557.5 1558.5 20188.7 23178.9 24374.8 24567.0 24718.4 38906.4 38947.6 39096.8 39144.6 39237.4 281023.0 282230.0 282845.0 282937.0 283328.0 27890.7 34847.7 35127.1 35201.9 35606.8 45241.5 45460.0 46135.5 46135.8 46219.6 29964.9 30913.1 30944.4 31499.7 31810.8 30678.6 31023.7 31090.8 31109.7 31229.5 37459.0 37651.0 37694.2 37822.0 37828.8 29491.7 29884.3 30132.0 30335.7 30433.0 24884.8 24944.9 24968.1 25063.9 25154.5 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:37203.68 Median:23061.69 stddev:96883.49 (420.1%) stddev-sans-first:97115.75 05:08:29 INFO - PID 1640 | Values: 347.3 356.0 417.5 417.7 451.1 18414.6 21436.9 22163.1 22177.9 23356.4 22755.0 23059.4 23153.3 23164.0 23243.0 6090.3 6349.7 6381.6 6393.1 6401.7 5985.5 6149.2 6158.1 6218.9 6230.7 6169.7 6208.2 6214.5 6218.2 6230.8 6003.9 6179.3 6229.3 6295.9 6298.3 5386.2 5519.8 5627.3 5643.9 5645.5 27147.7 27343.5 27503.6 27668.7 27785.0 2228.0 2281.8 2291.7 2296.3 2299.3 14917.7 14960.7 15313.5 17870.6 18376.8 2193.5 2208.7 2215.9 2227.7 2232.6 169907.2 170698.0 171809.0 172228.0 173142.3 12911.9 12999.1 13083.2 13182.9 13239.6 16820.7 16839.9 16845.0 16880.3 16885.4 8796.0 9079.5 9134.2 9278.9 9288.0 8672.4 8680.4 8686.2 8859.2 8878.4 7940.0 8089.4 8110.0 8129.9 8137.5 2183.6 2192.4 2192.5 2193.5 2392.9 870.5 966.7 982.9 994.7 997.3 21406.1 21451.5 21524.7 21582.4 21921.0 997.1 997.6 1014.9 1018.7 1028.9 9552.4 10903.6 11288.7 11296.3 11340.4 554665.0 560943.0 566873.0 572512.0 578250.0 135351.3 142793.0 144008.3 145805.0 147337.3 1079.8 1197.9 1249.6 1253.8 1254.0 19677.9 20426.3 22433.4 22848.8 23064.0 59699.7 60024.2 60063.7 60472.7 60825.7 61872.0 82133.9 82331.2 83181.6 83779.0 8196.7 8926.7 9173.3 9203.4 9305.8 14197.9 14460.3 14511.3 14561.2 14712.9 11855.6 11957.5 12202.0 12215.1 12268.6 10490.1 11213.6 11500.9 11708.8 11720.6 12061.5 12073.0 12334.9 12371.9 12374.9 8904.6 8909.5 9231.4 9264.6 9309.9 10070.3 12123.8 12228.4 12261.8 12322.3 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7083.51 Median:3956.99 stddev:4455.77 (112.6%) stddev-sans-first:4445.91 05:08:29 INFO - PID 1640 | Values: 1143.7 1208.7 1432.7 1433.6 1440.4 11355.3 11531.8 11887.6 11999.6 12021.1 11578.9 11691.0 11766.1 11781.3 11886.1 2497.3 2540.1 2563.6 2564.3 2567.4 2372.2 2423.2 2425.8 2429.5 2436.1 2500.2 2502.5 2535.2 2542.8 2550.8 2495.1 2509.3 2524.2 2524.7 2537.1 2441.3 2479.0 2493.6 2493.9 2552.4 11796.6 11945.6 12034.3 12044.3 12057.8 6595.8 6864.3 6877.0 6877.2 6887.0 4113.2 4441.4 4501.9 4513.0 4536.3 1265.8 1273.2 1302.6 1316.7 1317.3 14560.4 15118.0 16223.3 16689.4 16844.7 5202.5 5727.5 5892.5 5902.8 5908.4 12234.8 12368.8 12379.5 12411.4 12420.9 6612.4 6636.4 6652.1 6664.5 6668.5 6073.6 6094.2 6226.3 6236.1 6244.6 3629.1 4451.3 4490.7 4520.7 4578.2 1284.7 1306.4 1309.5 1320.0 1322.7 791.5 793.8 814.8 815.9 843.7 5927.9 6085.6 6096.5 6281.6 6357.1 576.2 588.8 597.7 608.1 609.1 3881.6 4032.4 4193.7 4212.8 4330.2 13856.9 15057.4 15191.8 15221.4 15234.0 14470.8 15085.5 15091.0 15127.2 15219.2 7559.4 8438.7 8633.9 8663.8 8688.4 5972.9 6852.2 7078.8 7109.8 7176.5 12545.9 12808.6 12864.0 12870.7 12964.7 11258.5 11612.8 13653.0 13752.1 13791.2 9567.3 9821.8 9833.0 9855.9 9872.7 8107.0 10846.3 10865.3 10966.8 10973.1 9203.4 9240.2 9310.6 9335.5 9338.9 7371.6 7595.4 9036.1 9068.9 9296.3 6797.5 8270.9 8355.6 8362.7 8372.0 6014.0 6059.3 6135.0 6200.8 6258.3 6055.1 6141.5 6185.1 6290.0 6311.0 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5317.32 Median:6093.15 stddev:1714.83 (28.1%) stddev-sans-first:1678.46 05:08:29 INFO - PID 1640 | Values: 340.6 373.7 385.5 398.3 411.3 4671.7 6176.4 6253.1 6305.7 6320.7 6039.2 6169.3 6190.0 6200.7 6215.3 4405.3 4549.8 4551.4 4551.5 4590.3 4123.6 4435.5 4530.7 4547.0 4549.2 4504.9 4511.4 4536.5 4537.9 4541.7 3364.8 3573.8 4283.6 4419.2 4492.0 3228.6 3862.2 3866.3 3877.2 3880.6 6027.2 6031.4 6043.2 6076.8 6077.0 4867.9 5028.0 5138.3 5172.9 5363.3 5439.5 5734.7 6627.5 6655.6 6669.9 4256.6 4422.7 4441.7 4443.9 4467.6 5529.8 5941.3 6972.4 7025.6 7054.4 3803.3 4421.4 4470.3 4473.8 4506.4 3670.9 4215.7 4336.8 4591.0 4604.7 5166.4 5230.9 5370.3 5426.6 5428.2 6126.0 6580.1 6642.4 6646.8 6664.0 1523.6 1561.2 1561.5 1568.4 1572.8 853.6 906.3 924.3 989.5 1016.8 5539.0 5783.8 6230.8 6246.0 6254.8 6551.9 6584.7 6625.4 6806.7 6809.8 6217.1 6229.8 6254.6 6255.4 6266.3 3108.9 3212.9 3555.9 3577.8 3603.1 6145.8 7000.9 7055.3 7059.4 7077.4 6176.6 6747.7 6902.3 7031.1 7048.3 6545.0 7001.9 7029.4 7158.6 7160.0 6673.7 6845.5 6928.2 6935.9 6939.7 5083.4 6368.6 6650.5 6816.9 6822.8 6914.3 7158.7 7159.4 7184.0 7214.1 3851.3 4507.3 4519.4 4526.8 4529.9 5992.8 6917.8 6970.7 6972.4 7003.4 6542.5 6555.9 6628.0 6642.7 6723.6 5447.3 5772.0 6522.9 6670.0 6687.7 6280.2 6477.1 6566.3 6598.1 6645.1 5517.6 6650.3 6663.2 6714.7 6768.0 5427.5 6076.9 6109.3 6438.2 6521.2 05:08:29 INFO - PID 1640 | 05:08:29 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:20794.14 Median:15427.00 stddev:28340.23 (183.7%) stddev-sans-first:28379.96 05:08:29 INFO - PID 1640 | Values: 798.7 817.9 828.3 847.1 853.0 16048.6 16531.0 16542.0 18494.3 18989.6 17608.5 17745.4 17885.7 17979.2 18403.4 730.9 950.9 952.7 955.2 957.0 972.6 985.5 986.5 987.0 987.9 1007.4 1019.6 1019.9 1020.2 1020.3 990.5 1015.4 1016.4 1017.2 1020.5 715.6 722.4 735.1 750.2 751.4 16470.0 16532.6 16745.6 16752.1 16765.3 16545.4 16928.0 16967.7 17230.6 17304.4 13665.5 13781.4 13953.2 14069.1 14092.5 3461.4 3534.9 3539.0 3539.3 3540.2 94562.0 113988.8 119833.0 131329.0 132845.0 12303.9 12757.4 13258.4 13455.6 13583.7 24998.0 25469.0 25470.6 25902.7 25949.9 7879.0 7979.2 7997.0 8001.6 8006.5 3848.9 3932.1 3962.3 4016.0 4060.5 3431.6 4233.5 4284.4 4364.1 4380.4 930.5 959.0 967.9 969.5 971.3 571.3 642.4 652.3 656.5 676.5 9388.4 10849.9 11180.6 11427.5 12361.6 558.9 657.8 670.2 675.5 688.7 4048.5 5300.5 5451.5 5474.8 5538.5 76557.5 87030.8 89293.0 98721.5 99725.0 62807.0 83988.0 84545.7 85313.6 85584.0 68837.6 69203.7 69572.7 69830.0 70601.6 9188.9 9809.6 10457.6 12267.8 12474.8 27422.5 39339.6 39588.0 39978.0 40462.8 60957.5 62935.0 72383.6 73489.0 74318.6 14460.4 15596.5 15894.6 16012.9 16016.1 17588.6 17599.7 17705.9 17912.5 17931.8 16147.6 16287.0 16402.3 16449.9 16465.0 15839.0 16231.1 16298.7 16298.8 17130.4 16130.4 16305.8 16633.2 16831.5 16858.2 11697.8 11738.6 11829.2 11842.3 12177.7 12439.3 13240.7 13339.1 13648.9 13845.0 05:08:29 INFO - PID 1640 | -------- Summary: end -------- 05:08:29 INFO - PID 1640 | 05:08:29 INFO - TEST-INFO | 1640: exit 0 05:08:29 INFO - TEST-OK | dromaeo_css | took 1115776ms 05:08:29 INFO - TEST-START | kraken 05:08:29 INFO - operating with platform_type : mac_ 05:08:29 INFO - Initialising browser for kraken test... 05:08:29 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpQfof7a/profile http://localhost:49240/getInfo.html) 05:08:32 INFO - PID 1651 | 2017-04-25 05:08:32.696 plugin-container[1653:10137] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 05:08:32 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:32 INFO - PID 1651 | 2017-04-25 05:08:32.697 plugin-container[1653:10137] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 05:08:32 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:32 INFO - PID 1651 | 2017-04-25 05:08:32.697 plugin-container[1653:10137] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:32 INFO - PID 1651 | __metrics Screen width/height:1600/1200 05:08:32 INFO - PID 1651 | colorDepth:24 05:08:32 INFO - PID 1651 | Browser inner width/height: 1024/689 05:08:32 INFO - PID 1651 | __metrics 05:08:32 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 05:08:33 INFO - TEST-INFO | 1651: exit 0 05:08:33 INFO - Browser initialized. 05:08:33 INFO - Running cycle 1/1 for kraken test... 05:08:33 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpQfof7a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:36 INFO - PID 1654 | 2017-04-25 05:08:36.036 plugin-container[1655:10265] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x483f, name = 'com.apple.tsm.portname' 05:08:36 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:36 INFO - PID 1654 | 2017-04-25 05:08:36.036 plugin-container[1655:10265] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 05:08:36 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:36 INFO - PID 1654 | 2017-04-25 05:08:36.036 plugin-container[1655:10265] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:45 INFO - PID 1654 | RSS: Main: 237539328 05:08:45 INFO - PID 1654 | 05:08:48 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:49 INFO - PID 1654 | RSS: Main: 249692160 05:08:49 INFO - PID 1654 | 05:08:52 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:08:52 INFO - PID 1654 | RSS: Main: 257892352 05:08:52 INFO - PID 1654 | 05:08:56 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:08:56 INFO - PID 1654 | RSS: Main: 260177920 05:08:56 INFO - PID 1654 | 05:08:58 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:08:59 INFO - PID 1654 | RSS: Main: 261287936 05:08:59 INFO - PID 1654 | 05:09:01 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:01 INFO - PID 1654 | RSS: Main: 261857280 05:09:01 INFO - PID 1654 | 05:09:04 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:05 INFO - PID 1654 | RSS: Main: 268607488 05:09:05 INFO - PID 1654 | 05:09:08 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:09 INFO - PID 1654 | RSS: Main: 270069760 05:09:09 INFO - PID 1654 | 05:09:12 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:09:12 INFO - PID 1654 | RSS: Main: 268988416 05:09:12 INFO - PID 1654 | 05:09:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:14 INFO - PID 1654 | RSS: Main: 268894208 05:09:14 INFO - PID 1654 | 05:09:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:17 INFO - PID 1654 | RSS: Main: 268890112 05:09:17 INFO - PID 1654 | 05:09:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:20 INFO - PID 1654 | RSS: Main: 268582912 05:09:20 INFO - PID 1654 | 05:09:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:23 INFO - PID 1654 | RSS: Main: 268513280 05:09:23 INFO - PID 1654 | 05:09:26 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:27 INFO - PID 1654 | RSS: Main: 268881920 05:09:27 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:09:29 INFO - PID 1654 | RSS: Main: 270467072 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | __start_tp_report 05:09:29 INFO - PID 1654 | _x_x_mozilla_page_load 05:09:29 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:09:29 INFO - PID 1654 | |i|pagename|runs| 05:09:29 INFO - PID 1654 | |0;ai-astar;103;116;114;114;115;113;115;114;115;116 05:09:29 INFO - PID 1654 | |1;audio-beat-detection;140;105;114;147;129;147;141;123;138;114 05:09:29 INFO - PID 1654 | |2;audio-dft;193;222;196;240;264;230;193;200;205;284 05:09:29 INFO - PID 1654 | |3;audio-fft;77;55;56;79;61;57;58;59;87;86 05:09:29 INFO - PID 1654 | |4;audio-oscillator;90;71;85;72;71;56;84;71;85;116 05:09:29 INFO - PID 1654 | |5;imaging-gaussian-blur;99;91;91;91;93;92;91;91;93;138 05:09:29 INFO - PID 1654 | |6;imaging-darkroom;97;99;99;98;99;98;99;128;116;99 05:09:29 INFO - PID 1654 | |7;imaging-desaturate;96;91;90;92;93;95;92;93;112;139 05:09:29 INFO - PID 1654 | |8;json-parse-financial;48;51;50;50;49;50;51;52;52;50 05:09:29 INFO - PID 1654 | |9;json-stringify-tinderbox;58;58;58;58;67;60;58;56;57;58 05:09:29 INFO - PID 1654 | |10;stanford-crypto-aes;81;85;83;84;83;85;82;87;85;83 05:09:29 INFO - PID 1654 | |11;stanford-crypto-ccm;152;133;137;134;132;136;155;143;179;130 05:09:29 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;183;183;184;202;228;230;186;187;183;190 05:09:29 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;71;70;66;67;68;65;69;69;67;67 05:09:29 INFO - PID 1654 | __end_tp_report 05:09:29 INFO - PID 1654 | __start_cc_report 05:09:29 INFO - PID 1654 | _x_x_mozilla_cycle_collect,995 05:09:29 INFO - PID 1654 | __end_cc_report 05:09:29 INFO - PID 1654 | __startTimestamp1493122169386__endTimestamp 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | ------- Summary: start ------- 05:09:29 INFO - PID 1654 | Number of tests: 14 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:1.00 05:09:29 INFO - PID 1654 | Values: 103.0 116.0 114.0 114.0 115.0 113.0 115.0 114.0 115.0 116.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:139.00 stddev:15.09 (10.9%) stddev-sans-first:15.55 05:09:29 INFO - PID 1654 | Values: 140.0 105.0 114.0 147.0 129.0 147.0 141.0 123.0 138.0 114.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:222.70 Median:226.00 stddev:31.84 (14.1%) stddev-sans-first:31.90 05:09:29 INFO - PID 1654 | Values: 193.0 222.0 196.0 240.0 264.0 230.0 193.0 200.0 205.0 284.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:67.50 Median:69.00 stddev:13.12 (19.0%) stddev-sans-first:13.45 05:09:29 INFO - PID 1654 | Values: 77.0 55.0 56.0 79.0 61.0 57.0 58.0 59.0 87.0 86.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:78.00 stddev:16.14 (20.7%) stddev-sans-first:16.72 05:09:29 INFO - PID 1654 | Values: 90.0 71.0 85.0 72.0 71.0 56.0 84.0 71.0 85.0 116.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:91.50 stddev:14.61 (16.0%) stddev-sans-first:15.48 05:09:29 INFO - PID 1654 | Values: 99.0 91.0 91.0 91.0 93.0 92.0 91.0 91.0 93.0 138.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:99.00 stddev:10.33 (10.4%) stddev-sans-first:10.71 05:09:29 INFO - PID 1654 | Values: 97.0 99.0 99.0 98.0 99.0 98.0 99.0 128.0 116.0 99.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:92.50 stddev:15.30 (16.5%) stddev-sans-first:16.19 05:09:29 INFO - PID 1654 | Values: 96.0 91.0 90.0 92.0 93.0 95.0 92.0 93.0 112.0 139.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:1.25 (2.5%) stddev-sans-first:1.01 05:09:29 INFO - PID 1654 | Values: 48.0 51.0 50.0 50.0 49.0 50.0 51.0 52.0 52.0 50.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.00 stddev:3.05 (5.3%) stddev-sans-first:3.22 05:09:29 INFO - PID 1654 | Values: 58.0 58.0 58.0 58.0 67.0 60.0 58.0 56.0 57.0 58.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:1.75 (2.1%) stddev-sans-first:1.54 05:09:29 INFO - PID 1654 | Values: 81.0 85.0 83.0 84.0 83.0 85.0 82.0 87.0 85.0 83.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.00 stddev:15.19 (10.9%) stddev-sans-first:15.77 05:09:29 INFO - PID 1654 | Values: 152.0 133.0 137.0 134.0 132.0 136.0 155.0 143.0 179.0 130.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:188.50 stddev:18.51 (9.8%) stddev-sans-first:19.06 05:09:29 INFO - PID 1654 | Values: 183.0 183.0 184.0 202.0 228.0 230.0 186.0 187.0 183.0 190.0 05:09:29 INFO - PID 1654 | 05:09:29 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.85 (2.7%) stddev-sans-first:1.59 05:09:29 INFO - PID 1654 | Values: 71.0 70.0 66.0 67.0 68.0 65.0 69.0 69.0 67.0 67.0 05:09:29 INFO - PID 1654 | -------- Summary: end -------- 05:09:29 INFO - PID 1654 | 05:09:30 INFO - TEST-INFO | 1654: exit 0 05:09:30 INFO - TEST-OK | kraken | took 60641ms 05:09:30 INFO - SUITE-END | took 1176s 05:09:30 INFO - Completed test suite (00:19:36) 05:09:30 INFO - javascript benchmark 05:09:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7869.200143201201, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.7099561039504, 3606.513120728701, 3614.0964758810296, 3641.9635803641954, 3653.689436397906, 5049.823256186034, 5619.831405057855, 5620.437956204382, 6136.171616831726, 6258.092576576394, 6141.0, 6159.722812473438, 6191.133241346215, 6247.5001999840015, 6258.561900666944, 5456.154296084113, 5466.535344495723, 5469.398366179717, 5474.479924407175, 5475.67145971241, 5399.83800485986, 5421.403645598981, 5561.721913904288, 5562.972185139069, 5617.269754931853, 4360.280553708634, 5360.490753378423, 5473.562115030828, 5500.889982200333, 5524.861878453051, 5378.569714422837, 5409.918851217235, 5447.264619276426, 5461.590380721462, 5518.310211223597, 5391.78432862685, 5401.7299135043095, 5409.891802163974, 5421.349438067457, 5429.891402171974, 6116.908246376263, 6117.694115294217, 6285.9057114143325, 6314.116023756677, 6314.400131987454, 6426.678666066725, 6582.76960306387, 6650.767223147167, 6658.3674550917585, 6659.167604049494, 6830.180378354579, 6863.313668633146, 6865.897011544831, 6871.381575658214, 6878.0, 6283.151774510383, 6330.715117819663, 6360.491160707133, 6385.584936979081, 6387.265464471552, 5958.255218097738, 6194.101855230966, 6821.317868213139, 6824.965875170692, 6926.792196234121, 6271.937280627135, 6353.650549219838, 6360.872782544416, 6524.412802847766, 6608.768693095719, 6623.370779775913, 6650.035744816974, 6702.765403210864, 6733.8653226935185, 6747.662616869137, 5320.882614650889, 6640.83397915056, 6646.53474256807, 6651.634160121143, 6658.933410665928, 6320.4311611955145, 6398.2641996170105, 6411.0, 6618.338166183439, 6677.265500794909, 5271.367435907716, 5293.285406470154, 5324.094903866275, 5332.466753324714, 5353.4646535346155, 4731.124741922756, 4734.621230301567, 4735.644826638016, 4741.028089241697, 4756.881077973009, 5119.3088932994315, 6183.258009038944, 6190.442860142519, 6311.305756366796, 6345.746170153142, 5667.404922483162, 6708.731650734014, 6764.83087922796, 6768.9661551691925, 6795.456363490909, 5310.522053015247, 6342.39747224013, 6363.140975968185, 6379.393957574023, 6381.425671689571, 5667.886642267132, 5892.234009578728, 5922.822315330547, 5971.731272092767, 5995.070764031582, 5563.944360556505, 6751.4261287790105, 6774.661266936732, 6862.553933994274, 6871.828204294733, 6752.054712340178, 6757.358050985148, 6801.489888258499, 6804.6257455840405, 6826.010228516738, 6836.794896152925, 6871.03805467225, 6934.306569343025, 6936.306369363023, 6941.201761797256, 5781.554611347163, 6333.493320534254, 6417.743290268337, 6567.704453299518, 6620.0, 6395.264544577433, 6812.046313516211, 6814.114165158498, 6828.283030281749, 6832.760853370109, 6199.0, 6319.52603554726, 6562.5406221564035, 6572.178477690289, 6575.835604109936, 5462.781488740406, 6518.120053792867, 6522.0, 6524.641144737085, 6641.435477984425, 6266.655333956676, 6307.621542707452, 6318.0, 6349.682515874096, 6370.426661600478, 5634.85912852182, 6559.672016399066, 6560.40956313934, 6580.934190658032, 6600.570962887397, 6365.267994180728, 6370.617762934239, 6378.649174295273, 6384.106225128393, 6387.712552935222], "value": 6044.723476955185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6749295324151, 818.1082619944259, 1085.6471646714815, 1138.379583127195, 1263.9178453400534, 36329.636703632954, 37464.25071498568, 37485.625143748555, 37534.43698344524, 37535.30808648915, 37190.88427347177, 37198.44202336967, 37429.25141497175, 37550.06124846874, 37578.060548486304, 7888.763337099882, 8032.1164671886045, 8071.475354101994, 8457.281131103864, 8683.435576687527, 8506.532140732257, 8549.102344253857, 8599.48403095813, 8638.784030399258, 8667.21995020448, 8572.185642363966, 8620.137986201393, 8632.309415246766, 8656.220940115389, 8656.913430865674, 8552.914470855274, 8603.526806025666, 8640.697575584856, 8645.351598630128, 8668.0, 8480.618372173267, 8525.95737021311, 8540.359473039547, 8551.0, 8551.914480855174, 33170.33659326824, 36667.16664166781, 37679.81160094209, 37829.62170378288, 38089.619103809164, 3500.527428797105, 3528.012156596157, 3529.94705079424, 3534.7172226222096, 3538.0800991742076, 30591.541126883116, 30608.387832243232, 30776.537402076574, 30788.692113078807, 30997.22506937322, 3152.2277042124824, 3192.5211218317204, 3198.3603279343993, 3202.0, 3207.6471588125287, 308436.0, 310666.0, 310857.0, 311009.0, 312960.0, 39754.0, 40487.98780030523, 48589.0, 49768.25347619789, 50220.74889625602, 49011.75494122578, 49051.26423103656, 49253.75373123112, 49296.75351623291, 49316.50683493191, 13827.861721382858, 13847.792283115761, 14010.229437380838, 14025.71948561023, 14036.087654302437, 11208.551657933755, 11240.100791936626, 11263.098952083814, 11263.943680281545, 11264.94367528157, 13379.989502362085, 13394.665133371744, 13514.918806495456, 13618.38717257706, 13689.247091410069, 5898.0, 5948.702564871739, 5961.970190149108, 5964.343922168558, 5968.462838344483, 992.5880759484877, 997.3218211616171, 1017.725214192164, 1019.8062368150028, 1049.7323182588543, 23993.760062399502, 24877.62683559748, 25057.498850022897, 25079.24762257135, 25198.496030079663, 1102.3165637304921, 1108.0913650806262, 1136.732867776072, 1145.6219447582278, 1147.9827802582968, 11006.009459148554, 12678.366081695878, 12786.041046921331, 12831.35843207836, 12879.356032198353, 331580.0, 331864.0, 332362.0, 332596.0884693804, 332599.0, 49053.754731226116, 54156.45843541593, 55812.441875581535, 56422.717886410304, 56786.7160664194, 1507.3367718203956, 1514.6592016796133, 1551.7517197248385, 1557.4548907882152, 1558.5480210738986, 20188.697169542174, 23178.884105579364, 24374.756252437248, 24567.0, 24718.382040449134, 38906.416403754534, 38947.610523895535, 39096.80451597724, 39144.6085539141, 39237.41143882787, 281023.0, 282230.0, 282845.0, 282937.0, 283328.0, 27890.721092789623, 34847.65152348545, 35127.12182195466, 35201.94394168179, 35606.821965890005, 45241.54758452505, 45460.0, 46135.53864461312, 46135.76932115452, 46219.613411597704, 29964.850175748983, 30913.072607821803, 30944.381112378076, 31499.685003149676, 31810.840945795124, 30678.589586385875, 31023.68976310208, 31090.75636974496, 31109.688903111586, 31229.487377422694, 37459.0, 37651.0, 37694.246115078095, 37822.0, 37828.81085594554, 29491.705082949753, 29884.252893677833, 30132.0, 30335.69664303417, 30433.0, 24884.751152488967, 24944.875275623504, 24968.126115585867, 25063.87468062648, 25154.496910062062], "value": 17644.78331757862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.260335485416, 355.9626239244878, 417.5469615467219, 417.6846480906915, 451.09780439121755, 18414.631707365843, 21436.89281553592, 22163.113475461003, 22177.889110554446, 23356.41608959777, 22755.0, 23059.385842990956, 23153.305400838002, 23164.0, 23243.0, 6090.269167699882, 6349.650769207692, 6381.553291269613, 6393.0730044143575, 6401.679916004205, 5985.4912332451795, 6149.16986206863, 6158.07628855673, 6218.875622487548, 6230.719617617196, 6169.660668663244, 6208.161898143738, 6214.471769899541, 6218.160548325964, 6230.781922632709, 6003.879922401549, 6179.2893817210925, 6229.25248970122, 6295.937040629627, 6298.338674439209, 5386.218998245272, 5519.779208831682, 5627.324721033461, 5643.943560564424, 5645.520130788888, 27147.72852271472, 27343.45313093727, 27503.587446188325, 27668.72331276702, 27785.027524036763, 2227.9888600557056, 2281.840271181018, 2291.713535808024, 2296.3455415206586, 2299.3331933739196, 14917.701645967129, 14960.700785984329, 15313.540593782205, 17870.642587148315, 18376.816231837645, 2193.5064610462678, 2208.7349518057777, 2215.878126703031, 2227.721534808149, 2232.598132336179, 169907.1504642469, 170698.0, 171809.0, 172228.0, 173142.26857731387, 12911.870881291256, 12999.09006369564, 13083.215007099605, 13182.868171318356, 13239.602811915658, 16820.6635867282, 16839.915800421164, 16845.0, 16880.324787008627, 16885.40901068457, 8795.956020219857, 9079.50062746542, 9134.22359099484, 9278.907210927804, 9288.024757400512, 8672.392932494791, 8680.392372533988, 8686.174813392718, 8859.158379953895, 8878.378513504122, 7940.0, 8089.393295502743, 8109.959450202711, 8129.9187008129165, 8137.471064380797, 2183.639699449605, 2192.397090800043, 2192.539566690981, 2193.484531135182, 2392.892319845611, 870.5386145342978, 966.7244835221928, 982.8820541534918, 994.7015895231401, 997.2670087485692, 21406.143754249966, 21451.463713406978, 21524.677129843065, 21582.35252942414, 21921.0, 997.0677416615488, 997.6159178716247, 1014.9340292880939, 1018.6842078955399, 1028.876534815812, 9552.42685438876, 10903.618373356894, 11288.661340159808, 11296.322220666787, 11340.376279304717, 554665.0, 560943.0, 566873.0, 572512.0, 578250.0, 135351.32324338314, 142793.0, 144008.27995859954, 145805.0, 147337.2633136849, 1079.8002369561657, 1197.91588612306, 1249.6376050945123, 1253.8244645749785, 1254.0406588959454, 19677.901610491856, 20426.285080022128, 22433.43916402103, 22848.77151228533, 23064.0, 59699.701501492214, 60024.19806415564, 60063.69968150131, 60472.697636513294, 60825.69587152036, 61872.0, 82133.9466513318, 82331.17668823474, 83181.58409208157, 83779.0, 8196.688529835197, 8926.73219803381, 9173.312001599774, 9203.35576509638, 9305.813883722152, 14197.929010354883, 14460.27698615044, 14511.346989385293, 14561.199134047305, 14712.926435367755, 11855.58505452305, 11957.461914213707, 12202.0, 12215.083868709704, 12268.631941041784, 10490.108340791117, 11213.60752373663, 11500.94249528747, 11708.824367634323, 11720.589779357682, 12061.51753929833, 12073.0, 12334.938325308674, 12371.876281237073, 12374.876251237733, 8904.643814247358, 8909.465432074096, 9231.399959002643, 9264.629414823332, 9309.906900931175, 10070.295079344376, 12123.81814272769, 12228.44971976281, 12261.816072758736, 12322.32227227511], "value": 10687.959217772264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.6854864912148, 1208.7340785027293, 1432.7119261295327, 1433.6344232220786, 1440.3878351700525, 11355.261907975975, 11531.769364612703, 11887.643370698872, 11999.580014699488, 12021.098417618681, 11578.884211157885, 11691.0, 11766.117541184403, 11781.29312241266, 11886.108541859352, 2497.2508247525716, 2540.060177734241, 2563.628273900283, 2564.269183282765, 2567.4351642638685, 2372.181597348912, 2423.2245681381964, 2425.842320249187, 2429.53838770633, 2436.062116085302, 2500.174942269056, 2502.5245203411296, 2535.2014115553543, 2542.83471574348, 2550.7831834294107, 2495.1142344467726, 2509.29739672891, 2524.1670248817845, 2524.7096583892903, 2537.112010796225, 2441.340837973737, 2478.95042099157, 2493.5760920643534, 2493.912713055034, 2552.387427017521, 11796.646100616996, 11945.641630751092, 12034.33811140387, 12044.277343359427, 12057.758844823054, 6595.835104122388, 6864.347886950732, 6876.965615171892, 6877.1747390312985, 6887.0, 4113.177364527077, 4441.444819397575, 4501.932471012938, 4512.954870451319, 4536.319552067183, 1265.7721610110177, 1273.2424207596466, 1302.6417735122916, 1316.6971596532755, 1317.308413083139, 14560.417583296761, 15118.0, 16223.269952852032, 16689.415870444474, 16844.747328789956, 5202.479752024768, 5727.455891690282, 5892.499137573354, 5902.763889444374, 5908.438698323653, 12234.81647775284, 12368.75262494745, 12379.504819807107, 12411.379431028412, 12420.875791241971, 6612.437942774822, 6636.435902948207, 6652.06871038055, 6664.500162487736, 6668.466522678271, 6073.605215660968, 6094.177286066413, 6226.25284965807, 6236.064590311489, 6244.594101383395, 3629.073462217871, 4451.310046942729, 4490.687296042541, 4520.706154099973, 4578.153041687298, 1284.6767829135817, 1306.3729409883308, 1309.5154792726753, 1319.9604011879467, 1322.6693326668333, 791.5092642561533, 793.8291020744356, 814.8085199978001, 815.9143289954469, 843.725789118539, 5927.851803704942, 6085.604435711664, 6096.512279017668, 6281.623102613767, 6357.141785858942, 576.2221001647742, 588.808637192914, 597.6951754605183, 608.1121562518683, 609.1411110334407, 3881.573026967031, 4032.415299781574, 4193.6645068394455, 4212.789360531961, 4330.17726631939, 13856.861431385758, 15057.397704091933, 15191.848081519265, 15221.391144354102, 15234.0, 14470.782938255934, 15085.54743357701, 15091.0, 15127.16800575979, 15219.162946037854, 7559.433042521723, 8438.662453501915, 8633.870491942625, 8663.78340541479, 8688.435251708619, 5972.910406343822, 6852.211995620568, 7078.787636370917, 7109.75115870942, 7176.497645164788, 12545.874541254836, 12808.551700690432, 12863.970882329204, 12870.678233043875, 12964.675883102998, 11258.493367798304, 11612.767744645229, 13653.044286900218, 13752.106113102616, 13791.241481718602, 9567.330286879851, 9821.754456138653, 9833.016698330395, 9855.901440985499, 9872.654457093968, 8106.959465202636, 10846.349219046882, 10865.348079115278, 10966.780664386508, 10973.067289280181, 9203.355765096647, 9240.214581760625, 9310.581023853807, 9335.53322333867, 9338.859917101114, 7371.631418429164, 7595.354394876276, 9036.141566551167, 9068.911730592108, 9296.256299495888, 6797.456203503807, 8270.917290827014, 8355.582220889053, 8362.749117526484, 8372.037215720271, 6013.9699301503215, 6059.272887253558, 6134.969325153345, 6200.7519699211525, 6258.280297765815, 6055.091736239423, 6141.539319798328, 6185.103160041859, 6290.025046117859, 6310.968445157745], "value": 5323.590758376287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5776836722464, 373.66556931546285, 385.5200275656808, 398.2671883733931, 411.31926661375417, 4671.743054132022, 6176.444120029197, 6253.1245625612455, 6305.684715764216, 6320.74717011319, 6039.1545183674325, 6169.290531588868, 6189.969050154743, 6200.720967556459, 6215.254169499666, 4405.273129933557, 4549.7725113744345, 4551.381651586979, 4551.476580193271, 4590.301588412292, 4123.567025462328, 4435.512093669694, 4530.66020048496, 4547.0, 4549.203889319372, 4504.8873778155485, 4511.35335602506, 4536.500984891659, 4537.909241815161, 4541.72749635023, 3364.831758412082, 3573.821308934556, 4283.593058659422, 4419.226635338803, 4491.955080449186, 3228.6287076986214, 3862.1889403225077, 3866.3427217372832, 3877.243937432202, 3880.5835869907564, 6027.246594175728, 6031.366706495843, 6043.244594425697, 6076.817695469143, 6076.96961515194, 4867.862317030531, 5028.044671512437, 5138.332016837825, 5172.948270517322, 5363.326121606712, 5439.456054394568, 5734.713264336767, 6627.502937279675, 6655.633940133291, 6669.866602667968, 4256.574342565749, 4422.71252368595, 4441.71128876622, 4443.888902777424, 4467.620252278561, 5529.811245380989, 5941.257342832103, 6972.442204623669, 7025.630002149583, 7054.365107140331, 3803.2773772983046, 4421.42521472213, 4470.307102399133, 4473.7986790594505, 4506.377704026548, 3670.8531658733887, 4215.683823713233, 4336.848210312624, 4590.97704511482, 4604.700694454849, 5166.354205724285, 5230.947690523046, 5370.3287089113865, 5426.647267927572, 5428.185772134211, 6126.019836826086, 6580.1246644706025, 6642.402183803384, 6646.767363142267, 6664.0, 1523.6495606010458, 1561.242797243336, 1561.461295852929, 1568.4118455579157, 1572.771948067524, 853.6116067189414, 906.3429013964954, 924.2513564013171, 989.4805227255748, 1016.7915577306634, 5538.972305138448, 5783.826485205451, 6230.7507699691505, 6246.031865060922, 6254.812355629248, 6551.934480655228, 6584.703688334036, 6625.370589793962, 6806.659667016629, 6809.829754256183, 6217.098520714471, 6229.7508099676415, 6254.6247225166635, 6255.437010669061, 6266.342034086355, 3108.8601012954473, 3212.8594349006235, 3555.8933232002564, 3577.821108944542, 3603.1352475405715, 6145.754169833246, 7000.894986575206, 7055.294470553006, 7059.3763434410375, 7077.398421134261, 6176.598521096114, 6747.730090796412, 6902.344277293649, 7031.08595882532, 7048.330408611174, 6544.9672751635935, 7001.92998070023, 7029.402500787388, 7158.606276654626, 7160.0, 6673.731990921709, 6845.520813543203, 6928.1986683461655, 6935.930640693528, 6939.653017349011, 5083.364579427572, 6368.554201206057, 6650.467962562887, 6816.909294512854, 6822.829429264308, 6914.27400123, 7158.713651453883, 7159.355657990805, 7183.988483224705, 7214.098237720285, 3851.326017946904, 4507.323901414814, 4519.435070616173, 4526.841560545365, 4529.932051019303, 5992.790252341147, 6917.827054323682, 6970.721171153097, 6972.372486476242, 7003.4397248219, 6542.54202205841, 6555.934440655532, 6627.966860165861, 6642.701078451385, 6723.596584204964, 5447.291852059207, 5772.0, 6522.923717586545, 6670.0, 6687.732490700318, 6280.152179455898, 6477.093206951125, 6566.343365663395, 6598.1422415085735, 6645.1361323027695, 5517.586181036519, 6650.273387910934, 6663.200415950117, 6714.697838597177, 6768.0, 5427.538659214011, 6076.936536106252, 6109.327973922954, 6438.227412710317, 6521.217453905561], "value": 4772.568182108382, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.7084714079361, 817.8650522663753, 828.300086426969, 847.0936098374738, 852.9892077887704, 16048.598785030366, 16531.0, 16542.0, 18494.260229590833, 18989.62020759584, 17608.503277221418, 17745.37891173809, 17885.7317140243, 17979.19093640786, 18403.44789656309, 730.8867125595541, 950.8906475755308, 952.7237101240667, 955.2024059909949, 957.042957042957, 972.6012334942675, 985.5170966226533, 986.4623780039859, 987.0179171724144, 987.8765154355706, 1007.4459047523869, 1019.6329321444274, 1019.9286049976505, 1020.2246292817475, 1020.2959957629212, 990.4750482244386, 1015.3907655406771, 1016.3749294184097, 1017.2421545948242, 1020.5305559442666, 715.5599306426562, 722.4112348436008, 735.1325435985535, 750.1972889008763, 751.3913729878816, 16470.011799292082, 16532.586685332844, 16745.581360465963, 16752.078635675156, 16765.329386824513, 16545.420910268083, 16927.984320940785, 16967.660646787117, 17230.569235769082, 17304.394346197947, 13665.521706740315, 13781.448742050306, 13953.232572208524, 14069.085509441853, 14092.506762263374, 3461.3769521486124, 3534.8762793302367, 3538.964610353915, 3539.292141571696, 3540.2388486475274, 94562.0, 113988.78258000623, 119833.0, 131329.0, 132845.0, 12303.938480307721, 12757.362131893367, 13258.40337184829, 13455.596332110052, 13583.728325433436, 24998.00007999696, 25468.981240750163, 25470.617940730903, 25902.740972590032, 25949.870250648626, 7879.0151231096115, 7979.202079791974, 7997.040355157418, 8001.5599142046585, 8006.519608823489, 3848.942265866014, 3932.134930315326, 3962.3264045111823, 4016.0, 4060.451839001697, 3431.553897993245, 4233.491980962304, 4284.357346398003, 4364.083542456056, 4380.4305440292555, 930.50683137937, 958.9664361747306, 967.9032096790405, 969.5152423788106, 971.2569884038575, 571.2659232885804, 642.3512252624789, 652.324843786688, 656.5338609587246, 676.4689718570899, 9388.436693798394, 10849.945750271198, 11180.552777888955, 11427.542898284142, 12361.62915112548, 558.9189567512769, 657.8486948001986, 670.165643773505, 675.5271310082961, 688.683205725362, 4048.473698419187, 5300.549453296436, 5451.454854514517, 5474.753636086386, 5538.47384498472, 76557.46885062268, 87030.82422939477, 89293.0, 98721.50639246758, 99725.0, 62807.0, 83988.0, 84545.73181402285, 85313.57343213244, 85584.0, 68837.62324753476, 69203.65398173078, 69572.652136739, 69830.0, 70601.64699176574, 9188.862167067633, 9809.577611246472, 10457.58169673235, 12267.75464490723, 12474.812877807022, 27422.45155096927, 39339.60660393474, 39588.0, 39978.0, 40462.78611641655, 60957.47606309878, 62935.0, 72383.63808180926, 73489.0, 74318.62840685979, 14460.421583136556, 15596.532104036896, 15894.602634933757, 16012.919935400249, 16016.119113448873, 17588.648227035133, 17599.736003959693, 17705.911470442566, 17912.462626121236, 17931.820681793535, 16147.596310092342, 16287.0, 16402.343906243615, 16449.917750411172, 16465.01209927408, 15839.0, 16231.107289099213, 16298.67402651964, 16298.837011629732, 17130.40043598468, 16130.354785808437, 16305.836941630907, 16633.168341583114, 16831.495055148363, 16858.241379137722, 11697.824532631847, 11738.647840564796, 11829.171957963204, 11842.348670823187, 12177.69555761113, 12439.315837629018, 13240.668983275495, 13339.132956357806, 13648.86351136476, 13844.961627877748], "value": 8197.9956409911, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 114.0, 114.0, 115.0, 113.0, 115.0, 114.0, 115.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 105.0, 114.0, 147.0, 129.0, 147.0, 141.0, 123.0, 138.0, 114.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 222.0, 196.0, 240.0, 264.0, 230.0, 193.0, 200.0, 205.0, 284.0], "value": 222.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 55.0, 56.0, 79.0, 61.0, 57.0, 58.0, 59.0, 87.0, 86.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 72.0, 71.0, 56.0, 84.0, 71.0, 85.0, 116.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 91.0, 91.0, 91.0, 93.0, 92.0, 91.0, 91.0, 93.0, 138.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 99.0, 98.0, 99.0, 98.0, 99.0, 128.0, 116.0, 99.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 91.0, 90.0, 92.0, 93.0, 95.0, 92.0, 93.0, 112.0, 139.0], "value": 99.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 50.0, 50.0, 49.0, 50.0, 51.0, 52.0, 52.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 67.0, 60.0, 58.0, 56.0, 57.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 83.0, 84.0, 83.0, 85.0, 82.0, 87.0, 85.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 137.0, 134.0, 132.0, 136.0, 155.0, 143.0, 179.0, 130.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 202.0, 228.0, 230.0, 186.0, 187.0, 183.0, 190.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 66.0, 67.0, 68.0, 65.0, 69.0, 69.0, 67.0, 67.0], "value": 67.9, "unit": "score"}]}]} 05:09:30 INFO - Return code: 0 05:09:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:09:30 ERROR - # TBPL SUCCESS # 05:09:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:30 INFO - 2017-04-25 05:09:30.732 screenresolution[1659:10656] starting screenresolution argv=screenresolution get 05:09:30 INFO - 2017-04-25 05:09:30.735 screenresolution[1659:10656] Display 0: 1600x1200x32@60 05:09:30 INFO - 2017-04-25 05:09:30.740 screenresolution[1660:10659] starting screenresolution argv=screenresolution list 05:09:30 INFO - Available Modes on Display 0 05:09:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:30 INFO - Intel Iris: 05:09:30 INFO - Chipset Model: Intel Iris 05:09:30 INFO - Type: GPU 05:09:30 INFO - Bus: Built-In 05:09:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:30 INFO - Vendor: Intel (0x8086) 05:09:30 INFO - Device ID: 0x0a2e 05:09:30 INFO - Revision ID: 0x0009 05:09:30 INFO - Displays: 05:09:30 INFO - Display: 05:09:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:30 INFO - Display Serial Number: 1600x1200 60 05:09:30 INFO - Main Display: Yes 05:09:30 INFO - Mirror: Off 05:09:30 INFO - Online: Yes 05:09:30 INFO - Rotation: Supported 05:09:30 INFO - Return code: 0 05:09:30 INFO - Running post-action listener: _resource_record_post_action 05:09:30 INFO - [mozharness: 2017-04-25 12:09:30.982241Z] Finished run-tests step (success) 05:09:30 INFO - Running post-run listener: _resource_record_post_run 05:09:31 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 40794112; Write bytes: 509824000; Read time: 410; Write time: 1537 05:09:31 INFO - TinderboxPrint: CPU usage
54.1% 05:09:31 INFO - TinderboxPrint: I/O read bytes / time
40,794,112 / 410 05:09:31 INFO - TinderboxPrint: I/O write bytes / time
509,824,000 / 1,537 05:09:31 INFO - TinderboxPrint: CPU idle
2,198.5 (45.9%) 05:09:31 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 05:09:31 INFO - TinderboxPrint: CPU user
1,624.4 (33.9%) 05:09:31 INFO - TinderboxPrint: Swap in / out
248,844,288 / 0 05:09:31 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201429504; Write bytes: 196544512; Read time: 16267; Write time: 402 05:09:31 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 39823360; Write bytes: 297501696; Read time: 394; Write time: 1087 05:09:31 INFO - Running post-run listener: _upload_blobber_files 05:09:31 INFO - Blob upload gear active. 05:09:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:31 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 05:09:31 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'] 05:09:31 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 05:09:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:09:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:32 INFO - (blobuploader) - INFO - Done attempting. 05:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:33 INFO - (blobuploader) - INFO - Done attempting. 05:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:34 INFO - (blobuploader) - INFO - Done attempting. 05:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:37 INFO - (blobuploader) - INFO - Done attempting. 05:09:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:37 INFO - Return code: 0 05:09:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/528f2bb2c2101acde517de04b18cd8b8c05b00a1b46b3576faa573b637e33ae1312520616b7843cd04f881801bf2fff9e825e2a1f3d18edd3a1d12ff0de5395c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b7b0d9faa5724d23151cfce2f56e124ec84ea01bb0554a68e800b236053628abb8fd26f2d0a338f262d75ed0d3a03c7b0a696abf71837b9b9c3cea0bcf2c870", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/525ce9a0c8842aadd64383cd34a5027d7103dac61f15e992dbddcd72f818973f4d383051fddfe855f40262b72c95c6f48a48f6eb63fdc74b6b8bde561d571dc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e93dd9e726878a02e143ccd5da120f200128b1a534053e909ddad127464e2f19b1d82491467ec9550fcb21f740762557e37c2c749940a4f55cecd85c591145b"} 05:09:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:37 INFO - Contents: 05:09:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/528f2bb2c2101acde517de04b18cd8b8c05b00a1b46b3576faa573b637e33ae1312520616b7843cd04f881801bf2fff9e825e2a1f3d18edd3a1d12ff0de5395c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b7b0d9faa5724d23151cfce2f56e124ec84ea01bb0554a68e800b236053628abb8fd26f2d0a338f262d75ed0d3a03c7b0a696abf71837b9b9c3cea0bcf2c870", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/525ce9a0c8842aadd64383cd34a5027d7103dac61f15e992dbddcd72f818973f4d383051fddfe855f40262b72c95c6f48a48f6eb63fdc74b6b8bde561d571dc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e93dd9e726878a02e143ccd5da120f200128b1a534053e909ddad127464e2f19b1d82491467ec9550fcb21f740762557e37c2c749940a4f55cecd85c591145b"} 05:09:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:37 INFO - Copying logs to upload dir... 05:09:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.260389 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 05:09:37.418282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:37.421363) ========= 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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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/528f2bb2c2101acde517de04b18cd8b8c05b00a1b46b3576faa573b637e33ae1312520616b7843cd04f881801bf2fff9e825e2a1f3d18edd3a1d12ff0de5395c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b7b0d9faa5724d23151cfce2f56e124ec84ea01bb0554a68e800b236053628abb8fd26f2d0a338f262d75ed0d3a03c7b0a696abf71837b9b9c3cea0bcf2c870", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/525ce9a0c8842aadd64383cd34a5027d7103dac61f15e992dbddcd72f818973f4d383051fddfe855f40262b72c95c6f48a48f6eb63fdc74b6b8bde561d571dc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e93dd9e726878a02e143ccd5da120f200128b1a534053e909ddad127464e2f19b1d82491467ec9550fcb21f740762557e37c2c749940a4f55cecd85c591145b"} build_url:https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/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/528f2bb2c2101acde517de04b18cd8b8c05b00a1b46b3576faa573b637e33ae1312520616b7843cd04f881801bf2fff9e825e2a1f3d18edd3a1d12ff0de5395c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b7b0d9faa5724d23151cfce2f56e124ec84ea01bb0554a68e800b236053628abb8fd26f2d0a338f262d75ed0d3a03c7b0a696abf71837b9b9c3cea0bcf2c870", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/525ce9a0c8842aadd64383cd34a5027d7103dac61f15e992dbddcd72f818973f4d383051fddfe855f40262b72c95c6f48a48f6eb63fdc74b6b8bde561d571dc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e93dd9e726878a02e143ccd5da120f200128b1a534053e909ddad127464e2f19b1d82491467ec9550fcb21f740762557e37c2c749940a4f55cecd85c591145b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:37.455582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:37.455870) ========= 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.DA4OfwZFYb/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.cAw5LITJ5i/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005104 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:37.504677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 05:09:37.505000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 05:09:37.505304) ========= ========= Total master_lag: 0.18 =========