builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0319 starttime: 1487158355.14 results: success (0) buildid: 20170215020746 builduid: 01c1d107135547169fd5f3c00456afde revision: 0a7831d838f793a263456df62f95a615472a7f95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.137664) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.138070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.138336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.163051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.163311) ========= 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.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 03:32:35-- 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% 147M=0s 2017-02-15 03:32:35 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.359876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.360182) ========= 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.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.020061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:35.408437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 03:32:35.408793) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a7831d838f793a263456df62f95a615472a7f95 --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 0a7831d838f793a263456df62f95a615472a7f95 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 03:32:35,481 truncating revision to first 12 chars 2017-02-15 03:32:35,482 Setting DEBUG logging. 2017-02-15 03:32:35,482 attempt 1/10 2017-02-15 03:32:35,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a7831d838f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 03:32:36,971 unpacking tar archive at: mozilla-central-0a7831d838f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.738818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 03:32:37.171133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:37.171446) ========= script_repo_revision: 0a7831d838f793a263456df62f95a615472a7f95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:37.171843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:37.172101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:32:37.191480) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-02-15 03:32:37.191778) ========= /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.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:32:37 INFO - MultiFileLogger online at 20170215 03:32:37 in /builds/slave/test 03:32:37 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 03:32:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:37 INFO - {'append_to_log': False, 03:32:37 INFO - 'base_work_dir': '/builds/slave/test', 03:32:37 INFO - 'blob_upload_branch': 'Firefox', 03:32:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:37 INFO - 'branch': 'Firefox', 03:32:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:37 INFO - 'config_files': ('talos/mac_config.py',), 03:32:37 INFO - 'default_actions': ('clobber', 03:32:37 INFO - 'read-buildbot-config', 03:32:37 INFO - 'download-and-extract', 03:32:37 INFO - 'populate-webroot', 03:32:37 INFO - 'create-virtualenv', 03:32:37 INFO - 'install', 03:32:37 INFO - 'run-tests'), 03:32:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:37 INFO - 'download_minidump_stackwalk': True, 03:32:37 INFO - 'download_symbols': 'ondemand', 03:32:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:37 INFO - 'installer_path': 'installer.exe', 03:32:37 INFO - 'log_level': 'info', 03:32:37 INFO - 'log_name': 'talos', 03:32:37 INFO - 'log_to_console': True, 03:32:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:32:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:32:37 INFO - 'opt_config_files': (), 03:32:37 INFO - 'pip_index': False, 03:32:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:32:37 INFO - 'cmd': ('bash', 03:32:37 INFO - '-c', 03:32:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:32:37 INFO - 'enabled': True, 03:32:37 INFO - 'halt_on_failure': False, 03:32:37 INFO - 'name': 'check_screen_resolution'},), 03:32:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:32:37 INFO - 'cmd': ('bash', 03:32:37 INFO - '-c', 03:32:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:32:37 INFO - 'enabled': True, 03:32:37 INFO - 'halt_on_failure': False, 03:32:37 INFO - 'name': 'check_screen_resolution'},), 03:32:37 INFO - 'run_cmd_checks_enabled': True, 03:32:37 INFO - 'sps_profile': False, 03:32:37 INFO - 'sps_profile_interval': 0, 03:32:37 INFO - 'suite': 'dromaeojs-e10s', 03:32:37 INFO - 'system_bits': '32', 03:32:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:37 INFO - 'title': 't-yosemite-r7-0319', 03:32:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:37 INFO - 'use_talos_json': True, 03:32:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:37 INFO - 'work_dir': 'build'} 03:32:37 INFO - [mozharness: 2017-02-15 11:32:37.395455Z] Running clobber step. 03:32:37 INFO - Running pre-action listener: _resource_record_pre_action 03:32:37 INFO - Running main action method: clobber 03:32:37 INFO - rmtree: /builds/slave/test/build 03:32:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - [mozharness: 2017-02-15 11:32:39.116946Z] Finished clobber step (success) 03:32:39 INFO - [mozharness: 2017-02-15 11:32:39.117092Z] Running read-buildbot-config step. 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: read_buildbot_config 03:32:39 INFO - Using buildbot properties: 03:32:39 INFO - { 03:32:39 INFO - "project": "", 03:32:39 INFO - "product": "firefox", 03:32:39 INFO - "script_repo_revision": "production", 03:32:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:32:39 INFO - "repository": "", 03:32:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:32:39 INFO - "buildid": "20170215020746", 03:32:39 INFO - "pgo_build": "False", 03:32:39 INFO - "basedir": "/builds/slave/test", 03:32:39 INFO - "buildnumber": 88, 03:32:39 INFO - "slavename": "t-yosemite-r7-0319", 03:32:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:32:39 INFO - "platform": "yosemite_r7", 03:32:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:32:39 INFO - "branch": "mozilla-central", 03:32:39 INFO - "repo_path": "mozilla-central", 03:32:39 INFO - "revision": "0a7831d838f793a263456df62f95a615472a7f95", 03:32:39 INFO - "stage_platform": "macosx64", 03:32:39 INFO - "builduid": "01c1d107135547169fd5f3c00456afde", 03:32:39 INFO - "slavebuilddir": "test" 03:32:39 INFO - } 03:32:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - [mozharness: 2017-02-15 11:32:39.120446Z] Finished read-buildbot-config step (success) 03:32:39 INFO - [mozharness: 2017-02-15 11:32:39.120563Z] Running download-and-extract step. 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: download_and_extract 03:32:39 INFO - mkdir: /builds/slave/test/build/tests 03:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:39 INFO - trying https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:32:39 INFO - Downloading https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 03:32:40 INFO - Downloaded 1199 bytes. 03:32:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:32:40 INFO - Using the following test package requirements: 03:32:40 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:32:40 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:32:40 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:32:40 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'jsshell-mac.zip'], 03:32:40 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:32:40 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:32:40 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:32:40 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:32:40 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:32:40 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:32:40 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:32:40 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:32:41 INFO - Expected file size: 51505141 03:32:41 INFO - Obtained file size: 51505141 03:32:57 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:32:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:32:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:32:57 INFO - Fetch https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:32:59 INFO - Expected file size: 51505141 03:32:59 INFO - Obtained file size: 51505141 03:33:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:33:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:33:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:33:15 INFO - Expected file size: 14403647 03:33:15 INFO - Obtained file size: 14403647 03:33:15 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')]} 03:33:15 INFO - trying https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 03:33:18 INFO - Downloaded 70567657 bytes. 03:33:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:33:18 INFO - mkdir: /builds/slave/test/properties 03:33:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:18 INFO - Contents: 03:33:18 INFO - build_url:https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:33:19 INFO - Running post-action listener: _resource_record_post_action 03:33:19 INFO - Running post-action listener: set_extra_try_arguments 03:33:19 INFO - [mozharness: 2017-02-15 11:33:19.268968Z] Finished download-and-extract step (success) 03:33:19 INFO - [mozharness: 2017-02-15 11:33:19.269128Z] Running populate-webroot step. 03:33:19 INFO - Running pre-action listener: _resource_record_pre_action 03:33:19 INFO - Running main action method: populate_webroot 03:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:19 INFO - '--tppagecycles', 03:33:19 INFO - '7'], 03:33:19 INFO - 'tests': ['tsvgm']}}, 03:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['damp', 'tps']}, 03:33:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'tests': ['damp', 'tps']}, 03:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['dromaeo_dom']}, 03:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['basic_compositor_video']}, 03:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['a11yr', 03:33:19 INFO - 'ts_paint', 03:33:19 INFO - 'tpaint', 03:33:19 INFO - 'sessionrestore', 03:33:19 INFO - 'sessionrestore_no_auto_restore', 03:33:19 INFO - 'tabpaint']}, 03:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['tsvgx', 03:33:19 INFO - 'tsvgr_opacity', 03:33:19 INFO - 'tart', 03:33:19 INFO - 'tscrollx', 03:33:19 INFO - 'cart', 03:33:19 INFO - 'tsvg_static']}, 03:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:19 INFO - 'tsvgr_opacity', 03:33:19 INFO - 'tart', 03:33:19 INFO - 'tscrollx', 03:33:19 INFO - 'cart', 03:33:19 INFO - 'tsvg_static']}, 03:33:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'talos_options': ['--disable-e10s'], 03:33:19 INFO - 'tests': ['tp5o']}, 03:33:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'talos_options': ['--disable-e10s', 03:33:19 INFO - '--xperf_path', 03:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:19 INFO - 'tests': ['tp5n']}, 03:33:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:19 INFO - 'talos_options': ['--xperf_path', 03:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:19 INFO - 'tests': ['tp5n']}}, 03:33:19 INFO - 'talos.zip': {'path': '', 03:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:19 INFO - Running post-action listener: _resource_record_post_action 03:33:19 INFO - [mozharness: 2017-02-15 11:33:19.287571Z] Finished populate-webroot step (success) 03:33:19 INFO - [mozharness: 2017-02-15 11:33:19.287679Z] Running create-virtualenv step. 03:33:19 INFO - Running pre-action listener: _resource_record_pre_action 03:33:19 INFO - Running main action method: create_virtualenv 03:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:19 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 03:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:19 INFO - Using real prefix '/tools/python27' 03:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:22 INFO - Installing pip.................done. 03:33:22 INFO - Return code: 0 03:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:23 INFO - Reading from file tmpfile_stdout 03:33:23 INFO - Output received: 03:33:23 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) 03:33:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:23 INFO - 'HOME': '/Users/cltbld', 03:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:23 INFO - 'LOGNAME': 'cltbld', 03:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:23 INFO - 'MOZ_NO_REMOTE': '1', 03:33:23 INFO - 'NO_EM_RESTART': '1', 03:33:23 INFO - 'PAGER': '/bin/cat', 03:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:23 INFO - 'PWD': '/builds/slave/test', 03:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:23 INFO - 'SHELL': '/bin/bash', 03:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:23 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:23 INFO - 'USER': 'cltbld', 03:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:23 INFO - 'XPC_FLAGS': '0x0', 03:33:23 INFO - 'XPC_SERVICE_NAME': '0', 03:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:23 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 03:33:23 INFO - Cleaning up... 03:33:23 INFO - Return code: 0 03:33:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:23 INFO - 'HOME': '/Users/cltbld', 03:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:23 INFO - 'LOGNAME': 'cltbld', 03:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:23 INFO - 'MOZ_NO_REMOTE': '1', 03:33:23 INFO - 'NO_EM_RESTART': '1', 03:33:23 INFO - 'PAGER': '/bin/cat', 03:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:23 INFO - 'PWD': '/builds/slave/test', 03:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:23 INFO - 'SHELL': '/bin/bash', 03:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:23 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:23 INFO - 'USER': 'cltbld', 03:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:23 INFO - 'XPC_FLAGS': '0x0', 03:33:23 INFO - 'XPC_SERVICE_NAME': '0', 03:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:23 INFO - Downloading/unpacking psutil>=3.1.1 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:27 INFO - Installing collected packages: psutil 03:33:27 INFO - Running setup.py install for psutil 03:33:27 INFO - building 'psutil._psutil_osx' extension 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 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 03:33:27 INFO - building 'psutil._psutil_posix' extension 03:33:27 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 03:33:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:33:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:33:27 INFO - ^ 03:33:27 INFO - 1 warning generated. 03:33:27 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 03:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:28 INFO - Successfully installed psutil 03:33:28 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:28 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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:28 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 03:33:28 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 03:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:28 INFO - 'HOME': '/Users/cltbld', 03:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PAGER': '/bin/cat', 03:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:28 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - 'XPC_FLAGS': '0x0', 03:33:28 INFO - 'XPC_SERVICE_NAME': '0', 03:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:31 INFO - Installing collected packages: mozsystemmonitor 03:33:31 INFO - Running setup.py install for mozsystemmonitor 03:33:31 INFO - Successfully installed mozsystemmonitor 03:33:31 INFO - Cleaning up... 03:33:31 INFO - Return code: 0 03:33:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:32 INFO - 'HOME': '/Users/cltbld', 03:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:32 INFO - 'LOGNAME': 'cltbld', 03:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:32 INFO - 'MOZ_NO_REMOTE': '1', 03:33:32 INFO - 'NO_EM_RESTART': '1', 03:33:32 INFO - 'PAGER': '/bin/cat', 03:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:32 INFO - 'PWD': '/builds/slave/test', 03:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:32 INFO - 'SHELL': '/bin/bash', 03:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:32 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:32 INFO - 'USER': 'cltbld', 03:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:32 INFO - 'XPC_FLAGS': '0x0', 03:33:32 INFO - 'XPC_SERVICE_NAME': '0', 03:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:36 INFO - warning: no files found matching '*.txt' 03:33:36 INFO - no previously-included directories found matching 'build' 03:33:36 INFO - no previously-included directories found matching 'dist' 03:33:36 INFO - no previously-included directories found matching '.git*' 03:33:36 INFO - Installing collected packages: jsonschema, functools32 03:33:36 INFO - Running setup.py install for functools32 03:33:36 INFO - warning: no files found matching '*.txt' 03:33:36 INFO - no previously-included directories found matching 'build' 03:33:36 INFO - no previously-included directories found matching 'dist' 03:33:36 INFO - no previously-included directories found matching '.git*' 03:33:36 INFO - Successfully installed jsonschema functools32 03:33:36 INFO - Cleaning up... 03:33:36 INFO - Return code: 0 03:33:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:36 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')]} 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 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')]} 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:36 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 03:33:36 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 03:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:36 INFO - 'HOME': '/Users/cltbld', 03:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:36 INFO - 'LOGNAME': 'cltbld', 03:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:36 INFO - 'MOZ_NO_REMOTE': '1', 03:33:36 INFO - 'NO_EM_RESTART': '1', 03:33:36 INFO - 'PAGER': '/bin/cat', 03:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:36 INFO - 'PWD': '/builds/slave/test', 03:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:36 INFO - 'SHELL': '/bin/bash', 03:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:36 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:36 INFO - 'USER': 'cltbld', 03:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:36 INFO - 'XPC_FLAGS': '0x0', 03:33:36 INFO - 'XPC_SERVICE_NAME': '0', 03:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:36 INFO - Cleaning up... 03:33:36 INFO - Return code: 0 03:33:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:36 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')]} 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 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')]} 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:36 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 03:33:36 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 03:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:36 INFO - 'HOME': '/Users/cltbld', 03:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:36 INFO - 'LOGNAME': 'cltbld', 03:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:36 INFO - 'MOZ_NO_REMOTE': '1', 03:33:36 INFO - 'NO_EM_RESTART': '1', 03:33:36 INFO - 'PAGER': '/bin/cat', 03:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:36 INFO - 'PWD': '/builds/slave/test', 03:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:36 INFO - 'SHELL': '/bin/bash', 03:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:36 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:36 INFO - 'USER': 'cltbld', 03:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:36 INFO - 'XPC_FLAGS': '0x0', 03:33:36 INFO - 'XPC_SERVICE_NAME': '0', 03:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:36 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 03:33:36 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 03:33:36 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 03:33:36 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 03:33:36 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 03:33:36 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 03:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 INFO - Downloading docopt-0.6.1.tar.gz 03:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:40 INFO - Running setup.py install for blobuploader 03:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:40 INFO - Running setup.py install for requests 03:33:41 INFO - Running setup.py install for docopt 03:33:41 INFO - Successfully installed blobuploader requests docopt 03:33:41 INFO - Cleaning up... 03:33:41 INFO - Return code: 0 03:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:41 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')]} 03:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:41 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')]} 03:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:41 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:41 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 03:33:41 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 03:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:41 INFO - 'HOME': '/Users/cltbld', 03:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:41 INFO - 'LOGNAME': 'cltbld', 03:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:41 INFO - 'MOZ_NO_REMOTE': '1', 03:33:41 INFO - 'NO_EM_RESTART': '1', 03:33:41 INFO - 'PAGER': '/bin/cat', 03:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:41 INFO - 'PWD': '/builds/slave/test', 03:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:41 INFO - 'SHELL': '/bin/bash', 03:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:41 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:41 INFO - 'USER': 'cltbld', 03:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:41 INFO - 'XPC_FLAGS': '0x0', 03:33:41 INFO - 'XPC_SERVICE_NAME': '0', 03:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:41 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-mAuWKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:41 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_oA_vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Cybfzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-0L16YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-IQ9I7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vPmhAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-hPMGK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-G9hWda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-tIN_oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-D30gG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:42 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Lvi4dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-ptGzoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-3Z1PXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-dVimqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-6J8nft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Ab6aVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-1cQNW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:43 INFO - Running setup.py install for manifestparser 03:33:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:43 INFO - Running setup.py install for mozcrash 03:33:43 INFO - Running setup.py install for mozdebug 03:33:44 INFO - Running setup.py install for mozdevice 03:33:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Running setup.py install for mozfile 03:33:44 INFO - Running setup.py install for mozhttpd 03:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Running setup.py install for mozinfo 03:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Running setup.py install for mozInstall 03:33:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:44 INFO - Running setup.py install for mozleak 03:33:44 INFO - Running setup.py install for mozlog 03:33:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Running setup.py install for moznetwork 03:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Running setup.py install for mozprocess 03:33:45 INFO - Running setup.py install for mozprofile 03:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Running setup.py install for mozrunner 03:33:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:45 INFO - Running setup.py install for mozscreenshot 03:33:45 INFO - Running setup.py install for moztest 03:33:46 INFO - Running setup.py install for mozversion 03:33:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:46 INFO - Cleaning up... 03:33:46 INFO - Return code: 0 03:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:46 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')]} 03:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:46 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')]} 03:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:46 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:46 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 03:33:46 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 03:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:46 INFO - 'HOME': '/Users/cltbld', 03:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:46 INFO - 'LOGNAME': 'cltbld', 03:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:46 INFO - 'MOZ_NO_REMOTE': '1', 03:33:46 INFO - 'NO_EM_RESTART': '1', 03:33:46 INFO - 'PAGER': '/bin/cat', 03:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:46 INFO - 'PWD': '/builds/slave/test', 03:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:46 INFO - 'SHELL': '/bin/bash', 03:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:46 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:46 INFO - 'USER': 'cltbld', 03:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:46 INFO - 'XPC_FLAGS': '0x0', 03:33:46 INFO - 'XPC_SERVICE_NAME': '0', 03:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:46 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-xTMLzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:46 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)) 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:46 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-fkrAvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:46 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-eAcuWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:46 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)) 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:46 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Xmhju0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:46 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-RSQtDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-yLeo0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TMpIv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-7K3mjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Aso9WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vpPlPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-67YKkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-qCIwvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-7kbhyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:47 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)) 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:47 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-67k84C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:48 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-9dpZTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:48 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)) 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:48 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-g5Q55X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:48 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-LzJHoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:48 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)) 03:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:48 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)) 03:33:48 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:48 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:48 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 03:33:48 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 03:33:48 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 03:33:48 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 03:33:48 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 03:33:48 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 03:33:50 INFO - Downloading blessings-1.6.tar.gz 03:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:51 INFO - Installing collected packages: blessings 03:33:51 INFO - Running setup.py install for blessings 03:33:51 INFO - Successfully installed blessings 03:33:51 INFO - Cleaning up... 03:33:51 INFO - Return code: 0 03:33:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:51 INFO - Reading from file tmpfile_stdout 03:33:51 INFO - Current package versions: 03:33:51 INFO - blessings == 1.6 03:33:51 INFO - blobuploader == 1.2.4 03:33:51 INFO - docopt == 0.6.1 03:33:51 INFO - functools32 == 3.2.3-2 03:33:51 INFO - jsonschema == 2.5.1 03:33:51 INFO - manifestparser == 1.1 03:33:51 INFO - mozInstall == 1.12 03:33:51 INFO - mozcrash == 1.0 03:33:51 INFO - mozdebug == 0.1 03:33:51 INFO - mozdevice == 0.49 03:33:51 INFO - mozfile == 1.2 03:33:51 INFO - mozhttpd == 0.7 03:33:51 INFO - mozinfo == 0.9 03:33:51 INFO - mozleak == 0.1 03:33:51 INFO - mozlog == 3.4 03:33:51 INFO - moznetwork == 0.27 03:33:51 INFO - mozprocess == 0.24 03:33:51 INFO - mozprofile == 0.28 03:33:51 INFO - mozrunner == 6.13 03:33:51 INFO - mozscreenshot == 0.1 03:33:51 INFO - mozsystemmonitor == 0.3 03:33:51 INFO - moztest == 0.8 03:33:51 INFO - mozversion == 1.4 03:33:51 INFO - psutil == 3.1.1 03:33:51 INFO - requests == 1.2.3 03:33:51 INFO - wsgiref == 0.1.2 03:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:51 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')]} 03:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:51 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')]} 03:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:51 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:51 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 03:33:51 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 03:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:51 INFO - 'HOME': '/Users/cltbld', 03:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:51 INFO - 'LOGNAME': 'cltbld', 03:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:51 INFO - 'MOZ_NO_REMOTE': '1', 03:33:51 INFO - 'NO_EM_RESTART': '1', 03:33:51 INFO - 'PAGER': '/bin/cat', 03:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:51 INFO - 'PWD': '/builds/slave/test', 03:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:51 INFO - 'SHELL': '/bin/bash', 03:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:51 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:51 INFO - 'USER': 'cltbld', 03:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:51 INFO - 'XPC_FLAGS': '0x0', 03:33:51 INFO - 'XPC_SERVICE_NAME': '0', 03:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 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)) 03:33:51 INFO - Cleaning up... 03:33:51 INFO - Return code: 0 03:33:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:51 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')]} 03:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:51 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')]} 03:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:51 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 0x1028c8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028cb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d0576dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, '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.FwP1tgp8wR/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.u1KszpjMsh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 03:33:51 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 03:33:51 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 03:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:51 INFO - 'HOME': '/Users/cltbld', 03:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:51 INFO - 'LOGNAME': 'cltbld', 03:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:51 INFO - 'MOZ_NO_REMOTE': '1', 03:33:51 INFO - 'NO_EM_RESTART': '1', 03:33:51 INFO - 'PAGER': '/bin/cat', 03:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:51 INFO - 'PWD': '/builds/slave/test', 03:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:51 INFO - 'SHELL': '/bin/bash', 03:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:33:51 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:51 INFO - 'USER': 'cltbld', 03:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:51 INFO - 'XPC_FLAGS': '0x0', 03:33:51 INFO - 'XPC_SERVICE_NAME': '0', 03:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:52 INFO - Cleaning up... 03:33:52 INFO - Return code: 0 03:33:52 INFO - Running post-action listener: _resource_record_post_action 03:33:52 INFO - Running post-action listener: _start_resource_monitoring 03:33:52 INFO - Starting resource monitoring. 03:33:52 INFO - [mozharness: 2017-02-15 11:33:52.141849Z] Finished create-virtualenv step (success) 03:33:52 INFO - [mozharness: 2017-02-15 11:33:52.142812Z] Running install step. 03:33:52 INFO - Running pre-action listener: _resource_record_pre_action 03:33:52 INFO - Running main action method: install 03:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:52 INFO - Reading from file tmpfile_stdout 03:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:52 INFO - Reading from file tmpfile_stdout 03:33:52 INFO - Output received: 03:33:52 INFO - Usage: mozinstall [options] installer 03:33:52 INFO - Options: 03:33:52 INFO - -h, --help show this help message and exit 03:33:52 INFO - -d DEST, --destination=DEST 03:33:52 INFO - Directory to install application into. [default: 03:33:52 INFO - "/builds/slave/test"] 03:33:52 INFO - --app=APP Application being installed. [default: firefox] 03:33:52 INFO - mkdir: /builds/slave/test/build/application 03:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Output received: 03:34:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:34:14 INFO - Running post-action listener: _resource_record_post_action 03:34:14 INFO - [mozharness: 2017-02-15 11:34:14.497624Z] Finished install step (success) 03:34:14 INFO - [mozharness: 2017-02-15 11:34:14.497750Z] Running run-tests step. 03:34:14 INFO - Running pre-action listener: _resource_record_pre_action 03:34:14 INFO - Running main action method: run_tests 03:34:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:34:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:34:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:34:14 INFO - 2017-02-15 03:34:14.512 screenresolution[2932:52056] starting screenresolution argv=screenresolution get 03:34:14 INFO - 2017-02-15 03:34:14.515 screenresolution[2932:52056] Display 0: 1600x1200x32@60 03:34:14 INFO - 2017-02-15 03:34:14.521 screenresolution[2933:52058] starting screenresolution argv=screenresolution list 03:34:14 INFO - Available Modes on Display 0 03:34:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:34:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:34:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:34:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:34:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:34:14 INFO - Intel Iris: 03:34:14 INFO - Chipset Model: Intel Iris 03:34:14 INFO - Type: GPU 03:34:14 INFO - Bus: Built-In 03:34:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:34:14 INFO - Vendor: Intel (0x8086) 03:34:14 INFO - Device ID: 0x0a2e 03:34:14 INFO - Revision ID: 0x0009 03:34:14 INFO - Displays: 03:34:14 INFO - Display: 03:34:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:34:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:34:14 INFO - Display Serial Number: 1600x1200 60 03:34:14 INFO - Main Display: Yes 03:34:14 INFO - Mirror: Off 03:34:14 INFO - Online: Yes 03:34:14 INFO - Rotation: Supported 03:34:14 INFO - Return code: 0 03:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:14 INFO - Python 2.7.3 03:34:14 INFO - Return code: 0 03:34:14 INFO - grabbing minidump binary from tooltool 03:34: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')]} 03:34:14 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 0x1026a6d30>, '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 0x1025cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10269bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:14 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 03:34:14 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 03:34:14 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 03:34:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:14 INFO - Return code: 0 03:34:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:34:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:14 INFO - ENV: RUST_BACKTRACE is now 1 03:34:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:34:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:14 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/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 03:34:14 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/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --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 03:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwP1tgp8wR/Render', 03:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:14 INFO - 'HOME': '/Users/cltbld', 03:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:14 INFO - 'LOGNAME': 'cltbld', 03:34:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:14 INFO - 'MOZ_NO_REMOTE': '1', 03:34:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:14 INFO - 'NO_EM_RESTART': '1', 03:34:14 INFO - 'PAGER': '/bin/cat', 03:34:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:14 INFO - 'PWD': '/builds/slave/test', 03:34:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:14 INFO - 'RUST_BACKTRACE': '1', 03:34:14 INFO - 'SHELL': '/bin/bash', 03:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u1KszpjMsh/Listeners', 03:34:14 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 03:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:14 INFO - 'USER': 'cltbld', 03:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:14 INFO - 'XPC_FLAGS': '0x0', 03:34:14 INFO - 'XPC_SERVICE_NAME': '0', 03:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:14 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/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 03:34:15 INFO - mozversion application_buildid: 20170215020746 03:34:15 INFO - mozversion application_changeset: 0a7831d838f793a263456df62f95a615472a7f95 03:34:15 INFO - mozversion application_display_name: Nightly 03:34:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:15 INFO - mozversion application_name: Firefox 03:34:15 INFO - mozversion application_remotingname: firefox 03:34:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:34:15 INFO - mozversion application_vendor: Mozilla 03:34:15 INFO - mozversion application_version: 54.0a1 03:34:15 INFO - mozversion platform_buildid: 20170215020746 03:34:15 INFO - mozversion platform_changeset: 0a7831d838f793a263456df62f95a615472a7f95 03:34:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:34:15 INFO - mozversion platform_version: 54.0a1 03:34:15 INFO - using testdate: 1487158455 03:34:15 INFO - actual date: 1487158455 03:34:15 INFO - starting webserver on 'localhost:54010' 03:34:15 INFO - SUITE-START | Running 2 tests 03:34:15 INFO - TEST-START | dromaeo_css 03:34:15 INFO - operating with platform_type : mac_ 03:34:15 INFO - Initialising browser for dromaeo_css test... 03:34:15 INFO - TEST-INFO | started process 2943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpvQU3Y_/profile http://localhost:54010/getInfo.html) 03:34:17 INFO - PROCESS | 2943 | 2017-02-15 03:34:17.694 plugin-container[2945:52212] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c3b, name = 'com.apple.tsm.portname' 03:34:17 INFO - PROCESS | 2943 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:17 INFO - PROCESS | 2943 | 2017-02-15 03:34:17.697 plugin-container[2945:52212] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4913, name = 'com.apple.CFPasteboardClient' 03:34:17 INFO - PROCESS | 2943 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:17 INFO - PROCESS | 2943 | 2017-02-15 03:34:17.697 plugin-container[2945:52212] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:34:17 INFO - PROCESS | 2943 | __metrics Screen width/height:1600/1200 03:34:17 INFO - PROCESS | 2943 | colorDepth:24 03:34:17 INFO - PROCESS | 2943 | Browser inner width/height: 1024/689 03:34:17 INFO - PROCESS | 2943 | __metrics 03:34:17 ERROR - PROCESS | 2943 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 03:34:18 INFO - TEST-INFO | 2943: exit 0 03:34:18 INFO - Browser initialized. 03:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:18 INFO - TEST-INFO | started process 2946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpvQU3Y_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:20 INFO - PROCESS | 2946 | 2017-02-15 03:34:20.965 plugin-container[2947:52329] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:34:20 INFO - PROCESS | 2946 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:20 INFO - PROCESS | 2946 | 2017-02-15 03:34:20.966 plugin-container[2947:52329] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:34:20 INFO - PROCESS | 2946 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:20 INFO - PROCESS | 2946 | 2017-02-15 03:34:20.966 plugin-container[2947:52329] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:34:30 INFO - PROCESS | 2946 | RSS: Main: 233791488 03:34:30 INFO - PROCESS | 2946 | 03:37:33 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54010/tests/dromaeo/cssquery-ext.html) 03:37:34 INFO - PROCESS | 2946 | RSS: Main: 259432448 03:37:34 INFO - PROCESS | 2946 | 03:39:18 INFO - PROCESS | 2946 | ************************* 03:39:18 INFO - PROCESS | 2946 | A coding exception was thrown and uncaught in a Task. 03:39:18 INFO - PROCESS | 2946 | 03:39:18 ERROR - PROCESS | 2946 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:39:18 INFO - PROCESS | 2946 | Full stack: 03:39:18 INFO - PROCESS | 2946 | ************************* 03:40:37 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-ext.html (next: http://localhost:54010/tests/dromaeo/cssquery-jquery.html) 03:40:38 INFO - PROCESS | 2946 | RSS: Main: 265023488 03:40:38 INFO - PROCESS | 2946 | 03:43:40 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54010/tests/dromaeo/cssquery-mootools.html) 03:43:40 INFO - PROCESS | 2946 | RSS: Main: 276725760 03:43:40 INFO - PROCESS | 2946 | 03:46:42 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54010/tests/dromaeo/cssquery-prototype.html) 03:46:43 INFO - PROCESS | 2946 | RSS: Main: 268689408 03:46:43 INFO - PROCESS | 2946 | 03:49:46 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54010/tests/dromaeo/cssquery-yui.html) 03:49:47 INFO - PROCESS | 2946 | RSS: Main: 272605184 03:49:47 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | Cycle 1(1): loaded http://localhost:54010/tests/dromaeo/cssquery-yui.html (next: http://localhost:54010/tests/dromaeo/cssquery-dojo.html) 03:52:50 INFO - PROCESS | 2946 | RSS: Main: 273702912 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | __start_tp_report 03:52:50 INFO - PROCESS | 2946 | _x_x_mozilla_page_load 03:52:50 INFO - PROCESS | 2946 | _x_x_mozilla_page_load_details 03:52:50 INFO - PROCESS | 2946 | |i|pagename|runs| 03:52:50 INFO - PROCESS | 2946 | |0;dojo.html;3305.7685961982666;3319.5684561007065;3338.3823992561393;3349.3971085204666;3353.010861795771;5460;5688.772449102031;5695.117256825199;5748.913766293509;5751.4248575142465;4545.772711364435;5535.667859928397;5619.325680918296;5645.040343141676;5719.513841323493;5076.289319495274;5090.083784918713;5102.795888164469;5155.5360017598405;5226.686398816064;4757.333973243749;5202.985417843522;5256.710880901549;5260.316158899338;5292.788288468457;4195.601417865298;5074.594032477393;5225.738713064369;5237.7381130943495;5246.7901283948595;4280.357946308048;5143.614228932807;5180.352455943007;5198.9480105198845;5224.738763061831;4288.935665965013;5138.126518491866;5158.974205128988;5185.792568297264;5188.533032027098;4591;5173.456787037345;5458.6724796512335;5536.280283563151;5611.494965453129;5161.948380516184;6229.906551401733;6238.563300568962;6242.687865606701;6245.594036387665;6168.352323006109;6183.87632247357;6192.59748116371;6198.783042593487;6204.565680402374;5627.212190293362;5664.631798933056;5670.688112153871;5866.648001119904;5920.644761314335;6132.080177996013;6137.508999280047;6145.248604147797;6165.0444181152;6212.9068063979075;5855;5996.040633498619;6133.028644417026;6133.242854861876;6141.025769127022;4972.378452693413;6004.849878753066;6141.393954534099;6247.937520624827;6263.060540918807;5116.437191908887;6199.876002480015;6216.689165541705;6224.844378890564;6225.221847269091;5143.022825663112;5965.13505541694;6084.11780291864;6126.754929802847;6140.8771824563255;4845.297431872359;4906.484819094015;4911.16510193268;4915.139850526144;4996.350474438373;4406.603405693439;4419.535948725337;4422.955770442254;4433.7561434121435;4469.888252793706;5725.456081672234;5739.799107031234;5740.368559458456;5740.913886291709;5758.193852860602;6105.550726437353;6108;6115.266168059772;6118.7410088057595;6272.937270627326;5570.442955704397;5587.608867379326;5600.0759874620235;5604.775808967677;5633.352164501135;5221.686698798008;5326.493983071602;5330.653507521999;5341.038613049611;5366.946330536644;6179.62922224668;6208.4722798562625;6230.937690623035;6252.062190671345;6273.749050037947;6152.538559607958;6272.059191121369;6274.152989346379;6276.654783986742;6294;6212.751489940532;6246.46905013079;6264.624122552661;6277;6284.402981716729;5918.585699001029;6102.938970610415;6174.783882564088;6182.938170618416;6233.657148856856;5068.417132029716;6144.815655530341;6164.321924588202;6172.166757487682;6193.876122477435;5969.76120955157;5980.372060933713;6121.483458747687;6133.793750436688;6138.143176733788;5809.663777331153;5871.706414679164;5872.236609240771;5919;6133.785317513865;5652.463016013472;5709.115087161496;5768.596198266249;5881.676507792113;5900.380460051804;5059.797608095635;6114.784027539347;6123.801220575414;6131.193168498027;6132.846678833065;5953.821385358447;5954.98765209924;5971.28344598651;5976.252968378953;5985.820425387245 03:52:50 INFO - PROCESS | 2946 | |1;ext.html;429.23381763552044;484.9175640141176;494.3153732081069;511.3480312601433;538.3432212700504;34441.655583444124;36455;38270.23459530811;40827;40899.59100408995;41629.167416651646;41898.58101418985;41973.790131049376;42017.7899110504;42145.15709685804;9402.10679985402;9618;9639.566219520138;9649.710508684751;10815.297005694643;10956.178286628496;11175.161862860277;11203.831942520868;11209.551617935273;11220.551177952872;8881.600327985223;11115.888841111606;11177.83233251502;11243.718907027307;11664.941675291611;11066.667999960015;11085.224034317602;11113.944430277797;11138.443077846156;11154.330740155616;10891.509882055247;10971.561137554489;11008.009279164913;11010.724731881686;11024.228304018721;35524;35891.64108358909;35902.64097359019;35962.640373596456;36173.63826361729;3722.2555488902326;3723.2739615774935;3783.2975161177305;3799.696024318048;3941.9211615767813;27073;27508.312292192655;28026.439471210462;28126.578101328498;28128.437431251466;3037.3014206732573;3082.7687923405833;3197.1687361286;3217.324361884007;3219.3239419721885;453973;457266;458813.70593147154;460807.9999999966;461936.6903165496;43984.842122102935;45102.54897450984;54542.72728636331;55105.72447137819;55310.34068977937;44411.777941110086;54619.72690136603;55000;58525.70737146372;58599;14276.857231427553;14356.353964071643;14481.551844815645;14507.347169377403;14516.274186290855;10897.727556811144;11188.272762270426;11197.888021119847;11214.719632009264;11223;16835.915820420818;16932.91533542349;16940.83059169417;16964.830351696324;16987.405440809758;7500.812479688051;7561.735339263099;7571.3942884569105;7598.734044308423;7612.982559621704;709.521073275537;823.2385043834429;838.9622466989;839.9160083991552;849.3417601358997;22560.984755686033;27371.04201352943;27615.585766213524;27623.30941726473;29356;868.3140319147928;898.2409863665192;904.8371293167293;1027.7584767579613;1030.0420608833706;10654.840177397346;12677.112602117762;13463.326833658279;14074.296285185905;14104.788428173586;591881;601259;613474;613629;837510;51345;51988.74005629947;52001.47998520042;52043;52177.95644087173;1324.8410190777167;1345.0920628575673;1363.6113707593486;1364.3314775759807;1364.597443754095;22219.333419997427;27248.591271131347;27796.027139050035;28249.85875070694;29087.7091229085;43444.78277608718;43852.56147438485;44048.11903761971;44048.11903761971;44107.338389923534;533512;533742;535329;537913;541656;24749;25016.499670006862;25294.747052529976;25447.36381590475;26251.343716407242;39929.60246391362;40548.59451405448;41501.58498414977;41772.164556708085;41820.79089604533;28730.856345718137;33422.164445889044;34062;34761.304773904885;35028.9491315261;27434.5884811724;32896;33563.993080207634;33961.66038339585;34096;32726;32789.688412463234;33872.15319617029;34104.65895341015;34200.14499637529;26946.787394566898;29418.852905735333;30020;30989.690103099583;31261;20550.486237844172;21756.238531651317;22046.66929996019;26652.733472665026;32184.517232241065 03:52:50 INFO - PROCESS | 2946 | |2;jquery.html;349.3955457059287;389.5656343177358;403.73757057912354;410.28200648864487;421.917780892012;19728.802711972876;21056.473588160305;21425.678614820772;21566;21790.128394864187;19776.703349449734;20617.07223174957;20911.745295282293;21765.564688706258;22079;5196.636235463509;5487.2317875497465;5576.693281869496;5582.720863956806;5589.972050139743;5409.26974858393;5466.098093814516;5789.565782566325;6141.754329826802;6174.073888916653;5327.706976116312;6130.632162070267;6154.384561543855;6190.3190649028575;6201.069839524062;6011.458968692817;6031.185789918371;6114.357992410822;6145.907811382833;6150.169727086831;5304.20436934459;6032.547558933054;6034.758609655609;6048.727807248684;6050.818475445743;13043.739125217537;13498.257595832225;13631.522896698667;13679.726405471934;13714.24571648559;2302.5740238056014;2323.8721870297127;2334.2180369576213;2340.6137987232087;2353.176388264111;9808.215342772632;9851.852222216672;9860.556274967643;10471.952804719544;10475;1756.350150444331;1766.2934826069547;1770.565841668253;1790.7761529808774;1825.963480730378;122163;125051.37474312661;129565;138636;139235;11681.649550513499;11853.288802671867;11988.100892432927;12018.759624807455;12192.939035304944;15698;15715.842841571666;15756.448524301824;15822.920885395499;15834.60413489672;8252.133525979805;8463.35815134834;8466.153384661484;8495.702650407206;8552.828943421222;8034.758957231293;8079.636416361278;8219.219174178443;8269.255766981001;8285.42002059862;4638.721676699409;4756.5956893664425;4840.298156767249;4849.927251091166;4923.556879880756;1791.7312403139633;2063.3500447359033;2072.927447539329;2076;2079.677649964258;812.7236739508477;833.9874901876477;835.3317346123077;844.8394804987033;855.3841234311286;20144.59710805776;20543.794562054187;20691.27580534674;20772.322208631656;20918;829.9708361631533;862.5169904853302;866;885.8051228729669;892.5314210039782;6326.145970294044;6417.6149431033355;6487.3836985486305;6493.155889734398;6608.8347791305605;615480;623803.9766619797;628561;643474;644540;131647.68352316547;141995.29002354923;143321;148399;163745;1009.8131845608586;1034.4879284753945;1065.3661071662348;1066.568039943824;1068.408071972755;15819.209039548206;19285.807141928963;19513.902430487757;19591.60816783628;19618.60762784765;45394;45654;57934.4206557929;58511;61891;74117.88823167764;75835.62082189554;81790.18209818064;82122;85279.2944141126;7001.809692352211;8108.513489190667;8199.754007379788;8559.786005349666;8707.476191666306;9338.626454941998;10013.39919604826;11701.590444334408;11770.58802941893;13551.72896542044;9922.652707155215;11132.387718675227;11397.943010284895;11614.825777613512;11659.008984236096;10907.727306817393;11044.889551104387;11086.390248536409;11489.655310340702;11561.826572601585;11143.665690029313;11335.319880807177;11627.709307267385;11768.293902365886;11872.465739041936;8161.102278749214;8186.631601578062;8277.875831862648;8567.957160214159;8635.093315201813;10161.187105031431;10961.177911656498;10994;11284.266522676;11375.829362559734 03:52:50 INFO - PROCESS | 2946 | |3;mootools.html;1429.585420228134;1433.734759069572;1449.5361484325012;1456.4538298138198;1456.5557504960982;8112.432129750912;8324.791880202998;8505.957470212641;8557.10150434204;8570.400071994964;8456.577171141449;8628.266597339218;8640.481571105722;8662.480251184934;8666.956665216665;2170.522485053286;2214.4795972946345;2221.577900198965;2222.4442889977;2230.5761905237955;2043.3257025181729;2069.8719198037106;2183.667962542848;2221.4557433428754;2224.2993457061057;2267.6598510223516;2271.1937262271904;2283.086765293879;2295.3228797504776;2299.1493147535434;2202.50443650179;2258.7402448718362;2284.7144106986543;2285.954280914389;2291.644795056769;1946.221511395439;2031.3499680102373;2279.2136712834044;2281.703378560793;2321.6749655048307;7708.61456927157;8154.184581541857;8288.544130072843;8505.872411913826;8622.094680058566;5102.719350435725;5251.842444726664;5267.920981185285;5269.604779641542;5292.391374991848;3437.5187473753695;3447.7414193935306;3465.480177973299;3522.6301238370115;3542.5926018507944;1102.8365074846033;1204.5482943896038;1221.5663439478947;1232.5994051933158;1249.5126900508808;10746.462676866126;10801.67594972152;10821;10906.781864362669;10920.945395273053;4108.589141085928;4391.363252328394;4459.955400446019;4493.573110554492;4505.954940450553;7779.688812447552;8758.036615972238;8780.956095219482;8810.603522841488;8816.691415800417;5078.644494885322;5080.085584594734;5087.313212716236;5094.083065048327;5097.617678674114;4538;4595.6783025187915;4710.974032434625;4716.693414928019;4783.904321913542;3606.6573675500786;3667.1932174921476;3685.7051435885064;3693.1874987502706;3761.605031471711;1137.056243318044;1138.5957984915235;1146.4095990564865;1155.3876445483907;1157.7973854575416;707.2962402409636;784.9136594974548;790.8141586727114;817.1256755271802;824.381713714714;5250.343707036621;5476.644018138808;5592.5805564582815;5642.520385767256;5680.971595141998;460.5923757474659;549.5905550365004;558.7513556467414;573.6615396915756;581.1312088427743;3096.8296743679316;3530.675996501312;3781.262653782541;3817.4464702617965;3824.7896365700153;9038.276937844958;9395.765105872408;9411.717648470556;9522.381045232176;9877.259205559612;9846.704598862045;9930.2055835533;10060.647877324258;10062.798744025225;10073.546690398949;7680.5391676499585;7911.723089691948;7927.286544211049;7928.365730741527;7939.920600794034;5246.737663116905;5692.6299790513485;5718.742656580381;5747.195392645117;5825.592208545361;8863.512506811929;9289.814203716023;9292.39599426035;9292.72121836346;9303.348765586345;8962.910370896469;9310.487923164292;9359.625614975324;9441;9443.669471568463;7185.568865868065;7303.963480182565;7305.853882922418;7343.8531229376185;7354.816129596803;7886.132525422085;7899.289063984269;7940.444168908121;7944;7949.8410031797885;6980.511364204457;7118.928810711826;7160.534565253241;7201.675924583302;7250.166230883516;6854.760083397057;7021.192562855337;7030.050943122613;7041.436685065285;7105.786826395217;6287.402696743802;6341.207349081365;6384.233891932998;6447.387498187664;6452.741890324334;4392;4773.928391074067;4911.8280860169725;4980.925286120639;5117.078925793393;4888.926666100083;5035.5468007878;5069.112905241642;5086.567641750345;5141.177411614124 03:52:50 INFO - PROCESS | 2946 | |4;prototype.html;312.45320688794607;364.2823637434254;366.24918916221736;370.65529057976073;374.9981250093749;4888.584470320023;4999.850004499862;5454.854480559083;5458.399576046631;5481.671099734019;4076.3274059780174;4536.977315113428;5165.096108181072;5247.212918062283;5438.945610543893;3545.050222377695;3815.6947444204466;4007.8797636070963;4036.5963403659694;4086.8160932758096;3667.7065834733157;3767.60440153784;4011.378236373352;4048;4048.643704359043;4010.7767131025025;4024.1951609678035;4030.9395359069636;4038.394240863879;4054.797260136996;3834.654881060718;3911.357229963422;3941.5861334559745;4044.8179831907487;4049.7975101244965;3027;3422.401079811048;3446.2590543033366;3480.7737497062863;3483.220705534498;4250.447441832573;5089.898202035939;5161.845144645667;5173.534381905646;5213.556847667953;4577.565131312554;4617.284320930261;4619.72281663098;4640.257558790578;4649.953500464986;5003.724795136266;5314.492434992886;5440.972795136038;5628.690422026787;5830.3586605473365;3328.7004169624606;3878.2437424702193;3925.941110883339;3926.8429262829454;3944.644981951609;5447.855950250452;5580.91628625571;5716.485516303553;6023.975924092914;6087.078202462799;3736.9439458408146;3802.186382077243;3841.519810023747;3862.5944275851193;3876.651101400831;3613.674769270778;3774.169682669863;3940.4286378474962;3962.7517332040316;3995.5005624296964;3797.145642230476;4102.856400025985;4322.37325587788;4403.493598236179;4516.706414083074;4475.79980314077;4617.538246175355;5169.612279079084;5527.866787308592;5840.153177789197;1105.834124881258;1144.673767976123;1164.714644911985;1296.1704509114174;1306.6276111308232;780.434185215714;804.4770898915751;816.7100679258897;843.20317300152;877.4866702978829;4331.1337732453;4419.513853476115;5025.045241404122;5089.440161582223;5131.2559678846355;5007.37407824022;5524.7348587079105;5641.746121424464;5642.6614403135945;5677.602567820296;4807.711537307703;4847.745798203852;5062.848114556569;5125.436202017775;5161.509656582619;2796.45469133517;2948.7935844491108;2973.4796410628055;3017.366353065881;3021.6525099613386;5884.764609415661;5888.705564721832;5938.465538101592;5939.584229103922;6065;5464.398916119224;5770.615052387397;5779.682117483495;5784.1902133701315;5866.70666466675;4783.851875549913;5331.920021199685;5964;6007.918574656516;6020.638761674313;5237.711925844115;5379.552303701885;5451.672899626035;5683.374828768915;5721.997300944636;4429.512753597037;5476.424975377528;5576.828865938199;5646.265985421869;5820.708964551671;4916;4962.330085438564;5206.713630750345;5993.760249590142;6098.115773212948;3248.78882872622;3919.431682406092;3944.2308749793515;3944.329463991071;3965.940510892281;5918.201042859159;5940.762369505344;5950.750342427966;5952.76188952437;5959.940400595939;4811.591014763784;5374.623776335776;5456.40820610207;5677;5775.306963164448;5274.393444753749;5743.1385292206505;5750.9712451439145;5752;5784.363719990713;5393.67637941709;5615.578831587565;5656.886862262814;5666.46168613981;5669.603127781016;4826.734529600905;5710.65736055838;5717.942820571741;5725.513331366714;5829;5632.464915832989;5646.830595082154;5655.773769049357;5659.047628568137;5684.9431505684415 03:52:50 INFO - PROCESS | 2946 | |5;yui.html;677.3226773226774;693.6219760230674;695.9164900211975;774.8295375017494;791.7466410748561;14361.712765744693;14821.333040013198;15250;15283.541493755178;15344.769828452581;14117.858821411783;14186.92906535466;14310.21293828839;14315.284235788222;14316.71366572668;894.552723638181;912.9634814607408;916.1434059154678;918.8162367526488;918.8483900156466;874.6107981948036;902.1249388093571;914.4010673009157;919.4437365393941;920.2316066084827;965.9275554333453;969.4764826993415;970.7281961050882;970.9271804614647;973.6251543155865;951.6526467839258;957.7174733453578;961.725908116187;964.2093483343662;968.0609808485758;578.5689661202431;672.4821887146869;705.9964700176466;712.5154894671621;719.784064780569;15060.774088388684;15112.5466236012;15287.312070956723;15468.5359439217;15513.146776927264;13720.313984300745;13865.722685546334;13893.802240488345;14098.71802563943;14147.929260353736;11166.218364714474;11270.549178032868;11293.491792869258;11370.31778093317;11664.825027624593;3059.7413754351546;3657.2868290683327;3670.137517683342;3727.1613886875507;3753.512043434336;81212;95323;95765.5211723944;96411.51794241054;97101.71737119673;10608.257421980541;10634.415107169025;10644.467776611138;10651.467426628638;11003.889961100447;22029.559408811732;22034.228801991852;22039.559208815735;22055.33833984983;22098;6194.039923811816;7251.311125443074;7272.63636818157;7278.1266248049515;7397.445191610651;4003.559608443069;4026.57720939303;4154.813033413504;4282.89292767677;4311.353297005474;3030.8939187128785;3605.0987253186704;3654.031681604377;3705.5923848376656;3708.610595887447;662.7216569041015;686.3411125319749;690.5338896245115;695.1935754524727;695.8608278344351;520.3365708721335;543.3545462643141;546.8988237176135;568.687222027883;697.7313734212365;8159.46963447374;8627.329533818473;9168.495732734631;9359.532023398802;9728;534.9946500534945;539.881919404044;580.7822066724979;631.0439683878927;683.733343995842;4110.116324990141;5057.645964782503;5080.949190508121;5401.189821526802;5567.387587365387;79875;93303.53348233216;96692.51653741686;97538.51230743801;100639.49680251552;85092;85701.57149214338;88543.11456885349;88701;89836.10163898408;66208;67496.32503674901;74535.25464745391;74906.87639685409;78971;9818.607255709692;10112.848307275544;10505.9474702626;10548;10711.41087240178;41709.58290417057;42522.36216456694;44515.44195953256;44925.55074449344;47678.76160619175;58407;63840;63941;67326.66336668286;67485.66257168683;12445.813312800134;12746.745065098461;12842;12936.506357323178;13576.524821631196;13869.411706201445;14394.784078238625;14434.566962991126;14447.566573002827;14639.194844283667;12691.428885699981;12971.675708107372;13076.476940922257;13304.600861974157;13515.189088654712;12849.807252891027;13071.215727056408;13109.934748279382;13327.533536326182;13595.660108497366;9351.953240233755;12749.107562470908;12759.299399556667;12953.805692914426;13669;10500.896235809478;10518.474076296001;10698.62554810578;11028.944855275673;11489.310641361544;8842;9281.86077208856;10423.530941107516;10691.465426728788;10710.839337409789 03:52:50 INFO - PROCESS | 2946 | __end_tp_report 03:52:50 INFO - PROCESS | 2946 | __start_cc_report 03:52:50 INFO - PROCESS | 2946 | _x_x_mozilla_cycle_collect,408 03:52:50 INFO - PROCESS | 2946 | __end_cc_report 03:52:50 INFO - PROCESS | 2946 | __startTimestamp1487159570331__endTimestamp 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | ------- Summary: start ------- 03:52:50 INFO - PROCESS | 2946 | Number of tests: 6 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#0] dojo.html Cycles:165 Average:5623.25 Median:5809.66 stddev:669.06 (11.5%) stddev-sans-first:645.94 03:52:50 INFO - PROCESS | 2946 | Values: 3305.8 3319.6 3338.4 3349.4 3353.0 5460.0 5688.8 5695.1 5748.9 5751.4 4545.8 5535.7 5619.3 5645.0 5719.5 5076.3 5090.1 5102.8 5155.5 5226.7 4757.3 5203.0 5256.7 5260.3 5292.8 4195.6 5074.6 5225.7 5237.7 5246.8 4280.4 5143.6 5180.4 5198.9 5224.7 4288.9 5138.1 5159.0 5185.8 5188.5 4591.0 5173.5 5458.7 5536.3 5611.5 5161.9 6229.9 6238.6 6242.7 6245.6 6168.4 6183.9 6192.6 6198.8 6204.6 5627.2 5664.6 5670.7 5866.6 5920.6 6132.1 6137.5 6145.2 6165.0 6212.9 5855.0 5996.0 6133.0 6133.2 6141.0 4972.4 6004.8 6141.4 6247.9 6263.1 5116.4 6199.9 6216.7 6224.8 6225.2 5143.0 5965.1 6084.1 6126.8 6140.9 4845.3 4906.5 4911.2 4915.1 4996.4 4406.6 4419.5 4423.0 4433.8 4469.9 5725.5 5739.8 5740.4 5740.9 5758.2 6105.6 6108.0 6115.3 6118.7 6272.9 5570.4 5587.6 5600.1 5604.8 5633.4 5221.7 5326.5 5330.7 5341.0 5366.9 6179.6 6208.5 6230.9 6252.1 6273.7 6152.5 6272.1 6274.2 6276.7 6294.0 6212.8 6246.5 6264.6 6277.0 6284.4 5918.6 6102.9 6174.8 6182.9 6233.7 5068.4 6144.8 6164.3 6172.2 6193.9 5969.8 5980.4 6121.5 6133.8 6138.1 5809.7 5871.7 5872.2 5919.0 6133.8 5652.5 5709.1 5768.6 5881.7 5900.4 5059.8 6114.8 6123.8 6131.2 6132.8 5953.8 5955.0 5971.3 5976.3 5985.8 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#1] ext.html Cycles:180 Average:66457.17 Median:34011.83 stddev:149282.94 (438.9%) stddev-sans-first:149619.40 03:52:50 INFO - PROCESS | 2946 | Values: 429.2 484.9 494.3 511.3 538.3 34441.7 36455.0 38270.2 40827.0 40899.6 41629.2 41898.6 41973.8 42017.8 42145.2 9402.1 9618.0 9639.6 9649.7 10815.3 10956.2 11175.2 11203.8 11209.6 11220.6 8881.6 11115.9 11177.8 11243.7 11664.9 11066.7 11085.2 11113.9 11138.4 11154.3 10891.5 10971.6 11008.0 11010.7 11024.2 35524.0 35891.6 35902.6 35962.6 36173.6 3722.3 3723.3 3783.3 3799.7 3941.9 27073.0 27508.3 28026.4 28126.6 28128.4 3037.3 3082.8 3197.2 3217.3 3219.3 453973.0 457266.0 458813.7 460808.0 461936.7 43984.8 45102.5 54542.7 55105.7 55310.3 44411.8 54619.7 55000.0 58525.7 58599.0 14276.9 14356.4 14481.6 14507.3 14516.3 10897.7 11188.3 11197.9 11214.7 11223.0 16835.9 16932.9 16940.8 16964.8 16987.4 7500.8 7561.7 7571.4 7598.7 7613.0 709.5 823.2 839.0 839.9 849.3 22561.0 27371.0 27615.6 27623.3 29356.0 868.3 898.2 904.8 1027.8 1030.0 10654.8 12677.1 13463.3 14074.3 14104.8 591881.0 601259.0 613474.0 613629.0 837510.0 51345.0 51988.7 52001.5 52043.0 52178.0 1324.8 1345.1 1363.6 1364.3 1364.6 22219.3 27248.6 27796.0 28249.9 29087.7 43444.8 43852.6 44048.1 44048.1 44107.3 533512.0 533742.0 535329.0 537913.0 541656.0 24749.0 25016.5 25294.7 25447.4 26251.3 39929.6 40548.6 41501.6 41772.2 41820.8 28730.9 33422.2 34062.0 34761.3 35028.9 27434.6 32896.0 33564.0 33961.7 34096.0 32726.0 32789.7 33872.2 34104.7 34200.1 26946.8 29418.9 30020.0 30989.7 31261.0 20550.5 21756.2 22046.7 26652.7 32184.5 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#2] jquery.html Cycles:180 Average:36487.07 Median:369.48 stddev:105965.78 (28679.7%) stddev-sans-first:106228.30 03:52:50 INFO - PROCESS | 2946 | Values: 349.4 389.6 403.7 410.3 421.9 19728.8 21056.5 21425.7 21566.0 21790.1 19776.7 20617.1 20911.7 21765.6 22079.0 5196.6 5487.2 5576.7 5582.7 5590.0 5409.3 5466.1 5789.6 6141.8 6174.1 5327.7 6130.6 6154.4 6190.3 6201.1 6011.5 6031.2 6114.4 6145.9 6150.2 5304.2 6032.5 6034.8 6048.7 6050.8 13043.7 13498.3 13631.5 13679.7 13714.2 2302.6 2323.9 2334.2 2340.6 2353.2 9808.2 9851.9 9860.6 10472.0 10475.0 1756.4 1766.3 1770.6 1790.8 1826.0 122163.0 125051.4 129565.0 138636.0 139235.0 11681.6 11853.3 11988.1 12018.8 12192.9 15698.0 15715.8 15756.4 15822.9 15834.6 8252.1 8463.4 8466.2 8495.7 8552.8 8034.8 8079.6 8219.2 8269.3 8285.4 4638.7 4756.6 4840.3 4849.9 4923.6 1791.7 2063.4 2072.9 2076.0 2079.7 812.7 834.0 835.3 844.8 855.4 20144.6 20543.8 20691.3 20772.3 20918.0 830.0 862.5 866.0 885.8 892.5 6326.1 6417.6 6487.4 6493.2 6608.8 615480.0 623804.0 628561.0 643474.0 644540.0 131647.7 141995.3 143321.0 148399.0 163745.0 1009.8 1034.5 1065.4 1066.6 1068.4 15819.2 19285.8 19513.9 19591.6 19618.6 45394.0 45654.0 57934.4 58511.0 61891.0 74117.9 75835.6 81790.2 82122.0 85279.3 7001.8 8108.5 8199.8 8559.8 8707.5 9338.6 10013.4 11701.6 11770.6 13551.7 9922.7 11132.4 11397.9 11614.8 11659.0 10907.7 11044.9 11086.4 11489.7 11561.8 11143.7 11335.3 11627.7 11768.3 11872.5 8161.1 8186.6 8277.9 8568.0 8635.1 10161.2 10961.2 10994.0 11284.3 11375.8 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#3] mootools.html Cycles:180 Average:5381.16 Median:5248.54 stddev:2975.55 (56.7%) stddev-sans-first:2969.08 03:52:50 INFO - PROCESS | 2946 | Values: 1429.6 1433.7 1449.5 1456.5 1456.6 8112.4 8324.8 8506.0 8557.1 8570.4 8456.6 8628.3 8640.5 8662.5 8667.0 2170.5 2214.5 2221.6 2222.4 2230.6 2043.3 2069.9 2183.7 2221.5 2224.3 2267.7 2271.2 2283.1 2295.3 2299.1 2202.5 2258.7 2284.7 2286.0 2291.6 1946.2 2031.3 2279.2 2281.7 2321.7 7708.6 8154.2 8288.5 8505.9 8622.1 5102.7 5251.8 5267.9 5269.6 5292.4 3437.5 3447.7 3465.5 3522.6 3542.6 1102.8 1204.5 1221.6 1232.6 1249.5 10746.5 10801.7 10821.0 10906.8 10920.9 4108.6 4391.4 4460.0 4493.6 4506.0 7779.7 8758.0 8781.0 8810.6 8816.7 5078.6 5080.1 5087.3 5094.1 5097.6 4538.0 4595.7 4711.0 4716.7 4783.9 3606.7 3667.2 3685.7 3693.2 3761.6 1137.1 1138.6 1146.4 1155.4 1157.8 707.3 784.9 790.8 817.1 824.4 5250.3 5476.6 5592.6 5642.5 5681.0 460.6 549.6 558.8 573.7 581.1 3096.8 3530.7 3781.3 3817.4 3824.8 9038.3 9395.8 9411.7 9522.4 9877.3 9846.7 9930.2 10060.6 10062.8 10073.5 7680.5 7911.7 7927.3 7928.4 7939.9 5246.7 5692.6 5718.7 5747.2 5825.6 8863.5 9289.8 9292.4 9292.7 9303.3 8962.9 9310.5 9359.6 9441.0 9443.7 7185.6 7304.0 7305.9 7343.9 7354.8 7886.1 7899.3 7940.4 7944.0 7949.8 6980.5 7118.9 7160.5 7201.7 7250.2 6854.8 7021.2 7030.1 7041.4 7105.8 6287.4 6341.2 6384.2 6447.4 6452.7 4392.0 4773.9 4911.8 4980.9 5117.1 4888.9 5035.5 5069.1 5086.6 5141.2 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#4] prototype.html Cycles:180 Average:4524.15 Median:5076.14 stddev:1413.44 (27.8%) stddev-sans-first:1381.60 03:52:50 INFO - PROCESS | 2946 | Values: 312.5 364.3 366.2 370.7 375.0 4888.6 4999.9 5454.9 5458.4 5481.7 4076.3 4537.0 5165.1 5247.2 5438.9 3545.1 3815.7 4007.9 4036.6 4086.8 3667.7 3767.6 4011.4 4048.0 4048.6 4010.8 4024.2 4030.9 4038.4 4054.8 3834.7 3911.4 3941.6 4044.8 4049.8 3027.0 3422.4 3446.3 3480.8 3483.2 4250.4 5089.9 5161.8 5173.5 5213.6 4577.6 4617.3 4619.7 4640.3 4650.0 5003.7 5314.5 5441.0 5628.7 5830.4 3328.7 3878.2 3925.9 3926.8 3944.6 5447.9 5580.9 5716.5 6024.0 6087.1 3736.9 3802.2 3841.5 3862.6 3876.7 3613.7 3774.2 3940.4 3962.8 3995.5 3797.1 4102.9 4322.4 4403.5 4516.7 4475.8 4617.5 5169.6 5527.9 5840.2 1105.8 1144.7 1164.7 1296.2 1306.6 780.4 804.5 816.7 843.2 877.5 4331.1 4419.5 5025.0 5089.4 5131.3 5007.4 5524.7 5641.7 5642.7 5677.6 4807.7 4847.7 5062.8 5125.4 5161.5 2796.5 2948.8 2973.5 3017.4 3021.7 5884.8 5888.7 5938.5 5939.6 6065.0 5464.4 5770.6 5779.7 5784.2 5866.7 4783.9 5331.9 5964.0 6007.9 6020.6 5237.7 5379.6 5451.7 5683.4 5722.0 4429.5 5476.4 5576.8 5646.3 5820.7 4916.0 4962.3 5206.7 5993.8 6098.1 3248.8 3919.4 3944.2 3944.3 3965.9 5918.2 5940.8 5950.8 5952.8 5959.9 4811.6 5374.6 5456.4 5677.0 5775.3 5274.4 5743.1 5751.0 5752.0 5784.4 5393.7 5615.6 5656.9 5666.5 5669.6 4826.7 5710.7 5717.9 5725.5 5829.0 5632.5 5646.8 5655.8 5659.0 5684.9 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - PROCESS | 2946 | [#5] yui.html Cycles:180 Average:19286.18 Median:44720.50 stddev:27036.37 (60.5%) stddev-sans-first:27076.10 03:52:50 INFO - PROCESS | 2946 | Values: 677.3 693.6 695.9 774.8 791.7 14361.7 14821.3 15250.0 15283.5 15344.8 14117.9 14186.9 14310.2 14315.3 14316.7 894.6 913.0 916.1 918.8 918.8 874.6 902.1 914.4 919.4 920.2 965.9 969.5 970.7 970.9 973.6 951.7 957.7 961.7 964.2 968.1 578.6 672.5 706.0 712.5 719.8 15060.8 15112.5 15287.3 15468.5 15513.1 13720.3 13865.7 13893.8 14098.7 14147.9 11166.2 11270.5 11293.5 11370.3 11664.8 3059.7 3657.3 3670.1 3727.2 3753.5 81212.0 95323.0 95765.5 96411.5 97101.7 10608.3 10634.4 10644.5 10651.5 11003.9 22029.6 22034.2 22039.6 22055.3 22098.0 6194.0 7251.3 7272.6 7278.1 7397.4 4003.6 4026.6 4154.8 4282.9 4311.4 3030.9 3605.1 3654.0 3705.6 3708.6 662.7 686.3 690.5 695.2 695.9 520.3 543.4 546.9 568.7 697.7 8159.5 8627.3 9168.5 9359.5 9728.0 535.0 539.9 580.8 631.0 683.7 4110.1 5057.6 5080.9 5401.2 5567.4 79875.0 93303.5 96692.5 97538.5 100639.5 85092.0 85701.6 88543.1 88701.0 89836.1 66208.0 67496.3 74535.3 74906.9 78971.0 9818.6 10112.8 10505.9 10548.0 10711.4 41709.6 42522.4 44515.4 44925.6 47678.8 58407.0 63840.0 63941.0 67326.7 67485.7 12445.8 12746.7 12842.0 12936.5 13576.5 13869.4 14394.8 14434.6 14447.6 14639.2 12691.4 12971.7 13076.5 13304.6 13515.2 12849.8 13071.2 13109.9 13327.5 13595.7 9352.0 12749.1 12759.3 12953.8 13669.0 10500.9 10518.5 10698.6 11028.9 11489.3 8842.0 9281.9 10423.5 10691.5 10710.8 03:52:50 INFO - PROCESS | 2946 | -------- Summary: end -------- 03:52:50 INFO - PROCESS | 2946 | 03:52:50 INFO - TEST-INFO | 2946: exit 0 03:52:50 INFO - TEST-OK | dromaeo_css | took 1115870ms 03:52:50 INFO - TEST-START | kraken 03:52:50 INFO - operating with platform_type : mac_ 03:52:50 INFO - Initialising browser for kraken test... 03:52:51 INFO - TEST-INFO | started process 2977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp0XTkk4/profile http://localhost:54010/getInfo.html) 03:52:54 INFO - PROCESS | 2977 | 2017-02-15 03:52:54.049 plugin-container[2978:54466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d2f, name = 'com.apple.tsm.portname' 03:52:54 INFO - PROCESS | 2977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:54 INFO - PROCESS | 2977 | 2017-02-15 03:52:54.054 plugin-container[2978:54466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 03:52:54 INFO - PROCESS | 2977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:54 INFO - PROCESS | 2977 | 2017-02-15 03:52:54.054 plugin-container[2978:54466] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:52:54 INFO - PROCESS | 2977 | __metrics Screen width/height:1600/1200 03:52:54 INFO - PROCESS | 2977 | colorDepth:24 03:52:54 INFO - PROCESS | 2977 | Browser inner width/height: 1024/689 03:52:54 INFO - PROCESS | 2977 | __metrics 03:52:54 ERROR - PROCESS | 2977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 03:52:55 INFO - TEST-INFO | 2977: exit 0 03:52:55 INFO - Browser initialized. 03:52:55 INFO - Running cycle 1/1 for kraken test... 03:52:55 INFO - TEST-INFO | started process 2979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp0XTkk4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:57 INFO - PROCESS | 2979 | 2017-02-15 03:52:57.346 plugin-container[2980:54581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 03:52:57 INFO - PROCESS | 2979 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:57 INFO - PROCESS | 2979 | 2017-02-15 03:52:57.346 plugin-container[2980:54581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 03:52:57 INFO - PROCESS | 2979 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:57 INFO - PROCESS | 2979 | 2017-02-15 03:52:57.346 plugin-container[2980:54581] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:53:07 INFO - PROCESS | 2979 | RSS: Main: 234475520 03:53:07 INFO - PROCESS | 2979 | 03:53:10 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54010/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:11 INFO - PROCESS | 2979 | RSS: Main: 247984128 03:53:11 INFO - PROCESS | 2979 | 03:53:13 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54010/tests/kraken/driver.html?testName=audio-dft) 03:53:14 INFO - PROCESS | 2979 | RSS: Main: 255963136 03:53:14 INFO - PROCESS | 2979 | 03:53:17 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54010/tests/kraken/driver.html?testName=audio-fft) 03:53:18 INFO - PROCESS | 2979 | RSS: Main: 258539520 03:53:18 INFO - PROCESS | 2979 | 03:53:20 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54010/tests/kraken/driver.html?testName=audio-oscillator) 03:53:21 INFO - PROCESS | 2979 | RSS: Main: 260829184 03:53:21 INFO - PROCESS | 2979 | 03:53:23 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:23 INFO - PROCESS | 2979 | RSS: Main: 261197824 03:53:23 INFO - PROCESS | 2979 | 03:53:27 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54010/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:27 INFO - PROCESS | 2979 | RSS: Main: 266973184 03:53:27 INFO - PROCESS | 2979 | 03:53:30 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54010/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:31 INFO - PROCESS | 2979 | RSS: Main: 266723328 03:53:31 INFO - PROCESS | 2979 | 03:53:34 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54010/tests/kraken/driver.html?testName=json-parse-financial) 03:53:35 INFO - PROCESS | 2979 | RSS: Main: 266555392 03:53:35 INFO - PROCESS | 2979 | 03:53:36 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:37 INFO - PROCESS | 2979 | RSS: Main: 265564160 03:53:37 INFO - PROCESS | 2979 | 03:53:39 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:40 INFO - PROCESS | 2979 | RSS: Main: 265560064 03:53:40 INFO - PROCESS | 2979 | 03:53:42 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:43 INFO - PROCESS | 2979 | RSS: Main: 265580544 03:53:43 INFO - PROCESS | 2979 | 03:53:46 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:46 INFO - PROCESS | 2979 | RSS: Main: 265940992 03:53:46 INFO - PROCESS | 2979 | 03:53:49 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:50 INFO - PROCESS | 2979 | RSS: Main: 274796544 03:53:50 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:54010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54010/tests/kraken/driver.html?testName=ai-astar) 03:53:52 INFO - PROCESS | 2979 | RSS: Main: 277340160 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | __start_tp_report 03:53:52 INFO - PROCESS | 2979 | _x_x_mozilla_page_load 03:53:52 INFO - PROCESS | 2979 | _x_x_mozilla_page_load_details 03:53:52 INFO - PROCESS | 2979 | |i|pagename|runs| 03:53:52 INFO - PROCESS | 2979 | |0;ai-astar;105;118;117;117;117;116;118;116;118;118 03:53:52 INFO - PROCESS | 2979 | |1;audio-beat-detection;151;137;116;195;144;127;117;122;194;150 03:53:52 INFO - PROCESS | 2979 | |2;audio-dft;205;215;209;221;199;202;223;218;198;201 03:53:52 INFO - PROCESS | 2979 | |3;audio-fft;85;64;53;92;73;86;117;85;78;62 03:53:52 INFO - PROCESS | 2979 | |4;audio-oscillator;91;68;83;70;73;73;86;72;70;76 03:53:52 INFO - PROCESS | 2979 | |5;imaging-gaussian-blur;138;123;88;94;91;94;82;137;90;107 03:53:52 INFO - PROCESS | 2979 | |6;imaging-darkroom;143;154;96;97;129;143;97;149;96;99 03:53:52 INFO - PROCESS | 2979 | |7;imaging-desaturate;90;95;92;95;130;147;128;92;93;93 03:53:52 INFO - PROCESS | 2979 | |8;json-parse-financial;61;63;64;63;63;63;62;63;64;63 03:53:52 INFO - PROCESS | 2979 | |9;json-stringify-tinderbox;81;77;70;78;71;68;70;72;68;106 03:53:52 INFO - PROCESS | 2979 | |10;stanford-crypto-aes;91;86;91;91;89;91;90;88;92;81 03:53:52 INFO - PROCESS | 2979 | |11;stanford-crypto-ccm;146;172;151;158;147;135;150;155;201;171 03:53:52 INFO - PROCESS | 2979 | |12;stanford-crypto-pbkdf2;178;203;213;178;177;175;184;177;181;177 03:53:52 INFO - PROCESS | 2979 | |13;stanford-crypto-sha256-iterative;71;67;71;70;71;75;70;67;65;72 03:53:52 INFO - PROCESS | 2979 | __end_tp_report 03:53:52 INFO - PROCESS | 2979 | __start_cc_report 03:53:52 INFO - PROCESS | 2979 | _x_x_mozilla_cycle_collect,1021 03:53:52 INFO - PROCESS | 2979 | __end_cc_report 03:53:52 INFO - PROCESS | 2979 | __startTimestamp1487159632546__endTimestamp 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | ------- Summary: start ------- 03:53:52 INFO - PROCESS | 2979 | Number of tests: 14 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.50 stddev:3.94 (3.4%) stddev-sans-first:0.83 03:53:52 INFO - PROCESS | 2979 | Values: 105.0 118.0 117.0 117.0 117.0 116.0 118.0 116.0 118.0 118.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:147.00 stddev:28.88 (19.6%) stddev-sans-first:30.55 03:53:52 INFO - PROCESS | 2979 | Values: 151.0 137.0 116.0 195.0 144.0 127.0 117.0 122.0 194.0 150.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#2] audio-dft Cycles:10 Average:209.10 Median:212.00 stddev:9.47 (4.5%) stddev-sans-first:9.93 03:53:52 INFO - PROCESS | 2979 | Values: 205.0 215.0 209.0 221.0 199.0 202.0 223.0 218.0 198.0 201.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#3] audio-fft Cycles:10 Average:79.50 Median:81.50 stddev:18.13 (22.2%) stddev-sans-first:19.12 03:53:52 INFO - PROCESS | 2979 | Values: 85.0 64.0 53.0 92.0 73.0 86.0 117.0 85.0 78.0 62.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:74.50 stddev:7.77 (10.4%) stddev-sans-first:6.13 03:53:52 INFO - PROCESS | 2979 | Values: 91.0 68.0 83.0 70.0 73.0 73.0 86.0 72.0 70.0 76.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:89.00 stddev:20.87 (23.4%) stddev-sans-first:18.25 03:53:52 INFO - PROCESS | 2979 | Values: 138.0 123.0 88.0 94.0 91.0 94.0 82.0 137.0 90.0 107.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#6] imaging-darkroom Cycles:10 Average:120.30 Median:96.00 stddev:25.36 (26.4%) stddev-sans-first:25.53 03:53:52 INFO - PROCESS | 2979 | Values: 143.0 154.0 96.0 97.0 129.0 143.0 97.0 149.0 96.0 99.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:92.50 stddev:20.99 (22.7%) stddev-sans-first:21.50 03:53:52 INFO - PROCESS | 2979 | Values: 90.0 95.0 92.0 95.0 130.0 147.0 128.0 92.0 93.0 93.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.60 03:53:52 INFO - PROCESS | 2979 | Values: 61.0 63.0 64.0 63.0 63.0 63.0 62.0 63.0 64.0 63.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:71.50 stddev:11.41 (16.0%) stddev-sans-first:11.96 03:53:52 INFO - PROCESS | 2979 | Values: 81.0 77.0 70.0 78.0 71.0 68.0 70.0 72.0 68.0 106.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:91.00 stddev:3.33 (3.7%) stddev-sans-first:3.46 03:53:52 INFO - PROCESS | 2979 | Values: 91.0 86.0 91.0 91.0 89.0 91.0 90.0 88.0 92.0 81.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:156.50 stddev:18.64 (11.9%) stddev-sans-first:19.20 03:53:52 INFO - PROCESS | 2979 | Values: 146.0 172.0 151.0 158.0 147.0 135.0 150.0 155.0 201.0 171.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:179.50 stddev:12.95 (7.2%) stddev-sans-first:13.54 03:53:52 INFO - PROCESS | 2979 | Values: 178.0 203.0 213.0 178.0 177.0 175.0 184.0 177.0 181.0 177.0 03:53:52 INFO - PROCESS | 2979 | 03:53:52 INFO - PROCESS | 2979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:71.00 stddev:2.88 (4.1%) stddev-sans-first:3.03 03:53:52 INFO - PROCESS | 2979 | Values: 71.0 67.0 71.0 70.0 71.0 75.0 70.0 67.0 65.0 72.0 03:53:52 INFO - PROCESS | 2979 | -------- Summary: end -------- 03:53:52 INFO - PROCESS | 2979 | 03:53:53 INFO - TEST-INFO | 2979: exit 0 03:53:53 INFO - TEST-OK | kraken | took 62475ms 03:53:53 INFO - SUITE-END | took 1178s 03:53:53 INFO - Completed test suite (00:19:38) 03:53:53 INFO - javascript benchmark 03:53:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7082.599135448644, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.7685961982666, 3319.5684561007065, 3338.3823992561393, 3349.3971085204666, 3353.010861795771, 5460.0, 5688.772449102031, 5695.117256825199, 5748.913766293509, 5751.4248575142465, 4545.772711364435, 5535.667859928397, 5619.325680918296, 5645.040343141676, 5719.513841323493, 5076.289319495274, 5090.083784918713, 5102.795888164469, 5155.5360017598405, 5226.686398816064, 4757.333973243749, 5202.985417843522, 5256.710880901549, 5260.316158899338, 5292.788288468457, 4195.601417865298, 5074.594032477393, 5225.738713064369, 5237.7381130943495, 5246.7901283948595, 4280.357946308048, 5143.614228932807, 5180.352455943007, 5198.9480105198845, 5224.738763061831, 4288.935665965013, 5138.126518491866, 5158.974205128988, 5185.792568297264, 5188.533032027098, 4591.0, 5173.456787037345, 5458.6724796512335, 5536.280283563151, 5611.494965453129, 5161.948380516184, 6229.906551401733, 6238.563300568962, 6242.687865606701, 6245.594036387665, 6168.352323006109, 6183.87632247357, 6192.59748116371, 6198.783042593487, 6204.565680402374, 5627.212190293362, 5664.631798933056, 5670.688112153871, 5866.648001119904, 5920.644761314335, 6132.080177996013, 6137.508999280047, 6145.248604147797, 6165.0444181152, 6212.9068063979075, 5855.0, 5996.040633498619, 6133.028644417026, 6133.242854861876, 6141.025769127022, 4972.378452693413, 6004.849878753066, 6141.393954534099, 6247.937520624827, 6263.060540918807, 5116.437191908887, 6199.876002480015, 6216.689165541705, 6224.844378890564, 6225.221847269091, 5143.022825663112, 5965.13505541694, 6084.11780291864, 6126.754929802847, 6140.8771824563255, 4845.297431872359, 4906.484819094015, 4911.16510193268, 4915.139850526144, 4996.350474438373, 4406.603405693439, 4419.535948725337, 4422.955770442254, 4433.7561434121435, 4469.888252793706, 5725.456081672234, 5739.799107031234, 5740.368559458456, 5740.913886291709, 5758.193852860602, 6105.550726437353, 6108.0, 6115.266168059772, 6118.7410088057595, 6272.937270627326, 5570.442955704397, 5587.608867379326, 5600.0759874620235, 5604.775808967677, 5633.352164501135, 5221.686698798008, 5326.493983071602, 5330.653507521999, 5341.038613049611, 5366.946330536644, 6179.62922224668, 6208.4722798562625, 6230.937690623035, 6252.062190671345, 6273.749050037947, 6152.538559607958, 6272.059191121369, 6274.152989346379, 6276.654783986742, 6294.0, 6212.751489940532, 6246.46905013079, 6264.624122552661, 6277.0, 6284.402981716729, 5918.585699001029, 6102.938970610415, 6174.783882564088, 6182.938170618416, 6233.657148856856, 5068.417132029716, 6144.815655530341, 6164.321924588202, 6172.166757487682, 6193.876122477435, 5969.76120955157, 5980.372060933713, 6121.483458747687, 6133.793750436688, 6138.143176733788, 5809.663777331153, 5871.706414679164, 5872.236609240771, 5919.0, 6133.785317513865, 5652.463016013472, 5709.115087161496, 5768.596198266249, 5881.676507792113, 5900.380460051804, 5059.797608095635, 6114.784027539347, 6123.801220575414, 6131.193168498027, 6132.846678833065, 5953.821385358447, 5954.98765209924, 5971.28344598651, 5976.252968378953, 5985.820425387245], "value": 5583.1027839717235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.23381763552044, 484.9175640141176, 494.3153732081069, 511.3480312601433, 538.3432212700504, 34441.655583444124, 36455.0, 38270.23459530811, 40827.0, 40899.59100408995, 41629.167416651646, 41898.58101418985, 41973.790131049376, 42017.7899110504, 42145.15709685804, 9402.10679985402, 9618.0, 9639.566219520138, 9649.710508684751, 10815.297005694643, 10956.178286628496, 11175.161862860277, 11203.831942520868, 11209.551617935273, 11220.551177952872, 8881.600327985223, 11115.888841111606, 11177.83233251502, 11243.718907027307, 11664.941675291611, 11066.667999960015, 11085.224034317602, 11113.944430277797, 11138.443077846156, 11154.330740155616, 10891.509882055247, 10971.561137554489, 11008.009279164913, 11010.724731881686, 11024.228304018721, 35524.0, 35891.64108358909, 35902.64097359019, 35962.640373596456, 36173.63826361729, 3722.2555488902326, 3723.2739615774935, 3783.2975161177305, 3799.696024318048, 3941.9211615767813, 27073.0, 27508.312292192655, 28026.439471210462, 28126.578101328498, 28128.437431251466, 3037.3014206732573, 3082.7687923405833, 3197.1687361286, 3217.324361884007, 3219.3239419721885, 453973.0, 457266.0, 458813.70593147154, 460807.9999999966, 461936.6903165496, 43984.842122102935, 45102.54897450984, 54542.72728636331, 55105.72447137819, 55310.34068977937, 44411.777941110086, 54619.72690136603, 55000.0, 58525.70737146372, 58599.0, 14276.857231427553, 14356.353964071643, 14481.551844815645, 14507.347169377403, 14516.274186290855, 10897.727556811144, 11188.272762270426, 11197.888021119847, 11214.719632009264, 11223.0, 16835.915820420818, 16932.91533542349, 16940.83059169417, 16964.830351696324, 16987.405440809758, 7500.812479688051, 7561.735339263099, 7571.3942884569105, 7598.734044308423, 7612.982559621704, 709.521073275537, 823.2385043834429, 838.9622466989, 839.9160083991552, 849.3417601358997, 22560.984755686033, 27371.04201352943, 27615.585766213524, 27623.30941726473, 29356.0, 868.3140319147928, 898.2409863665192, 904.8371293167293, 1027.7584767579613, 1030.0420608833706, 10654.840177397346, 12677.112602117762, 13463.326833658279, 14074.296285185905, 14104.788428173586, 591881.0, 601259.0, 613474.0, 613629.0, 837510.0, 51345.0, 51988.74005629947, 52001.47998520042, 52043.0, 52177.95644087173, 1324.8410190777167, 1345.0920628575673, 1363.6113707593486, 1364.3314775759807, 1364.597443754095, 22219.333419997427, 27248.591271131347, 27796.027139050035, 28249.85875070694, 29087.7091229085, 43444.78277608718, 43852.56147438485, 44048.11903761971, 44048.11903761971, 44107.338389923534, 533512.0, 533742.0, 535329.0, 537913.0, 541656.0, 24749.0, 25016.499670006862, 25294.747052529976, 25447.36381590475, 26251.343716407242, 39929.60246391362, 40548.59451405448, 41501.58498414977, 41772.164556708085, 41820.79089604533, 28730.856345718137, 33422.164445889044, 34062.0, 34761.304773904885, 35028.9491315261, 27434.5884811724, 32896.0, 33563.993080207634, 33961.66038339585, 34096.0, 32726.0, 32789.688412463234, 33872.15319617029, 34104.65895341015, 34200.14499637529, 26946.787394566898, 29418.852905735333, 30020.0, 30989.690103099583, 31261.0, 20550.486237844172, 21756.238531651317, 22046.66929996019, 26652.733472665026, 32184.517232241065], "value": 18814.328851880844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3955457059287, 389.5656343177358, 403.73757057912354, 410.28200648864487, 421.917780892012, 19728.802711972876, 21056.473588160305, 21425.678614820772, 21566.0, 21790.128394864187, 19776.703349449734, 20617.07223174957, 20911.745295282293, 21765.564688706258, 22079.0, 5196.636235463509, 5487.2317875497465, 5576.693281869496, 5582.720863956806, 5589.972050139743, 5409.26974858393, 5466.098093814516, 5789.565782566325, 6141.754329826802, 6174.073888916653, 5327.706976116312, 6130.632162070267, 6154.384561543855, 6190.3190649028575, 6201.069839524062, 6011.458968692817, 6031.185789918371, 6114.357992410822, 6145.907811382833, 6150.169727086831, 5304.20436934459, 6032.547558933054, 6034.758609655609, 6048.727807248684, 6050.818475445743, 13043.739125217537, 13498.257595832225, 13631.522896698667, 13679.726405471934, 13714.24571648559, 2302.5740238056014, 2323.8721870297127, 2334.2180369576213, 2340.6137987232087, 2353.176388264111, 9808.215342772632, 9851.852222216672, 9860.556274967643, 10471.952804719544, 10475.0, 1756.350150444331, 1766.2934826069547, 1770.565841668253, 1790.7761529808774, 1825.963480730378, 122163.0, 125051.37474312661, 129565.0, 138636.0, 139235.0, 11681.649550513499, 11853.288802671867, 11988.100892432927, 12018.759624807455, 12192.939035304944, 15698.0, 15715.842841571666, 15756.448524301824, 15822.920885395499, 15834.60413489672, 8252.133525979805, 8463.35815134834, 8466.153384661484, 8495.702650407206, 8552.828943421222, 8034.758957231293, 8079.636416361278, 8219.219174178443, 8269.255766981001, 8285.42002059862, 4638.721676699409, 4756.5956893664425, 4840.298156767249, 4849.927251091166, 4923.556879880756, 1791.7312403139633, 2063.3500447359033, 2072.927447539329, 2076.0, 2079.677649964258, 812.7236739508477, 833.9874901876477, 835.3317346123077, 844.8394804987033, 855.3841234311286, 20144.59710805776, 20543.794562054187, 20691.27580534674, 20772.322208631656, 20918.0, 829.9708361631533, 862.5169904853302, 866.0, 885.8051228729669, 892.5314210039782, 6326.145970294044, 6417.6149431033355, 6487.3836985486305, 6493.155889734398, 6608.8347791305605, 615480.0, 623803.9766619797, 628561.0, 643474.0, 644540.0, 131647.68352316547, 141995.29002354923, 143321.0, 148399.0, 163745.0, 1009.8131845608586, 1034.4879284753945, 1065.3661071662348, 1066.568039943824, 1068.408071972755, 15819.209039548206, 19285.807141928963, 19513.902430487757, 19591.60816783628, 19618.60762784765, 45394.0, 45654.0, 57934.4206557929, 58511.0, 61891.0, 74117.88823167764, 75835.62082189554, 81790.18209818064, 82122.0, 85279.2944141126, 7001.809692352211, 8108.513489190667, 8199.754007379788, 8559.786005349666, 8707.476191666306, 9338.626454941998, 10013.39919604826, 11701.590444334408, 11770.58802941893, 13551.72896542044, 9922.652707155215, 11132.387718675227, 11397.943010284895, 11614.825777613512, 11659.008984236096, 10907.727306817393, 11044.889551104387, 11086.390248536409, 11489.655310340702, 11561.826572601585, 11143.665690029313, 11335.319880807177, 11627.709307267385, 11768.293902365886, 11872.465739041936, 8161.102278749214, 8186.631601578062, 8277.875831862648, 8567.957160214159, 8635.093315201813, 10161.187105031431, 10961.177911656498, 10994.0, 11284.266522676, 11375.829362559734], "value": 9388.376568827378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.585420228134, 1433.734759069572, 1449.5361484325012, 1456.4538298138198, 1456.5557504960982, 8112.432129750912, 8324.791880202998, 8505.957470212641, 8557.10150434204, 8570.400071994964, 8456.577171141449, 8628.266597339218, 8640.481571105722, 8662.480251184934, 8666.956665216665, 2170.522485053286, 2214.4795972946345, 2221.577900198965, 2222.4442889977, 2230.5761905237955, 2043.3257025181729, 2069.8719198037106, 2183.667962542848, 2221.4557433428754, 2224.2993457061057, 2267.6598510223516, 2271.1937262271904, 2283.086765293879, 2295.3228797504776, 2299.1493147535434, 2202.50443650179, 2258.7402448718362, 2284.7144106986543, 2285.954280914389, 2291.644795056769, 1946.221511395439, 2031.3499680102373, 2279.2136712834044, 2281.703378560793, 2321.6749655048307, 7708.61456927157, 8154.184581541857, 8288.544130072843, 8505.872411913826, 8622.094680058566, 5102.719350435725, 5251.842444726664, 5267.920981185285, 5269.604779641542, 5292.391374991848, 3437.5187473753695, 3447.7414193935306, 3465.480177973299, 3522.6301238370115, 3542.5926018507944, 1102.8365074846033, 1204.5482943896038, 1221.5663439478947, 1232.5994051933158, 1249.5126900508808, 10746.462676866126, 10801.67594972152, 10821.0, 10906.781864362669, 10920.945395273053, 4108.589141085928, 4391.363252328394, 4459.955400446019, 4493.573110554492, 4505.954940450553, 7779.688812447552, 8758.036615972238, 8780.956095219482, 8810.603522841488, 8816.691415800417, 5078.644494885322, 5080.085584594734, 5087.313212716236, 5094.083065048327, 5097.617678674114, 4538.0, 4595.6783025187915, 4710.974032434625, 4716.693414928019, 4783.904321913542, 3606.6573675500786, 3667.1932174921476, 3685.7051435885064, 3693.1874987502706, 3761.605031471711, 1137.056243318044, 1138.5957984915235, 1146.4095990564865, 1155.3876445483907, 1157.7973854575416, 707.2962402409636, 784.9136594974548, 790.8141586727114, 817.1256755271802, 824.381713714714, 5250.343707036621, 5476.644018138808, 5592.5805564582815, 5642.520385767256, 5680.971595141998, 460.5923757474659, 549.5905550365004, 558.7513556467414, 573.6615396915756, 581.1312088427743, 3096.8296743679316, 3530.675996501312, 3781.262653782541, 3817.4464702617965, 3824.7896365700153, 9038.276937844958, 9395.765105872408, 9411.717648470556, 9522.381045232176, 9877.259205559612, 9846.704598862045, 9930.2055835533, 10060.647877324258, 10062.798744025225, 10073.546690398949, 7680.5391676499585, 7911.723089691948, 7927.286544211049, 7928.365730741527, 7939.920600794034, 5246.737663116905, 5692.6299790513485, 5718.742656580381, 5747.195392645117, 5825.592208545361, 8863.512506811929, 9289.814203716023, 9292.39599426035, 9292.72121836346, 9303.348765586345, 8962.910370896469, 9310.487923164292, 9359.625614975324, 9441.0, 9443.669471568463, 7185.568865868065, 7303.963480182565, 7305.853882922418, 7343.8531229376185, 7354.816129596803, 7886.132525422085, 7899.289063984269, 7940.444168908121, 7944.0, 7949.8410031797885, 6980.511364204457, 7118.928810711826, 7160.534565253241, 7201.675924583302, 7250.166230883516, 6854.760083397057, 7021.192562855337, 7030.050943122613, 7041.436685065285, 7105.786826395217, 6287.402696743802, 6341.207349081365, 6384.233891932998, 6447.387498187664, 6452.741890324334, 4392.0, 4773.928391074067, 4911.8280860169725, 4980.925286120639, 5117.078925793393, 4888.926666100083, 5035.5468007878, 5069.112905241642, 5086.567641750345, 5141.177411614124], "value": 4287.98090024069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.45320688794607, 364.2823637434254, 366.24918916221736, 370.65529057976073, 374.9981250093749, 4888.584470320023, 4999.850004499862, 5454.854480559083, 5458.399576046631, 5481.671099734019, 4076.3274059780174, 4536.977315113428, 5165.096108181072, 5247.212918062283, 5438.945610543893, 3545.050222377695, 3815.6947444204466, 4007.8797636070963, 4036.5963403659694, 4086.8160932758096, 3667.7065834733157, 3767.60440153784, 4011.378236373352, 4048.0, 4048.643704359043, 4010.7767131025025, 4024.1951609678035, 4030.9395359069636, 4038.394240863879, 4054.797260136996, 3834.654881060718, 3911.357229963422, 3941.5861334559745, 4044.8179831907487, 4049.7975101244965, 3027.0, 3422.401079811048, 3446.2590543033366, 3480.7737497062863, 3483.220705534498, 4250.447441832573, 5089.898202035939, 5161.845144645667, 5173.534381905646, 5213.556847667953, 4577.565131312554, 4617.284320930261, 4619.72281663098, 4640.257558790578, 4649.953500464986, 5003.724795136266, 5314.492434992886, 5440.972795136038, 5628.690422026787, 5830.3586605473365, 3328.7004169624606, 3878.2437424702193, 3925.941110883339, 3926.8429262829454, 3944.644981951609, 5447.855950250452, 5580.91628625571, 5716.485516303553, 6023.975924092914, 6087.078202462799, 3736.9439458408146, 3802.186382077243, 3841.519810023747, 3862.5944275851193, 3876.651101400831, 3613.674769270778, 3774.169682669863, 3940.4286378474962, 3962.7517332040316, 3995.5005624296964, 3797.145642230476, 4102.856400025985, 4322.37325587788, 4403.493598236179, 4516.706414083074, 4475.79980314077, 4617.538246175355, 5169.612279079084, 5527.866787308592, 5840.153177789197, 1105.834124881258, 1144.673767976123, 1164.714644911985, 1296.1704509114174, 1306.6276111308232, 780.434185215714, 804.4770898915751, 816.7100679258897, 843.20317300152, 877.4866702978829, 4331.1337732453, 4419.513853476115, 5025.045241404122, 5089.440161582223, 5131.2559678846355, 5007.37407824022, 5524.7348587079105, 5641.746121424464, 5642.6614403135945, 5677.602567820296, 4807.711537307703, 4847.745798203852, 5062.848114556569, 5125.436202017775, 5161.509656582619, 2796.45469133517, 2948.7935844491108, 2973.4796410628055, 3017.366353065881, 3021.6525099613386, 5884.764609415661, 5888.705564721832, 5938.465538101592, 5939.584229103922, 6065.0, 5464.398916119224, 5770.615052387397, 5779.682117483495, 5784.1902133701315, 5866.70666466675, 4783.851875549913, 5331.920021199685, 5964.0, 6007.918574656516, 6020.638761674313, 5237.711925844115, 5379.552303701885, 5451.672899626035, 5683.374828768915, 5721.997300944636, 4429.512753597037, 5476.424975377528, 5576.828865938199, 5646.265985421869, 5820.708964551671, 4916.0, 4962.330085438564, 5206.713630750345, 5993.760249590142, 6098.115773212948, 3248.78882872622, 3919.431682406092, 3944.2308749793515, 3944.329463991071, 3965.940510892281, 5918.201042859159, 5940.762369505344, 5950.750342427966, 5952.76188952437, 5959.940400595939, 4811.591014763784, 5374.623776335776, 5456.40820610207, 5677.0, 5775.306963164448, 5274.393444753749, 5743.1385292206505, 5750.9712451439145, 5752.0, 5784.363719990713, 5393.67637941709, 5615.578831587565, 5656.886862262814, 5666.46168613981, 5669.603127781016, 4826.734529600905, 5710.65736055838, 5717.942820571741, 5725.513331366714, 5829.0, 5632.464915832989, 5646.830595082154, 5655.773769049357, 5659.047628568137, 5684.9431505684415], "value": 4080.527976879338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.3226773226774, 693.6219760230674, 695.9164900211975, 774.8295375017494, 791.7466410748561, 14361.712765744693, 14821.333040013198, 15250.0, 15283.541493755178, 15344.769828452581, 14117.858821411783, 14186.92906535466, 14310.21293828839, 14315.284235788222, 14316.71366572668, 894.552723638181, 912.9634814607408, 916.1434059154678, 918.8162367526488, 918.8483900156466, 874.6107981948036, 902.1249388093571, 914.4010673009157, 919.4437365393941, 920.2316066084827, 965.9275554333453, 969.4764826993415, 970.7281961050882, 970.9271804614647, 973.6251543155865, 951.6526467839258, 957.7174733453578, 961.725908116187, 964.2093483343662, 968.0609808485758, 578.5689661202431, 672.4821887146869, 705.9964700176466, 712.5154894671621, 719.784064780569, 15060.774088388684, 15112.5466236012, 15287.312070956723, 15468.5359439217, 15513.146776927264, 13720.313984300745, 13865.722685546334, 13893.802240488345, 14098.71802563943, 14147.929260353736, 11166.218364714474, 11270.549178032868, 11293.491792869258, 11370.31778093317, 11664.825027624593, 3059.7413754351546, 3657.2868290683327, 3670.137517683342, 3727.1613886875507, 3753.512043434336, 81212.0, 95323.0, 95765.5211723944, 96411.51794241054, 97101.71737119673, 10608.257421980541, 10634.415107169025, 10644.467776611138, 10651.467426628638, 11003.889961100447, 22029.559408811732, 22034.228801991852, 22039.559208815735, 22055.33833984983, 22098.0, 6194.039923811816, 7251.311125443074, 7272.63636818157, 7278.1266248049515, 7397.445191610651, 4003.559608443069, 4026.57720939303, 4154.813033413504, 4282.89292767677, 4311.353297005474, 3030.8939187128785, 3605.0987253186704, 3654.031681604377, 3705.5923848376656, 3708.610595887447, 662.7216569041015, 686.3411125319749, 690.5338896245115, 695.1935754524727, 695.8608278344351, 520.3365708721335, 543.3545462643141, 546.8988237176135, 568.687222027883, 697.7313734212365, 8159.46963447374, 8627.329533818473, 9168.495732734631, 9359.532023398802, 9728.0, 534.9946500534945, 539.881919404044, 580.7822066724979, 631.0439683878927, 683.733343995842, 4110.116324990141, 5057.645964782503, 5080.949190508121, 5401.189821526802, 5567.387587365387, 79875.0, 93303.53348233216, 96692.51653741686, 97538.51230743801, 100639.49680251552, 85092.0, 85701.57149214338, 88543.11456885349, 88701.0, 89836.10163898408, 66208.0, 67496.32503674901, 74535.25464745391, 74906.87639685409, 78971.0, 9818.607255709692, 10112.848307275544, 10505.9474702626, 10548.0, 10711.41087240178, 41709.58290417057, 42522.36216456694, 44515.44195953256, 44925.55074449344, 47678.76160619175, 58407.0, 63840.0, 63941.0, 67326.66336668286, 67485.66257168683, 12445.813312800134, 12746.745065098461, 12842.0, 12936.506357323178, 13576.524821631196, 13869.411706201445, 14394.784078238625, 14434.566962991126, 14447.566573002827, 14639.194844283667, 12691.428885699981, 12971.675708107372, 13076.476940922257, 13304.600861974157, 13515.189088654712, 12849.807252891027, 13071.215727056408, 13109.934748279382, 13327.533536326182, 13595.660108497366, 9351.953240233755, 12749.107562470908, 12759.299399556667, 12953.805692914426, 13669.0, 10500.896235809478, 10518.474076296001, 10698.62554810578, 11028.944855275673, 11489.310641361544, 8842.0, 9281.86077208856, 10423.530941107516, 10691.465426728788, 10710.839337409789], "value": 7314.516491037499, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 118.0, 118.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 137.0, 116.0, 195.0, 144.0, 127.0, 117.0, 122.0, 194.0, 150.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 215.0, 209.0, 221.0, 199.0, 202.0, 223.0, 218.0, 198.0, 201.0], "value": 209.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 53.0, 92.0, 73.0, 86.0, 117.0, 85.0, 78.0, 62.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 83.0, 70.0, 73.0, 73.0, 86.0, 72.0, 70.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 123.0, 88.0, 94.0, 91.0, 94.0, 82.0, 137.0, 90.0, 107.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 154.0, 96.0, 97.0, 129.0, 143.0, 97.0, 149.0, 96.0, 99.0], "value": 120.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 92.0, 95.0, 130.0, 147.0, 128.0, 92.0, 93.0, 93.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 70.0, 78.0, 71.0, 68.0, 70.0, 72.0, 68.0, 106.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 91.0, 91.0, 89.0, 91.0, 90.0, 88.0, 92.0, 81.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 172.0, 151.0, 158.0, 147.0, 135.0, 150.0, 155.0, 201.0, 171.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 203.0, 213.0, 178.0, 177.0, 175.0, 184.0, 177.0, 181.0, 177.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 71.0, 70.0, 71.0, 75.0, 70.0, 67.0, 65.0, 72.0], "value": 69.9, "unit": "score"}]}]} 03:53:53 INFO - Return code: 0 03:53:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:53 ERROR - # TBPL SUCCESS # 03:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:53:53 INFO - 2017-02-15 03:53:53.895 screenresolution[2984:54986] starting screenresolution argv=screenresolution get 03:53:53 INFO - 2017-02-15 03:53:53.898 screenresolution[2984:54986] Display 0: 1600x1200x32@60 03:53:53 INFO - 2017-02-15 03:53:53.904 screenresolution[2985:54989] starting screenresolution argv=screenresolution list 03:53:53 INFO - Available Modes on Display 0 03:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:53:54 INFO - Intel Iris: 03:53:54 INFO - Chipset Model: Intel Iris 03:53:54 INFO - Type: GPU 03:53:54 INFO - Bus: Built-In 03:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 03:53:54 INFO - Vendor: Intel (0x8086) 03:53:54 INFO - Device ID: 0x0a2e 03:53:54 INFO - Revision ID: 0x0009 03:53:54 INFO - Displays: 03:53:54 INFO - Display: 03:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:53:54 INFO - Display Serial Number: 1600x1200 60 03:53:54 INFO - Main Display: Yes 03:53:54 INFO - Mirror: Off 03:53:54 INFO - Online: Yes 03:53:54 INFO - Rotation: Supported 03:53:54 INFO - Return code: 0 03:53:54 INFO - Running post-action listener: _resource_record_post_action 03:53:54 INFO - [mozharness: 2017-02-15 11:53:54.138387Z] Finished run-tests step (success) 03:53:54 INFO - Running post-run listener: _resource_record_post_run 03:53:54 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 184320; Write bytes: 557600768; Read time: 4; Write time: 1719 03:53:54 INFO - TinderboxPrint: CPU usage
54.6% 03:53:54 INFO - TinderboxPrint: I/O read bytes / time
184,320 / 4 03:53:54 INFO - TinderboxPrint: I/O write bytes / time
557,600,768 / 1,719 03:53:54 INFO - TinderboxPrint: CPU idle
2,180.5 (45.4%) 03:53:54 INFO - TinderboxPrint: CPU system
970.1 (20.2%) 03:53:54 INFO - TinderboxPrint: CPU user
1,655.1 (34.4%) 03:53:54 INFO - TinderboxPrint: Swap in / out
252,391,424 / 0 03:53:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247048704; Write bytes: 239632384; Read time: 17844; Write time: 521 03:53:54 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 184320; Write bytes: 302505984; Read time: 4; Write time: 1151 03:53:54 INFO - Running post-run listener: _upload_blobber_files 03:53:54 INFO - Blob upload gear active. 03:53:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:54 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 03:53:54 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'] 03:53:54 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 03:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:56 INFO - (blobuploader) - INFO - Done attempting. 03:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:57 INFO - (blobuploader) - INFO - Done attempting. 03:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:58 INFO - (blobuploader) - INFO - Done attempting. 03:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:00 INFO - (blobuploader) - INFO - Done attempting. 03:54:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:00 INFO - Return code: 0 03:54:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4be27118c51ecb21b331b5df57b757c130d164b3ec62d9333dde4a38c42213cbef80f085a8ba86b6c463bc418856566421caf0a653566ffc4549a12bfcc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/959ad71627ff1badbcaa7407ef7386e51d90b544051650881db78e0b30e6c439d0dbff84c854f47438206e45caf612b1b56f24a779453817d9070b45738a50c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70d5c3fed6f7f82ac76e2de4a9d87bb095ece530ab5ec4ced8b2b35986792398952e50596e199f2bef20b9b1c960390b971763c5e64a604b47c545a0febd2ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6807a51f2bc79eb7dc128928f5c5c1119aae4ef82c7453de528b2275d9b37b2056925fc090c8857737eee702007916b30c4061d61be7823084cc05cb17eac27"} 03:54:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:00 INFO - Contents: 03:54:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4be27118c51ecb21b331b5df57b757c130d164b3ec62d9333dde4a38c42213cbef80f085a8ba86b6c463bc418856566421caf0a653566ffc4549a12bfcc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/959ad71627ff1badbcaa7407ef7386e51d90b544051650881db78e0b30e6c439d0dbff84c854f47438206e45caf612b1b56f24a779453817d9070b45738a50c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70d5c3fed6f7f82ac76e2de4a9d87bb095ece530ab5ec4ced8b2b35986792398952e50596e199f2bef20b9b1c960390b971763c5e64a604b47c545a0febd2ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6807a51f2bc79eb7dc128928f5c5c1119aae4ef82c7453de528b2275d9b37b2056925fc090c8857737eee702007916b30c4061d61be7823084cc05cb17eac27"} 03:54:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:00 INFO - Copying logs to upload dir... 03:54:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.443331 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-02-15 03:54:00.675306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:54:00.679068) ========= 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.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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/26a4be27118c51ecb21b331b5df57b757c130d164b3ec62d9333dde4a38c42213cbef80f085a8ba86b6c463bc418856566421caf0a653566ffc4549a12bfcc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/959ad71627ff1badbcaa7407ef7386e51d90b544051650881db78e0b30e6c439d0dbff84c854f47438206e45caf612b1b56f24a779453817d9070b45738a50c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70d5c3fed6f7f82ac76e2de4a9d87bb095ece530ab5ec4ced8b2b35986792398952e50596e199f2bef20b9b1c960390b971763c5e64a604b47c545a0febd2ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6807a51f2bc79eb7dc128928f5c5c1119aae4ef82c7453de528b2275d9b37b2056925fc090c8857737eee702007916b30c4061d61be7823084cc05cb17eac27"} build_url:https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/QhyCKAIlRcKAgqiUM1hNzw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4be27118c51ecb21b331b5df57b757c130d164b3ec62d9333dde4a38c42213cbef80f085a8ba86b6c463bc418856566421caf0a653566ffc4549a12bfcc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/959ad71627ff1badbcaa7407ef7386e51d90b544051650881db78e0b30e6c439d0dbff84c854f47438206e45caf612b1b56f24a779453817d9070b45738a50c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a70d5c3fed6f7f82ac76e2de4a9d87bb095ece530ab5ec4ced8b2b35986792398952e50596e199f2bef20b9b1c960390b971763c5e64a604b47c545a0febd2ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6807a51f2bc79eb7dc128928f5c5c1119aae4ef82c7453de528b2275d9b37b2056925fc090c8857737eee702007916b30c4061d61be7823084cc05cb17eac27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:54:00.713335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:54:00.713671) ========= 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.FwP1tgp8wR/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.u1KszpjMsh/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.005362 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:54:00.762572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:54:00.762975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:54:00.763296) ========= ========= Total master_lag: 0.18 =========