builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1476488126.32 results: success (0) buildid: 20161014144235 builduid: cb463a0add744897a27dd56f40f95750 revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.320681) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.321448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.321984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.348499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.348822) ========= 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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-14 16:35:26-- 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% 14.2M=0.001s 2016-10-14 16:35:26 (14.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.500233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.501036) ========= 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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.029181 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:26.551488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 16:35:26.551902) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de5d73a0568d1c3d50da32169026cc68ee09b1ae --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 de5d73a0568d1c3d50da32169026cc68ee09b1ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-14 16:35:26,627 truncating revision to first 12 chars 2016-10-14 16:35:26,627 Setting DEBUG logging. 2016-10-14 16:35:26,627 attempt 1/10 2016-10-14 16:35:26,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de5d73a0568d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 16:35:28,105 unpacking tar archive at: mozilla-central-de5d73a0568d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.720924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 16:35:28.294888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:28.295235) ========= script_repo_revision: de5d73a0568d1c3d50da32169026cc68ee09b1ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:28.295661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:28.295954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:35:28.313620) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-14 16:35:28.313908) ========= /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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:35:28 INFO - MultiFileLogger online at 20161014 16:35:28 in /builds/slave/test 16:35:28 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 16:35:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:28 INFO - {'append_to_log': False, 16:35:28 INFO - 'base_work_dir': '/builds/slave/test', 16:35:28 INFO - 'blob_upload_branch': 'Firefox', 16:35:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:28 INFO - 'branch': 'Firefox', 16:35:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:28 INFO - 'config_files': ('talos/mac_config.py',), 16:35:28 INFO - 'default_actions': ('clobber', 16:35:28 INFO - 'read-buildbot-config', 16:35:28 INFO - 'download-and-extract', 16:35:28 INFO - 'populate-webroot', 16:35:28 INFO - 'create-virtualenv', 16:35:28 INFO - 'install', 16:35:28 INFO - 'run-tests'), 16:35:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:28 INFO - 'download_minidump_stackwalk': True, 16:35:28 INFO - 'download_symbols': 'ondemand', 16:35:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:28 INFO - 'installer_path': 'installer.exe', 16:35:28 INFO - 'log_level': 'info', 16:35:28 INFO - 'log_name': 'talos', 16:35:28 INFO - 'log_to_console': True, 16:35:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:35:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:35:28 INFO - 'opt_config_files': (), 16:35:28 INFO - 'pip_index': False, 16:35:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:28 INFO - 'cmd': ('bash', 16:35:28 INFO - '-c', 16:35:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:28 INFO - 'enabled': True, 16:35:28 INFO - 'halt_on_failure': False, 16:35:28 INFO - 'name': 'check_screen_resolution'},), 16:35:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:28 INFO - 'cmd': ('bash', 16:35:28 INFO - '-c', 16:35:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:28 INFO - 'enabled': True, 16:35:28 INFO - 'halt_on_failure': False, 16:35:28 INFO - 'name': 'check_screen_resolution'},), 16:35:28 INFO - 'run_cmd_checks_enabled': True, 16:35:28 INFO - 'sps_profile': False, 16:35:28 INFO - 'sps_profile_interval': 0, 16:35:28 INFO - 'suite': 'dromaeojs-e10s', 16:35:28 INFO - 'system_bits': '32', 16:35:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:28 INFO - 'title': 't-yosemite-r7-0106', 16:35:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:28 INFO - 'use_talos_json': True, 16:35:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:28 INFO - 'work_dir': 'build'} 16:35:28 INFO - [mozharness: 2016-10-14 23:35:28.518384Z] Running clobber step. 16:35:28 INFO - Running pre-action listener: _resource_record_pre_action 16:35:28 INFO - Running main action method: clobber 16:35:28 INFO - rmtree: /builds/slave/test/build 16:35:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:30 INFO - Running post-action listener: _resource_record_post_action 16:35:30 INFO - [mozharness: 2016-10-14 23:35:30.712201Z] Finished clobber step (success) 16:35:30 INFO - [mozharness: 2016-10-14 23:35:30.712340Z] Running read-buildbot-config step. 16:35:30 INFO - Running pre-action listener: _resource_record_pre_action 16:35:30 INFO - Running main action method: read_buildbot_config 16:35:30 INFO - Using buildbot properties: 16:35:30 INFO - { 16:35:30 INFO - "project": "", 16:35:30 INFO - "product": "firefox", 16:35:30 INFO - "script_repo_revision": "production", 16:35:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:35:30 INFO - "repository": "", 16:35:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:35:30 INFO - "buildid": "20161014144235", 16:35:30 INFO - "pgo_build": "False", 16:35:30 INFO - "basedir": "/builds/slave/test", 16:35:30 INFO - "buildnumber": 75, 16:35:30 INFO - "slavename": "t-yosemite-r7-0106", 16:35:30 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:35:30 INFO - "platform": "yosemite_r7", 16:35:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:35:30 INFO - "branch": "mozilla-central", 16:35:30 INFO - "repo_path": "mozilla-central", 16:35:30 INFO - "revision": "de5d73a0568d1c3d50da32169026cc68ee09b1ae", 16:35:30 INFO - "stage_platform": "macosx64", 16:35:30 INFO - "builduid": "cb463a0add744897a27dd56f40f95750", 16:35:30 INFO - "slavebuilddir": "test" 16:35:30 INFO - } 16:35:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:35:30 INFO - Running post-action listener: _resource_record_post_action 16:35:30 INFO - [mozharness: 2016-10-14 23:35:30.715650Z] Finished read-buildbot-config step (success) 16:35:30 INFO - [mozharness: 2016-10-14 23:35:30.715801Z] Running download-and-extract step. 16:35:30 INFO - Running pre-action listener: _resource_record_pre_action 16:35:30 INFO - Running main action method: download_and_extract 16:35:30 INFO - mkdir: /builds/slave/test/build/tests 16:35: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')]} 16:35:30 INFO - trying https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:35:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:32 INFO - Downloaded 1199 bytes. 16:35:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:35:32 INFO - Using the following test package requirements: 16:35:32 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:35:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:35:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:35:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'jsshell-mac.zip'], 16:35:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:35:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:35:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:35:32 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:35:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:35:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:35:32 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:35:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:35:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:35:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:35:32 INFO - Http code: 200 16:35:32 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:35:32 INFO - x-amz-cf-id: YQSflhY4KTNivuWvKk9Ob1BUVSQ8hxN5Qg4QTNV3RBd-dF38qzyJVQ== 16:35:32 INFO - x-amz-version-id: v2oMC3FxxZq6PcVIwZlM26xfI6c2s0BH 16:35:33 INFO - Expected file size: 16516674 16:35:33 INFO - Obtained file size: 16516674 16:35:39 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 16:35:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:35:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:35:40 INFO - Http code: 200 16:35:40 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:35:40 INFO - x-amz-cf-id: XFFZ5La2mtZ0yatCgXGpLjjV69MbngSRzN1Ac3YYC1L1szP9bKn1IA== 16:35:40 INFO - x-amz-version-id: v2oMC3FxxZq6PcVIwZlM26xfI6c2s0BH 16:35:40 INFO - Expected file size: 16516674 16:35:40 INFO - Obtained file size: 16516674 16:35:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:35:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:35:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:35:47 INFO - Http code: 200 16:35:47 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 16:35:47 INFO - x-amz-cf-id: 1qNMZhjiHh6CmAqjwuWFQjGps1e4l-s8lFhXWgQ-y-Sjsy51PywhCA== 16:35:47 INFO - x-amz-version-id: ckHd9cD_mWJFSrgsefn93k0tIlt3YJOh 16:35:48 INFO - Expected file size: 14409028 16:35:48 INFO - Obtained file size: 14409028 16:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:48 INFO - trying https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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 16:35:51 INFO - Downloaded 111972944 bytes. 16:35:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:51 INFO - mkdir: /builds/slave/test/properties 16:35:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:51 INFO - Contents: 16:35:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:35:52 INFO - Running post-action listener: _resource_record_post_action 16:35:52 INFO - Running post-action listener: set_extra_try_arguments 16:35:52 INFO - [mozharness: 2016-10-14 23:35:52.138500Z] Finished download-and-extract step (success) 16:35:52 INFO - [mozharness: 2016-10-14 23:35:52.138625Z] Running populate-webroot step. 16:35:52 INFO - Running pre-action listener: _resource_record_pre_action 16:35:52 INFO - Running main action method: populate_webroot 16:35:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:52 INFO - '--tppagecycles', 16:35:52 INFO - '7'], 16:35:52 INFO - 'tests': ['tsvgm']}}, 16:35:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:35:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:35:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['damp', 'tps']}, 16:35:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'tests': ['damp', 'tps']}, 16:35:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['dromaeo_dom']}, 16:35:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['basic_compositor_video']}, 16:35:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:35:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'other-e10s': {'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['a11yr', 16:35:52 INFO - 'ts_paint', 16:35:52 INFO - 'tpaint', 16:35:52 INFO - 'sessionrestore', 16:35:52 INFO - 'sessionrestore_no_auto_restore', 16:35:52 INFO - 'tabpaint']}, 16:35:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['tsvgx', 16:35:52 INFO - 'tsvgr_opacity', 16:35:52 INFO - 'tart', 16:35:52 INFO - 'tscrollx', 16:35:52 INFO - 'cart']}, 16:35:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:35:52 INFO - 'tsvgr_opacity', 16:35:52 INFO - 'tart', 16:35:52 INFO - 'tscrollx', 16:35:52 INFO - 'cart']}, 16:35:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'talos_options': ['--disable-e10s'], 16:35:52 INFO - 'tests': ['tp5o']}, 16:35:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'tests': ['tp5o']}, 16:35:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'talos_options': ['--disable-e10s', 16:35:52 INFO - '--xperf_path', 16:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:52 INFO - 'tests': ['tp5n']}, 16:35:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:52 INFO - 'talos_options': ['--xperf_path', 16:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:52 INFO - 'tests': ['tp5n']}}, 16:35:52 INFO - 'talos.zip': {'path': '', 16:35:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:52 INFO - Running post-action listener: _resource_record_post_action 16:35:52 INFO - [mozharness: 2016-10-14 23:35:52.157498Z] Finished populate-webroot step (success) 16:35:52 INFO - [mozharness: 2016-10-14 23:35:52.157604Z] Running create-virtualenv step. 16:35:52 INFO - Running pre-action listener: _resource_record_pre_action 16:35:52 INFO - Running main action method: create_virtualenv 16:35:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:52 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 16:35:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:52 INFO - Using real prefix '/tools/python27' 16:35:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:55 INFO - Installing pip.................done. 16:35:55 INFO - Return code: 0 16:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:35:56 INFO - Reading from file tmpfile_stdout 16:35:56 INFO - Output received: 16:35:56 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) 16:35:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:56 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:35:56 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 16:35:56 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 16:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:56 INFO - 'HOME': '/Users/cltbld', 16:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:56 INFO - 'LOGNAME': 'cltbld', 16:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:56 INFO - 'MOZ_NO_REMOTE': '1', 16:35:56 INFO - 'NO_EM_RESTART': '1', 16:35:56 INFO - 'PAGER': '/bin/cat', 16:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:56 INFO - 'PWD': '/builds/slave/test', 16:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:56 INFO - 'SHELL': '/bin/bash', 16:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:35:56 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:56 INFO - 'USER': 'cltbld', 16:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:56 INFO - 'XPC_FLAGS': '0x0', 16:35:56 INFO - 'XPC_SERVICE_NAME': '0', 16:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:56 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 16:35:56 INFO - Cleaning up... 16:35:56 INFO - Return code: 0 16:35:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:56 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:35:56 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 16:35:56 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 16:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:56 INFO - 'HOME': '/Users/cltbld', 16:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:56 INFO - 'LOGNAME': 'cltbld', 16:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:56 INFO - 'MOZ_NO_REMOTE': '1', 16:35:56 INFO - 'NO_EM_RESTART': '1', 16:35:56 INFO - 'PAGER': '/bin/cat', 16:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:56 INFO - 'PWD': '/builds/slave/test', 16:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:56 INFO - 'SHELL': '/bin/bash', 16:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:35:56 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:56 INFO - 'USER': 'cltbld', 16:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:56 INFO - 'XPC_FLAGS': '0x0', 16:35:56 INFO - 'XPC_SERVICE_NAME': '0', 16:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:56 INFO - Downloading/unpacking psutil>=3.1.1 16:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:00 INFO - Installing collected packages: psutil 16:36:00 INFO - Running setup.py install for psutil 16:36:00 INFO - building 'psutil._psutil_osx' extension 16:36:00 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 16:36:00 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 16:36:01 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 16:36:01 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 16:36:01 INFO - building 'psutil._psutil_posix' extension 16:36:01 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 16:36:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:36:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:36:01 INFO - ^ 16:36:01 INFO - 1 warning generated. 16:36:01 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 16:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:01 INFO - Successfully installed psutil 16:36:01 INFO - Cleaning up... 16:36:01 INFO - Return code: 0 16:36:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:36:01 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')]} 16:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:01 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')]} 16:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:01 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:01 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 16:36:01 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 16:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:01 INFO - 'HOME': '/Users/cltbld', 16:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:01 INFO - 'LOGNAME': 'cltbld', 16:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:01 INFO - 'MOZ_NO_REMOTE': '1', 16:36:01 INFO - 'NO_EM_RESTART': '1', 16:36:01 INFO - 'PAGER': '/bin/cat', 16:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:01 INFO - 'PWD': '/builds/slave/test', 16:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:01 INFO - 'SHELL': '/bin/bash', 16:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:01 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:01 INFO - 'USER': 'cltbld', 16:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:01 INFO - 'XPC_FLAGS': '0x0', 16:36:01 INFO - 'XPC_SERVICE_NAME': '0', 16:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:01 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 16:36:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:36:05 INFO - Installing collected packages: mozsystemmonitor 16:36:05 INFO - Running setup.py install for mozsystemmonitor 16:36:05 INFO - Successfully installed mozsystemmonitor 16:36:05 INFO - Cleaning up... 16:36:05 INFO - Return code: 0 16:36:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:05 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:05 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 16:36:05 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 16:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:05 INFO - 'HOME': '/Users/cltbld', 16:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:05 INFO - 'LOGNAME': 'cltbld', 16:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:05 INFO - 'MOZ_NO_REMOTE': '1', 16:36:05 INFO - 'NO_EM_RESTART': '1', 16:36:05 INFO - 'PAGER': '/bin/cat', 16:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:05 INFO - 'PWD': '/builds/slave/test', 16:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:05 INFO - 'SHELL': '/bin/bash', 16:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:05 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:05 INFO - 'USER': 'cltbld', 16:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:05 INFO - 'XPC_FLAGS': '0x0', 16:36:05 INFO - 'XPC_SERVICE_NAME': '0', 16:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:05 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 16:36:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:36:08 INFO - warning: no files found matching '*.txt' 16:36:08 INFO - no previously-included directories found matching 'build' 16:36:08 INFO - no previously-included directories found matching 'dist' 16:36:08 INFO - no previously-included directories found matching '.git*' 16:36:08 INFO - Installing collected packages: jsonschema, functools32 16:36:08 INFO - Running setup.py install for functools32 16:36:09 INFO - warning: no files found matching '*.txt' 16:36:09 INFO - no previously-included directories found matching 'build' 16:36:09 INFO - no previously-included directories found matching 'dist' 16:36:09 INFO - no previously-included directories found matching '.git*' 16:36:09 INFO - Successfully installed jsonschema functools32 16:36:09 INFO - Cleaning up... 16:36:09 INFO - Return code: 0 16:36:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:09 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:09 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 16:36:09 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 16:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:09 INFO - 'HOME': '/Users/cltbld', 16:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:09 INFO - 'LOGNAME': 'cltbld', 16:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:09 INFO - 'MOZ_NO_REMOTE': '1', 16:36:09 INFO - 'NO_EM_RESTART': '1', 16:36:09 INFO - 'PAGER': '/bin/cat', 16:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:09 INFO - 'PWD': '/builds/slave/test', 16:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:09 INFO - 'SHELL': '/bin/bash', 16:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:09 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:09 INFO - 'USER': 'cltbld', 16:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:09 INFO - 'XPC_FLAGS': '0x0', 16:36:09 INFO - 'XPC_SERVICE_NAME': '0', 16:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:36:09 INFO - Cleaning up... 16:36:09 INFO - Return code: 0 16:36:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:09 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:09 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 16:36:09 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 16:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:09 INFO - 'HOME': '/Users/cltbld', 16:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:09 INFO - 'LOGNAME': 'cltbld', 16:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:09 INFO - 'MOZ_NO_REMOTE': '1', 16:36:09 INFO - 'NO_EM_RESTART': '1', 16:36:09 INFO - 'PAGER': '/bin/cat', 16:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:09 INFO - 'PWD': '/builds/slave/test', 16:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:09 INFO - 'SHELL': '/bin/bash', 16:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:09 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:09 INFO - 'USER': 'cltbld', 16:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:09 INFO - 'XPC_FLAGS': '0x0', 16:36:09 INFO - 'XPC_SERVICE_NAME': '0', 16:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:13 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 16:36:13 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 16:36:13 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 16:36:13 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 16:36:13 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 16:36:13 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 16:36:13 INFO - Downloading docopt-0.6.1.tar.gz 16:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:13 INFO - Running setup.py install for blobuploader 16:36:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:13 INFO - Running setup.py install for requests 16:36:14 INFO - Running setup.py install for docopt 16:36:14 INFO - Successfully installed blobuploader requests docopt 16:36:14 INFO - Cleaning up... 16:36:14 INFO - Return code: 0 16:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:14 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')]} 16:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:14 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')]} 16:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:14 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:14 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 16:36:14 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 16:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:14 INFO - 'HOME': '/Users/cltbld', 16:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:14 INFO - 'LOGNAME': 'cltbld', 16:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:14 INFO - 'MOZ_NO_REMOTE': '1', 16:36:14 INFO - 'NO_EM_RESTART': '1', 16:36:14 INFO - 'PAGER': '/bin/cat', 16:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:14 INFO - 'PWD': '/builds/slave/test', 16:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:14 INFO - 'SHELL': '/bin/bash', 16:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:14 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:14 INFO - 'USER': 'cltbld', 16:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:14 INFO - 'XPC_FLAGS': '0x0', 16:36:14 INFO - 'XPC_SERVICE_NAME': '0', 16:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LytKFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-35koVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-DIxjCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5NQxSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3Oc4tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-PKIYAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-aeJHaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5EkwGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Oqfkd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-YX3ARw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-BvXePa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-OP7Spl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-YQHdD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:16 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8GARoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:16 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-WW4nhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:16 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-XtZ0Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:16 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-j0tLL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:16 INFO - Running setup.py install for manifestparser 16:36:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:16 INFO - Running setup.py install for mozcrash 16:36:16 INFO - Running setup.py install for mozdebug 16:36:16 INFO - Running setup.py install for mozdevice 16:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for mozfile 16:36:17 INFO - Running setup.py install for mozhttpd 16:36:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for mozinfo 16:36:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for mozInstall 16:36:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for mozleak 16:36:17 INFO - Running setup.py install for mozlog 16:36:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:17 INFO - Running setup.py install for moznetwork 16:36:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:18 INFO - Running setup.py install for mozprocess 16:36:18 INFO - Running setup.py install for mozprofile 16:36:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:18 INFO - Running setup.py install for mozrunner 16:36:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:18 INFO - Running setup.py install for mozscreenshot 16:36:18 INFO - Running setup.py install for moztest 16:36:18 INFO - Running setup.py install for mozversion 16:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:19 INFO - Cleaning up... 16:36:19 INFO - Return code: 0 16:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:19 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:19 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 16:36:19 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 16:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:19 INFO - 'HOME': '/Users/cltbld', 16:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:19 INFO - 'LOGNAME': 'cltbld', 16:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:19 INFO - 'MOZ_NO_REMOTE': '1', 16:36:19 INFO - 'NO_EM_RESTART': '1', 16:36:19 INFO - 'PAGER': '/bin/cat', 16:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:19 INFO - 'PWD': '/builds/slave/test', 16:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:19 INFO - 'SHELL': '/bin/bash', 16:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:19 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:19 INFO - 'USER': 'cltbld', 16:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:19 INFO - 'XPC_FLAGS': '0x0', 16:36:19 INFO - 'XPC_SERVICE_NAME': '0', 16:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8XamsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-AxtXfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-TWgWdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-P26dbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Ve8Kr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bkWfij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:19 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)) 16:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5OFiK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hSyNaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xK6QgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Dp3Dcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-BJ2hSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9bKLag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Ffrbt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-dLninT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gn6xGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:20 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)) 16:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-VBGnMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:21 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)) 16:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-DJI1r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 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)) 16:36:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:21 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 16:36:21 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 16:36:21 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 16:36:21 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 16:36:21 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 16:36:21 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 16:36:24 INFO - Downloading blessings-1.6.tar.gz 16:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:24 INFO - Installing collected packages: blessings 16:36:24 INFO - Running setup.py install for blessings 16:36:24 INFO - Successfully installed blessings 16:36:24 INFO - Cleaning up... 16:36:24 INFO - Return code: 0 16:36:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:24 INFO - Reading from file tmpfile_stdout 16:36:24 INFO - Current package versions: 16:36:24 INFO - blessings == 1.6 16:36:24 INFO - blobuploader == 1.2.4 16:36:24 INFO - docopt == 0.6.1 16:36:24 INFO - functools32 == 3.2.3-2 16:36:24 INFO - jsonschema == 2.5.1 16:36:24 INFO - manifestparser == 1.1 16:36:24 INFO - mozInstall == 1.12 16:36:24 INFO - mozcrash == 0.17 16:36:24 INFO - mozdebug == 0.1 16:36:24 INFO - mozdevice == 0.48 16:36:24 INFO - mozfile == 1.2 16:36:24 INFO - mozhttpd == 0.7 16:36:24 INFO - mozinfo == 0.9 16:36:24 INFO - mozleak == 0.1 16:36:24 INFO - mozlog == 3.4 16:36:24 INFO - moznetwork == 0.27 16:36:24 INFO - mozprocess == 0.23 16:36:24 INFO - mozprofile == 0.28 16:36:24 INFO - mozrunner == 6.12 16:36:24 INFO - mozscreenshot == 0.1 16:36:24 INFO - mozsystemmonitor == 0.3 16:36:24 INFO - moztest == 0.7 16:36:24 INFO - mozversion == 1.4 16:36:24 INFO - psutil == 3.1.1 16:36:24 INFO - requests == 1.2.3 16:36:24 INFO - wsgiref == 0.1.2 16:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:24 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')]} 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:25 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 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:25 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 16:36:25 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 16:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:25 INFO - 'HOME': '/Users/cltbld', 16:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:25 INFO - 'LOGNAME': 'cltbld', 16:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:25 INFO - 'MOZ_NO_REMOTE': '1', 16:36:25 INFO - 'NO_EM_RESTART': '1', 16:36:25 INFO - 'PAGER': '/bin/cat', 16:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:25 INFO - 'PWD': '/builds/slave/test', 16:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:25 INFO - 'SHELL': '/bin/bash', 16:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:25 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:25 INFO - 'USER': 'cltbld', 16:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:25 INFO - 'XPC_FLAGS': '0x0', 16:36:25 INFO - 'XPC_SERVICE_NAME': '0', 16:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 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)) 16:36:25 INFO - Cleaning up... 16:36:25 INFO - Return code: 0 16:36:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e34c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6b857b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, '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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 16:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:25 INFO - 'HOME': '/Users/cltbld', 16:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:25 INFO - 'LOGNAME': 'cltbld', 16:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:25 INFO - 'MOZ_NO_REMOTE': '1', 16:36:25 INFO - 'NO_EM_RESTART': '1', 16:36:25 INFO - 'PAGER': '/bin/cat', 16:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:25 INFO - 'PWD': '/builds/slave/test', 16:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:25 INFO - 'SHELL': '/bin/bash', 16:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:36:25 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:25 INFO - 'USER': 'cltbld', 16:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:25 INFO - 'XPC_FLAGS': '0x0', 16:36:25 INFO - 'XPC_SERVICE_NAME': '0', 16:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:36:25 INFO - Cleaning up... 16:36:25 INFO - Return code: 0 16:36:25 INFO - Running post-action listener: _resource_record_post_action 16:36:25 INFO - Running post-action listener: _start_resource_monitoring 16:36:25 INFO - Starting resource monitoring. 16:36:25 INFO - [mozharness: 2016-10-14 23:36:25.710459Z] Finished create-virtualenv step (success) 16:36:25 INFO - [mozharness: 2016-10-14 23:36:25.711525Z] Running install step. 16:36:25 INFO - Running pre-action listener: _resource_record_pre_action 16:36:25 INFO - Running main action method: install 16:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:25 INFO - Reading from file tmpfile_stdout 16:36:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:26 INFO - Reading from file tmpfile_stdout 16:36:26 INFO - Output received: 16:36:26 INFO - Usage: mozinstall [options] installer 16:36:26 INFO - Options: 16:36:26 INFO - -h, --help show this help message and exit 16:36:26 INFO - -d DEST, --destination=DEST 16:36:26 INFO - Directory to install application into. [default: 16:36:26 INFO - "/builds/slave/test"] 16:36:26 INFO - --app=APP Application being installed. [default: firefox] 16:36:26 INFO - mkdir: /builds/slave/test/build/application 16:36:26 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'] 16:36:26 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 16:37:01 INFO - Reading from file tmpfile_stdout 16:37:01 INFO - Output received: 16:37:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:37:01 INFO - Running post-action listener: _resource_record_post_action 16:37:01 INFO - [mozharness: 2016-10-14 23:37:01.195318Z] Finished install step (success) 16:37:01 INFO - [mozharness: 2016-10-14 23:37:01.195483Z] Running run-tests step. 16:37:01 INFO - Running pre-action listener: _resource_record_pre_action 16:37:01 INFO - Running main action method: run_tests 16:37:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:37:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:37:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:37:01 INFO - 2016-10-14 16:37:01.210 screenresolution[1643:7554] starting screenresolution argv=screenresolution get 16:37:01 INFO - 2016-10-14 16:37:01.212 screenresolution[1643:7554] Display 0: 1600x1200x32@60 16:37:01 INFO - 2016-10-14 16:37:01.218 screenresolution[1644:7556] starting screenresolution argv=screenresolution list 16:37:01 INFO - Available Modes on Display 0 16:37:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:37:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:37:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:37:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:37:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:37:01 INFO - Intel Iris: 16:37:01 INFO - Chipset Model: Intel Iris 16:37:01 INFO - Type: GPU 16:37:01 INFO - Bus: Built-In 16:37:01 INFO - VRAM (Dynamic, Max): 1536 MB 16:37:01 INFO - Vendor: Intel (0x8086) 16:37:01 INFO - Device ID: 0x0a2e 16:37:01 INFO - Revision ID: 0x0009 16:37:01 INFO - Displays: 16:37:01 INFO - Display: 16:37:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:37:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:37:01 INFO - Display Serial Number: 1600x1200 60 16:37:01 INFO - Main Display: Yes 16:37:01 INFO - Mirror: Off 16:37:01 INFO - Online: Yes 16:37:01 INFO - Rotation: Supported 16:37:01 INFO - Return code: 0 16:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:01 INFO - Python 2.7.3 16:37:01 INFO - Return code: 0 16:37:01 INFO - grabbing minidump binary from tooltool 16:37:01 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')]} 16:37:01 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 0x10e160d30>, '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 0x10df86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e158b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:01 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 16:37:01 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 16:37:01 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 16:37:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:01 INFO - Return code: 0 16:37:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:01 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 16:37:01 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 16:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N2J71uWbGN/Render', 16:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:01 INFO - 'HOME': '/Users/cltbld', 16:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:01 INFO - 'LOGNAME': 'cltbld', 16:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:01 INFO - 'MOZ_NO_REMOTE': '1', 16:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:01 INFO - 'NO_EM_RESTART': '1', 16:37:01 INFO - 'PAGER': '/bin/cat', 16:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:01 INFO - 'PWD': '/builds/slave/test', 16:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:01 INFO - 'SHELL': '/bin/bash', 16:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sk1oQG9ZZf/Listeners', 16:37:01 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 16:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:01 INFO - 'USER': 'cltbld', 16:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:01 INFO - 'XPC_FLAGS': '0x0', 16:37:01 INFO - 'XPC_SERVICE_NAME': '0', 16:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:01 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/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 16:37:01 INFO - mozversion application_buildid: 20161014144235 16:37:01 INFO - mozversion application_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:37:01 INFO - mozversion application_display_name: Nightly 16:37:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:01 INFO - mozversion application_name: Firefox 16:37:01 INFO - mozversion application_remotingname: firefox 16:37:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:37:01 INFO - mozversion application_vendor: Mozilla 16:37:01 INFO - mozversion application_version: 52.0a1 16:37:01 INFO - mozversion platform_buildid: 20161014144235 16:37:01 INFO - mozversion platform_changeset: de5d73a0568d1c3d50da32169026cc68ee09b1ae 16:37:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:37:01 INFO - mozversion platform_version: 52.0a1 16:37:01 INFO - using testdate: 1476488221 16:37:01 INFO - actual date: 1476488221 16:37:01 INFO - starting webserver on 'localhost:49266' 16:37:01 INFO - SUITE-START | Running 2 tests 16:37:01 INFO - TEST-START | dromaeo_css 16:37:01 INFO - operating with platform_type : mac_ 16:37:01 INFO - Initialising browser for dromaeo_css test... 16:37:01 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpEJHAcL/profile http://localhost:49266/getInfo.html) 16:37:04 INFO - PROCESS | 1654 | 2016-10-14 16:37:04.903 plugin-container[1656:7703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 16:37:04 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:37:04 INFO - PROCESS | 1654 | 2016-10-14 16:37:04.906 plugin-container[1656:7703] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 16:37:04 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:37:04 INFO - PROCESS | 1654 | 2016-10-14 16:37:04.906 plugin-container[1656:7703] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:37:04 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 16:37:04 INFO - PROCESS | 1654 | colorDepth:24 16:37:04 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 16:37:04 INFO - PROCESS | 1654 | __metrics 16:37:05 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:37:05 INFO - TEST-INFO | 1654: exit 0 16:37:05 INFO - Browser initialized. 16:37:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:37:05 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpEJHAcL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:08 INFO - PROCESS | 1657 | 2016-10-14 16:37:08.197 plugin-container[1658:7824] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863b, name = 'com.apple.tsm.portname' 16:37:08 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:37:08 INFO - PROCESS | 1657 | 2016-10-14 16:37:08.197 plugin-container[1658:7824] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0f, name = 'com.apple.CFPasteboardClient' 16:37:08 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:37:08 INFO - PROCESS | 1657 | 2016-10-14 16:37:08.198 plugin-container[1658:7824] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:37:17 INFO - PROCESS | 1657 | RSS: Main: 237531136 16:37:17 INFO - PROCESS | 1657 | 16:38:07 INFO - PROCESS | 1657 | 1476488287556 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] 16:40:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 16:40:23 INFO - PROCESS | 1657 | RSS: Main: 251633664 16:40:23 INFO - PROCESS | 1657 | 16:43:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 16:43:25 INFO - PROCESS | 1657 | RSS: Main: 264105984 16:43:25 INFO - PROCESS | 1657 | 16:46:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 16:46:28 INFO - PROCESS | 1657 | RSS: Main: 268632064 16:46:28 INFO - PROCESS | 1657 | 16:49:30 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 16:49:31 INFO - PROCESS | 1657 | RSS: Main: 268271616 16:49:31 INFO - PROCESS | 1657 | 16:52:33 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 16:52:34 INFO - PROCESS | 1657 | RSS: Main: 274714624 16:52:34 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 16:55:37 INFO - PROCESS | 1657 | RSS: Main: 277504000 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | __start_tp_report 16:55:37 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 16:55:37 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 16:55:37 INFO - PROCESS | 1657 | |i|pagename|runs| 16:55:37 INFO - PROCESS | 1657 | |0;dojo.html;3070.5240687693404;3380.814055226963;3414.5219669246326;3436.2096717754926;3442.8106454145027;5652.886942261152;5719.799807006751;5765.884682306357;5794.82615521534;5833.591648584601;5675.2054712340305;5708.628939118955;5818.3308919474275;5831.212786273852;5833.504152147062;5187.533122019017;5246.5278124968745;5264.973675131619;5301.3373328333955;5301.443348448415;5238.973805130988;5334.866628334304;5361;5381.0852155133725;5396.757145928423;3871.825767840454;5239.266502689627;5352.304200453936;5377.274068000809;5425.864353391157;3973.821178046966;5171.534561889411;5191.143461328877;5193.506616871391;5251.737413129328;5132.743362831843;5156.381234251914;5158.690478571298;5165.483451654804;5226.294450249244;4083.2445997490263;5733.111367738007;5821.27234095738;5854.795082172103;5860.794872179454;6182.69086545671;6192.752289908398;6221.595596286227;6251.031090181029;6251.906221406683;6216.658083805389;6223.222097237845;6224.968875155595;6255.781047663356;6279.309275979638;5744.253247077853;5896.1450589664255;5901.557383196277;5923.870062819939;5966.0454327307425;6200.906986395207;6274.498040156868;6321.241451025906;6326.6520341381665;6401.135846660734;6105.145279660851;6172.629642221481;6173.351798061229;6174.536909731788;6194.4115309045565;6223.502119830493;6272.937270627326;6280.560360774702;6282.528810339243;6282.780102696383;6091.786787462417;6122.326544080148;6141.30190404341;6144.8185894007875;6220.782272620437;6151.6001459904965;6212.378762123842;6254.843628909313;6257.5932564383165;6266.49868010558;4986.426560945465;4995.575376093073;4998.925016124761;5010.949890501121;5013.649044566918;4384.4081049058605;4391.3193455014525;4421.911561768747;4462.219111655448;4514.187446259705;5043.739065233692;5919.289685237713;5921.023031199804;5980.132880732356;6051.788187413419;6211.819754246679;6229.626222426578;6230.408111229426;6252.906206406908;6270.717817698214;5656.943430565724;5948.226730525004;5989.221401217901;5990.101484777319;6068.696565171724;5371.57027437804;5437.510624043855;5442.809501667422;5447.645903016291;5461.2354270402175;6230.813075607739;6258.499320054476;6267.874642507216;6284.717187726472;6327.17746692927;5122.795088196431;5676.318841739017;6167.599106058092;6231.75072997075;6244.906326405198;5197.7141257231215;5208.557272631869;6397.26431460388;6420.646864422315;6430.3891130342545;6042.1540984261355;6092.45167934888;6119.472088496418;6125.0218003337495;6229.688515574113;5163.793448262028;6117.5838231413945;6166.4758495526585;6200.503959683305;6238.812835614939;4367.781610919505;4529.705569137996;4973.651844370859;6161.383861613803;6168.845778855385;5119.334486516729;6017.819465416044;6082.90875636857;6144.38556144382;6162.414570615784;5152.536271735562;5193.37679478465;5893.02765043763;6078;6129.724162412613;6086.7260973255425;6094.268687757498;6142.437386315837;6145.217886812774;6207.255129384503;5128.7179205144075;5890.793822216202;5930.584859059824;6002.69986500682;6015.248093988252 16:55:37 INFO - PROCESS | 1657 | |1;ext.html;466.35875670952464;472.70455965021864;504.4627471742594;504.57867680486794;529.3039652856492;38969.80515097424;41340.99999999993;41365.58634413659;41395.379069313945;41411.37882931758;35283;43231;43431.56568434315;43487.565124348745;43707.3443898341;9489;9620.27847911406;9656.71029869105;9676.419414835098;9692.46691431971;9604.2316614671;9667.806643867118;9706.514674266295;9708.17480514157;9735.318527703064;9624.663136790214;9638.084381983736;9666.081722236377;9691.515424228795;9691.854622180674;8627.827443451128;9600.1359877611;9650.613975440974;9701.854472182922;9707.495338222587;9568.808623827554;9608.375455595364;9642.662506812228;9649.228061755042;9658.32391732579;40265.396019059444;41144;41146.38280425796;41196;41332;3328.8834890778708;3398.712382093133;3536.6286539913453;3888.844446222148;3920.882373528799;31174.688253117405;31473.527897081563;31852.522212166838;31910.042698718844;32753.836230818695;3211.630662473822;3229.321842413096;3240.935181296361;3293.6047674279002;3345.46472564391;427724;485522;489572.10427895264;490311;493465;61769.382306177264;62002;62048.75902481925;62221.06668399978;62248.37751622426;57254.7137264311;61206.38793612096;65082.67458662677;65530.672346638916;65673.34326656768;16414.67170656604;16430.83569164317;16590.17049147538;16595.585110372096;16644.3342266308;12750.48998040068;12879.034072444605;12892.80660790089;12892.968562514976;12897.677558061123;17517.036562989157;17541.736873946647;17679.20443580042;17713;17793.110344482724;6384.138141350951;6392.721455708876;6465.573246179532;6536.627308265222;6554.311797261219;877.455977294069;966.7051549277538;1055.678018204455;1091.9181061420425;1099.6755956992547;30808.537871931938;31159.376812464077;31294.687053129634;31551.684483155335;31752.682473174973;993.3791380387258;1019.7348689340824;1077.9514921828536;1104.2932523185168;1159.0090472645934;15517.689646207238;16088.11515366666;16117.435889743803;16389.180540972902;16514.174291285388;663125;664466;672205;672331;673215;58722.70638646865;59330.703346482995;59670.40329596735;59878.70060649756;59918;1346.4008516210388;1381.5855243426931;1399.3423091147145;1402.5792262321263;1409;22874.65688014648;29062.982795602053;29610.555841662823;30569.17885264342;30637.387252255277;44787.55212447964;52458.213126803894;52590.474095258556;52903;52941.47058529365;509644;613117.6226496332;613854;614063.4293854426;615331;26036.21891343263;26287.342816429744;27419;27434.5884811724;27526.724732752416;41487.58512414958;48073.27890081722;48220.27669584889;48494.51505485041;49540.00919981508;39705;40112.98587676541;40390.59609403986;41576.16847662969;42403.7879810599;37780;39764.80117599509;40982.79508602557;41210.78811208087;41782.79108604559;38602.42096368501;39048.219035619695;39600.2079958405;39927;40380.99047523835;35256.471152932216;35438;35643.28713425769;35883.46174807328;36179.45730813987;24358.87820560886;24860.12989545357;26213.737862621892;26215.868920655274;26272 16:55:37 INFO - PROCESS | 1657 | |2;jquery.html;373.382052702777;377.217274156126;384.267969518068;388.1964333828975;407.30147796528945;18710;19897.104630291637;21288.935553222334;21534.353969380925;21576.784232157675;11849.526018959254;12146.514139434434;12191.329476878767;12221.694457638563;20671.173153073898;5156.948430515703;5449.128139497681;5458.699771512565;5463.071277882769;5483.287172667548;5184.922226166611;5194.35070616173;5383.623146379755;5421.674699518022;5434.375046869602;4592.288195329713;5284.233786101013;5410.91883621744;5425.7287135643255;5459.12653975364;5173.327467429248;5309.761060752276;5338.065838478289;5374.7850085996515;5406.270153529283;4001.3197756381487;4346.478422589278;4373.322135069069;4513.616342610882;5240.371155461369;11037;13275.933620331933;13471.865281347256;13499.190048597018;13585.184888906697;2166.1335465813645;2207.249535158038;2224.399412158708;2351.917682881091;2763.5992781046634;9521.952390238073;10385.169186465064;10386.376817390981;10566.154707623371;10572.577096916115;1830.588117673526;1871.9157637906326;1881.5578339090303;1900.9524761880925;1905.6093500832296;121996.1700574501;126507;128921.26472411686;129691.35154324168;131715.6828431713;9392.671256506126;10558.63044793444;11027.889721102687;11626.651200463999;11794.351310677823;14659.34032968519;14659.560213193621;14664;14669.633259168393;14672.266386680623;8361.581920903931;8650.567471626393;8713.041565427799;8784.91215087841;8823.117688231254;7045;7410.925890741131;8593.570321483901;8779.253763430052;9027.864582031274;4473.3960915276675;4552.112338094106;4587.472440669299;4698.342232087511;4718.197906355927;1484.346887369554;1908.80911908808;1945.9178678813817;1962.1660794162424;1971.6155349706955;783.2832957843623;857.691231156783;917.6971599372191;1022.4478781458079;1042.6871938418444;20975.790242097384;21851.235206767687;21888.45278868041;21912.013959371547;22030.44923876916;872.6596627315225;929.9628014879464;942.8821397325335;951.0584521323977;980.3039841712464;10394.844077338847;10532.15742740579;11411.42942852854;11426.08591312693;11464.31214127155;570619;577396;581483.0925845428;589403;597482;99290;117535;125905;126321.736782631;148990.2752431198;935.6631612619451;976.951152442375;979.1236843025453;984.3847595252967;1003.357850975391;19351.12919918635;19574.510637233612;19760.505987350432;19862.304819331253;19986.60026799427;56435.15347269877;56750.7162464185;57924.2510570664;58271.70864145652;59734;66373.66813165903;86825;87472;88384;89255;7645.770626881203;7909.485883417559;8137.918620813953;8192.426530142833;8275.089740128702;9205.815883682155;10416.583336666448;11348.148888833206;11615.361155136548;12899.484020639446;11085.556577736801;11317.886821131684;11482.598109066143;11599.246049006788;11600.419979000848;8693.261072808882;9030;11028.944855275673;11545.595904143314;11720.238184517979;11516.905893940397;11564.537418503165;11564.94217528907;11733.296002239893;11816.277872470144;7160.427165826617;7460.850782984418;7725.729599463992;8022.27799498048;8313.792155196168;10281.12610428122;11086.944565277123;11281.7743645125;11393.886061139283;11531.192816502764 16:55:37 INFO - PROCESS | 1657 | |3;mootools.html;1432;1524.7560390337544;1752.9044347282947;1885.7454243677116;1914.5022294203511;8045.39659525535;8312.335013198945;8474.02548706899;9036.909630903689;9053.592588333524;8432.83134337313;8742.519161446118;8770.649174033048;8886.333524985635;8888.866666999984;2351.7883390494853;2375.596148654733;2383.6067048936907;2384.8807559622037;2391.9594976185417;2346.2609278077434;2381.154690085012;2383.535210633927;2385.8926348314367;2390.3904504351367;2372.988135059331;2374.4776149247223;2387.1167667962877;2389.880505974703;2396.9161079362225;2349.436135327509;2359.681443005198;2367.9644805327935;2371.5968285391436;2371.92884213473;2345.835791494596;2363.1492662641435;2365.136725095345;2369.253685089209;2380.416797884512;8912.287017038621;8951.41815781972;8960.731178064669;8962.148595883446;8964.59659315326;5239.711815850127;5341.813036543703;5396.83809485716;5422.728863556846;5438.428964958662;3632.328019316435;3635.7818530887967;3665.5784584772828;3675.1730860556427;3699.075231192202;1068.3002633275216;1076.1337123615485;1077.1329080090525;1091.1161958813307;1091.7379828841101;11529;11651;11659.00898423635;11665.125115616278;11667;4543.227651299287;4600.3099535070005;4794;4811.254255590319;4820.566149046603;9803.558839852223;9960;10018.148457381058;10024.899751002542;10059.245556583139;5407.918881216785;5413.079776438015;5424.783008679688;5433.320834895638;5444.537214336826;4409.228385032607;4591.494935557086;4768.833090841804;4916.06594746997;4954.851354459372;3179.998300535324;3401.6768407001296;3916.6083391660604;3995.34076877312;4036.59634036594;1299.7465494228725;1314.2180402660401;1314.3559655768604;1315.658028810608;1325.7481078595035;789.6091434739841;794.2494342846071;849.8172892828071;916.6929078758557;942.1426501883391;4793.736344501086;5788.7684492620665;5933.050711886164;6011.27864656244;6138.1099740537375;413.4893406642794;424.3486248608371;436.21045906908597;439.5845925600277;448.19325214613565;3445.776749254029;3619.873304434332;4012.9197416051516;4031;4056.499095334745;10119.342242754197;10764.654418197726;10788.406637635006;10791.892081079088;10810.29733067348;10428.530716117793;10564.735881603021;10860.945695271474;10884.40135792539;10911.781764364827;8214.178582141858;8243.752687419386;8298.377621678399;8304.128066552925;8346.20711032463;5835.7373918174635;5999.70001499932;6012.6993650316435;6021.608595441282;6075.149479073022;9485.146336829719;9916.454594997056;9964;10074.848877266993;10104.191664666956;10076.596936122472;10176;10217.33587316822;10251.48742562854;10256.179505639382;6934.7226110955;6945.236024037453;7424.554526728413;7431.628418578941;7623.4663573549315;8312.501249925024;8445.915540844513;8515.02077261123;8523.445976011539;8535.786605334917;7398.3341499265325;7476.775696729107;7550.056242969629;7562.357199637872;7623.390128789572;7358.080239970004;7430.071241094864;7443.44174186949;7529.661165247687;7648.655810488653;6974.68613912365;7133.643317833984;7137.928620713934;7142.714291428285;7161.4270858330165;4477.126960242721;4951.529604687549;4994.650374473752;5145.434002259673;5161.251618515369;4992.775325110451;5030.421501527371;5067.189249720027;5275.683458992473;5315.335583052119 16:55:37 INFO - PROCESS | 1657 | |4;prototype.html;285.2483705436175;311.9017509484512;318.1251558214909;319.068320504128;321.7747576696312;4472.955270447294;4993.101241776479;5093.617978651602;5693.316801983758;5723.7407770290465;4556.794944227509;5499.890002199953;5543.699364763628;5579.581531385153;5594;3405.3019131078067;3995.740276882008;4103.938440923389;4166.541680415167;4208;3602.765820221677;3981.223661386031;4200.537940826506;4218.0262914645255;4248.511421186572;3788.9012186465893;4183.602557757008;4184.075325350343;4196.349565817303;4211.452511173558;3402;4016.9555915462192;4070.75575465473;4158.6465150462245;4234.534201237861;3032.8331941743195;3392.6268110507826;3576.159602493412;3580.5166302549083;3620.1356301504748;4661.254199328125;5226.425093239741;5365.275687782138;5373;5428.592855535811;4409.677096870958;4648.628109751212;4802.783874725646;4850.611951043943;4884.389451318585;4912.919157785317;5127.66670166438;5790.930806672471;5829.775747093116;5831.562632802515;3695.7228207884245;3977.0455090778296;3994.980025099885;4001.9599804001878;4006.59934006597;5081.28861959326;5628.409017053192;5870.853228669274;5873.383294754075;6115.510759139258;3640.672339489459;3817.3319669057805;4062.3297155968935;4085.2442298174933;4112.732672376286;3300.9174770630925;3999.4002399040614;4095.4061661059577;4140.37894315855;4151.6886233532605;4238.279492486285;4818.10864989978;4827.42070951488;4846.321514987904;4854.587360074363;4719.702081927498;4924.852254432372;5793.899159159831;5796;5837.8908007479295;1220.8767933501022;1305.7138718362405;1391.3425357566998;1406.796014577901;1421.2680469558186;801.410962942237;875.387228939732;880.7269746378643;889.9809717873;890.3366991591306;4568.6116680081905;5066.46802085783;5417.320630604447;5521.668699878021;5549.528290095306;6082.878342433127;6104.572679912363;6114.694265286718;6115.510759139258;6123.4488895999575;5005;5297.913927644823;5486.1222204447095;5515.503604675599;5610.747516361774;2851.960847993653;2929.853507324668;3171.3815805918084;3191.5372271021038;3197.8081315121167;5957.374475680078;6004.579679422399;6249.75000999964;6263.617646470946;6359.745610175633;5254.789808407697;5556.888862222733;5931.3178984417345;6124.29480164503;6135.693215339215;5407.486288802557;6117.461253579714;6225.688715564203;6320.304766475684;6337.556371054075;4057.756534607933;4735.076660051394;5001.174336499866;5276.472352764847;5960.225170727777;4959.231319145538;5190.48095190493;5377.596680249075;6042.516598672008;6058.182145410489;5929.851753706192;6305.468937395073;6322.166571694157;6323.73148125023;6406.615603063831;3916.432117343026;3936.389859571771;3958.584348643351;3965.682745380305;3988.940165897572;4990.8003679853855;5110.13832253939;5997.860406522746;6077.908831367621;6115.196017175033;5269.262303277621;5681.460261275172;5913.02435098204;5932.525397968238;6020.969895150496;5737.483626473638;5805.274340707411;5809;5853.166176154626;5932.377100404568;4552.7495987720995;5317.388500322512;5784.595078344475;5817.243758311562;5822.912656310244;4480.260756975063;4814.903701925872;5151.6393852431465;5603.831885043455;5901.704914754159;5762.913556296575;5792.437650844616;5796.652200867961;5817.970910145422;5824.5340372770925 16:55:37 INFO - PROCESS | 1657 | |5;yui.html;734.9595772232527;735.1766022055295;747.4842358772447;790.9485883417577;828.6064119543222;15323.540293791177;15930.920345398286;16057.19714014299;16065.036097834138;16107.275172617232;14709.11745295283;14710.338034788434;14759.48341808037;14784.186869722162;14813.851861481382;878.5782824244351;891.6076926152505;895.1361935732017;896.332232486795;897.6768363389175;891.3582220801013;893.2005854759985;896.6278994217392;897.2149369301861;899.204204279211;936.8266870628921;947.1759569174827;949.1599934058373;949.9620015199419;951.6621599332241;933.5145724223365;941.6986564299427;943.1370296178987;943.2595412601075;943.9144983269262;682.2427105912433;702.1609177033447;702.6346299924062;703.3002162847948;705.5167210460851;13405.262710550916;13491.595252142451;13496.39266233022;13497.662558436117;13527.864721352857;11581.594644187497;11720.706982325424;11832.467538960767;11983.700407489796;12612.495500179983;10303.042322795582;10510.421926794023;10541.631042913461;10686.091682207021;10778.191635627281;3627.546556680415;3709.1098136447326;3722.641235948859;3847.2497862916744;3884.3008258513455;103688.4077898051;104033;106623.80128596077;106825.46587267015;106872.46563767131;10783.6225732099;10915.890841091488;11184.217104802585;11208.551657933755;11392.20254582188;21396.251131210334;21695.45761355979;21748.565028699337;21763.782362176175;21794.237201697866;7652.273034061755;7868.173841746649;7882.842343153105;8125.992720464874;8184.0948355264845;4457.888552786141;4506.59440650343;4568.451785785727;4592.609628181642;4692.249240121632;3693.759905606127;3747.3442147624055;3754.887353379403;3758.0980564664283;3769.660730534265;669.5982410553629;675.7229535890261;684.650828077684;688.4526801192964;695.5722230828004;538.9919151212735;550.9035918714209;604.1753007145215;676.470879115442;697.1042210759251;7722.92277077222;7938.960305198437;8179.018517777786;9570.56932438042;9634.951825240829;522.2192821731536;578.0491092153384;585.4488276189427;609.3540846702509;691.5656887755074;3801.904952376213;3992.5807790182193;4117.75293482392;4587.243104887656;4598.816047358135;67782.98325525022;115796.42101789438;143608;150726;158636.62045069333;91863.0813691868;101724.49137754412;107269;110140.89859101467;133948;74536.62731686415;80046;84827.15172848193;107078;111072;7700.28312796574;9439.575219115019;9872.901270987199;9891.851622225817;9905.900940990787;49802.501974981235;57733.711331443075;58711.11933321089;61237.38762612317;62384.752304954556;74859;75867.62066189633;80810;84750;87240;12566.308853013172;12789.424475898793;12894.161879477804;13400.262985535888;13579.796303055264;14455.927720361331;14481.493147739779;14567.198804065878;14720.116792992454;15306;13478;13573.59279221625;13579.932100339434;13797.51708690191;13999.16005039701;13214;13629.250391228577;13773;13976;14237.074590151607;13392;13428.127171733806;13525.59423217305;13588.728225435634;13750.587482375544;10068.590397344524;10609.681709548726;10810.541324744954;11193.474055672437;11205.943970280096;10782.191335650015;11067.501962411872;11176.441177940907;11310.377929213972;11368.147388945697 16:55:37 INFO - PROCESS | 1657 | __end_tp_report 16:55:37 INFO - PROCESS | 1657 | __start_cc_report 16:55:37 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,366 16:55:37 INFO - PROCESS | 1657 | __end_cc_report 16:55:37 INFO - PROCESS | 1657 | __startTimestamp1476489337655__endTimestamp 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | ------- Summary: start ------- 16:55:37 INFO - PROCESS | 1657 | Number of tests: 6 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5677.60 Median:5930.58 stddev:694.80 (11.7%) stddev-sans-first:666.15 16:55:37 INFO - PROCESS | 1657 | Values: 3070.5 3380.8 3414.5 3436.2 3442.8 5652.9 5719.8 5765.9 5794.8 5833.6 5675.2 5708.6 5818.3 5831.2 5833.5 5187.5 5246.5 5265.0 5301.3 5301.4 5239.0 5334.9 5361.0 5381.1 5396.8 3871.8 5239.3 5352.3 5377.3 5425.9 3973.8 5171.5 5191.1 5193.5 5251.7 5132.7 5156.4 5158.7 5165.5 5226.3 4083.2 5733.1 5821.3 5854.8 5860.8 6182.7 6192.8 6221.6 6251.0 6251.9 6216.7 6223.2 6225.0 6255.8 6279.3 5744.3 5896.1 5901.6 5923.9 5966.0 6200.9 6274.5 6321.2 6326.7 6401.1 6105.1 6172.6 6173.4 6174.5 6194.4 6223.5 6272.9 6280.6 6282.5 6282.8 6091.8 6122.3 6141.3 6144.8 6220.8 6151.6 6212.4 6254.8 6257.6 6266.5 4986.4 4995.6 4998.9 5010.9 5013.6 4384.4 4391.3 4421.9 4462.2 4514.2 5043.7 5919.3 5921.0 5980.1 6051.8 6211.8 6229.6 6230.4 6252.9 6270.7 5656.9 5948.2 5989.2 5990.1 6068.7 5371.6 5437.5 5442.8 5447.6 5461.2 6230.8 6258.5 6267.9 6284.7 6327.2 5122.8 5676.3 6167.6 6231.8 6244.9 5197.7 5208.6 6397.3 6420.6 6430.4 6042.2 6092.5 6119.5 6125.0 6229.7 5163.8 6117.6 6166.5 6200.5 6238.8 4367.8 4529.7 4973.7 6161.4 6168.8 5119.3 6017.8 6082.9 6144.4 6162.4 5152.5 5193.4 5893.0 6078.0 6129.7 6086.7 6094.3 6142.4 6145.2 6207.3 5128.7 5890.8 5930.6 6002.7 6015.2 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:71534.57 Median:41336.50 stddev:156672.18 (379.0%) stddev-sans-first:157020.82 16:55:37 INFO - PROCESS | 1657 | Values: 466.4 472.7 504.5 504.6 529.3 38969.8 41341.0 41365.6 41395.4 41411.4 35283.0 43231.0 43431.6 43487.6 43707.3 9489.0 9620.3 9656.7 9676.4 9692.5 9604.2 9667.8 9706.5 9708.2 9735.3 9624.7 9638.1 9666.1 9691.5 9691.9 8627.8 9600.1 9650.6 9701.9 9707.5 9568.8 9608.4 9642.7 9649.2 9658.3 40265.4 41144.0 41146.4 41196.0 41332.0 3328.9 3398.7 3536.6 3888.8 3920.9 31174.7 31473.5 31852.5 31910.0 32753.8 3211.6 3229.3 3240.9 3293.6 3345.5 427724.0 485522.0 489572.1 490311.0 493465.0 61769.4 62002.0 62048.8 62221.1 62248.4 57254.7 61206.4 65082.7 65530.7 65673.3 16414.7 16430.8 16590.2 16595.6 16644.3 12750.5 12879.0 12892.8 12893.0 12897.7 17517.0 17541.7 17679.2 17713.0 17793.1 6384.1 6392.7 6465.6 6536.6 6554.3 877.5 966.7 1055.7 1091.9 1099.7 30808.5 31159.4 31294.7 31551.7 31752.7 993.4 1019.7 1078.0 1104.3 1159.0 15517.7 16088.1 16117.4 16389.2 16514.2 663125.0 664466.0 672205.0 672331.0 673215.0 58722.7 59330.7 59670.4 59878.7 59918.0 1346.4 1381.6 1399.3 1402.6 1409.0 22874.7 29063.0 29610.6 30569.2 30637.4 44787.6 52458.2 52590.5 52903.0 52941.5 509644.0 613117.6 613854.0 614063.4 615331.0 26036.2 26287.3 27419.0 27434.6 27526.7 41487.6 48073.3 48220.3 48494.5 49540.0 39705.0 40113.0 40390.6 41576.2 42403.8 37780.0 39764.8 40982.8 41210.8 41782.8 38602.4 39048.2 39600.2 39927.0 40381.0 35256.5 35438.0 35643.3 35883.5 36179.5 24358.9 24860.1 26213.7 26215.9 26272.0 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34438.93 Median:2557.76 stddev:97907.59 (3827.9%) stddev-sans-first:98148.84 16:55:37 INFO - PROCESS | 1657 | Values: 373.4 377.2 384.3 388.2 407.3 18710.0 19897.1 21288.9 21534.4 21576.8 11849.5 12146.5 12191.3 12221.7 20671.2 5156.9 5449.1 5458.7 5463.1 5483.3 5184.9 5194.4 5383.6 5421.7 5434.4 4592.3 5284.2 5410.9 5425.7 5459.1 5173.3 5309.8 5338.1 5374.8 5406.3 4001.3 4346.5 4373.3 4513.6 5240.4 11037.0 13275.9 13471.9 13499.2 13585.2 2166.1 2207.2 2224.4 2351.9 2763.6 9522.0 10385.2 10386.4 10566.2 10572.6 1830.6 1871.9 1881.6 1901.0 1905.6 121996.2 126507.0 128921.3 129691.4 131715.7 9392.7 10558.6 11027.9 11626.7 11794.4 14659.3 14659.6 14664.0 14669.6 14672.3 8361.6 8650.6 8713.0 8784.9 8823.1 7045.0 7410.9 8593.6 8779.3 9027.9 4473.4 4552.1 4587.5 4698.3 4718.2 1484.3 1908.8 1945.9 1962.2 1971.6 783.3 857.7 917.7 1022.4 1042.7 20975.8 21851.2 21888.5 21912.0 22030.4 872.7 930.0 942.9 951.1 980.3 10394.8 10532.2 11411.4 11426.1 11464.3 570619.0 577396.0 581483.1 589403.0 597482.0 99290.0 117535.0 125905.0 126321.7 148990.3 935.7 977.0 979.1 984.4 1003.4 19351.1 19574.5 19760.5 19862.3 19986.6 56435.2 56750.7 57924.3 58271.7 59734.0 66373.7 86825.0 87472.0 88384.0 89255.0 7645.8 7909.5 8137.9 8192.4 8275.1 9205.8 10416.6 11348.1 11615.4 12899.5 11085.6 11317.9 11482.6 11599.2 11600.4 8693.3 9030.0 11028.9 11545.6 11720.2 11516.9 11564.5 11564.9 11733.3 11816.3 7160.4 7460.9 7725.7 8022.3 8313.8 10281.1 11086.9 11281.8 11393.9 11531.2 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5722.37 Median:4781.28 stddev:3230.00 (67.6%) stddev-sans-first:3222.97 16:55:37 INFO - PROCESS | 1657 | Values: 1432.0 1524.8 1752.9 1885.7 1914.5 8045.4 8312.3 8474.0 9036.9 9053.6 8432.8 8742.5 8770.6 8886.3 8888.9 2351.8 2375.6 2383.6 2384.9 2392.0 2346.3 2381.2 2383.5 2385.9 2390.4 2373.0 2374.5 2387.1 2389.9 2396.9 2349.4 2359.7 2368.0 2371.6 2371.9 2345.8 2363.1 2365.1 2369.3 2380.4 8912.3 8951.4 8960.7 8962.1 8964.6 5239.7 5341.8 5396.8 5422.7 5438.4 3632.3 3635.8 3665.6 3675.2 3699.1 1068.3 1076.1 1077.1 1091.1 1091.7 11529.0 11651.0 11659.0 11665.1 11667.0 4543.2 4600.3 4794.0 4811.3 4820.6 9803.6 9960.0 10018.1 10024.9 10059.2 5407.9 5413.1 5424.8 5433.3 5444.5 4409.2 4591.5 4768.8 4916.1 4954.9 3180.0 3401.7 3916.6 3995.3 4036.6 1299.7 1314.2 1314.4 1315.7 1325.7 789.6 794.2 849.8 916.7 942.1 4793.7 5788.8 5933.1 6011.3 6138.1 413.5 424.3 436.2 439.6 448.2 3445.8 3619.9 4012.9 4031.0 4056.5 10119.3 10764.7 10788.4 10791.9 10810.3 10428.5 10564.7 10860.9 10884.4 10911.8 8214.2 8243.8 8298.4 8304.1 8346.2 5835.7 5999.7 6012.7 6021.6 6075.1 9485.1 9916.5 9964.0 10074.8 10104.2 10076.6 10176.0 10217.3 10251.5 10256.2 6934.7 6945.2 7424.6 7431.6 7623.5 8312.5 8445.9 8515.0 8523.4 8535.8 7398.3 7476.8 7550.1 7562.4 7623.4 7358.1 7430.1 7443.4 7529.7 7648.7 6974.7 7133.6 7137.9 7142.7 7161.4 4477.1 4951.5 4994.7 5145.4 5161.3 4992.8 5030.4 5067.2 5275.7 5315.3 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4666.63 Median:5118.90 stddev:1462.84 (28.6%) stddev-sans-first:1429.51 16:55:37 INFO - PROCESS | 1657 | Values: 285.2 311.9 318.1 319.1 321.8 4473.0 4993.1 5093.6 5693.3 5723.7 4556.8 5499.9 5543.7 5579.6 5594.0 3405.3 3995.7 4103.9 4166.5 4208.0 3602.8 3981.2 4200.5 4218.0 4248.5 3788.9 4183.6 4184.1 4196.3 4211.5 3402.0 4017.0 4070.8 4158.6 4234.5 3032.8 3392.6 3576.2 3580.5 3620.1 4661.3 5226.4 5365.3 5373.0 5428.6 4409.7 4648.6 4802.8 4850.6 4884.4 4912.9 5127.7 5790.9 5829.8 5831.6 3695.7 3977.0 3995.0 4002.0 4006.6 5081.3 5628.4 5870.9 5873.4 6115.5 3640.7 3817.3 4062.3 4085.2 4112.7 3300.9 3999.4 4095.4 4140.4 4151.7 4238.3 4818.1 4827.4 4846.3 4854.6 4719.7 4924.9 5793.9 5796.0 5837.9 1220.9 1305.7 1391.3 1406.8 1421.3 801.4 875.4 880.7 890.0 890.3 4568.6 5066.5 5417.3 5521.7 5549.5 6082.9 6104.6 6114.7 6115.5 6123.4 5005.0 5297.9 5486.1 5515.5 5610.7 2852.0 2929.9 3171.4 3191.5 3197.8 5957.4 6004.6 6249.8 6263.6 6359.7 5254.8 5556.9 5931.3 6124.3 6135.7 5407.5 6117.5 6225.7 6320.3 6337.6 4057.8 4735.1 5001.2 5276.5 5960.2 4959.2 5190.5 5377.6 6042.5 6058.2 5929.9 6305.5 6322.2 6323.7 6406.6 3916.4 3936.4 3958.6 3965.7 3988.9 4990.8 5110.1 5997.9 6077.9 6115.2 5269.3 5681.5 5913.0 5932.5 6021.0 5737.5 5805.3 5809.0 5853.2 5932.4 4552.7 5317.4 5784.6 5817.2 5822.9 4480.3 4814.9 5151.6 5603.8 5901.7 5762.9 5792.4 5796.7 5818.0 5824.5 16:55:37 INFO - PROCESS | 1657 | 16:55:37 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:22539.35 Median:3756.49 stddev:34953.10 (930.5%) stddev-sans-first:35012.81 16:55:37 INFO - PROCESS | 1657 | Values: 735.0 735.2 747.5 790.9 828.6 15323.5 15930.9 16057.2 16065.0 16107.3 14709.1 14710.3 14759.5 14784.2 14813.9 878.6 891.6 895.1 896.3 897.7 891.4 893.2 896.6 897.2 899.2 936.8 947.2 949.2 950.0 951.7 933.5 941.7 943.1 943.3 943.9 682.2 702.2 702.6 703.3 705.5 13405.3 13491.6 13496.4 13497.7 13527.9 11581.6 11720.7 11832.5 11983.7 12612.5 10303.0 10510.4 10541.6 10686.1 10778.2 3627.5 3709.1 3722.6 3847.2 3884.3 103688.4 104033.0 106623.8 106825.5 106872.5 10783.6 10915.9 11184.2 11208.6 11392.2 21396.3 21695.5 21748.6 21763.8 21794.2 7652.3 7868.2 7882.8 8126.0 8184.1 4457.9 4506.6 4568.5 4592.6 4692.2 3693.8 3747.3 3754.9 3758.1 3769.7 669.6 675.7 684.7 688.5 695.6 539.0 550.9 604.2 676.5 697.1 7722.9 7939.0 8179.0 9570.6 9635.0 522.2 578.0 585.4 609.4 691.6 3801.9 3992.6 4117.8 4587.2 4598.8 67783.0 115796.4 143608.0 150726.0 158636.6 91863.1 101724.5 107269.0 110140.9 133948.0 74536.6 80046.0 84827.2 107078.0 111072.0 7700.3 9439.6 9872.9 9891.9 9905.9 49802.5 57733.7 58711.1 61237.4 62384.8 74859.0 75867.6 80810.0 84750.0 87240.0 12566.3 12789.4 12894.2 13400.3 13579.8 14455.9 14481.5 14567.2 14720.1 15306.0 13478.0 13573.6 13579.9 13797.5 13999.2 13214.0 13629.3 13773.0 13976.0 14237.1 13392.0 13428.1 13525.6 13588.7 13750.6 10068.6 10609.7 10810.5 11193.5 11205.9 10782.2 11067.5 11176.4 11310.4 11368.1 16:55:37 INFO - PROCESS | 1657 | -------- Summary: end -------- 16:55:37 INFO - PROCESS | 1657 | 16:55:38 INFO - TEST-INFO | 1657: exit 0 16:55:38 INFO - TEST-OK | dromaeo_css | took 1116500ms 16:55:38 INFO - TEST-START | kraken 16:55:38 INFO - operating with platform_type : mac_ 16:55:38 INFO - Initialising browser for kraken test... 16:55:38 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp9sQVYG/profile http://localhost:49266/getInfo.html) 16:55:41 INFO - PROCESS | 1666 | 2016-10-14 16:55:41.001 plugin-container[1667:9873] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 16:55:41 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:41 INFO - PROCESS | 1666 | 2016-10-14 16:55:41.004 plugin-container[1667:9873] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 16:55:41 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:41 INFO - PROCESS | 1666 | 2016-10-14 16:55:41.004 plugin-container[1667:9873] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:55:41 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 16:55:41 INFO - PROCESS | 1666 | colorDepth:24 16:55:41 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 16:55:41 INFO - PROCESS | 1666 | __metrics 16:55:41 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:55:41 INFO - TEST-INFO | 1666: exit 0 16:55:41 INFO - Browser initialized. 16:55:41 INFO - Running cycle 1/1 for kraken test... 16:55:41 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp9sQVYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:44 INFO - PROCESS | 1668 | 2016-10-14 16:55:44.228 plugin-container[1669:9989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 16:55:44 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:44 INFO - PROCESS | 1668 | 2016-10-14 16:55:44.229 plugin-container[1669:9989] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 16:55:44 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:55:44 INFO - PROCESS | 1668 | 2016-10-14 16:55:44.230 plugin-container[1669:9989] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:55:53 INFO - PROCESS | 1668 | RSS: Main: 237125632 16:55:53 INFO - PROCESS | 1668 | 16:55:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:57 INFO - PROCESS | 1668 | RSS: Main: 249966592 16:55:57 INFO - PROCESS | 1668 | 16:56:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 16:56:01 INFO - PROCESS | 1668 | RSS: Main: 257572864 16:56:01 INFO - PROCESS | 1668 | 16:56:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 16:56:05 INFO - PROCESS | 1668 | RSS: Main: 260521984 16:56:05 INFO - PROCESS | 1668 | 16:56:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 16:56:07 INFO - PROCESS | 1668 | RSS: Main: 262811648 16:56:07 INFO - PROCESS | 1668 | 16:56:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:56:10 INFO - PROCESS | 1668 | RSS: Main: 263294976 16:56:10 INFO - PROCESS | 1668 | 16:56:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:14 INFO - PROCESS | 1668 | RSS: Main: 264003584 16:56:14 INFO - PROCESS | 1668 | 16:56:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:17 INFO - PROCESS | 1668 | RSS: Main: 264183808 16:56:17 INFO - PROCESS | 1668 | 16:56:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 16:56:21 INFO - PROCESS | 1668 | RSS: Main: 264216576 16:56:21 INFO - PROCESS | 1668 | 16:56:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:23 INFO - PROCESS | 1668 | RSS: Main: 263823360 16:56:23 INFO - PROCESS | 1668 | 16:56:25 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:26 INFO - PROCESS | 1668 | RSS: Main: 263905280 16:56:26 INFO - PROCESS | 1668 | 16:56:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:29 INFO - PROCESS | 1668 | RSS: Main: 263827456 16:56:29 INFO - PROCESS | 1668 | 16:56:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:32 INFO - PROCESS | 1668 | RSS: Main: 264339456 16:56:32 INFO - PROCESS | 1668 | 16:56:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:36 INFO - PROCESS | 1668 | RSS: Main: 263753728 16:56:36 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 16:56:38 INFO - PROCESS | 1668 | RSS: Main: 265326592 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | __start_tp_report 16:56:38 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 16:56:38 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 16:56:38 INFO - PROCESS | 1668 | |i|pagename|runs| 16:56:38 INFO - PROCESS | 1668 | |0;ai-astar;106;117;117;116;115;117;117;116;122;174 16:56:38 INFO - PROCESS | 1668 | |1;audio-beat-detection;149;147;144;190;117;117;117;114;139;104 16:56:38 INFO - PROCESS | 1668 | |2;audio-dft;201;226;198;200;191;183;221;235;200;202 16:56:38 INFO - PROCESS | 1668 | |3;audio-fft;85;59;59;81;51;52;52;73;107;52 16:56:38 INFO - PROCESS | 1668 | |4;audio-oscillator;82;73;83;73;69;71;104;100;102;74 16:56:38 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;88;77;131;135;86;99;116;88;76 16:56:38 INFO - PROCESS | 1668 | |6;imaging-darkroom;98;151;153;99;129;120;99;98;105;170 16:56:38 INFO - PROCESS | 1668 | |7;imaging-desaturate;96;91;98;85;88;91;77;151;136;125 16:56:38 INFO - PROCESS | 1668 | |8;json-parse-financial;56;58;57;57;55;59;62;58;59;56 16:56:38 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;75;68;75;96;56;68;69;69;72;72 16:56:38 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;84;86;114;110;109;87;89;86;91;96 16:56:38 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;159;168;161;165;156;146;142;185;215;143 16:56:38 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;229;221;172;236;171;174;175;163;174;180 16:56:38 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;68;68;72;74;81;79;86;69;70;69 16:56:38 INFO - PROCESS | 1668 | __end_tp_report 16:56:38 INFO - PROCESS | 1668 | __start_cc_report 16:56:38 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,941 16:56:38 INFO - PROCESS | 1668 | __end_cc_report 16:56:38 INFO - PROCESS | 1668 | __startTimestamp1476489398548__endTimestamp 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | ------- Summary: start ------- 16:56:38 INFO - PROCESS | 1668 | Number of tests: 14 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:121.70 Median:117.00 stddev:18.80 (16.1%) stddev-sans-first:19.06 16:56:38 INFO - PROCESS | 1668 | Values: 106.0 117.0 117.0 116.0 115.0 117.0 117.0 116.0 122.0 174.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:141.50 stddev:25.43 (18.0%) stddev-sans-first:26.37 16:56:38 INFO - PROCESS | 1668 | Values: 149.0 147.0 144.0 190.0 117.0 117.0 117.0 114.0 139.0 104.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:205.70 Median:201.50 stddev:16.32 (8.1%) stddev-sans-first:17.22 16:56:38 INFO - PROCESS | 1668 | Values: 201.0 226.0 198.0 200.0 191.0 183.0 221.0 235.0 200.0 202.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:67.10 Median:59.00 stddev:18.90 (32.0%) stddev-sans-first:18.90 16:56:38 INFO - PROCESS | 1668 | Values: 85.0 59.0 59.0 81.0 51.0 52.0 52.0 73.0 107.0 52.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:73.00 stddev:13.80 (18.9%) stddev-sans-first:14.63 16:56:38 INFO - PROCESS | 1668 | Values: 82.0 73.0 83.0 73.0 69.0 71.0 104.0 100.0 102.0 74.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:87.00 stddev:21.42 (24.6%) stddev-sans-first:22.44 16:56:38 INFO - PROCESS | 1668 | Values: 89.0 88.0 77.0 131.0 135.0 86.0 99.0 116.0 88.0 76.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:122.20 Median:134.00 stddev:27.20 (20.3%) stddev-sans-first:27.40 16:56:38 INFO - PROCESS | 1668 | Values: 98.0 151.0 153.0 99.0 129.0 120.0 99.0 98.0 105.0 170.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:89.50 stddev:24.63 (27.5%) stddev-sans-first:25.96 16:56:38 INFO - PROCESS | 1668 | Values: 96.0 91.0 98.0 85.0 88.0 91.0 77.0 151.0 136.0 125.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:2.00 (3.5%) stddev-sans-first:2.03 16:56:38 INFO - PROCESS | 1668 | Values: 56.0 58.0 57.0 57.0 55.0 59.0 62.0 58.0 59.0 56.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.00 stddev:10.00 (13.9%) stddev-sans-first:10.55 16:56:38 INFO - PROCESS | 1668 | Values: 75.0 68.0 75.0 96.0 56.0 68.0 69.0 69.0 72.0 72.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:95.20 Median:86.50 stddev:11.46 (13.2%) stddev-sans-first:11.41 16:56:38 INFO - PROCESS | 1668 | Values: 84.0 86.0 114.0 110.0 109.0 87.0 89.0 86.0 91.0 96.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:164.00 Median:163.00 stddev:22.13 (13.6%) stddev-sans-first:23.39 16:56:38 INFO - PROCESS | 1668 | Values: 159.0 168.0 161.0 165.0 156.0 146.0 142.0 185.0 215.0 143.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:177.50 stddev:27.58 (15.5%) stddev-sans-first:25.28 16:56:38 INFO - PROCESS | 1668 | Values: 229.0 221.0 172.0 236.0 171.0 174.0 175.0 163.0 174.0 180.0 16:56:38 INFO - PROCESS | 1668 | 16:56:38 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.00 stddev:6.31 (8.6%) stddev-sans-first:6.36 16:56:38 INFO - PROCESS | 1668 | Values: 68.0 68.0 72.0 74.0 81.0 79.0 86.0 69.0 70.0 69.0 16:56:38 INFO - PROCESS | 1668 | -------- Summary: end -------- 16:56:38 INFO - PROCESS | 1668 | 16:56:39 INFO - TEST-INFO | 1668: exit 0 16:56:39 INFO - TEST-OK | kraken | took 61110ms 16:56:39 INFO - SUITE-END | took 1177s 16:56:39 INFO - Completed test suite (00:19:37) 16:56:39 INFO - javascript benchmark 16:56:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7296.078526956345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.5240687693404, 3380.814055226963, 3414.5219669246326, 3436.2096717754926, 3442.8106454145027, 5652.886942261152, 5719.799807006751, 5765.884682306357, 5794.82615521534, 5833.591648584601, 5675.2054712340305, 5708.628939118955, 5818.3308919474275, 5831.212786273852, 5833.504152147062, 5187.533122019017, 5246.5278124968745, 5264.973675131619, 5301.3373328333955, 5301.443348448415, 5238.973805130988, 5334.866628334304, 5361.0, 5381.0852155133725, 5396.757145928423, 3871.825767840454, 5239.266502689627, 5352.304200453936, 5377.274068000809, 5425.864353391157, 3973.821178046966, 5171.534561889411, 5191.143461328877, 5193.506616871391, 5251.737413129328, 5132.743362831843, 5156.381234251914, 5158.690478571298, 5165.483451654804, 5226.294450249244, 4083.2445997490263, 5733.111367738007, 5821.27234095738, 5854.795082172103, 5860.794872179454, 6182.69086545671, 6192.752289908398, 6221.595596286227, 6251.031090181029, 6251.906221406683, 6216.658083805389, 6223.222097237845, 6224.968875155595, 6255.781047663356, 6279.309275979638, 5744.253247077853, 5896.1450589664255, 5901.557383196277, 5923.870062819939, 5966.0454327307425, 6200.906986395207, 6274.498040156868, 6321.241451025906, 6326.6520341381665, 6401.135846660734, 6105.145279660851, 6172.629642221481, 6173.351798061229, 6174.536909731788, 6194.4115309045565, 6223.502119830493, 6272.937270627326, 6280.560360774702, 6282.528810339243, 6282.780102696383, 6091.786787462417, 6122.326544080148, 6141.30190404341, 6144.8185894007875, 6220.782272620437, 6151.6001459904965, 6212.378762123842, 6254.843628909313, 6257.5932564383165, 6266.49868010558, 4986.426560945465, 4995.575376093073, 4998.925016124761, 5010.949890501121, 5013.649044566918, 4384.4081049058605, 4391.3193455014525, 4421.911561768747, 4462.219111655448, 4514.187446259705, 5043.739065233692, 5919.289685237713, 5921.023031199804, 5980.132880732356, 6051.788187413419, 6211.819754246679, 6229.626222426578, 6230.408111229426, 6252.906206406908, 6270.717817698214, 5656.943430565724, 5948.226730525004, 5989.221401217901, 5990.101484777319, 6068.696565171724, 5371.57027437804, 5437.510624043855, 5442.809501667422, 5447.645903016291, 5461.2354270402175, 6230.813075607739, 6258.499320054476, 6267.874642507216, 6284.717187726472, 6327.17746692927, 5122.795088196431, 5676.318841739017, 6167.599106058092, 6231.75072997075, 6244.906326405198, 5197.7141257231215, 5208.557272631869, 6397.26431460388, 6420.646864422315, 6430.3891130342545, 6042.1540984261355, 6092.45167934888, 6119.472088496418, 6125.0218003337495, 6229.688515574113, 5163.793448262028, 6117.5838231413945, 6166.4758495526585, 6200.503959683305, 6238.812835614939, 4367.781610919505, 4529.705569137996, 4973.651844370859, 6161.383861613803, 6168.845778855385, 5119.334486516729, 6017.819465416044, 6082.90875636857, 6144.38556144382, 6162.414570615784, 5152.536271735562, 5193.37679478465, 5893.02765043763, 6078.0, 6129.724162412613, 6086.7260973255425, 6094.268687757498, 6142.437386315837, 6145.217886812774, 6207.255129384503, 5128.7179205144075, 5890.793822216202, 5930.584859059824, 6002.69986500682, 6015.248093988252], "value": 5637.291664306233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.35875670952464, 472.70455965021864, 504.4627471742594, 504.57867680486794, 529.3039652856492, 38969.80515097424, 41340.99999999993, 41365.58634413659, 41395.379069313945, 41411.37882931758, 35283.0, 43231.0, 43431.56568434315, 43487.565124348745, 43707.3443898341, 9489.0, 9620.27847911406, 9656.71029869105, 9676.419414835098, 9692.46691431971, 9604.2316614671, 9667.806643867118, 9706.514674266295, 9708.17480514157, 9735.318527703064, 9624.663136790214, 9638.084381983736, 9666.081722236377, 9691.515424228795, 9691.854622180674, 8627.827443451128, 9600.1359877611, 9650.613975440974, 9701.854472182922, 9707.495338222587, 9568.808623827554, 9608.375455595364, 9642.662506812228, 9649.228061755042, 9658.32391732579, 40265.396019059444, 41144.0, 41146.38280425796, 41196.0, 41332.0, 3328.8834890778708, 3398.712382093133, 3536.6286539913453, 3888.844446222148, 3920.882373528799, 31174.688253117405, 31473.527897081563, 31852.522212166838, 31910.042698718844, 32753.836230818695, 3211.630662473822, 3229.321842413096, 3240.935181296361, 3293.6047674279002, 3345.46472564391, 427724.0, 485522.0, 489572.10427895264, 490311.0, 493465.0, 61769.382306177264, 62002.0, 62048.75902481925, 62221.06668399978, 62248.37751622426, 57254.7137264311, 61206.38793612096, 65082.67458662677, 65530.672346638916, 65673.34326656768, 16414.67170656604, 16430.83569164317, 16590.17049147538, 16595.585110372096, 16644.3342266308, 12750.48998040068, 12879.034072444605, 12892.80660790089, 12892.968562514976, 12897.677558061123, 17517.036562989157, 17541.736873946647, 17679.20443580042, 17713.0, 17793.110344482724, 6384.138141350951, 6392.721455708876, 6465.573246179532, 6536.627308265222, 6554.311797261219, 877.455977294069, 966.7051549277538, 1055.678018204455, 1091.9181061420425, 1099.6755956992547, 30808.537871931938, 31159.376812464077, 31294.687053129634, 31551.684483155335, 31752.682473174973, 993.3791380387258, 1019.7348689340824, 1077.9514921828536, 1104.2932523185168, 1159.0090472645934, 15517.689646207238, 16088.11515366666, 16117.435889743803, 16389.180540972902, 16514.174291285388, 663125.0, 664466.0, 672205.0, 672331.0, 673215.0, 58722.70638646865, 59330.703346482995, 59670.40329596735, 59878.70060649756, 59918.0, 1346.4008516210388, 1381.5855243426931, 1399.3423091147145, 1402.5792262321263, 1409.0, 22874.65688014648, 29062.982795602053, 29610.555841662823, 30569.17885264342, 30637.387252255277, 44787.55212447964, 52458.213126803894, 52590.474095258556, 52903.0, 52941.47058529365, 509644.0, 613117.6226496332, 613854.0, 614063.4293854426, 615331.0, 26036.21891343263, 26287.342816429744, 27419.0, 27434.5884811724, 27526.724732752416, 41487.58512414958, 48073.27890081722, 48220.27669584889, 48494.51505485041, 49540.00919981508, 39705.0, 40112.98587676541, 40390.59609403986, 41576.16847662969, 42403.7879810599, 37780.0, 39764.80117599509, 40982.79508602557, 41210.78811208087, 41782.79108604559, 38602.42096368501, 39048.219035619695, 39600.2079958405, 39927.0, 40380.99047523835, 35256.471152932216, 35438.0, 35643.28713425769, 35883.46174807328, 36179.45730813987, 24358.87820560886, 24860.12989545357, 26213.737862621892, 26215.868920655274, 26272.0], "value": 20191.21029339861, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.382052702777, 377.217274156126, 384.267969518068, 388.1964333828975, 407.30147796528945, 18710.0, 19897.104630291637, 21288.935553222334, 21534.353969380925, 21576.784232157675, 11849.526018959254, 12146.514139434434, 12191.329476878767, 12221.694457638563, 20671.173153073898, 5156.948430515703, 5449.128139497681, 5458.699771512565, 5463.071277882769, 5483.287172667548, 5184.922226166611, 5194.35070616173, 5383.623146379755, 5421.674699518022, 5434.375046869602, 4592.288195329713, 5284.233786101013, 5410.91883621744, 5425.7287135643255, 5459.12653975364, 5173.327467429248, 5309.761060752276, 5338.065838478289, 5374.7850085996515, 5406.270153529283, 4001.3197756381487, 4346.478422589278, 4373.322135069069, 4513.616342610882, 5240.371155461369, 11037.0, 13275.933620331933, 13471.865281347256, 13499.190048597018, 13585.184888906697, 2166.1335465813645, 2207.249535158038, 2224.399412158708, 2351.917682881091, 2763.5992781046634, 9521.952390238073, 10385.169186465064, 10386.376817390981, 10566.154707623371, 10572.577096916115, 1830.588117673526, 1871.9157637906326, 1881.5578339090303, 1900.9524761880925, 1905.6093500832296, 121996.1700574501, 126507.0, 128921.26472411686, 129691.35154324168, 131715.6828431713, 9392.671256506126, 10558.63044793444, 11027.889721102687, 11626.651200463999, 11794.351310677823, 14659.34032968519, 14659.560213193621, 14664.0, 14669.633259168393, 14672.266386680623, 8361.581920903931, 8650.567471626393, 8713.041565427799, 8784.91215087841, 8823.117688231254, 7045.0, 7410.925890741131, 8593.570321483901, 8779.253763430052, 9027.864582031274, 4473.3960915276675, 4552.112338094106, 4587.472440669299, 4698.342232087511, 4718.197906355927, 1484.346887369554, 1908.80911908808, 1945.9178678813817, 1962.1660794162424, 1971.6155349706955, 783.2832957843623, 857.691231156783, 917.6971599372191, 1022.4478781458079, 1042.6871938418444, 20975.790242097384, 21851.235206767687, 21888.45278868041, 21912.013959371547, 22030.44923876916, 872.6596627315225, 929.9628014879464, 942.8821397325335, 951.0584521323977, 980.3039841712464, 10394.844077338847, 10532.15742740579, 11411.42942852854, 11426.08591312693, 11464.31214127155, 570619.0, 577396.0, 581483.0925845428, 589403.0, 597482.0, 99290.0, 117535.0, 125905.0, 126321.736782631, 148990.2752431198, 935.6631612619451, 976.951152442375, 979.1236843025453, 984.3847595252967, 1003.357850975391, 19351.12919918635, 19574.510637233612, 19760.505987350432, 19862.304819331253, 19986.60026799427, 56435.15347269877, 56750.7162464185, 57924.2510570664, 58271.70864145652, 59734.0, 66373.66813165903, 86825.0, 87472.0, 88384.0, 89255.0, 7645.770626881203, 7909.485883417559, 8137.918620813953, 8192.426530142833, 8275.089740128702, 9205.815883682155, 10416.583336666448, 11348.148888833206, 11615.361155136548, 12899.484020639446, 11085.556577736801, 11317.886821131684, 11482.598109066143, 11599.246049006788, 11600.419979000848, 8693.261072808882, 9030.0, 11028.944855275673, 11545.595904143314, 11720.238184517979, 11516.905893940397, 11564.537418503165, 11564.94217528907, 11733.296002239893, 11816.277872470144, 7160.427165826617, 7460.850782984418, 7725.729599463992, 8022.27799498048, 8313.792155196168, 10281.12610428122, 11086.944565277123, 11281.7743645125, 11393.886061139283, 11531.192816502764], "value": 9160.333506558161, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.0, 1524.7560390337544, 1752.9044347282947, 1885.7454243677116, 1914.5022294203511, 8045.39659525535, 8312.335013198945, 8474.02548706899, 9036.909630903689, 9053.592588333524, 8432.83134337313, 8742.519161446118, 8770.649174033048, 8886.333524985635, 8888.866666999984, 2351.7883390494853, 2375.596148654733, 2383.6067048936907, 2384.8807559622037, 2391.9594976185417, 2346.2609278077434, 2381.154690085012, 2383.535210633927, 2385.8926348314367, 2390.3904504351367, 2372.988135059331, 2374.4776149247223, 2387.1167667962877, 2389.880505974703, 2396.9161079362225, 2349.436135327509, 2359.681443005198, 2367.9644805327935, 2371.5968285391436, 2371.92884213473, 2345.835791494596, 2363.1492662641435, 2365.136725095345, 2369.253685089209, 2380.416797884512, 8912.287017038621, 8951.41815781972, 8960.731178064669, 8962.148595883446, 8964.59659315326, 5239.711815850127, 5341.813036543703, 5396.83809485716, 5422.728863556846, 5438.428964958662, 3632.328019316435, 3635.7818530887967, 3665.5784584772828, 3675.1730860556427, 3699.075231192202, 1068.3002633275216, 1076.1337123615485, 1077.1329080090525, 1091.1161958813307, 1091.7379828841101, 11529.0, 11651.0, 11659.00898423635, 11665.125115616278, 11667.0, 4543.227651299287, 4600.3099535070005, 4794.0, 4811.254255590319, 4820.566149046603, 9803.558839852223, 9960.0, 10018.148457381058, 10024.899751002542, 10059.245556583139, 5407.918881216785, 5413.079776438015, 5424.783008679688, 5433.320834895638, 5444.537214336826, 4409.228385032607, 4591.494935557086, 4768.833090841804, 4916.06594746997, 4954.851354459372, 3179.998300535324, 3401.6768407001296, 3916.6083391660604, 3995.34076877312, 4036.59634036594, 1299.7465494228725, 1314.2180402660401, 1314.3559655768604, 1315.658028810608, 1325.7481078595035, 789.6091434739841, 794.2494342846071, 849.8172892828071, 916.6929078758557, 942.1426501883391, 4793.736344501086, 5788.7684492620665, 5933.050711886164, 6011.27864656244, 6138.1099740537375, 413.4893406642794, 424.3486248608371, 436.21045906908597, 439.5845925600277, 448.19325214613565, 3445.776749254029, 3619.873304434332, 4012.9197416051516, 4031.0, 4056.499095334745, 10119.342242754197, 10764.654418197726, 10788.406637635006, 10791.892081079088, 10810.29733067348, 10428.530716117793, 10564.735881603021, 10860.945695271474, 10884.40135792539, 10911.781764364827, 8214.178582141858, 8243.752687419386, 8298.377621678399, 8304.128066552925, 8346.20711032463, 5835.7373918174635, 5999.70001499932, 6012.6993650316435, 6021.608595441282, 6075.149479073022, 9485.146336829719, 9916.454594997056, 9964.0, 10074.848877266993, 10104.191664666956, 10076.596936122472, 10176.0, 10217.33587316822, 10251.48742562854, 10256.179505639382, 6934.7226110955, 6945.236024037453, 7424.554526728413, 7431.628418578941, 7623.4663573549315, 8312.501249925024, 8445.915540844513, 8515.02077261123, 8523.445976011539, 8535.786605334917, 7398.3341499265325, 7476.775696729107, 7550.056242969629, 7562.357199637872, 7623.390128789572, 7358.080239970004, 7430.071241094864, 7443.44174186949, 7529.661165247687, 7648.655810488653, 6974.68613912365, 7133.643317833984, 7137.928620713934, 7142.714291428285, 7161.4270858330165, 4477.126960242721, 4951.529604687549, 4994.650374473752, 5145.434002259673, 5161.251618515369, 4992.775325110451, 5030.421501527371, 5067.189249720027, 5275.683458992473, 5315.335583052119], "value": 4514.170081677529, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.2483705436175, 311.9017509484512, 318.1251558214909, 319.068320504128, 321.7747576696312, 4472.955270447294, 4993.101241776479, 5093.617978651602, 5693.316801983758, 5723.7407770290465, 4556.794944227509, 5499.890002199953, 5543.699364763628, 5579.581531385153, 5594.0, 3405.3019131078067, 3995.740276882008, 4103.938440923389, 4166.541680415167, 4208.0, 3602.765820221677, 3981.223661386031, 4200.537940826506, 4218.0262914645255, 4248.511421186572, 3788.9012186465893, 4183.602557757008, 4184.075325350343, 4196.349565817303, 4211.452511173558, 3402.0, 4016.9555915462192, 4070.75575465473, 4158.6465150462245, 4234.534201237861, 3032.8331941743195, 3392.6268110507826, 3576.159602493412, 3580.5166302549083, 3620.1356301504748, 4661.254199328125, 5226.425093239741, 5365.275687782138, 5373.0, 5428.592855535811, 4409.677096870958, 4648.628109751212, 4802.783874725646, 4850.611951043943, 4884.389451318585, 4912.919157785317, 5127.66670166438, 5790.930806672471, 5829.775747093116, 5831.562632802515, 3695.7228207884245, 3977.0455090778296, 3994.980025099885, 4001.9599804001878, 4006.59934006597, 5081.28861959326, 5628.409017053192, 5870.853228669274, 5873.383294754075, 6115.510759139258, 3640.672339489459, 3817.3319669057805, 4062.3297155968935, 4085.2442298174933, 4112.732672376286, 3300.9174770630925, 3999.4002399040614, 4095.4061661059577, 4140.37894315855, 4151.6886233532605, 4238.279492486285, 4818.10864989978, 4827.42070951488, 4846.321514987904, 4854.587360074363, 4719.702081927498, 4924.852254432372, 5793.899159159831, 5796.0, 5837.8908007479295, 1220.8767933501022, 1305.7138718362405, 1391.3425357566998, 1406.796014577901, 1421.2680469558186, 801.410962942237, 875.387228939732, 880.7269746378643, 889.9809717873, 890.3366991591306, 4568.6116680081905, 5066.46802085783, 5417.320630604447, 5521.668699878021, 5549.528290095306, 6082.878342433127, 6104.572679912363, 6114.694265286718, 6115.510759139258, 6123.4488895999575, 5005.0, 5297.913927644823, 5486.1222204447095, 5515.503604675599, 5610.747516361774, 2851.960847993653, 2929.853507324668, 3171.3815805918084, 3191.5372271021038, 3197.8081315121167, 5957.374475680078, 6004.579679422399, 6249.75000999964, 6263.617646470946, 6359.745610175633, 5254.789808407697, 5556.888862222733, 5931.3178984417345, 6124.29480164503, 6135.693215339215, 5407.486288802557, 6117.461253579714, 6225.688715564203, 6320.304766475684, 6337.556371054075, 4057.756534607933, 4735.076660051394, 5001.174336499866, 5276.472352764847, 5960.225170727777, 4959.231319145538, 5190.48095190493, 5377.596680249075, 6042.516598672008, 6058.182145410489, 5929.851753706192, 6305.468937395073, 6322.166571694157, 6323.73148125023, 6406.615603063831, 3916.432117343026, 3936.389859571771, 3958.584348643351, 3965.682745380305, 3988.940165897572, 4990.8003679853855, 5110.13832253939, 5997.860406522746, 6077.908831367621, 6115.196017175033, 5269.262303277621, 5681.460261275172, 5913.02435098204, 5932.525397968238, 6020.969895150496, 5737.483626473638, 5805.274340707411, 5809.0, 5853.166176154626, 5932.377100404568, 4552.7495987720995, 5317.388500322512, 5784.595078344475, 5817.243758311562, 5822.912656310244, 4480.260756975063, 4814.903701925872, 5151.6393852431465, 5603.831885043455, 5901.704914754159, 5762.913556296575, 5792.437650844616, 5796.652200867961, 5817.970910145422, 5824.5340372770925], "value": 4199.4666270671, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.9595772232527, 735.1766022055295, 747.4842358772447, 790.9485883417577, 828.6064119543222, 15323.540293791177, 15930.920345398286, 16057.19714014299, 16065.036097834138, 16107.275172617232, 14709.11745295283, 14710.338034788434, 14759.48341808037, 14784.186869722162, 14813.851861481382, 878.5782824244351, 891.6076926152505, 895.1361935732017, 896.332232486795, 897.6768363389175, 891.3582220801013, 893.2005854759985, 896.6278994217392, 897.2149369301861, 899.204204279211, 936.8266870628921, 947.1759569174827, 949.1599934058373, 949.9620015199419, 951.6621599332241, 933.5145724223365, 941.6986564299427, 943.1370296178987, 943.2595412601075, 943.9144983269262, 682.2427105912433, 702.1609177033447, 702.6346299924062, 703.3002162847948, 705.5167210460851, 13405.262710550916, 13491.595252142451, 13496.39266233022, 13497.662558436117, 13527.864721352857, 11581.594644187497, 11720.706982325424, 11832.467538960767, 11983.700407489796, 12612.495500179983, 10303.042322795582, 10510.421926794023, 10541.631042913461, 10686.091682207021, 10778.191635627281, 3627.546556680415, 3709.1098136447326, 3722.641235948859, 3847.2497862916744, 3884.3008258513455, 103688.4077898051, 104033.0, 106623.80128596077, 106825.46587267015, 106872.46563767131, 10783.6225732099, 10915.890841091488, 11184.217104802585, 11208.551657933755, 11392.20254582188, 21396.251131210334, 21695.45761355979, 21748.565028699337, 21763.782362176175, 21794.237201697866, 7652.273034061755, 7868.173841746649, 7882.842343153105, 8125.992720464874, 8184.0948355264845, 4457.888552786141, 4506.59440650343, 4568.451785785727, 4592.609628181642, 4692.249240121632, 3693.759905606127, 3747.3442147624055, 3754.887353379403, 3758.0980564664283, 3769.660730534265, 669.5982410553629, 675.7229535890261, 684.650828077684, 688.4526801192964, 695.5722230828004, 538.9919151212735, 550.9035918714209, 604.1753007145215, 676.470879115442, 697.1042210759251, 7722.92277077222, 7938.960305198437, 8179.018517777786, 9570.56932438042, 9634.951825240829, 522.2192821731536, 578.0491092153384, 585.4488276189427, 609.3540846702509, 691.5656887755074, 3801.904952376213, 3992.5807790182193, 4117.75293482392, 4587.243104887656, 4598.816047358135, 67782.98325525022, 115796.42101789438, 143608.0, 150726.0, 158636.62045069333, 91863.0813691868, 101724.49137754412, 107269.0, 110140.89859101467, 133948.0, 74536.62731686415, 80046.0, 84827.15172848193, 107078.0, 111072.0, 7700.28312796574, 9439.575219115019, 9872.901270987199, 9891.851622225817, 9905.900940990787, 49802.501974981235, 57733.711331443075, 58711.11933321089, 61237.38762612317, 62384.752304954556, 74859.0, 75867.62066189633, 80810.0, 84750.0, 87240.0, 12566.308853013172, 12789.424475898793, 12894.161879477804, 13400.262985535888, 13579.796303055264, 14455.927720361331, 14481.493147739779, 14567.198804065878, 14720.116792992454, 15306.0, 13478.0, 13573.59279221625, 13579.932100339434, 13797.51708690191, 13999.16005039701, 13214.0, 13629.250391228577, 13773.0, 13976.0, 14237.074590151607, 13392.0, 13428.127171733806, 13525.59423217305, 13588.728225435634, 13750.587482375544, 10068.590397344524, 10609.681709548726, 10810.541324744954, 11193.474055672437, 11205.943970280096, 10782.191335650015, 11067.501962411872, 11176.441177940907, 11310.377929213972, 11368.147388945697], "value": 7630.894789755917, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 116.0, 115.0, 117.0, 117.0, 116.0, 122.0, 174.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 144.0, 190.0, 117.0, 117.0, 117.0, 114.0, 139.0, 104.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 226.0, 198.0, 200.0, 191.0, 183.0, 221.0, 235.0, 200.0, 202.0], "value": 205.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 59.0, 81.0, 51.0, 52.0, 52.0, 73.0, 107.0, 52.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 83.0, 73.0, 69.0, 71.0, 104.0, 100.0, 102.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 77.0, 131.0, 135.0, 86.0, 99.0, 116.0, 88.0, 76.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 151.0, 153.0, 99.0, 129.0, 120.0, 99.0, 98.0, 105.0, 170.0], "value": 122.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 91.0, 98.0, 85.0, 88.0, 91.0, 77.0, 151.0, 136.0, 125.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 57.0, 55.0, 59.0, 62.0, 58.0, 59.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 75.0, 96.0, 56.0, 68.0, 69.0, 69.0, 72.0, 72.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 110.0, 109.0, 87.0, 89.0, 86.0, 91.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 168.0, 161.0, 165.0, 156.0, 146.0, 142.0, 185.0, 215.0, 143.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 221.0, 172.0, 236.0, 171.0, 174.0, 175.0, 163.0, 174.0, 180.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 72.0, 74.0, 81.0, 79.0, 86.0, 69.0, 70.0, 69.0], "value": 73.6, "unit": "score"}]}]} 16:56:39 INFO - Return code: 0 16:56:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:56:39 ERROR - # TBPL SUCCESS # 16:56:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:56:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:56:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:56:39 INFO - 2016-10-14 16:56:39.903 screenresolution[1673:10374] starting screenresolution argv=screenresolution get 16:56:39 INFO - 2016-10-14 16:56:39.906 screenresolution[1673:10374] Display 0: 1600x1200x32@60 16:56:39 INFO - 2016-10-14 16:56:39.912 screenresolution[1674:10377] starting screenresolution argv=screenresolution list 16:56:39 INFO - Available Modes on Display 0 16:56:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:56:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:56:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:56:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:56:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:56:40 INFO - Intel Iris: 16:56:40 INFO - Chipset Model: Intel Iris 16:56:40 INFO - Type: GPU 16:56:40 INFO - Bus: Built-In 16:56:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:56:40 INFO - Vendor: Intel (0x8086) 16:56:40 INFO - Device ID: 0x0a2e 16:56:40 INFO - Revision ID: 0x0009 16:56:40 INFO - Displays: 16:56:40 INFO - Display: 16:56:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:56:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:56:40 INFO - Display Serial Number: 1600x1200 60 16:56:40 INFO - Main Display: Yes 16:56:40 INFO - Mirror: Off 16:56:40 INFO - Online: Yes 16:56:40 INFO - Rotation: Supported 16:56:40 INFO - Return code: 0 16:56:40 INFO - Running post-action listener: _resource_record_post_action 16:56:40 INFO - [mozharness: 2016-10-14 23:56:40.149879Z] Finished run-tests step (success) 16:56:40 INFO - Running post-run listener: _resource_record_post_run 16:56:40 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 39336448; Write bytes: 712080896; Read time: 387; Write time: 2104 16:56:40 INFO - TinderboxPrint: CPU usage
54.4% 16:56:40 INFO - TinderboxPrint: I/O read bytes / time
39,336,448 / 387 16:56:40 INFO - TinderboxPrint: I/O write bytes / time
712,080,896 / 2,104 16:56:40 INFO - TinderboxPrint: CPU idle
2,214.8 (45.6%) 16:56:40 INFO - TinderboxPrint: CPU system
979.2 (20.2%) 16:56:40 INFO - TinderboxPrint: CPU user
1,659.7 (34.2%) 16:56:40 INFO - TinderboxPrint: Swap in / out
447,782,912 / 0 16:56:40 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 406587904; Write bytes: 395024384; Read time: 31471; Write time: 738 16:56:40 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 32064000; Write bytes: 297610752; Read time: 298; Write time: 1316 16:56:40 INFO - Running post-run listener: _upload_blobber_files 16:56:40 INFO - Blob upload gear active. 16:56:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:56:40 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 16:56:40 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'] 16:56:40 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 16:56:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:41 INFO - (blobuploader) - INFO - Done attempting. 16:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:42 INFO - (blobuploader) - INFO - Done attempting. 16:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:44 INFO - (blobuploader) - INFO - Done attempting. 16:56:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:56:44 INFO - Return code: 0 16:56:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:56:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:56:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7cec4175a040001d218982a26de7045915065e9862468e0e65100f461b93a548e14508d50990b7c98b1a79c400af1acab0657ca97e1e480a43d59723da129bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada4eddff3f6e5d1744dc91eabdd8cb26174ee2c04139bc4091ce784b02986b55bdb029c7156d49d0da9371f1dd30440bdca047083f6d1d9bd261c4fc4fe5032", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4d2eff2ad6df80bf88e4578a1640038081faef425e2a0f81dca108cc5df8a06202e2801ad7104db094baf8291e1fff182c5652c635b30b11f6943e25423ee6"} 16:56:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:56:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:56:44 INFO - Contents: 16:56:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7cec4175a040001d218982a26de7045915065e9862468e0e65100f461b93a548e14508d50990b7c98b1a79c400af1acab0657ca97e1e480a43d59723da129bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada4eddff3f6e5d1744dc91eabdd8cb26174ee2c04139bc4091ce784b02986b55bdb029c7156d49d0da9371f1dd30440bdca047083f6d1d9bd261c4fc4fe5032", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4d2eff2ad6df80bf88e4578a1640038081faef425e2a0f81dca108cc5df8a06202e2801ad7104db094baf8291e1fff182c5652c635b30b11f6943e25423ee6"} 16:56:44 INFO - Running post-run listener: copy_logs_to_upload_dir 16:56:44 INFO - Copying logs to upload dir... 16:56:44 INFO - mkdir: /builds/slave/test/build/upload/logs 16:56:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.485831 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-14 16:56:44.835656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.839273) ========= 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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/e7cec4175a040001d218982a26de7045915065e9862468e0e65100f461b93a548e14508d50990b7c98b1a79c400af1acab0657ca97e1e480a43d59723da129bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada4eddff3f6e5d1744dc91eabdd8cb26174ee2c04139bc4091ce784b02986b55bdb029c7156d49d0da9371f1dd30440bdca047083f6d1d9bd261c4fc4fe5032", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4d2eff2ad6df80bf88e4578a1640038081faef425e2a0f81dca108cc5df8a06202e2801ad7104db094baf8291e1fff182c5652c635b30b11f6943e25423ee6"} build_url:https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010723 build_url: 'https://queue.taskcluster.net/v1/task/Fg52O9enS-OvY-KCIkQudQ/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/e7cec4175a040001d218982a26de7045915065e9862468e0e65100f461b93a548e14508d50990b7c98b1a79c400af1acab0657ca97e1e480a43d59723da129bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada4eddff3f6e5d1744dc91eabdd8cb26174ee2c04139bc4091ce784b02986b55bdb029c7156d49d0da9371f1dd30440bdca047083f6d1d9bd261c4fc4fe5032", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4d2eff2ad6df80bf88e4578a1640038081faef425e2a0f81dca108cc5df8a06202e2801ad7104db094baf8291e1fff182c5652c635b30b11f6943e25423ee6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.870958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.871284) ========= 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.N2J71uWbGN/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.sk1oQG9ZZf/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.920027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:56:44.920364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:56:44.920726) ========= ========= Total master_lag: 0.17 =========