builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0370 starttime: 1476996649.87 results: success (0) buildid: 20161020112549 builduid: 6895b2fa5ec2483295d2b0667e81ecc3 revision: f0f1aaf051d6798e1e73d1feee07ca847333167a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:49.867751) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:49.868177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:49.868453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:49.891018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:49.891329) ========= 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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 --2016-10-20 13:50:49-- 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% 68.3M=0s 2016-10-20 13:50:50 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:50.030952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:50.031282) ========= 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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.024186 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:50.080046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:50:50.080407) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0f1aaf051d6798e1e73d1feee07ca847333167a --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 f0f1aaf051d6798e1e73d1feee07ca847333167a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 2016-10-20 13:50:50,161 truncating revision to first 12 chars 2016-10-20 13:50:50,161 Setting DEBUG logging. 2016-10-20 13:50:50,161 attempt 1/10 2016-10-20 13:50:50,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0f1aaf051d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 13:50:51,213 unpacking tar archive at: mozilla-central-f0f1aaf051d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 13:50:51.416079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:51.416415) ========= script_repo_revision: f0f1aaf051d6798e1e73d1feee07ca847333167a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:51.416801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:51.417087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 13:50:51.435050) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-20 13:50:51.435354) ========= /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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:50:51 INFO - MultiFileLogger online at 20161020 13:50:51 in /builds/slave/test 13:50:51 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 13:50:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:51 INFO - {'append_to_log': False, 13:50:51 INFO - 'base_work_dir': '/builds/slave/test', 13:50:51 INFO - 'blob_upload_branch': 'Firefox', 13:50:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:51 INFO - 'branch': 'Firefox', 13:50:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:51 INFO - 'config_files': ('talos/mac_config.py',), 13:50:51 INFO - 'default_actions': ('clobber', 13:50:51 INFO - 'read-buildbot-config', 13:50:51 INFO - 'download-and-extract', 13:50:51 INFO - 'populate-webroot', 13:50:51 INFO - 'create-virtualenv', 13:50:51 INFO - 'install', 13:50:51 INFO - 'run-tests'), 13:50:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:51 INFO - 'download_minidump_stackwalk': True, 13:50:51 INFO - 'download_symbols': 'ondemand', 13:50:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:51 INFO - 'installer_path': 'installer.exe', 13:50:51 INFO - 'log_level': 'info', 13:50:51 INFO - 'log_name': 'talos', 13:50:51 INFO - 'log_to_console': True, 13:50:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:51 INFO - 'opt_config_files': (), 13:50:51 INFO - 'pip_index': False, 13:50:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:51 INFO - 'cmd': ('bash', 13:50:51 INFO - '-c', 13:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:51 INFO - 'enabled': True, 13:50:51 INFO - 'halt_on_failure': False, 13:50:51 INFO - 'name': 'check_screen_resolution'},), 13:50:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:51 INFO - 'cmd': ('bash', 13:50:51 INFO - '-c', 13:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:51 INFO - 'enabled': True, 13:50:51 INFO - 'halt_on_failure': False, 13:50:51 INFO - 'name': 'check_screen_resolution'},), 13:50:51 INFO - 'run_cmd_checks_enabled': True, 13:50:51 INFO - 'sps_profile': False, 13:50:51 INFO - 'sps_profile_interval': 0, 13:50:51 INFO - 'suite': 'dromaeojs-e10s', 13:50:51 INFO - 'system_bits': '32', 13:50:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:51 INFO - 'title': 't-yosemite-r7-0370', 13:50:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:51 INFO - 'use_talos_json': True, 13:50:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:51 INFO - 'work_dir': 'build'} 13:50:51 INFO - [mozharness: 2016-10-20 20:50:51.634188Z] Running clobber step. 13:50:51 INFO - Running pre-action listener: _resource_record_pre_action 13:50:51 INFO - Running main action method: clobber 13:50:51 INFO - rmtree: /builds/slave/test/build 13:50:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:53 INFO - Running post-action listener: _resource_record_post_action 13:50:53 INFO - [mozharness: 2016-10-20 20:50:53.357800Z] Finished clobber step (success) 13:50:53 INFO - [mozharness: 2016-10-20 20:50:53.357922Z] Running read-buildbot-config step. 13:50:53 INFO - Running pre-action listener: _resource_record_pre_action 13:50:53 INFO - Running main action method: read_buildbot_config 13:50:53 INFO - Using buildbot properties: 13:50:53 INFO - { 13:50:53 INFO - "project": "", 13:50:53 INFO - "product": "firefox", 13:50:53 INFO - "script_repo_revision": "production", 13:50:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:50:53 INFO - "repository": "", 13:50:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:50:53 INFO - "buildid": "20161020112549", 13:50:53 INFO - "pgo_build": "False", 13:50:53 INFO - "basedir": "/builds/slave/test", 13:50:53 INFO - "buildnumber": 29, 13:50:53 INFO - "slavename": "t-yosemite-r7-0370", 13:50:53 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:50:53 INFO - "platform": "yosemite_r7", 13:50:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:53 INFO - "branch": "mozilla-central", 13:50:53 INFO - "repo_path": "mozilla-central", 13:50:53 INFO - "revision": "f0f1aaf051d6798e1e73d1feee07ca847333167a", 13:50:53 INFO - "stage_platform": "macosx64", 13:50:53 INFO - "builduid": "6895b2fa5ec2483295d2b0667e81ecc3", 13:50:53 INFO - "slavebuilddir": "test" 13:50:53 INFO - } 13:50:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:53 INFO - Running post-action listener: _resource_record_post_action 13:50:53 INFO - [mozharness: 2016-10-20 20:50:53.361119Z] Finished read-buildbot-config step (success) 13:50:53 INFO - [mozharness: 2016-10-20 20:50:53.361256Z] Running download-and-extract step. 13:50:53 INFO - Running pre-action listener: _resource_record_pre_action 13:50:53 INFO - Running main action method: download_and_extract 13:50:53 INFO - mkdir: /builds/slave/test/build/tests 13:50: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')]} 13:50:53 INFO - trying https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:50:54 INFO - Downloaded 1199 bytes. 13:50:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:54 INFO - Using the following test package requirements: 13:50:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'jsshell-mac.zip'], 13:50:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:55 INFO - Http code: 200 13:50:55 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 13:50:55 INFO - x-amz-cf-id: 8jYVG4l7lsJzido7lPZwDYQX1_wGUaSd8Dp968fBw9l20DHiq5pRYQ== 13:50:55 INFO - x-amz-version-id: lJmxPa0wubmOtR2tP3d3RU.gvA0QBCoc 13:50:55 INFO - Expected file size: 16506983 13:50:55 INFO - Obtained file size: 16506983 13:51:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:51:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:51:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:51:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:51:02 INFO - Http code: 200 13:51:02 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 13:51:02 INFO - x-amz-cf-id: le_DqoBG6tQ1PEqPuZHTEi7CdVEMGAI0cPXJ4xGa5alAUxCMHyP7nA== 13:51:02 INFO - x-amz-version-id: lJmxPa0wubmOtR2tP3d3RU.gvA0QBCoc 13:51:03 INFO - Expected file size: 16506983 13:51:03 INFO - Obtained file size: 16506983 13:51:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:51:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:51:10 INFO - Http code: 200 13:51:10 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 13:51:10 INFO - x-amz-cf-id: CkkdTl43PckTdpiTTw-AJ6HoCDpTfJ0egUlmUuJlWUL4yqvsjkFhMw== 13:51:10 INFO - x-amz-version-id: v7Q7zGgeBWnqOefmUkHURhUetLlH5zZM 13:51:10 INFO - Expected file size: 14409028 13:51:10 INFO - Obtained file size: 14409028 13:51: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')]} 13:51:11 INFO - trying https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:51:14 INFO - Downloaded 111641819 bytes. 13:51:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - mkdir: /builds/slave/test/properties 13:51:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:14 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:14 INFO - Contents: 13:51:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - Running post-action listener: _resource_record_post_action 13:51:14 INFO - Running post-action listener: set_extra_try_arguments 13:51:14 INFO - [mozharness: 2016-10-20 20:51:14.764515Z] Finished download-and-extract step (success) 13:51:14 INFO - [mozharness: 2016-10-20 20:51:14.764631Z] Running populate-webroot step. 13:51:14 INFO - Running pre-action listener: _resource_record_pre_action 13:51:14 INFO - Running main action method: populate_webroot 13:51:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:14 INFO - '--tppagecycles', 13:51:14 INFO - '7'], 13:51:14 INFO - 'tests': ['tsvgm']}}, 13:51:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['damp', 'tps']}, 13:51:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'tests': ['damp', 'tps']}, 13:51:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['dromaeo_dom']}, 13:51:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['basic_compositor_video']}, 13:51:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['a11yr', 13:51:14 INFO - 'ts_paint', 13:51:14 INFO - 'tpaint', 13:51:14 INFO - 'sessionrestore', 13:51:14 INFO - 'sessionrestore_no_auto_restore', 13:51:14 INFO - 'tabpaint']}, 13:51:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['tsvgx', 13:51:14 INFO - 'tsvgr_opacity', 13:51:14 INFO - 'tart', 13:51:14 INFO - 'tscrollx', 13:51:14 INFO - 'cart']}, 13:51:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:14 INFO - 'tsvgr_opacity', 13:51:14 INFO - 'tart', 13:51:14 INFO - 'tscrollx', 13:51:14 INFO - 'cart']}, 13:51:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'talos_options': ['--disable-e10s'], 13:51:14 INFO - 'tests': ['tp5o']}, 13:51:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'tests': ['tp5o']}, 13:51:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'talos_options': ['--disable-e10s', 13:51:14 INFO - '--xperf_path', 13:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:14 INFO - 'tests': ['tp5n']}, 13:51:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:14 INFO - 'talos_options': ['--xperf_path', 13:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:14 INFO - 'tests': ['tp5n']}}, 13:51:14 INFO - 'talos.zip': {'path': '', 13:51:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:14 INFO - Running post-action listener: _resource_record_post_action 13:51:14 INFO - [mozharness: 2016-10-20 20:51:14.783404Z] Finished populate-webroot step (success) 13:51:14 INFO - [mozharness: 2016-10-20 20:51:14.783511Z] Running create-virtualenv step. 13:51:14 INFO - Running pre-action listener: _resource_record_pre_action 13:51:14 INFO - Running main action method: create_virtualenv 13:51:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:14 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 13:51:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:14 INFO - Using real prefix '/tools/python27' 13:51:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:15 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:18 INFO - Installing pip.................done. 13:51:18 INFO - Return code: 0 13:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:18 INFO - Reading from file tmpfile_stdout 13:51:18 INFO - Output received: 13:51:18 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) 13:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:18 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 13:51:18 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 13:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:18 INFO - 'HOME': '/Users/cltbld', 13:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:18 INFO - 'LOGNAME': 'cltbld', 13:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:18 INFO - 'MOZ_NO_REMOTE': '1', 13:51:18 INFO - 'NO_EM_RESTART': '1', 13:51:18 INFO - 'PAGER': '/bin/cat', 13:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:18 INFO - 'PWD': '/builds/slave/test', 13:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:18 INFO - 'SHELL': '/bin/bash', 13:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:18 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:18 INFO - 'USER': 'cltbld', 13:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:18 INFO - 'XPC_FLAGS': '0x0', 13:51:18 INFO - 'XPC_SERVICE_NAME': '0', 13:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 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 13:51:18 INFO - Cleaning up... 13:51:19 INFO - Return code: 0 13:51:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:19 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')]} 13:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:19 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')]} 13:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:19 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:19 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 13:51:19 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 13:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:19 INFO - 'HOME': '/Users/cltbld', 13:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:19 INFO - 'LOGNAME': 'cltbld', 13:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:19 INFO - 'MOZ_NO_REMOTE': '1', 13:51:19 INFO - 'NO_EM_RESTART': '1', 13:51:19 INFO - 'PAGER': '/bin/cat', 13:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:19 INFO - 'PWD': '/builds/slave/test', 13:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:19 INFO - 'SHELL': '/bin/bash', 13:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:19 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:19 INFO - 'USER': 'cltbld', 13:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:19 INFO - 'XPC_FLAGS': '0x0', 13:51:19 INFO - 'XPC_SERVICE_NAME': '0', 13:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:19 INFO - Downloading/unpacking psutil>=3.1.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:22 INFO - Installing collected packages: psutil 13:51:22 INFO - Running setup.py install for psutil 13:51:22 INFO - building 'psutil._psutil_osx' extension 13:51:22 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 13:51:23 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 13:51:23 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 13:51:23 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 13:51:23 INFO - building 'psutil._psutil_posix' extension 13:51:23 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 13:51:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:23 INFO - ^ 13:51:23 INFO - 1 warning generated. 13:51:23 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 13:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:23 INFO - Successfully installed psutil 13:51:23 INFO - Cleaning up... 13:51:23 INFO - Return code: 0 13:51:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:23 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')]} 13:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:23 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')]} 13:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:23 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:23 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 13:51:23 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 13:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:23 INFO - 'HOME': '/Users/cltbld', 13:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:23 INFO - 'LOGNAME': 'cltbld', 13:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:23 INFO - 'MOZ_NO_REMOTE': '1', 13:51:23 INFO - 'NO_EM_RESTART': '1', 13:51:23 INFO - 'PAGER': '/bin/cat', 13:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:23 INFO - 'PWD': '/builds/slave/test', 13:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:23 INFO - 'SHELL': '/bin/bash', 13:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:23 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:23 INFO - 'USER': 'cltbld', 13:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:23 INFO - 'XPC_FLAGS': '0x0', 13:51:23 INFO - 'XPC_SERVICE_NAME': '0', 13:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:23 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 13:51:23 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 13:51:23 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 13:51:23 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 13:51:23 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 13:51:23 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 13:51:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:26 INFO - Installing collected packages: mozsystemmonitor 13:51:26 INFO - Running setup.py install for mozsystemmonitor 13:51:26 INFO - Successfully installed mozsystemmonitor 13:51:26 INFO - Cleaning up... 13:51:26 INFO - Return code: 0 13:51:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:26 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:26 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 13:51:26 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 13:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:26 INFO - 'HOME': '/Users/cltbld', 13:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:26 INFO - 'LOGNAME': 'cltbld', 13:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:26 INFO - 'MOZ_NO_REMOTE': '1', 13:51:26 INFO - 'NO_EM_RESTART': '1', 13:51:26 INFO - 'PAGER': '/bin/cat', 13:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:26 INFO - 'PWD': '/builds/slave/test', 13:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:26 INFO - 'SHELL': '/bin/bash', 13:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:26 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:26 INFO - 'USER': 'cltbld', 13:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:26 INFO - 'XPC_FLAGS': '0x0', 13:51:26 INFO - 'XPC_SERVICE_NAME': '0', 13:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:26 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 13:51:26 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 13:51:26 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 13:51:26 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 13:51:26 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 13:51:26 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 13:51:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:30 INFO - warning: no files found matching '*.txt' 13:51:30 INFO - no previously-included directories found matching 'build' 13:51:30 INFO - no previously-included directories found matching 'dist' 13:51:30 INFO - no previously-included directories found matching '.git*' 13:51:30 INFO - Installing collected packages: jsonschema, functools32 13:51:30 INFO - Running setup.py install for functools32 13:51:30 INFO - warning: no files found matching '*.txt' 13:51:30 INFO - no previously-included directories found matching 'build' 13:51:30 INFO - no previously-included directories found matching 'dist' 13:51:30 INFO - no previously-included directories found matching '.git*' 13:51:30 INFO - Successfully installed jsonschema functools32 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:30 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 13:51:30 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 13:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:30 INFO - 'HOME': '/Users/cltbld', 13:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PAGER': '/bin/cat', 13:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:30 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - 'XPC_FLAGS': '0x0', 13:51:30 INFO - 'XPC_SERVICE_NAME': '0', 13:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:30 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 13:51:30 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 13:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:30 INFO - 'HOME': '/Users/cltbld', 13:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PAGER': '/bin/cat', 13:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:30 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - 'XPC_FLAGS': '0x0', 13:51:30 INFO - 'XPC_SERVICE_NAME': '0', 13:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:30 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 13:51:30 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 13:51:30 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 13:51:30 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 13:51:30 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 13:51:30 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 13:51:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:34 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 13:51:34 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 13:51:34 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 13:51:34 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 13:51:34 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 13:51:34 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 13:51:34 INFO - Downloading docopt-0.6.1.tar.gz 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:34 INFO - Running setup.py install for blobuploader 13:51:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:34 INFO - Running setup.py install for requests 13:51:35 INFO - Running setup.py install for docopt 13:51:35 INFO - Successfully installed blobuploader requests docopt 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:35 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')]} 13:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 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')]} 13:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:35 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 13:51:35 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 13:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:35 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-6PZjsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ezoKnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-t6fQ8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-FXFyAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-PpFxZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-BZmjLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-dqFWbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-OY3dyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-L3EAfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-QPKtp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:36 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-FPbm7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kYooYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-l8wl4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-4v2ELt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7AWVaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-w4FNGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:37 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-hpGlHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:37 INFO - Running setup.py install for manifestparser 13:51:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:37 INFO - Running setup.py install for mozcrash 13:51:37 INFO - Running setup.py install for mozdebug 13:51:38 INFO - Running setup.py install for mozdevice 13:51:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozfile 13:51:38 INFO - Running setup.py install for mozhttpd 13:51:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozinfo 13:51:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozInstall 13:51:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozleak 13:51:39 INFO - Running setup.py install for mozlog 13:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for moznetwork 13:51:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozprocess 13:51:39 INFO - Running setup.py install for mozprofile 13:51:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozrunner 13:51:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozscreenshot 13:51:40 INFO - Running setup.py install for moztest 13:51:40 INFO - Running setup.py install for mozversion 13:51:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:40 INFO - Cleaning up... 13:51:40 INFO - Return code: 0 13:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:40 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')]} 13:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 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')]} 13:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:40 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 13:51:40 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 13:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:40 INFO - 'HOME': '/Users/cltbld', 13:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:40 INFO - 'LOGNAME': 'cltbld', 13:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:40 INFO - 'MOZ_NO_REMOTE': '1', 13:51:40 INFO - 'NO_EM_RESTART': '1', 13:51:40 INFO - 'PAGER': '/bin/cat', 13:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:40 INFO - 'PWD': '/builds/slave/test', 13:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:40 INFO - 'SHELL': '/bin/bash', 13:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:40 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:40 INFO - 'USER': 'cltbld', 13:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:40 INFO - 'XPC_FLAGS': '0x0', 13:51:40 INFO - 'XPC_SERVICE_NAME': '0', 13:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-zl0F0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 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)) 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3Vyucm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-MBShbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 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)) 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-SVHcad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xHx0Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-I_S4Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-O6wcg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Wk8gGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-fjQhT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-boKgkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xZUQ2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Pbhrcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Ufp4hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:42 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-NovNJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-UI0BfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:42 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-BoLnmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:42 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xO5ZoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:42 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)) 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:42 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)) 13:51:42 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:42 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:42 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 13:51:42 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 13:51:42 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 13:51:42 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 13:51:42 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 13:51:42 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 13:51:44 INFO - Downloading blessings-1.6.tar.gz 13:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:45 INFO - Installing collected packages: blessings 13:51:45 INFO - Running setup.py install for blessings 13:51:45 INFO - Successfully installed blessings 13:51:45 INFO - Cleaning up... 13:51:45 INFO - Return code: 0 13:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:45 INFO - Reading from file tmpfile_stdout 13:51:45 INFO - Current package versions: 13:51:45 INFO - blessings == 1.6 13:51:45 INFO - blobuploader == 1.2.4 13:51:45 INFO - docopt == 0.6.1 13:51:45 INFO - functools32 == 3.2.3-2 13:51:45 INFO - jsonschema == 2.5.1 13:51:45 INFO - manifestparser == 1.1 13:51:45 INFO - mozInstall == 1.12 13:51:45 INFO - mozcrash == 0.17 13:51:45 INFO - mozdebug == 0.1 13:51:45 INFO - mozdevice == 0.48 13:51:45 INFO - mozfile == 1.2 13:51:45 INFO - mozhttpd == 0.7 13:51:45 INFO - mozinfo == 0.9 13:51:45 INFO - mozleak == 0.1 13:51:45 INFO - mozlog == 3.4 13:51:45 INFO - moznetwork == 0.27 13:51:45 INFO - mozprocess == 0.23 13:51:45 INFO - mozprofile == 0.28 13:51:45 INFO - mozrunner == 6.12 13:51:45 INFO - mozscreenshot == 0.1 13:51:45 INFO - mozsystemmonitor == 0.3 13:51:45 INFO - moztest == 0.7 13:51:45 INFO - mozversion == 1.4 13:51:45 INFO - psutil == 3.1.1 13:51:45 INFO - requests == 1.2.3 13:51:45 INFO - wsgiref == 0.1.2 13:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 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 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:45 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 13:51:45 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 13:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:45 INFO - 'HOME': '/Users/cltbld', 13:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:45 INFO - 'LOGNAME': 'cltbld', 13:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:45 INFO - 'MOZ_NO_REMOTE': '1', 13:51:45 INFO - 'NO_EM_RESTART': '1', 13:51:45 INFO - 'PAGER': '/bin/cat', 13:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:45 INFO - 'PWD': '/builds/slave/test', 13:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:45 INFO - 'SHELL': '/bin/bash', 13:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:45 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:45 INFO - 'USER': 'cltbld', 13:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:45 INFO - 'XPC_FLAGS': '0x0', 13:51:45 INFO - 'XPC_SERVICE_NAME': '0', 13:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:45 INFO - Cleaning up... 13:51:45 INFO - Return code: 0 13:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109873490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff190c76b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, '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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 13:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:45 INFO - 'HOME': '/Users/cltbld', 13:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:45 INFO - 'LOGNAME': 'cltbld', 13:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:45 INFO - 'MOZ_NO_REMOTE': '1', 13:51:45 INFO - 'NO_EM_RESTART': '1', 13:51:45 INFO - 'PAGER': '/bin/cat', 13:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:45 INFO - 'PWD': '/builds/slave/test', 13:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:45 INFO - 'SHELL': '/bin/bash', 13:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:51:45 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:45 INFO - 'USER': 'cltbld', 13:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:45 INFO - 'XPC_FLAGS': '0x0', 13:51:45 INFO - 'XPC_SERVICE_NAME': '0', 13:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:46 INFO - Cleaning up... 13:51:46 INFO - Return code: 0 13:51:46 INFO - Running post-action listener: _resource_record_post_action 13:51:46 INFO - Running post-action listener: _start_resource_monitoring 13:51:46 INFO - Starting resource monitoring. 13:51:46 INFO - [mozharness: 2016-10-20 20:51:46.152456Z] Finished create-virtualenv step (success) 13:51:46 INFO - [mozharness: 2016-10-20 20:51:46.153557Z] Running install step. 13:51:46 INFO - Running pre-action listener: _resource_record_pre_action 13:51:46 INFO - Running main action method: install 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:46 INFO - Reading from file tmpfile_stdout 13:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:46 INFO - Reading from file tmpfile_stdout 13:51:46 INFO - Output received: 13:51:46 INFO - Usage: mozinstall [options] installer 13:51:46 INFO - Options: 13:51:46 INFO - -h, --help show this help message and exit 13:51:46 INFO - -d DEST, --destination=DEST 13:51:46 INFO - Directory to install application into. [default: 13:51:46 INFO - "/builds/slave/test"] 13:51:46 INFO - --app=APP Application being installed. [default: firefox] 13:51:46 INFO - mkdir: /builds/slave/test/build/application 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:52:20 INFO - Reading from file tmpfile_stdout 13:52:20 INFO - Output received: 13:52:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:20 INFO - Running post-action listener: _resource_record_post_action 13:52:20 INFO - [mozharness: 2016-10-20 20:52:20.802807Z] Finished install step (success) 13:52:20 INFO - [mozharness: 2016-10-20 20:52:20.802998Z] Running run-tests step. 13:52:20 INFO - Running pre-action listener: _resource_record_pre_action 13:52:20 INFO - Running main action method: run_tests 13:52:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:20 INFO - 2016-10-20 13:52:20.818 screenresolution[7471:137739] starting screenresolution argv=screenresolution get 13:52:20 INFO - 2016-10-20 13:52:20.821 screenresolution[7471:137739] Display 0: 1600x1200x32@60 13:52:20 INFO - 2016-10-20 13:52:20.827 screenresolution[7472:137741] starting screenresolution argv=screenresolution list 13:52:20 INFO - Available Modes on Display 0 13:52:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:21 INFO - Intel Iris: 13:52:21 INFO - Chipset Model: Intel Iris 13:52:21 INFO - Type: GPU 13:52:21 INFO - Bus: Built-In 13:52:21 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:21 INFO - Vendor: Intel (0x8086) 13:52:21 INFO - Device ID: 0x0a2e 13:52:21 INFO - Revision ID: 0x0009 13:52:21 INFO - Displays: 13:52:21 INFO - Display: 13:52:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:21 INFO - Display Serial Number: 1600x1200 60 13:52:21 INFO - Main Display: Yes 13:52:21 INFO - Mirror: Off 13:52:21 INFO - Online: Yes 13:52:21 INFO - Rotation: Supported 13:52:21 INFO - Return code: 0 13:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:21 INFO - Python 2.7.3 13:52:21 INFO - Return code: 0 13:52:21 INFO - grabbing minidump binary from tooltool 13:52:21 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')]} 13:52:21 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 0x109687d30>, '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 0x1094addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10967fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:21 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 13:52:21 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 13:52:21 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 13:52:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:21 INFO - Return code: 0 13:52:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 13:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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 13:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5e5KvnC1wx/Render', 13:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:21 INFO - 'HOME': '/Users/cltbld', 13:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:21 INFO - 'LOGNAME': 'cltbld', 13:52:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:21 INFO - 'MOZ_NO_REMOTE': '1', 13:52:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:21 INFO - 'NO_EM_RESTART': '1', 13:52:21 INFO - 'PAGER': '/bin/cat', 13:52:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:21 INFO - 'PWD': '/builds/slave/test', 13:52:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:21 INFO - 'SHELL': '/bin/bash', 13:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZHVttCwaqI/Listeners', 13:52:21 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 13:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:21 INFO - 'USER': 'cltbld', 13:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:21 INFO - 'XPC_FLAGS': '0x0', 13:52:21 INFO - 'XPC_SERVICE_NAME': '0', 13:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 13:52:21 INFO - mozversion application_buildid: 20161020112549 13:52:21 INFO - mozversion application_changeset: f0f1aaf051d6798e1e73d1feee07ca847333167a 13:52:21 INFO - mozversion application_display_name: Nightly 13:52:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:21 INFO - mozversion application_name: Firefox 13:52:21 INFO - mozversion application_remotingname: firefox 13:52:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:21 INFO - mozversion application_vendor: Mozilla 13:52:21 INFO - mozversion application_version: 52.0a1 13:52:21 INFO - mozversion platform_buildid: 20161020112549 13:52:21 INFO - mozversion platform_changeset: f0f1aaf051d6798e1e73d1feee07ca847333167a 13:52:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:21 INFO - mozversion platform_version: 52.0a1 13:52:21 INFO - using testdate: 1476996741 13:52:21 INFO - actual date: 1476996741 13:52:21 INFO - starting webserver on 'localhost:53221' 13:52:21 INFO - SUITE-START | Running 2 tests 13:52:21 INFO - TEST-START | dromaeo_css 13:52:21 INFO - operating with platform_type : mac_ 13:52:21 INFO - Initialising browser for dromaeo_css test... 13:52:21 INFO - TEST-INFO | started process 7482 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpw3S1Mj/profile http://localhost:53221/getInfo.html) 13:52:24 INFO - PROCESS | 7482 | 2016-10-20 13:52:24.054 plugin-container[7484:137897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 13:52:24 INFO - PROCESS | 7482 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:24 INFO - PROCESS | 7482 | 2016-10-20 13:52:24.057 plugin-container[7484:137897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 13:52:24 INFO - PROCESS | 7482 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:24 INFO - PROCESS | 7482 | 2016-10-20 13:52:24.057 plugin-container[7484:137897] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:24 INFO - PROCESS | 7482 | __metrics Screen width/height:1600/1200 13:52:24 INFO - PROCESS | 7482 | colorDepth:24 13:52:24 INFO - PROCESS | 7482 | Browser inner width/height: 1024/689 13:52:24 INFO - PROCESS | 7482 | __metrics 13:52:24 ERROR - PROCESS | 7482 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 13:52:24 INFO - TEST-INFO | 7482: exit 0 13:52:24 INFO - Browser initialized. 13:52:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:24 INFO - TEST-INFO | started process 7485 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpw3S1Mj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:27 INFO - PROCESS | 7485 | 2016-10-20 13:52:27.513 plugin-container[7486:138015] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 13:52:27 INFO - PROCESS | 7485 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:27 INFO - PROCESS | 7485 | 2016-10-20 13:52:27.513 plugin-container[7486:138015] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 13:52:27 INFO - PROCESS | 7485 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:27 INFO - PROCESS | 7485 | 2016-10-20 13:52:27.513 plugin-container[7486:138015] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:37 INFO - PROCESS | 7485 | RSS: Main: 237146112 13:52:37 INFO - PROCESS | 7485 | 13:53:26 INFO - PROCESS | 7485 | 1476996806784 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:55:40 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53221/tests/dromaeo/cssquery-ext.html) 13:55:42 INFO - PROCESS | 7485 | RSS: Main: 249389056 13:55:42 INFO - PROCESS | 7485 | 13:58:44 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-ext.html (next: http://localhost:53221/tests/dromaeo/cssquery-jquery.html) 13:58:45 INFO - PROCESS | 7485 | RSS: Main: 263512064 13:58:45 INFO - PROCESS | 7485 | 14:01:47 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53221/tests/dromaeo/cssquery-mootools.html) 14:01:47 INFO - PROCESS | 7485 | RSS: Main: 268242944 14:01:47 INFO - PROCESS | 7485 | 14:04:49 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53221/tests/dromaeo/cssquery-prototype.html) 14:04:50 INFO - PROCESS | 7485 | RSS: Main: 268034048 14:04:50 INFO - PROCESS | 7485 | 14:07:52 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53221/tests/dromaeo/cssquery-yui.html) 14:07:53 INFO - PROCESS | 7485 | RSS: Main: 273432576 14:07:53 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | Cycle 1(1): loaded http://localhost:53221/tests/dromaeo/cssquery-yui.html (next: http://localhost:53221/tests/dromaeo/cssquery-dojo.html) 14:10:56 INFO - PROCESS | 7485 | RSS: Main: 276086784 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | __start_tp_report 14:10:56 INFO - PROCESS | 7485 | _x_x_mozilla_page_load 14:10:56 INFO - PROCESS | 7485 | _x_x_mozilla_page_load_details 14:10:56 INFO - PROCESS | 7485 | |i|pagename|runs| 14:10:56 INFO - PROCESS | 7485 | |0;dojo.html;3327.4010678077934;3354.0943945134813;3369.915752106197;3376.5948086229655;3377.071305391017;5613.017721898672;5652.830415087554;5653.886922261558;5664.461876121773;5694.430556944303;5619;5640.915386269199;5686.09022556391;5694.145878118274;5727.255456790622;5123.180291153416;5162.638615296931;5190.870228244286;5221.660592061504;5258.44786297439;5164.483551644843;5263.078961181797;5276.393214780311;5281.603879709037;5324.946750532484;5091.134507133796;5142.640015198937;5163.457836927125;5186.403563590197;5208.348956380452;5157.535821776059;5174.715390653512;5179;5180.0157969985585;5211.765470553834;5115.948840511584;5128.9230661540105;5162.586993040548;5182.170852663593;5203.16749320107;5529.225908372831;5572.498475137217;5578.888422231573;5607.691576963265;5718.628289161191;5534.920690465361;6136.938630613681;6160.199174107337;6220.066989951498;6222.719977601018;6200.596961197508;6201.937980620181;6202.751889924398;6209.161763162006;6223.906641400383;5606.103023516218;5665.915011274834;5744.253247077853;5789.247397838296;5844.590878638454;6139.093519790236;6222;6228.56400051992;6231.501479881598;6246.094316324107;5986.461218490357;6064.969675151596;6082.178905847654;6086.087086936906;6110.602810817282;6059.333473317932;6082.391760823971;6122.66325352101;6130.877382452326;6159.784407545804;6057.727402266909;6077.453029227391;6109.450149486567;6140.995089002448;6147.801178770186;6103.084537319349;6112.711514445909;6125.723854043132;6133.82435864808;6148.831721972811;4763.2140696784645;4893.241547560134;4915.459299477055;4927;4931.457539670633;4304.870853874389;4345.543717909637;4369.300911854151;4414.227510185705;4498.437695288089;5226.268322434862;5734.340550836707;5745.080787074048;5779.162021506942;5824.534037277008;6097.237845269341;6127.325994140641;6129.601575897553;6131.14164017038;6141.140240366352;5670.971645141748;5739.253896993448;5767.134929760486;5782.2194003808945;5819.0689489681445;5374.193870919394;5379.946200538023;5393.352797664227;5407.270018547524;5411.918821217685;6214.720337584729;6304.684765761694;6323.272823625342;6331.525135614847;6349.809505714836;6040.395960403925;6097.176881120992;6108;6109.633421994695;6136.969315153396;6281.905771413341;6299.622022678654;6301.464375528131;6305.779297724557;6326.936730632819;6045.335013148638;6106.419890110433;6123.08153776937;6124.265088189268;6124.755009799558;6011.398860114128;6094.421030002142;6096.329403765671;6120.142398366865;6138.51101655979;5995.190649262294;6020.127081573235;6031.24609423822;6053.213082299273;6081.6351018939;5891.852703682271;6023.156758053964;6046.1535385045245;6053.152558641882;6075.696215189311;4420.624246939046;5777.971110144423;5819.6508209507565;5893.675847828411;5983.55123365758;5523.8066667666435;5862.94137058624;6039.335673076046;6078.483328917092;6099;5884.823455296348;5925.555583331181;5960.672163031075;5973.163757073926;5977.970110149421 14:10:56 INFO - PROCESS | 7485 | |1;ext.html;479.6330806932696;486.63988648400175;496.1763472635425;511.1923161404983;540.4055538907201;38529.61470385295;40404.79797601015;40558.39162412566;40566.59433405665;40574.39138412926;41757;41863.79068104663;42166.36750448738;42218.36672449916;42235.155296894045;9365.438073715564;9608.279379046564;9611.086946740083;9624.133827955482;9631.373960692568;9461.905380946171;9548.713538593853;9555.283353748497;9556.569954352071;9572.186364159055;9508.714738557854;9538.856917146248;9544.188743956738;9567.282453815957;9604;9466.90533094667;9525.761855953588;9528.714138575853;9538.713838584854;9545.90454095457;9465.574049167804;9465.763355916088;9487.478188699619;9519.000504946951;9541.475218862959;39848.20303593941;39950.20099597992;40074;40086.79956600198;40284.194316113804;2830.2075418882746;3317.2370354818527;3343;3392.8642854286045;3494.8951531453845;26246.606300905503;29568.408631827242;29796.10611681653;30120.945766898054;31171.37657246865;2579.3680548265606;3189.1867573768773;3212.261179928606;3216.5014422764507;3302.570665813429;352903;352915;353102;353543;355670;49522.50477495251;54113.1883021755;56211.875762484524;56503.71748141233;56529.43470565242;58185;58481.415185847596;58738.41261587329;59268.81462370729;59485.40514594799;15520;15553;15565;15725.764113538306;15750.9212453937;12190.207636503776;12216.938915305367;12256.325902075294;12264;12268;13896.235707036009;14998.250087495582;15069.54791356261;15151.696966060617;15309.311081001382;5632.070708333161;6244.063390491463;6281.7173227204885;6352.301246862841;6414;874.8906386701663;939.8768471676282;1007.868977032981;1014.2089170447063;1080.4543705428707;28030.738616762294;28146.85926570395;29577.408451831274;29734.85132574323;30131;1037.8376218635176;1047.0733400940223;1080.7784404197278;1089.4062735809002;1134.0927258193412;15001.624959375884;15516.922415387851;15576.454824081104;15730.921345393428;15822.683546329008;634192;636121;639373;650985;927701;56257;57670.71164644234;58459.415405846245;58529.707351462974;58558;1359.7620416427085;1379.4137491566246;1401.6636007358366;1410.2948525737131;1411.5271384086445;25654.871725641253;29859.850700746356;30138.397232055675;30162.84918575393;30204.84897575498;48107.518924810305;48522.5147748518;48635.5136448631;48636;48689.83516071444;572053;591207.0879291152;594267;595102;595616;24458.755412445647;24968.250952470727;25065;25624.54068700776;25789.097381591553;35494.64505354913;45547;46407.76796115998;47358.28962565495;47374.763126184145;34428.13929651779;38437.615623843405;38524.42213366858;38954.80522597369;39592;38196;38605.28124470857;38704.41943370908;39161.608383915795;39366.409503858034;29773.10680679583;32415.675843241264;37380.43929341117;37554.248915021;37670.434943476415;31873.521897172024;33971.344306723055;34081.82959085288;34503.4824477638;34524.48213276853;21601.243956461447;21809.672854906872;22406.215782447536;22520.769849226253;25475 14:10:56 INFO - PROCESS | 7485 | |2;jquery.html;312.3768082675063;336.89666342727554;366.77626647744853;368.793475653634;372.8229091181691;19539.609207815854;19950.30173943912;20012.799872001295;20494.692579611317;20747.273845415413;18120.093995300216;20166.19335226589;20309.695354569656;20931.686024709605;21169.57660846782;4769.689970151946;5193.45468725784;5708.343540492855;6037.72830222641;6041.335453100155;5513.917291240635;6796.592204467723;6801.625910574917;6811.455083593325;6814.591124532544;5692.146178073281;6013.579049466539;6040.848978775522;6752.257251702309;6810.046593476917;6006.729697163638;6042.818715438544;6057.485113765335;6083.330833608299;6093.634381937076;5780.9710951445395;5870.471657550798;5917.940820591825;5922.2597175353085;5933.643981361089;13159.736805263938;13381.598552043455;18764.624707505773;25435.872820635963;25796.839142238645;2109.5886302171084;2140.8929553522416;2275.2605403243847;2281.840271181018;2793.8184018038764;9382.5308734563;9932.751681207956;10266.79466410675;10317.226208034352;10325;1860.9162587683586;1874.7750269967555;1879.4361691492634;1892.943211703651;1922.5770330527262;98403.52394714086;119772;120018.39990800078;120630;122335.38832305782;10514.316569422963;10893.074088702391;10960.725981850517;11440.199186057063;11480.253783504213;11921;12068.155229134052;14238.572842814732;14330;14334.354954027094;8152.184781521919;8317.875231871527;8395.748127556182;8468.32253419725;8476.957615211884;6544.574602650812;7977;8187.71343002992;8242.587870606445;8383.622736976851;3634.9818250908575;4491.505934347219;4492.191405546968;4570.6800523963;4578.587927086512;1624.3989723802033;1855.4897403213954;1910.3695780392436;1919.577692907558;1921.7213504042115;840.8612578924532;926.1571969507715;934.5327336331834;950.7385468996082;980.4117529482396;20115.39653810388;20948;21004;21034.368968930958;21090.261840835497;852.48424703055;917.2570218123342;917.4770380882833;931.1991687149047;964.9517524123765;8217.260446559838;10557.9472102639;10903.236773425942;11030.889691103146;11032.834507482394;564705;569805;600738;637867;638585.807070971;133318;138011.54971125803;140127;140221;142699.2865035668;963.7735132243918;973.6738192705523;991.8016396720685;995.2682332740978;1001.249063202598;18328.541786455444;18422;18573.90713046426;18698.719519206952;19004.714929275797;52350.73824630852;53137.46862531325;53327.733361334496;54324;54475.72762136323;54778.72610636921;77519.2248077512;78679;79125.60437197777;81329;6396.744130234739;7154.570725756471;7733.729319473791;7875.645595948311;8182.67269309221;10248.872624011501;10362.75646922344;10406.439034144636;11341.943290283496;12049.939750301193;8959.1936725695;9504.572294246915;10387.636432724817;10603.469826508797;10677.89322106769;10207.081362677394;10346.27576069698;10348.172146228435;10613.575456981634;10835.729106772395;10487.632932847313;10620.991005854432;10687.732806679895;10885.510152043018;10892.509837057192;7625.894245334506;7865.213478652089;7936.166702496154;8067.3949453792375;8092.352611791161;10160.644377446753;10242.07821296057;10345.068943795095;10473.68578942633;10493 14:10:56 INFO - PROCESS | 7485 | |3;mootools.html;1541.2910061371772;1575.3541048170248;1749.9237968649277;1788.4545213709814;1904.42867139858;7954.96022519888;8252.29855462285;8343.249107580317;8949.149830766082;8969.416987895791;8392.328613710904;8713.30293576514;8713.607887645056;8828.77928051799;8868.02451730309;2359.8112151027876;2376.786089251967;2401.687780588521;2408.4580969281947;2410.9397265068337;2355.9882200588972;2400.7719266669724;2400.8799560022017;2401.927942161738;2408.4821763320883;2376.536575367804;2386.9283921482383;2399.3881560202126;2403.158894386959;2405.2663937499055;2354.5290941811704;2365.5387199496104;2375.323032935605;2382.201962342617;2398.3284680289457;2303.689001984744;2328.4295347639936;2338.263447014202;2341.9297421077395;2344.9296521104393;8768.956155219246;8829.735107946772;8877;8894.243989260856;8896.911030889738;5242.370915490127;5386.084365657847;5431.293931788881;5437.782488700447;5446.537044351235;3326.850291736878;3585.659362360572;3632.219072899313;3685.7419980601367;3691.0587800110798;1021.3565453764155;1090.2422816142785;1097.4732128578328;1106.2090605217227;1107.5901916290943;11483.655490335303;11517.308961462339;11617.18679692422;11625.128115391295;11628.883711162865;4341.934870976938;4547.09058188357;4585.839495617637;4750.61995040396;4907.901841963212;8732.257758090633;9280.628774849065;9876.962918893556;9888.901110988942;9922.950385248028;5402.540784033401;5418.783248670088;5439;5446.700431476307;5446.782128714886;4447.844325448594;4599.172149013143;4776.546228108324;4914.434839993375;4926.088673595396;3566.144125409935;3583.9606514111138;3925;3993.960060399359;4121.443605113332;1095.9616413425492;1304.7455746129413;1311.2919023727081;1319.9472021119047;1324.1657755614094;831.4346244553761;885.0795173019987;917.8669092981614;928.8374534456578;948.1561410344799;4948.529889660476;5648.237487939075;5860.882782344329;6038.607490513103;6110.541709371815;385.43533723095237;427.5446649318528;432.96536277097755;447.3178402935549;448.83617479619704;3969.7419667721506;4017;4046.7976601169826;4085.3054980652764;4099.651529619956;10318;10570.52432640533;10666.41334726582;10689.786204275872;10696.78606427867;10283.897161028444;10480.790384192425;10632.734181645521;10670.786584268271;10686.465676716132;8120.390970677223;8159.347252219927;8240.711575094843;8243.95878020618;8244.051934027544;5813.941860581509;5816.098504731774;5920.970395147997;5960.135780311917;5981.551383646331;8861.291096712119;9359.719208423758;10009;10011.599536018477;10074.294799363974;10107.69676909694;10154.54304556282;10180.490975451346;10198.286119971828;10208.948955255177;6866.313368663094;7113.964430178023;7271.490995630255;7463.328300452768;7534.246575342641;8096.83806323882;8278.751637450887;8477.364197685321;8478.194571515696;8487.448315859448;7275.527090739085;7451.552906825608;7569.848603027798;7622.390208783173;7735;7249.673764680497;7382.114146302478;7436.293552112541;7516.774496765106;7606.353459955966;6961.408280296231;7116.893246601202;7121.394681452135;7131.0729605151;7151.392131668867;4517.819287228474;4943.431505376928;5066.594672426123;5136.434992150935;5138.049460849755;4875.19559272716;4958.504149585013;5041.193409054534;5158.3294171758935;5178.559822415137 14:10:56 INFO - PROCESS | 7485 | |4;prototype.html;296.93467437163827;297.4126100950624;304.9725524702777;308.2048315346405;311.1226341716359;4872.927955849712;5415.864603384917;5457.253678822768;5520.350231888686;5528.917066244009;4517.186906356863;5359.464053594638;5372.301600791901;5430.0768869292215;5440.755166017529;3024.6219222597174;3178.507331363631;3276.8197749123788;3988.8205030773684;4020.3567429211184;3956.5449973253158;4078.4290199372113;4083.775392353419;4121.475054229939;4168.687348448879;3518.489818976247;4099.71302008858;4111.5477297497255;4112.670986321102;4136.855210067648;3333.916652083693;3478.9478157827652;3983.5817239190046;4119.382092686091;4134.793260337001;3548.627394123606;3550.5856017907813;3560.732945029133;3571.196480791827;3593.6047034826147;4763.737994410306;4797.328374027604;4867.318575399447;5250.842474725764;5267.604929630293;4253.851115210953;4719.07977944301;4752.1921273383605;4754;4768.904621907543;4882.193588372289;4974.602031837444;5187.988342273258;5480.273713780147;5722.399148089432;3893.4549163117185;3901.5708272090333;3912.2957867583823;3920;3943.2704949584418;5587.469190426903;6009;6011.669358185298;6020.729067191987;6028.5478589106;3529.2588556403443;3850.9807450962567;3867.6325749053794;3913.3151698452657;3943;3971.3050216212623;3976;3998.8000599969887;4034.11249525104;4035.5205721648945;4656.208444564432;4677.555632214934;4690.053627744516;4697.248440249544;4730.574248317599;4293.957060429419;5072.757174492273;5566;5716.713013499039;5725.456081672234;1314.8290722206052;1324.3576865220361;1355.7933439239084;1359.5853264754344;1363.4341748174397;673.7540797608935;702.2941943347006;718.2888939949516;731.5500966905315;765.9463837531431;4661.440627124767;4826.996796329484;5271.973640131775;5299.4700529946695;5417.566594672417;5293.655912365684;5485.135054081552;5715.857103572361;5917.911231331534;5946.67293298864;5163.7676304566385;5277.313949186581;5416.3750874737425;5423.891522169534;5436.858259765414;2675.662168915542;3022.9244268893453;3076.7846700553605;3089.4593446146832;3121.2352973521633;5791.247137872049;6094.939050609526;6119.418655227746;6136.846578835565;6191;5571.910533549919;5721.771129154788;5961.433663801932;6041.8489537761025;6046.848828779316;5199.584033277404;6128.63228206309;6135;6146.354632763585;6210.72051757681;4879.878003049952;5502.230971784341;5854.121881717776;5889.911651325147;5960.284765828128;4976.880201954531;5763.855903602276;5781.94218057814;5797.681127537857;5849.4554868632285;4905.48492408292;5409.972950135224;5440.8639784004135;6093.446171226309;6171.352008039091;3716.1976441425345;3857.40210267409;3892.455056292065;3897.512810898638;3910.042039700178;4817.518248175154;5429.077056900257;5876.6180198286975;5909.881802363842;5910.408959104056;4828.613710903049;4935.568685081286;5732.274021885808;5733.885322293614;5763.971180144073;5056.6713163644245;5650.55910742758;5730.684812335361;5743.368229494668;5748.166515855094;5217.399999000164;5395.92081583677;5565.693886836101;5623.2127502148915;5708.115242137475;5143.61422893277;5283.920741188962;5370.704611246419;5447.754851031634;5587.245721827501;5621.80323688669;5626.746796394254;5627.971860140837;5676.971615141898;5692.288463942007 14:10:56 INFO - PROCESS | 7485 | |5;yui.html;674.9223839258484;675.2201207605218;687.8074139241011;733.783533857512;766.1954947305328;13357.53248636298;15534.766978495332;15752.291146898388;16455.670886582262;16523.834761652364;14914.701705965874;14988.700225995473;15003.099814011168;15029.774553381681;15057.096574205529;694.6214313199318;712.7077898061796;872.8996165440976;875.2604049578097;893.7765558610347;885.3315746611331;891.0510306523564;901.0673952459173;905.6286922361833;907.2288554728461;936.194872409727;951.9000504946985;953.0564740906522;953.904609539044;958.9856152157688;930.6463543853326;942.4015749998731;948.6632245552833;948.9845864924533;950.5009869818332;706.2407911495163;707.6002058836741;707.7770502291813;707.7876637008877;711.1643818513278;15247.466338678092;15294.923525382414;15341.386344546205;15359;15414.22928853553;14600.707985840223;14707.411703531845;14775.482858100022;14799.92600036993;14843.703125937529;11743.412829358498;11824.822627660593;11907.583234586747;12045.217060891015;12161.966232870216;3382.9492557611657;3763.473113764075;3781.4894989176382;3954.5452272988687;4015.19696060789;111770;112445;113209;114493;122334;11344.978951894203;11365.602203922823;11476.942615286871;11523.423828808694;11918.523259069714;23600.29199124029;23800.88099559491;23824;23856;24016.39959001039;8092.190780921861;8162.795930101676;8200;8268.917310826935;8439.367047471464;4345.652347812167;4409.382686423904;4444.599986001211;4486.102779444124;4486.1924853526025;3477.530533378012;3587.892363229107;3588.766730162531;3605.3330133925306;3605.963940360615;594.8423667728056;637.2671427858;644.690548536705;646.8544577470032;652.3281020548842;575.5110140901039;672.6468603982948;679.6339357890577;683.4907993544841;709.3474003916409;9363.906360936304;9605.279604029585;9606.951965240129;9659.806803863883;9718.61125554984;568.7042737776416;626.8307556959595;651.8989556618732;671.3957438305466;673.9561928474732;4402.757848318373;4491.595756381941;4771.165046116916;5193.402758682724;5309.628326017141;94036.52981735184;96204;96345;100074;112570;101253.79939209692;117329;133901.3304933469;134650.32674836562;135314;101639.45901352525;107557.46221268686;107696.4615176919;124162;125861.37069314595;8785.692500762698;9285.442873427615;9987.800243994934;10050.447225402673;10135.239857010607;58874;61230.38769612247;61338.07992880021;62569.37430625635;63054.36945630668;58124.70937645285;71585.6420717893;87180.56409717911;90844;98250;12458.442694663167;12967.351632418153;13698.65753356174;13699.315034248448;13774.517891873737;15013.924930375279;15045.849541504882;15165.317560709575;15209.847901520843;15710.685786284439;13857.30713464343;13876.58370248894;14041.929790350983;14092;14417.35121919537;13935.721285574029;13990.650233744238;14012.719745604827;14325.140491570539;14381.280935952951;13459;13524.256165910576;13755.587332380044;14046.929765351108;14310.928445357707;11376.715582110513;11410.82883756761;11458.197926145423;11602.825957610812;11949.761004779682;9107.59015844302;10367.066963973279;11250.099992000456;11504.367259800456;11847.229930054518 14:10:56 INFO - PROCESS | 7485 | __end_tp_report 14:10:56 INFO - PROCESS | 7485 | __start_cc_report 14:10:56 INFO - PROCESS | 7485 | _x_x_mozilla_cycle_collect,368 14:10:56 INFO - PROCESS | 7485 | __end_cc_report 14:10:56 INFO - PROCESS | 7485 | __startTimestamp1476997856788__endTimestamp 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | ------- Summary: start ------- 14:10:56 INFO - PROCESS | 7485 | Number of tests: 6 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#0] dojo.html Cycles:165 Average:5680.85 Median:5891.85 stddev:625.70 (10.6%) stddev-sans-first:599.76 14:10:56 INFO - PROCESS | 7485 | Values: 3327.4 3354.1 3369.9 3376.6 3377.1 5613.0 5652.8 5653.9 5664.5 5694.4 5619.0 5640.9 5686.1 5694.1 5727.3 5123.2 5162.6 5190.9 5221.7 5258.4 5164.5 5263.1 5276.4 5281.6 5324.9 5091.1 5142.6 5163.5 5186.4 5208.3 5157.5 5174.7 5179.0 5180.0 5211.8 5115.9 5128.9 5162.6 5182.2 5203.2 5529.2 5572.5 5578.9 5607.7 5718.6 5534.9 6136.9 6160.2 6220.1 6222.7 6200.6 6201.9 6202.8 6209.2 6223.9 5606.1 5665.9 5744.3 5789.2 5844.6 6139.1 6222.0 6228.6 6231.5 6246.1 5986.5 6065.0 6082.2 6086.1 6110.6 6059.3 6082.4 6122.7 6130.9 6159.8 6057.7 6077.5 6109.5 6141.0 6147.8 6103.1 6112.7 6125.7 6133.8 6148.8 4763.2 4893.2 4915.5 4927.0 4931.5 4304.9 4345.5 4369.3 4414.2 4498.4 5226.3 5734.3 5745.1 5779.2 5824.5 6097.2 6127.3 6129.6 6131.1 6141.1 5671.0 5739.3 5767.1 5782.2 5819.1 5374.2 5379.9 5393.4 5407.3 5411.9 6214.7 6304.7 6323.3 6331.5 6349.8 6040.4 6097.2 6108.0 6109.6 6137.0 6281.9 6299.6 6301.5 6305.8 6326.9 6045.3 6106.4 6123.1 6124.3 6124.8 6011.4 6094.4 6096.3 6120.1 6138.5 5995.2 6020.1 6031.2 6053.2 6081.6 5891.9 6023.2 6046.2 6053.2 6075.7 4420.6 5778.0 5819.7 5893.7 5983.6 5523.8 5862.9 6039.3 6078.5 6099.0 5884.8 5925.6 5960.7 5973.2 5978.0 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#1] ext.html Cycles:180 Average:67530.51 Median:38829.61 stddev:153015.93 (394.1%) stddev-sans-first:153362.37 14:10:56 INFO - PROCESS | 7485 | Values: 479.6 486.6 496.2 511.2 540.4 38529.6 40404.8 40558.4 40566.6 40574.4 41757.0 41863.8 42166.4 42218.4 42235.2 9365.4 9608.3 9611.1 9624.1 9631.4 9461.9 9548.7 9555.3 9556.6 9572.2 9508.7 9538.9 9544.2 9567.3 9604.0 9466.9 9525.8 9528.7 9538.7 9545.9 9465.6 9465.8 9487.5 9519.0 9541.5 39848.2 39950.2 40074.0 40086.8 40284.2 2830.2 3317.2 3343.0 3392.9 3494.9 26246.6 29568.4 29796.1 30120.9 31171.4 2579.4 3189.2 3212.3 3216.5 3302.6 352903.0 352915.0 353102.0 353543.0 355670.0 49522.5 54113.2 56211.9 56503.7 56529.4 58185.0 58481.4 58738.4 59268.8 59485.4 15520.0 15553.0 15565.0 15725.8 15750.9 12190.2 12216.9 12256.3 12264.0 12268.0 13896.2 14998.3 15069.5 15151.7 15309.3 5632.1 6244.1 6281.7 6352.3 6414.0 874.9 939.9 1007.9 1014.2 1080.5 28030.7 28146.9 29577.4 29734.9 30131.0 1037.8 1047.1 1080.8 1089.4 1134.1 15001.6 15516.9 15576.5 15730.9 15822.7 634192.0 636121.0 639373.0 650985.0 927701.0 56257.0 57670.7 58459.4 58529.7 58558.0 1359.8 1379.4 1401.7 1410.3 1411.5 25654.9 29859.9 30138.4 30162.8 30204.8 48107.5 48522.5 48635.5 48636.0 48689.8 572053.0 591207.1 594267.0 595102.0 595616.0 24458.8 24968.3 25065.0 25624.5 25789.1 35494.6 45547.0 46407.8 47358.3 47374.8 34428.1 38437.6 38524.4 38954.8 39592.0 38196.0 38605.3 38704.4 39161.6 39366.4 29773.1 32415.7 37380.4 37554.2 37670.4 31873.5 33971.3 34081.8 34503.5 34524.5 21601.2 21809.7 22406.2 22520.8 25475.0 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#2] jquery.html Cycles:180 Average:34918.50 Median:324.64 stddev:100948.99 (31096.0%) stddev-sans-first:101198.74 14:10:56 INFO - PROCESS | 7485 | Values: 312.4 336.9 366.8 368.8 372.8 19539.6 19950.3 20012.8 20494.7 20747.3 18120.1 20166.2 20309.7 20931.7 21169.6 4769.7 5193.5 5708.3 6037.7 6041.3 5513.9 6796.6 6801.6 6811.5 6814.6 5692.1 6013.6 6040.8 6752.3 6810.0 6006.7 6042.8 6057.5 6083.3 6093.6 5781.0 5870.5 5917.9 5922.3 5933.6 13159.7 13381.6 18764.6 25435.9 25796.8 2109.6 2140.9 2275.3 2281.8 2793.8 9382.5 9932.8 10266.8 10317.2 10325.0 1860.9 1874.8 1879.4 1892.9 1922.6 98403.5 119772.0 120018.4 120630.0 122335.4 10514.3 10893.1 10960.7 11440.2 11480.3 11921.0 12068.2 14238.6 14330.0 14334.4 8152.2 8317.9 8395.7 8468.3 8477.0 6544.6 7977.0 8187.7 8242.6 8383.6 3635.0 4491.5 4492.2 4570.7 4578.6 1624.4 1855.5 1910.4 1919.6 1921.7 840.9 926.2 934.5 950.7 980.4 20115.4 20948.0 21004.0 21034.4 21090.3 852.5 917.3 917.5 931.2 965.0 8217.3 10557.9 10903.2 11030.9 11032.8 564705.0 569805.0 600738.0 637867.0 638585.8 133318.0 138011.5 140127.0 140221.0 142699.3 963.8 973.7 991.8 995.3 1001.2 18328.5 18422.0 18573.9 18698.7 19004.7 52350.7 53137.5 53327.7 54324.0 54475.7 54778.7 77519.2 78679.0 79125.6 81329.0 6396.7 7154.6 7733.7 7875.6 8182.7 10248.9 10362.8 10406.4 11341.9 12049.9 8959.2 9504.6 10387.6 10603.5 10677.9 10207.1 10346.3 10348.2 10613.6 10835.7 10487.6 10621.0 10687.7 10885.5 10892.5 7625.9 7865.2 7936.2 8067.4 8092.4 10160.6 10242.1 10345.1 10473.7 10493.0 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#3] mootools.html Cycles:180 Average:5682.52 Median:4825.87 stddev:3176.61 (65.8%) stddev-sans-first:3170.27 14:10:56 INFO - PROCESS | 7485 | Values: 1541.3 1575.4 1749.9 1788.5 1904.4 7955.0 8252.3 8343.2 8949.1 8969.4 8392.3 8713.3 8713.6 8828.8 8868.0 2359.8 2376.8 2401.7 2408.5 2410.9 2356.0 2400.8 2400.9 2401.9 2408.5 2376.5 2386.9 2399.4 2403.2 2405.3 2354.5 2365.5 2375.3 2382.2 2398.3 2303.7 2328.4 2338.3 2341.9 2344.9 8769.0 8829.7 8877.0 8894.2 8896.9 5242.4 5386.1 5431.3 5437.8 5446.5 3326.9 3585.7 3632.2 3685.7 3691.1 1021.4 1090.2 1097.5 1106.2 1107.6 11483.7 11517.3 11617.2 11625.1 11628.9 4341.9 4547.1 4585.8 4750.6 4907.9 8732.3 9280.6 9877.0 9888.9 9923.0 5402.5 5418.8 5439.0 5446.7 5446.8 4447.8 4599.2 4776.5 4914.4 4926.1 3566.1 3584.0 3925.0 3994.0 4121.4 1096.0 1304.7 1311.3 1319.9 1324.2 831.4 885.1 917.9 928.8 948.2 4948.5 5648.2 5860.9 6038.6 6110.5 385.4 427.5 433.0 447.3 448.8 3969.7 4017.0 4046.8 4085.3 4099.7 10318.0 10570.5 10666.4 10689.8 10696.8 10283.9 10480.8 10632.7 10670.8 10686.5 8120.4 8159.3 8240.7 8244.0 8244.1 5813.9 5816.1 5921.0 5960.1 5981.6 8861.3 9359.7 10009.0 10011.6 10074.3 10107.7 10154.5 10180.5 10198.3 10208.9 6866.3 7114.0 7271.5 7463.3 7534.2 8096.8 8278.8 8477.4 8478.2 8487.4 7275.5 7451.6 7569.8 7622.4 7735.0 7249.7 7382.1 7436.3 7516.8 7606.4 6961.4 7116.9 7121.4 7131.1 7151.4 4517.8 4943.4 5066.6 5136.4 5138.0 4875.2 4958.5 5041.2 5158.3 5178.6 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#4] prototype.html Cycles:180 Average:4589.77 Median:5193.79 stddev:1439.97 (27.7%) stddev-sans-first:1407.50 14:10:56 INFO - PROCESS | 7485 | Values: 296.9 297.4 305.0 308.2 311.1 4872.9 5415.9 5457.3 5520.4 5528.9 4517.2 5359.5 5372.3 5430.1 5440.8 3024.6 3178.5 3276.8 3988.8 4020.4 3956.5 4078.4 4083.8 4121.5 4168.7 3518.5 4099.7 4111.5 4112.7 4136.9 3333.9 3478.9 3983.6 4119.4 4134.8 3548.6 3550.6 3560.7 3571.2 3593.6 4763.7 4797.3 4867.3 5250.8 5267.6 4253.9 4719.1 4752.2 4754.0 4768.9 4882.2 4974.6 5188.0 5480.3 5722.4 3893.5 3901.6 3912.3 3920.0 3943.3 5587.5 6009.0 6011.7 6020.7 6028.5 3529.3 3851.0 3867.6 3913.3 3943.0 3971.3 3976.0 3998.8 4034.1 4035.5 4656.2 4677.6 4690.1 4697.2 4730.6 4294.0 5072.8 5566.0 5716.7 5725.5 1314.8 1324.4 1355.8 1359.6 1363.4 673.8 702.3 718.3 731.6 765.9 4661.4 4827.0 5272.0 5299.5 5417.6 5293.7 5485.1 5715.9 5917.9 5946.7 5163.8 5277.3 5416.4 5423.9 5436.9 2675.7 3022.9 3076.8 3089.5 3121.2 5791.2 6094.9 6119.4 6136.8 6191.0 5571.9 5721.8 5961.4 6041.8 6046.8 5199.6 6128.6 6135.0 6146.4 6210.7 4879.9 5502.2 5854.1 5889.9 5960.3 4976.9 5763.9 5781.9 5797.7 5849.5 4905.5 5410.0 5440.9 6093.4 6171.4 3716.2 3857.4 3892.5 3897.5 3910.0 4817.5 5429.1 5876.6 5909.9 5910.4 4828.6 4935.6 5732.3 5733.9 5764.0 5056.7 5650.6 5730.7 5743.4 5748.2 5217.4 5395.9 5565.7 5623.2 5708.1 5143.6 5283.9 5370.7 5447.8 5587.2 5621.8 5626.7 5628.0 5677.0 5692.3 14:10:56 INFO - PROCESS | 7485 | 14:10:56 INFO - PROCESS | 7485 | [#5] yui.html Cycles:180 Average:23528.91 Median:3588.33 stddev:35781.12 (997.2%) stddev-sans-first:35840.35 14:10:56 INFO - PROCESS | 7485 | Values: 674.9 675.2 687.8 733.8 766.2 13357.5 15534.8 15752.3 16455.7 16523.8 14914.7 14988.7 15003.1 15029.8 15057.1 694.6 712.7 872.9 875.3 893.8 885.3 891.1 901.1 905.6 907.2 936.2 951.9 953.1 953.9 959.0 930.6 942.4 948.7 949.0 950.5 706.2 707.6 707.8 707.8 711.2 15247.5 15294.9 15341.4 15359.0 15414.2 14600.7 14707.4 14775.5 14799.9 14843.7 11743.4 11824.8 11907.6 12045.2 12162.0 3382.9 3763.5 3781.5 3954.5 4015.2 111770.0 112445.0 113209.0 114493.0 122334.0 11345.0 11365.6 11476.9 11523.4 11918.5 23600.3 23800.9 23824.0 23856.0 24016.4 8092.2 8162.8 8200.0 8268.9 8439.4 4345.7 4409.4 4444.6 4486.1 4486.2 3477.5 3587.9 3588.8 3605.3 3606.0 594.8 637.3 644.7 646.9 652.3 575.5 672.6 679.6 683.5 709.3 9363.9 9605.3 9607.0 9659.8 9718.6 568.7 626.8 651.9 671.4 674.0 4402.8 4491.6 4771.2 5193.4 5309.6 94036.5 96204.0 96345.0 100074.0 112570.0 101253.8 117329.0 133901.3 134650.3 135314.0 101639.5 107557.5 107696.5 124162.0 125861.4 8785.7 9285.4 9987.8 10050.4 10135.2 58874.0 61230.4 61338.1 62569.4 63054.4 58124.7 71585.6 87180.6 90844.0 98250.0 12458.4 12967.4 13698.7 13699.3 13774.5 15013.9 15045.8 15165.3 15209.8 15710.7 13857.3 13876.6 14041.9 14092.0 14417.4 13935.7 13990.7 14012.7 14325.1 14381.3 13459.0 13524.3 13755.6 14046.9 14310.9 11376.7 11410.8 11458.2 11602.8 11949.8 9107.6 10367.1 11250.1 11504.4 11847.2 14:10:56 INFO - PROCESS | 7485 | -------- Summary: end -------- 14:10:56 INFO - PROCESS | 7485 | 14:10:57 INFO - TEST-INFO | 7485: exit 0 14:10:57 INFO - TEST-OK | dromaeo_css | took 1116004ms 14:10:57 INFO - TEST-START | kraken 14:10:57 INFO - operating with platform_type : mac_ 14:10:57 INFO - Initialising browser for kraken test... 14:10:57 INFO - TEST-INFO | started process 7489 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp8aKaKH/profile http://localhost:53221/getInfo.html) 14:11:00 INFO - PROCESS | 7489 | 2016-10-20 14:11:00.205 plugin-container[7490:139965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:11:00 INFO - PROCESS | 7489 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:00 INFO - PROCESS | 7489 | 2016-10-20 14:11:00.208 plugin-container[7490:139965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 14:11:00 INFO - PROCESS | 7489 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:00 INFO - PROCESS | 7489 | 2016-10-20 14:11:00.208 plugin-container[7490:139965] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:00 INFO - PROCESS | 7489 | __metrics Screen width/height:1600/1200 14:11:00 INFO - PROCESS | 7489 | colorDepth:24 14:11:00 INFO - PROCESS | 7489 | Browser inner width/height: 1024/689 14:11:00 INFO - PROCESS | 7489 | __metrics 14:11:00 ERROR - PROCESS | 7489 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 14:11:00 INFO - TEST-INFO | 7489: exit 0 14:11:00 INFO - Browser initialized. 14:11:01 INFO - Running cycle 1/1 for kraken test... 14:11:01 INFO - TEST-INFO | started process 7491 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp8aKaKH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:03 INFO - PROCESS | 7491 | 2016-10-20 14:11:03.585 plugin-container[7492:140077] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 14:11:03 INFO - PROCESS | 7491 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:03 INFO - PROCESS | 7491 | 2016-10-20 14:11:03.586 plugin-container[7492:140077] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:11:03 INFO - PROCESS | 7491 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:03 INFO - PROCESS | 7491 | 2016-10-20 14:11:03.586 plugin-container[7492:140077] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:13 INFO - PROCESS | 7491 | RSS: Main: 236986368 14:11:13 INFO - PROCESS | 7491 | 14:11:15 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53221/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:16 INFO - PROCESS | 7491 | RSS: Main: 249368576 14:11:16 INFO - PROCESS | 7491 | 14:11:19 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53221/tests/kraken/driver.html?testName=audio-dft) 14:11:20 INFO - PROCESS | 7491 | RSS: Main: 257024000 14:11:20 INFO - PROCESS | 7491 | 14:11:23 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53221/tests/kraken/driver.html?testName=audio-fft) 14:11:24 INFO - PROCESS | 7491 | RSS: Main: 259821568 14:11:24 INFO - PROCESS | 7491 | 14:11:26 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53221/tests/kraken/driver.html?testName=audio-oscillator) 14:11:26 INFO - PROCESS | 7491 | RSS: Main: 261226496 14:11:26 INFO - PROCESS | 7491 | 14:11:28 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53221/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:29 INFO - PROCESS | 7491 | RSS: Main: 261693440 14:11:29 INFO - PROCESS | 7491 | 14:11:32 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53221/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:32 INFO - PROCESS | 7491 | RSS: Main: 262111232 14:11:32 INFO - PROCESS | 7491 | 14:11:35 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53221/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:36 INFO - PROCESS | 7491 | RSS: Main: 261931008 14:11:36 INFO - PROCESS | 7491 | 14:11:39 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53221/tests/kraken/driver.html?testName=json-parse-financial) 14:11:39 INFO - PROCESS | 7491 | RSS: Main: 263585792 14:11:39 INFO - PROCESS | 7491 | 14:11:41 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53221/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:42 INFO - PROCESS | 7491 | RSS: Main: 263278592 14:11:42 INFO - PROCESS | 7491 | 14:11:44 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:44 INFO - PROCESS | 7491 | RSS: Main: 263413760 14:11:44 INFO - PROCESS | 7491 | 14:11:47 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:47 INFO - PROCESS | 7491 | RSS: Main: 263352320 14:11:47 INFO - PROCESS | 7491 | 14:11:50 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:51 INFO - PROCESS | 7491 | RSS: Main: 263843840 14:11:51 INFO - PROCESS | 7491 | 14:11:54 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:55 INFO - PROCESS | 7491 | RSS: Main: 263806976 14:11:55 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | Cycle 1(1): loaded http://localhost:53221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53221/tests/kraken/driver.html?testName=ai-astar) 14:11:57 INFO - PROCESS | 7491 | RSS: Main: 265338880 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | __start_tp_report 14:11:57 INFO - PROCESS | 7491 | _x_x_mozilla_page_load 14:11:57 INFO - PROCESS | 7491 | _x_x_mozilla_page_load_details 14:11:57 INFO - PROCESS | 7491 | |i|pagename|runs| 14:11:57 INFO - PROCESS | 7491 | |0;ai-astar;113;118;119;114;117;116;118;118;118;119 14:11:57 INFO - PROCESS | 7491 | |1;audio-beat-detection;151;116;116;157;117;116;120;115;145;117 14:11:57 INFO - PROCESS | 7491 | |2;audio-dft;200;199;205;242;261;230;201;199;198;205 14:11:57 INFO - PROCESS | 7491 | |3;audio-fft;86;60;70;84;60;59;60;57;79;60 14:11:57 INFO - PROCESS | 7491 | |4;audio-oscillator;86;70;91;71;70;71;89;68;75;117 14:11:57 INFO - PROCESS | 7491 | |5;imaging-gaussian-blur;132;88;96;129;90;100;133;106;89;111 14:11:57 INFO - PROCESS | 7491 | |6;imaging-darkroom;104;98;95;96;97;98;96;98;150;121 14:11:57 INFO - PROCESS | 7491 | |7;imaging-desaturate;88;91;86;95;92;88;90;90;87;111 14:11:57 INFO - PROCESS | 7491 | |8;json-parse-financial;55;55;55;60;58;55;63;73;48;58 14:11:57 INFO - PROCESS | 7491 | |9;json-stringify-tinderbox;78;66;77;112;115;105;84;77;73;76 14:11:57 INFO - PROCESS | 7491 | |10;stanford-crypto-aes;87;92;89;94;87;89;88;91;89;89 14:11:57 INFO - PROCESS | 7491 | |11;stanford-crypto-ccm;174;158;163;162;176;165;166;159;215;156 14:11:57 INFO - PROCESS | 7491 | |12;stanford-crypto-pbkdf2;178;238;234;231;177;176;184;184;241;193 14:11:57 INFO - PROCESS | 7491 | |13;stanford-crypto-sha256-iterative;73;63;82;89;88;97;88;80;72;73 14:11:57 INFO - PROCESS | 7491 | __end_tp_report 14:11:57 INFO - PROCESS | 7491 | __start_cc_report 14:11:57 INFO - PROCESS | 7491 | _x_x_mozilla_cycle_collect,950 14:11:57 INFO - PROCESS | 7491 | __end_cc_report 14:11:57 INFO - PROCESS | 7491 | __startTimestamp1476997917693__endTimestamp 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | ------- Summary: start ------- 14:11:57 INFO - PROCESS | 7491 | Number of tests: 14 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.00 stddev:2.05 (1.7%) stddev-sans-first:1.59 14:11:57 INFO - PROCESS | 7491 | Values: 113.0 118.0 119.0 114.0 117.0 116.0 118.0 118.0 118.0 119.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:118.50 stddev:16.85 (14.2%) stddev-sans-first:15.48 14:11:57 INFO - PROCESS | 7491 | Values: 151.0 116.0 116.0 157.0 117.0 116.0 120.0 115.0 145.0 117.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#2] audio-dft Cycles:10 Average:214.00 Median:205.00 stddev:22.32 (10.9%) stddev-sans-first:23.09 14:11:57 INFO - PROCESS | 7491 | Values: 200.0 199.0 205.0 242.0 261.0 230.0 201.0 199.0 198.0 205.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#3] audio-fft Cycles:10 Average:67.50 Median:65.00 stddev:11.36 (17.5%) stddev-sans-first:9.88 14:11:57 INFO - PROCESS | 7491 | Values: 86.0 60.0 70.0 84.0 60.0 59.0 60.0 57.0 79.0 60.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:73.00 stddev:15.39 (21.1%) stddev-sans-first:16.21 14:11:57 INFO - PROCESS | 7491 | Values: 86.0 70.0 91.0 71.0 70.0 71.0 89.0 68.0 75.0 117.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#5] imaging-gaussian-blur Cycles:10 Average:107.40 Median:110.50 stddev:18.09 (16.4%) stddev-sans-first:16.85 14:11:57 INFO - PROCESS | 7491 | Values: 132.0 88.0 96.0 129.0 90.0 100.0 133.0 106.0 89.0 111.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:96.50 stddev:17.49 (18.1%) stddev-sans-first:18.55 14:11:57 INFO - PROCESS | 7491 | Values: 104.0 98.0 95.0 96.0 97.0 98.0 96.0 98.0 150.0 121.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:90.00 stddev:7.24 (8.0%) stddev-sans-first:7.55 14:11:57 INFO - PROCESS | 7491 | Values: 88.0 91.0 86.0 95.0 92.0 88.0 90.0 90.0 87.0 111.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:6.58 (11.3%) stddev-sans-first:6.89 14:11:57 INFO - PROCESS | 7491 | Values: 55.0 55.0 55.0 60.0 58.0 55.0 63.0 73.0 48.0 58.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:76.50 stddev:17.56 (23.0%) stddev-sans-first:18.37 14:11:57 INFO - PROCESS | 7491 | Values: 78.0 66.0 77.0 112.0 115.0 105.0 84.0 77.0 73.0 76.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:89.00 stddev:2.22 (2.5%) stddev-sans-first:2.17 14:11:57 INFO - PROCESS | 7491 | Values: 87.0 92.0 89.0 94.0 87.0 89.0 88.0 91.0 89.0 89.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#11] stanford-crypto-ccm Cycles:10 Average:169.40 Median:165.50 stddev:17.28 (10.4%) stddev-sans-first:18.25 14:11:57 INFO - PROCESS | 7491 | Values: 174.0 158.0 163.0 162.0 176.0 165.0 166.0 159.0 215.0 156.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.60 Median:212.00 stddev:28.41 (13.4%) stddev-sans-first:28.58 14:11:57 INFO - PROCESS | 7491 | Values: 178.0 238.0 234.0 231.0 177.0 176.0 184.0 184.0 241.0 193.0 14:11:57 INFO - PROCESS | 7491 | 14:11:57 INFO - PROCESS | 7491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.50 Median:85.00 stddev:10.28 (12.1%) stddev-sans-first:10.54 14:11:57 INFO - PROCESS | 7491 | Values: 73.0 63.0 82.0 89.0 88.0 97.0 88.0 80.0 72.0 73.0 14:11:57 INFO - PROCESS | 7491 | -------- Summary: end -------- 14:11:57 INFO - PROCESS | 7491 | 14:11:58 INFO - TEST-INFO | 7491: exit 0 14:11:58 INFO - TEST-OK | kraken | took 61137ms 14:11:58 INFO - SUITE-END | took 1177s 14:11:58 INFO - Completed test suite (00:19:37) 14:11:58 INFO - javascript benchmark 14:11:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7265.961913694447, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.4010678077934, 3354.0943945134813, 3369.915752106197, 3376.5948086229655, 3377.071305391017, 5613.017721898672, 5652.830415087554, 5653.886922261558, 5664.461876121773, 5694.430556944303, 5619.0, 5640.915386269199, 5686.09022556391, 5694.145878118274, 5727.255456790622, 5123.180291153416, 5162.638615296931, 5190.870228244286, 5221.660592061504, 5258.44786297439, 5164.483551644843, 5263.078961181797, 5276.393214780311, 5281.603879709037, 5324.946750532484, 5091.134507133796, 5142.640015198937, 5163.457836927125, 5186.403563590197, 5208.348956380452, 5157.535821776059, 5174.715390653512, 5179.0, 5180.0157969985585, 5211.765470553834, 5115.948840511584, 5128.9230661540105, 5162.586993040548, 5182.170852663593, 5203.16749320107, 5529.225908372831, 5572.498475137217, 5578.888422231573, 5607.691576963265, 5718.628289161191, 5534.920690465361, 6136.938630613681, 6160.199174107337, 6220.066989951498, 6222.719977601018, 6200.596961197508, 6201.937980620181, 6202.751889924398, 6209.161763162006, 6223.906641400383, 5606.103023516218, 5665.915011274834, 5744.253247077853, 5789.247397838296, 5844.590878638454, 6139.093519790236, 6222.0, 6228.56400051992, 6231.501479881598, 6246.094316324107, 5986.461218490357, 6064.969675151596, 6082.178905847654, 6086.087086936906, 6110.602810817282, 6059.333473317932, 6082.391760823971, 6122.66325352101, 6130.877382452326, 6159.784407545804, 6057.727402266909, 6077.453029227391, 6109.450149486567, 6140.995089002448, 6147.801178770186, 6103.084537319349, 6112.711514445909, 6125.723854043132, 6133.82435864808, 6148.831721972811, 4763.2140696784645, 4893.241547560134, 4915.459299477055, 4927.0, 4931.457539670633, 4304.870853874389, 4345.543717909637, 4369.300911854151, 4414.227510185705, 4498.437695288089, 5226.268322434862, 5734.340550836707, 5745.080787074048, 5779.162021506942, 5824.534037277008, 6097.237845269341, 6127.325994140641, 6129.601575897553, 6131.14164017038, 6141.140240366352, 5670.971645141748, 5739.253896993448, 5767.134929760486, 5782.2194003808945, 5819.0689489681445, 5374.193870919394, 5379.946200538023, 5393.352797664227, 5407.270018547524, 5411.918821217685, 6214.720337584729, 6304.684765761694, 6323.272823625342, 6331.525135614847, 6349.809505714836, 6040.395960403925, 6097.176881120992, 6108.0, 6109.633421994695, 6136.969315153396, 6281.905771413341, 6299.622022678654, 6301.464375528131, 6305.779297724557, 6326.936730632819, 6045.335013148638, 6106.419890110433, 6123.08153776937, 6124.265088189268, 6124.755009799558, 6011.398860114128, 6094.421030002142, 6096.329403765671, 6120.142398366865, 6138.51101655979, 5995.190649262294, 6020.127081573235, 6031.24609423822, 6053.213082299273, 6081.6351018939, 5891.852703682271, 6023.156758053964, 6046.1535385045245, 6053.152558641882, 6075.696215189311, 4420.624246939046, 5777.971110144423, 5819.6508209507565, 5893.675847828411, 5983.55123365758, 5523.8066667666435, 5862.94137058624, 6039.335673076046, 6078.483328917092, 6099.0, 5884.823455296348, 5925.555583331181, 5960.672163031075, 5973.163757073926, 5977.970110149421], "value": 5641.7741454384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.6330806932696, 486.63988648400175, 496.1763472635425, 511.1923161404983, 540.4055538907201, 38529.61470385295, 40404.79797601015, 40558.39162412566, 40566.59433405665, 40574.39138412926, 41757.0, 41863.79068104663, 42166.36750448738, 42218.36672449916, 42235.155296894045, 9365.438073715564, 9608.279379046564, 9611.086946740083, 9624.133827955482, 9631.373960692568, 9461.905380946171, 9548.713538593853, 9555.283353748497, 9556.569954352071, 9572.186364159055, 9508.714738557854, 9538.856917146248, 9544.188743956738, 9567.282453815957, 9604.0, 9466.90533094667, 9525.761855953588, 9528.714138575853, 9538.713838584854, 9545.90454095457, 9465.574049167804, 9465.763355916088, 9487.478188699619, 9519.000504946951, 9541.475218862959, 39848.20303593941, 39950.20099597992, 40074.0, 40086.79956600198, 40284.194316113804, 2830.2075418882746, 3317.2370354818527, 3343.0, 3392.8642854286045, 3494.8951531453845, 26246.606300905503, 29568.408631827242, 29796.10611681653, 30120.945766898054, 31171.37657246865, 2579.3680548265606, 3189.1867573768773, 3212.261179928606, 3216.5014422764507, 3302.570665813429, 352903.0, 352915.0, 353102.0, 353543.0, 355670.0, 49522.50477495251, 54113.1883021755, 56211.875762484524, 56503.71748141233, 56529.43470565242, 58185.0, 58481.415185847596, 58738.41261587329, 59268.81462370729, 59485.40514594799, 15520.0, 15553.0, 15565.0, 15725.764113538306, 15750.9212453937, 12190.207636503776, 12216.938915305367, 12256.325902075294, 12264.0, 12268.0, 13896.235707036009, 14998.250087495582, 15069.54791356261, 15151.696966060617, 15309.311081001382, 5632.070708333161, 6244.063390491463, 6281.7173227204885, 6352.301246862841, 6414.0, 874.8906386701663, 939.8768471676282, 1007.868977032981, 1014.2089170447063, 1080.4543705428707, 28030.738616762294, 28146.85926570395, 29577.408451831274, 29734.85132574323, 30131.0, 1037.8376218635176, 1047.0733400940223, 1080.7784404197278, 1089.4062735809002, 1134.0927258193412, 15001.624959375884, 15516.922415387851, 15576.454824081104, 15730.921345393428, 15822.683546329008, 634192.0, 636121.0, 639373.0, 650985.0, 927701.0, 56257.0, 57670.71164644234, 58459.415405846245, 58529.707351462974, 58558.0, 1359.7620416427085, 1379.4137491566246, 1401.6636007358366, 1410.2948525737131, 1411.5271384086445, 25654.871725641253, 29859.850700746356, 30138.397232055675, 30162.84918575393, 30204.84897575498, 48107.518924810305, 48522.5147748518, 48635.5136448631, 48636.0, 48689.83516071444, 572053.0, 591207.0879291152, 594267.0, 595102.0, 595616.0, 24458.755412445647, 24968.250952470727, 25065.0, 25624.54068700776, 25789.097381591553, 35494.64505354913, 45547.0, 46407.76796115998, 47358.28962565495, 47374.763126184145, 34428.13929651779, 38437.615623843405, 38524.42213366858, 38954.80522597369, 39592.0, 38196.0, 38605.28124470857, 38704.41943370908, 39161.608383915795, 39366.409503858034, 29773.10680679583, 32415.675843241264, 37380.43929341117, 37554.248915021, 37670.434943476415, 31873.521897172024, 33971.344306723055, 34081.82959085288, 34503.4824477638, 34524.48213276853, 21601.243956461447, 21809.672854906872, 22406.215782447536, 22520.769849226253, 25475.0], "value": 19207.708436471465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3768082675063, 336.89666342727554, 366.77626647744853, 368.793475653634, 372.8229091181691, 19539.609207815854, 19950.30173943912, 20012.799872001295, 20494.692579611317, 20747.273845415413, 18120.093995300216, 20166.19335226589, 20309.695354569656, 20931.686024709605, 21169.57660846782, 4769.689970151946, 5193.45468725784, 5708.343540492855, 6037.72830222641, 6041.335453100155, 5513.917291240635, 6796.592204467723, 6801.625910574917, 6811.455083593325, 6814.591124532544, 5692.146178073281, 6013.579049466539, 6040.848978775522, 6752.257251702309, 6810.046593476917, 6006.729697163638, 6042.818715438544, 6057.485113765335, 6083.330833608299, 6093.634381937076, 5780.9710951445395, 5870.471657550798, 5917.940820591825, 5922.2597175353085, 5933.643981361089, 13159.736805263938, 13381.598552043455, 18764.624707505773, 25435.872820635963, 25796.839142238645, 2109.5886302171084, 2140.8929553522416, 2275.2605403243847, 2281.840271181018, 2793.8184018038764, 9382.5308734563, 9932.751681207956, 10266.79466410675, 10317.226208034352, 10325.0, 1860.9162587683586, 1874.7750269967555, 1879.4361691492634, 1892.943211703651, 1922.5770330527262, 98403.52394714086, 119772.0, 120018.39990800078, 120630.0, 122335.38832305782, 10514.316569422963, 10893.074088702391, 10960.725981850517, 11440.199186057063, 11480.253783504213, 11921.0, 12068.155229134052, 14238.572842814732, 14330.0, 14334.354954027094, 8152.184781521919, 8317.875231871527, 8395.748127556182, 8468.32253419725, 8476.957615211884, 6544.574602650812, 7977.0, 8187.71343002992, 8242.587870606445, 8383.622736976851, 3634.9818250908575, 4491.505934347219, 4492.191405546968, 4570.6800523963, 4578.587927086512, 1624.3989723802033, 1855.4897403213954, 1910.3695780392436, 1919.577692907558, 1921.7213504042115, 840.8612578924532, 926.1571969507715, 934.5327336331834, 950.7385468996082, 980.4117529482396, 20115.39653810388, 20948.0, 21004.0, 21034.368968930958, 21090.261840835497, 852.48424703055, 917.2570218123342, 917.4770380882833, 931.1991687149047, 964.9517524123765, 8217.260446559838, 10557.9472102639, 10903.236773425942, 11030.889691103146, 11032.834507482394, 564705.0, 569805.0, 600738.0, 637867.0, 638585.807070971, 133318.0, 138011.54971125803, 140127.0, 140221.0, 142699.2865035668, 963.7735132243918, 973.6738192705523, 991.8016396720685, 995.2682332740978, 1001.249063202598, 18328.541786455444, 18422.0, 18573.90713046426, 18698.719519206952, 19004.714929275797, 52350.73824630852, 53137.46862531325, 53327.733361334496, 54324.0, 54475.72762136323, 54778.72610636921, 77519.2248077512, 78679.0, 79125.60437197777, 81329.0, 6396.744130234739, 7154.570725756471, 7733.729319473791, 7875.645595948311, 8182.67269309221, 10248.872624011501, 10362.75646922344, 10406.439034144636, 11341.943290283496, 12049.939750301193, 8959.1936725695, 9504.572294246915, 10387.636432724817, 10603.469826508797, 10677.89322106769, 10207.081362677394, 10346.27576069698, 10348.172146228435, 10613.575456981634, 10835.729106772395, 10487.632932847313, 10620.991005854432, 10687.732806679895, 10885.510152043018, 10892.509837057192, 7625.894245334506, 7865.213478652089, 7936.166702496154, 8067.3949453792375, 8092.352611791161, 10160.644377446753, 10242.07821296057, 10345.068943795095, 10473.68578942633, 10493.0], "value": 9306.154856501915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.2910061371772, 1575.3541048170248, 1749.9237968649277, 1788.4545213709814, 1904.42867139858, 7954.96022519888, 8252.29855462285, 8343.249107580317, 8949.149830766082, 8969.416987895791, 8392.328613710904, 8713.30293576514, 8713.607887645056, 8828.77928051799, 8868.02451730309, 2359.8112151027876, 2376.786089251967, 2401.687780588521, 2408.4580969281947, 2410.9397265068337, 2355.9882200588972, 2400.7719266669724, 2400.8799560022017, 2401.927942161738, 2408.4821763320883, 2376.536575367804, 2386.9283921482383, 2399.3881560202126, 2403.158894386959, 2405.2663937499055, 2354.5290941811704, 2365.5387199496104, 2375.323032935605, 2382.201962342617, 2398.3284680289457, 2303.689001984744, 2328.4295347639936, 2338.263447014202, 2341.9297421077395, 2344.9296521104393, 8768.956155219246, 8829.735107946772, 8877.0, 8894.243989260856, 8896.911030889738, 5242.370915490127, 5386.084365657847, 5431.293931788881, 5437.782488700447, 5446.537044351235, 3326.850291736878, 3585.659362360572, 3632.219072899313, 3685.7419980601367, 3691.0587800110798, 1021.3565453764155, 1090.2422816142785, 1097.4732128578328, 1106.2090605217227, 1107.5901916290943, 11483.655490335303, 11517.308961462339, 11617.18679692422, 11625.128115391295, 11628.883711162865, 4341.934870976938, 4547.09058188357, 4585.839495617637, 4750.61995040396, 4907.901841963212, 8732.257758090633, 9280.628774849065, 9876.962918893556, 9888.901110988942, 9922.950385248028, 5402.540784033401, 5418.783248670088, 5439.0, 5446.700431476307, 5446.782128714886, 4447.844325448594, 4599.172149013143, 4776.546228108324, 4914.434839993375, 4926.088673595396, 3566.144125409935, 3583.9606514111138, 3925.0, 3993.960060399359, 4121.443605113332, 1095.9616413425492, 1304.7455746129413, 1311.2919023727081, 1319.9472021119047, 1324.1657755614094, 831.4346244553761, 885.0795173019987, 917.8669092981614, 928.8374534456578, 948.1561410344799, 4948.529889660476, 5648.237487939075, 5860.882782344329, 6038.607490513103, 6110.541709371815, 385.43533723095237, 427.5446649318528, 432.96536277097755, 447.3178402935549, 448.83617479619704, 3969.7419667721506, 4017.0, 4046.7976601169826, 4085.3054980652764, 4099.651529619956, 10318.0, 10570.52432640533, 10666.41334726582, 10689.786204275872, 10696.78606427867, 10283.897161028444, 10480.790384192425, 10632.734181645521, 10670.786584268271, 10686.465676716132, 8120.390970677223, 8159.347252219927, 8240.711575094843, 8243.95878020618, 8244.051934027544, 5813.941860581509, 5816.098504731774, 5920.970395147997, 5960.135780311917, 5981.551383646331, 8861.291096712119, 9359.719208423758, 10009.0, 10011.599536018477, 10074.294799363974, 10107.69676909694, 10154.54304556282, 10180.490975451346, 10198.286119971828, 10208.948955255177, 6866.313368663094, 7113.964430178023, 7271.490995630255, 7463.328300452768, 7534.246575342641, 8096.83806323882, 8278.751637450887, 8477.364197685321, 8478.194571515696, 8487.448315859448, 7275.527090739085, 7451.552906825608, 7569.848603027798, 7622.390208783173, 7735.0, 7249.673764680497, 7382.114146302478, 7436.293552112541, 7516.774496765106, 7606.353459955966, 6961.408280296231, 7116.893246601202, 7121.394681452135, 7131.0729605151, 7151.392131668867, 4517.819287228474, 4943.431505376928, 5066.594672426123, 5136.434992150935, 5138.049460849755, 4875.19559272716, 4958.504149585013, 5041.193409054534, 5158.3294171758935, 5178.559822415137], "value": 4500.105586407092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.93467437163827, 297.4126100950624, 304.9725524702777, 308.2048315346405, 311.1226341716359, 4872.927955849712, 5415.864603384917, 5457.253678822768, 5520.350231888686, 5528.917066244009, 4517.186906356863, 5359.464053594638, 5372.301600791901, 5430.0768869292215, 5440.755166017529, 3024.6219222597174, 3178.507331363631, 3276.8197749123788, 3988.8205030773684, 4020.3567429211184, 3956.5449973253158, 4078.4290199372113, 4083.775392353419, 4121.475054229939, 4168.687348448879, 3518.489818976247, 4099.71302008858, 4111.5477297497255, 4112.670986321102, 4136.855210067648, 3333.916652083693, 3478.9478157827652, 3983.5817239190046, 4119.382092686091, 4134.793260337001, 3548.627394123606, 3550.5856017907813, 3560.732945029133, 3571.196480791827, 3593.6047034826147, 4763.737994410306, 4797.328374027604, 4867.318575399447, 5250.842474725764, 5267.604929630293, 4253.851115210953, 4719.07977944301, 4752.1921273383605, 4754.0, 4768.904621907543, 4882.193588372289, 4974.602031837444, 5187.988342273258, 5480.273713780147, 5722.399148089432, 3893.4549163117185, 3901.5708272090333, 3912.2957867583823, 3920.0, 3943.2704949584418, 5587.469190426903, 6009.0, 6011.669358185298, 6020.729067191987, 6028.5478589106, 3529.2588556403443, 3850.9807450962567, 3867.6325749053794, 3913.3151698452657, 3943.0, 3971.3050216212623, 3976.0, 3998.8000599969887, 4034.11249525104, 4035.5205721648945, 4656.208444564432, 4677.555632214934, 4690.053627744516, 4697.248440249544, 4730.574248317599, 4293.957060429419, 5072.757174492273, 5566.0, 5716.713013499039, 5725.456081672234, 1314.8290722206052, 1324.3576865220361, 1355.7933439239084, 1359.5853264754344, 1363.4341748174397, 673.7540797608935, 702.2941943347006, 718.2888939949516, 731.5500966905315, 765.9463837531431, 4661.440627124767, 4826.996796329484, 5271.973640131775, 5299.4700529946695, 5417.566594672417, 5293.655912365684, 5485.135054081552, 5715.857103572361, 5917.911231331534, 5946.67293298864, 5163.7676304566385, 5277.313949186581, 5416.3750874737425, 5423.891522169534, 5436.858259765414, 2675.662168915542, 3022.9244268893453, 3076.7846700553605, 3089.4593446146832, 3121.2352973521633, 5791.247137872049, 6094.939050609526, 6119.418655227746, 6136.846578835565, 6191.0, 5571.910533549919, 5721.771129154788, 5961.433663801932, 6041.8489537761025, 6046.848828779316, 5199.584033277404, 6128.63228206309, 6135.0, 6146.354632763585, 6210.72051757681, 4879.878003049952, 5502.230971784341, 5854.121881717776, 5889.911651325147, 5960.284765828128, 4976.880201954531, 5763.855903602276, 5781.94218057814, 5797.681127537857, 5849.4554868632285, 4905.48492408292, 5409.972950135224, 5440.8639784004135, 6093.446171226309, 6171.352008039091, 3716.1976441425345, 3857.40210267409, 3892.455056292065, 3897.512810898638, 3910.042039700178, 4817.518248175154, 5429.077056900257, 5876.6180198286975, 5909.881802363842, 5910.408959104056, 4828.613710903049, 4935.568685081286, 5732.274021885808, 5733.885322293614, 5763.971180144073, 5056.6713163644245, 5650.55910742758, 5730.684812335361, 5743.368229494668, 5748.166515855094, 5217.399999000164, 5395.92081583677, 5565.693886836101, 5623.2127502148915, 5708.115242137475, 5143.61422893277, 5283.920741188962, 5370.704611246419, 5447.754851031634, 5587.245721827501, 5621.80323688669, 5626.746796394254, 5627.971860140837, 5676.971615141898, 5692.288463942007], "value": 4113.2425700497615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.9223839258484, 675.2201207605218, 687.8074139241011, 733.783533857512, 766.1954947305328, 13357.53248636298, 15534.766978495332, 15752.291146898388, 16455.670886582262, 16523.834761652364, 14914.701705965874, 14988.700225995473, 15003.099814011168, 15029.774553381681, 15057.096574205529, 694.6214313199318, 712.7077898061796, 872.8996165440976, 875.2604049578097, 893.7765558610347, 885.3315746611331, 891.0510306523564, 901.0673952459173, 905.6286922361833, 907.2288554728461, 936.194872409727, 951.9000504946985, 953.0564740906522, 953.904609539044, 958.9856152157688, 930.6463543853326, 942.4015749998731, 948.6632245552833, 948.9845864924533, 950.5009869818332, 706.2407911495163, 707.6002058836741, 707.7770502291813, 707.7876637008877, 711.1643818513278, 15247.466338678092, 15294.923525382414, 15341.386344546205, 15359.0, 15414.22928853553, 14600.707985840223, 14707.411703531845, 14775.482858100022, 14799.92600036993, 14843.703125937529, 11743.412829358498, 11824.822627660593, 11907.583234586747, 12045.217060891015, 12161.966232870216, 3382.9492557611657, 3763.473113764075, 3781.4894989176382, 3954.5452272988687, 4015.19696060789, 111770.0, 112445.0, 113209.0, 114493.0, 122334.0, 11344.978951894203, 11365.602203922823, 11476.942615286871, 11523.423828808694, 11918.523259069714, 23600.29199124029, 23800.88099559491, 23824.0, 23856.0, 24016.39959001039, 8092.190780921861, 8162.795930101676, 8200.0, 8268.917310826935, 8439.367047471464, 4345.652347812167, 4409.382686423904, 4444.599986001211, 4486.102779444124, 4486.1924853526025, 3477.530533378012, 3587.892363229107, 3588.766730162531, 3605.3330133925306, 3605.963940360615, 594.8423667728056, 637.2671427858, 644.690548536705, 646.8544577470032, 652.3281020548842, 575.5110140901039, 672.6468603982948, 679.6339357890577, 683.4907993544841, 709.3474003916409, 9363.906360936304, 9605.279604029585, 9606.951965240129, 9659.806803863883, 9718.61125554984, 568.7042737776416, 626.8307556959595, 651.8989556618732, 671.3957438305466, 673.9561928474732, 4402.757848318373, 4491.595756381941, 4771.165046116916, 5193.402758682724, 5309.628326017141, 94036.52981735184, 96204.0, 96345.0, 100074.0, 112570.0, 101253.79939209692, 117329.0, 133901.3304933469, 134650.32674836562, 135314.0, 101639.45901352525, 107557.46221268686, 107696.4615176919, 124162.0, 125861.37069314595, 8785.692500762698, 9285.442873427615, 9987.800243994934, 10050.447225402673, 10135.239857010607, 58874.0, 61230.38769612247, 61338.07992880021, 62569.37430625635, 63054.36945630668, 58124.70937645285, 71585.6420717893, 87180.56409717911, 90844.0, 98250.0, 12458.442694663167, 12967.351632418153, 13698.65753356174, 13699.315034248448, 13774.517891873737, 15013.924930375279, 15045.849541504882, 15165.317560709575, 15209.847901520843, 15710.685786284439, 13857.30713464343, 13876.58370248894, 14041.929790350983, 14092.0, 14417.35121919537, 13935.721285574029, 13990.650233744238, 14012.719745604827, 14325.140491570539, 14381.280935952951, 13459.0, 13524.256165910576, 13755.587332380044, 14046.929765351108, 14310.928445357707, 11376.715582110513, 11410.82883756761, 11458.197926145423, 11602.825957610812, 11949.761004779682, 9107.59015844302, 10367.066963973279, 11250.099992000456, 11504.367259800456, 11847.229930054518], "value": 7882.161752183713, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 119.0, 114.0, 117.0, 116.0, 118.0, 118.0, 118.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 116.0, 157.0, 117.0, 116.0, 120.0, 115.0, 145.0, 117.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 205.0, 242.0, 261.0, 230.0, 201.0, 199.0, 198.0, 205.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 70.0, 84.0, 60.0, 59.0, 60.0, 57.0, 79.0, 60.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 91.0, 71.0, 70.0, 71.0, 89.0, 68.0, 75.0, 117.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 88.0, 96.0, 129.0, 90.0, 100.0, 133.0, 106.0, 89.0, 111.0], "value": 107.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 98.0, 95.0, 96.0, 97.0, 98.0, 96.0, 98.0, 150.0, 121.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 86.0, 95.0, 92.0, 88.0, 90.0, 90.0, 87.0, 111.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 60.0, 58.0, 55.0, 63.0, 73.0, 48.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 66.0, 77.0, 112.0, 115.0, 105.0, 84.0, 77.0, 73.0, 76.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 89.0, 94.0, 87.0, 89.0, 88.0, 91.0, 89.0, 89.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 158.0, 163.0, 162.0, 176.0, 165.0, 166.0, 159.0, 215.0, 156.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 238.0, 234.0, 231.0, 177.0, 176.0, 184.0, 184.0, 241.0, 193.0], "value": 203.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 63.0, 82.0, 89.0, 88.0, 97.0, 88.0, 80.0, 72.0, 73.0], "value": 80.5, "unit": "score"}]}]} 14:11:58 INFO - Return code: 0 14:11:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:58 ERROR - # TBPL SUCCESS # 14:11:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:59 INFO - 2016-10-20 14:11:59.009 screenresolution[7499:140653] starting screenresolution argv=screenresolution get 14:11:59 INFO - 2016-10-20 14:11:59.011 screenresolution[7499:140653] Display 0: 1600x1200x32@60 14:11:59 INFO - 2016-10-20 14:11:59.018 screenresolution[7500:140655] starting screenresolution argv=screenresolution list 14:11:59 INFO - Available Modes on Display 0 14:11:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:59 INFO - Intel Iris: 14:11:59 INFO - Chipset Model: Intel Iris 14:11:59 INFO - Type: GPU 14:11:59 INFO - Bus: Built-In 14:11:59 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:59 INFO - Vendor: Intel (0x8086) 14:11:59 INFO - Device ID: 0x0a2e 14:11:59 INFO - Revision ID: 0x0009 14:11:59 INFO - Displays: 14:11:59 INFO - Display: 14:11:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:59 INFO - Display Serial Number: 1600x1200 60 14:11:59 INFO - Main Display: Yes 14:11:59 INFO - Mirror: Off 14:11:59 INFO - Online: Yes 14:11:59 INFO - Rotation: Supported 14:11:59 INFO - Return code: 0 14:11:59 INFO - Running post-action listener: _resource_record_post_action 14:11:59 INFO - [mozharness: 2016-10-20 21:11:59.261629Z] Finished run-tests step (success) 14:11:59 INFO - Running post-run listener: _resource_record_post_run 14:11:59 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 253952; Write bytes: 714770944; Read time: 7; Write time: 2082 14:11:59 INFO - TinderboxPrint: CPU usage
54.8% 14:11:59 INFO - TinderboxPrint: I/O read bytes / time
253,952 / 7 14:11:59 INFO - TinderboxPrint: I/O write bytes / time
714,770,944 / 2,082 14:11:59 INFO - TinderboxPrint: CPU idle
2,191.7 (45.2%) 14:11:59 INFO - TinderboxPrint: CPU system
990.1 (20.4%) 14:11:59 INFO - TinderboxPrint: CPU user
1,668.0 (34.4%) 14:11:59 INFO - TinderboxPrint: Swap in / out
405,770,240 / 0 14:11:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394953216; Write bytes: 390071808; Read time: 29296; Write time: 835 14:11:59 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 253952; Write bytes: 304309248; Read time: 7; Write time: 1191 14:11:59 INFO - Running post-run listener: _upload_blobber_files 14:11:59 INFO - Blob upload gear active. 14:11:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:59 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 14:11:59 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'] 14:11:59 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 14:12:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:12:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:01 INFO - (blobuploader) - INFO - Done attempting. 14:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:02 INFO - (blobuploader) - INFO - Done attempting. 14:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:04 INFO - (blobuploader) - INFO - Done attempting. 14:12:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:04 INFO - Return code: 0 14:12:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def2e3eb2f57d9b5edc40e65508da4b42d13a61a4f8525a6b803cebfbb9957b8111bbb897807fe687519f99b7f8f135bf53f12080253a7bb6cda62f36ccf6824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab6b4a2b9c40a4495b13bcee8046cd12baa2d867bec623e56d02d7608d00673a5ecd1822c7c0a9530c21d3f022b87875ab812975a29d8119890644c66dc685b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c563d6f09718025531da23eaf2bdebac20acf1c3a10cf78cc074dbf66b52d2ec2023da65364df70abcc92045270d2831befb35202ec66d865e740a7c75dd5c10"} 14:12:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:04 INFO - Contents: 14:12:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def2e3eb2f57d9b5edc40e65508da4b42d13a61a4f8525a6b803cebfbb9957b8111bbb897807fe687519f99b7f8f135bf53f12080253a7bb6cda62f36ccf6824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab6b4a2b9c40a4495b13bcee8046cd12baa2d867bec623e56d02d7608d00673a5ecd1822c7c0a9530c21d3f022b87875ab812975a29d8119890644c66dc685b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c563d6f09718025531da23eaf2bdebac20acf1c3a10cf78cc074dbf66b52d2ec2023da65364df70abcc92045270d2831befb35202ec66d865e740a7c75dd5c10"} 14:12:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:04 INFO - Copying logs to upload dir... 14:12:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.472543 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-20 14:12:04.949411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 14:12:04.952549) ========= 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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/def2e3eb2f57d9b5edc40e65508da4b42d13a61a4f8525a6b803cebfbb9957b8111bbb897807fe687519f99b7f8f135bf53f12080253a7bb6cda62f36ccf6824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab6b4a2b9c40a4495b13bcee8046cd12baa2d867bec623e56d02d7608d00673a5ecd1822c7c0a9530c21d3f022b87875ab812975a29d8119890644c66dc685b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c563d6f09718025531da23eaf2bdebac20acf1c3a10cf78cc074dbf66b52d2ec2023da65364df70abcc92045270d2831befb35202ec66d865e740a7c75dd5c10"} build_url:https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011676 build_url: 'https://queue.taskcluster.net/v1/task/Yqfv1FAlQIm6mjBDx6rguw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def2e3eb2f57d9b5edc40e65508da4b42d13a61a4f8525a6b803cebfbb9957b8111bbb897807fe687519f99b7f8f135bf53f12080253a7bb6cda62f36ccf6824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ab6b4a2b9c40a4495b13bcee8046cd12baa2d867bec623e56d02d7608d00673a5ecd1822c7c0a9530c21d3f022b87875ab812975a29d8119890644c66dc685b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c563d6f09718025531da23eaf2bdebac20acf1c3a10cf78cc074dbf66b52d2ec2023da65364df70abcc92045270d2831befb35202ec66d865e740a7c75dd5c10"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 14:12:04.984971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:12:04.985327) ========= 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.5e5KvnC1wx/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.ZHVttCwaqI/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.004866 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:12:05.033675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 14:12:05.033958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 14:12:05.034262) ========= ========= Total master_lag: 0.17 =========