builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0034 starttime: 1493380710.78 results: success (0) buildid: 20170428030259 builduid: 12650e0f1d8d4dbe87c2b73c4d934ad0 revision: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.779550) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.779962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.780247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.808057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.808417) ========= 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.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 04:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2017-04-28 04:58:30 (15.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139671 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.974051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:30.974401) ========= 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.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.037994 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:31.035606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 04:58:31.035959) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 --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 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 04:58:31,134 truncating revision to first 12 chars 2017-04-28 04:58:31,134 Setting DEBUG logging. 2017-04-28 04:58:31,134 attempt 1/10 2017-04-28 04:58:31,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/84762dbeb538?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 04:58:31,838 unpacking tar archive at: mozilla-central-84762dbeb538/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 04:58:32.393319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:32.393639) ========= script_repo_revision: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:32.394031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:32.394314) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 04:58:32.415667) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-28 04:58:32.416024) ========= /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.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:58:32 INFO - MultiFileLogger online at 20170428 04:58:32 in /builds/slave/test 04:58:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:58:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:58:32 INFO - {'append_to_log': False, 04:58:32 INFO - 'base_work_dir': '/builds/slave/test', 04:58:32 INFO - 'blob_upload_branch': 'Firefox', 04:58:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:58:32 INFO - 'branch': 'Firefox', 04:58:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:58:32 INFO - 'config_files': ('talos/mac_config.py',), 04:58:32 INFO - 'default_actions': ('clobber', 04:58:32 INFO - 'read-buildbot-config', 04:58:32 INFO - 'download-and-extract', 04:58:32 INFO - 'populate-webroot', 04:58:32 INFO - 'create-virtualenv', 04:58:32 INFO - 'install', 04:58:32 INFO - 'run-tests'), 04:58:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:58:32 INFO - 'download_minidump_stackwalk': True, 04:58:32 INFO - 'download_symbols': 'ondemand', 04:58:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:58:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:58:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:58:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:58:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:58:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:58:32 INFO - 'gecko_profile': False, 04:58:32 INFO - 'gecko_profile_interval': 0, 04:58:32 INFO - 'installer_path': 'installer.exe', 04:58:32 INFO - 'log_level': 'info', 04:58:32 INFO - 'log_name': 'talos', 04:58:32 INFO - 'log_to_console': True, 04:58:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:58:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:58:32 INFO - 'opt_config_files': (), 04:58:32 INFO - 'pip_index': False, 04:58:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:58:32 INFO - 'cmd': ('bash', 04:58:32 INFO - '-c', 04:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:58:32 INFO - 'enabled': True, 04:58:32 INFO - 'halt_on_failure': False, 04:58:32 INFO - 'name': 'check_screen_resolution'},), 04:58:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:58:32 INFO - 'cmd': ('bash', 04:58:32 INFO - '-c', 04:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:58:32 INFO - 'enabled': True, 04:58:32 INFO - 'halt_on_failure': False, 04:58:32 INFO - 'name': 'check_screen_resolution'},), 04:58:32 INFO - 'run_cmd_checks_enabled': True, 04:58:32 INFO - 'suite': 'dromaeojs-e10s', 04:58:32 INFO - 'system_bits': '32', 04:58:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:58:32 INFO - 'title': 't-yosemite-r7-0034', 04:58:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:58:32 INFO - 'use_talos_json': True, 04:58:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:58:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:58:32 INFO - 'work_dir': 'build'} 04:58:32 INFO - [mozharness: 2017-04-28 11:58:32.636737Z] Running clobber step. 04:58:32 INFO - Running pre-action listener: _resource_record_pre_action 04:58:32 INFO - Running main action method: clobber 04:58:32 INFO - rmtree: /builds/slave/test/build 04:58:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:58:37 INFO - Running post-action listener: _resource_record_post_action 04:58:37 INFO - [mozharness: 2017-04-28 11:58:37.444368Z] Finished clobber step (success) 04:58:37 INFO - [mozharness: 2017-04-28 11:58:37.444560Z] Running read-buildbot-config step. 04:58:37 INFO - Running pre-action listener: _resource_record_pre_action 04:58:37 INFO - Running main action method: read_buildbot_config 04:58:37 INFO - Using buildbot properties: 04:58:37 INFO - { 04:58:37 INFO - "project": "", 04:58:37 INFO - "product": "firefox", 04:58:37 INFO - "script_repo_revision": "production", 04:58:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:58:37 INFO - "repository": "", 04:58:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:58:37 INFO - "buildid": "20170428030259", 04:58:37 INFO - "stage_platform": "macosx64", 04:58:37 INFO - "basedir": "/builds/slave/test", 04:58:37 INFO - "nightly_build": "True", 04:58:37 INFO - "buildnumber": 16, 04:58:37 INFO - "slavename": "t-yosemite-r7-0034", 04:58:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:58:37 INFO - "platform": "yosemite_r7", 04:58:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:58:37 INFO - "branch": "mozilla-central", 04:58:37 INFO - "repo_path": "mozilla-central", 04:58:37 INFO - "revision": "84762dbeb5380461fe27f0afa0e27e8ba9dd3b01", 04:58:37 INFO - "pgo_build": "False", 04:58:37 INFO - "builduid": "12650e0f1d8d4dbe87c2b73c4d934ad0", 04:58:37 INFO - "slavebuilddir": "test" 04:58:37 INFO - } 04:58:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:58:37 INFO - Running post-action listener: _resource_record_post_action 04:58:37 INFO - [mozharness: 2017-04-28 11:58:37.447991Z] Finished read-buildbot-config step (success) 04:58:37 INFO - [mozharness: 2017-04-28 11:58:37.448160Z] Running download-and-extract step. 04:58:37 INFO - Running pre-action listener: _resource_record_pre_action 04:58:37 INFO - Running main action method: download_and_extract 04:58:37 INFO - mkdir: /builds/slave/test/build/tests 04:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:37 INFO - trying https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:58:37 INFO - Downloading https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:58:38 INFO - Downloaded 1325 bytes. 04:58:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:58:38 INFO - Using the following test package requirements: 04:58:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:58:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:58:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:58:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:58:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'jsshell-mac.zip'], 04:58:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:58:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:58:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:58:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:58:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:58:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:58:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:58:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:58:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:58:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:58:38 INFO - Fetch https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:58:39 INFO - Content-Length response header: 52695336 04:58:39 INFO - Bytes received: 52695336 04:58:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:58:58 INFO - Content-Length response header: 52695336 04:58:58 INFO - Bytes received: 52695336 04:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:59:15 INFO - Content-Length response header: 14408809 04:59:15 INFO - Bytes received: 14408809 04:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:16 INFO - trying https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:59:16 INFO - Downloading https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:59:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:59:18 INFO - Downloaded 71301083 bytes. 04:59:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:59:18 INFO - mkdir: /builds/slave/test/properties 04:59:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:59:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:59:18 INFO - Contents: 04:59:18 INFO - build_url:https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - Running post-action listener: set_extra_try_arguments 04:59:19 INFO - [mozharness: 2017-04-28 11:59:19.625777Z] Finished download-and-extract step (success) 04:59:19 INFO - [mozharness: 2017-04-28 11:59:19.625902Z] Running populate-webroot step. 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: populate_webroot 04:59:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:19 INFO - '--tppagecycles', 04:59:19 INFO - '7'], 04:59:19 INFO - 'tests': ['tsvgm']}}, 04:59:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:59:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:59:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['damp', 'tps']}, 04:59:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'tests': ['damp', 'tps']}, 04:59:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['dromaeo_dom']}, 04:59:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:59:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:59:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['a11yr', 04:59:19 INFO - 'ts_paint', 04:59:19 INFO - 'tpaint', 04:59:19 INFO - 'sessionrestore', 04:59:19 INFO - 'sessionrestore_no_auto_restore', 04:59:19 INFO - 'tabpaint']}, 04:59:19 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:59:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:59:19 INFO - 'bloom_basic_ref']}, 04:59:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['tsvgx', 04:59:19 INFO - 'tsvgr_opacity', 04:59:19 INFO - 'tart', 04:59:19 INFO - 'tscrollx', 04:59:19 INFO - 'cart', 04:59:19 INFO - 'tsvg_static']}, 04:59:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:59:19 INFO - 'tsvgr_opacity', 04:59:19 INFO - 'tart', 04:59:19 INFO - 'tscrollx', 04:59:19 INFO - 'cart', 04:59:19 INFO - 'tsvg_static']}, 04:59:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'talos_options': ['--disable-e10s'], 04:59:19 INFO - 'tests': ['tp5o']}, 04:59:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:59:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'talos_options': ['--disable-e10s', 04:59:19 INFO - '--xperf_path', 04:59:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:19 INFO - 'tests': ['tp5n']}, 04:59:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:59:19 INFO - 'talos_options': ['--xperf_path', 04:59:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:19 INFO - 'tests': ['tp5n']}}, 04:59:19 INFO - 'talos.zip': {'path': '', 04:59:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:19 INFO - Running post-action listener: _resource_record_post_action 04:59:19 INFO - [mozharness: 2017-04-28 11:59:19.645627Z] Finished populate-webroot step (success) 04:59:19 INFO - [mozharness: 2017-04-28 11:59:19.645747Z] Running create-virtualenv step. 04:59:19 INFO - Running pre-action listener: _resource_record_pre_action 04:59:19 INFO - Running main action method: create_virtualenv 04:59:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:59: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 04:59:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:59:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:19 INFO - Using real prefix '/tools/python27' 04:59:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:59:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:23 INFO - Installing pip.................done. 04:59:23 INFO - Return code: 0 04:59:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:59:23 INFO - Reading from file tmpfile_stdout 04:59:23 INFO - Output received: 04:59: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) 04:59:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:59: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')]} 04:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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')]} 04:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59: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 04:59: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 04:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:23 INFO - 'HOME': '/Users/cltbld', 04:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:23 INFO - 'LOGNAME': 'cltbld', 04:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:23 INFO - 'MOZ_NO_REMOTE': '1', 04:59:23 INFO - 'NO_EM_RESTART': '1', 04:59:23 INFO - 'PAGER': '/bin/cat', 04:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:23 INFO - 'PWD': '/builds/slave/test', 04:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:23 INFO - 'SHELL': '/bin/bash', 04:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:23 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:23 INFO - 'USER': 'cltbld', 04:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:23 INFO - 'XPC_FLAGS': '0x0', 04:59:23 INFO - 'XPC_SERVICE_NAME': '0', 04:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:59:24 INFO - Cleaning up... 04:59:24 INFO - Return code: 0 04:59:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:24 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:24 INFO - 'HOME': '/Users/cltbld', 04:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:24 INFO - 'LOGNAME': 'cltbld', 04:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:24 INFO - 'MOZ_NO_REMOTE': '1', 04:59:24 INFO - 'NO_EM_RESTART': '1', 04:59:24 INFO - 'PAGER': '/bin/cat', 04:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:24 INFO - 'PWD': '/builds/slave/test', 04:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:24 INFO - 'SHELL': '/bin/bash', 04:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:24 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:24 INFO - 'USER': 'cltbld', 04:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:24 INFO - 'XPC_FLAGS': '0x0', 04:59:24 INFO - 'XPC_SERVICE_NAME': '0', 04:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:24 INFO - Downloading/unpacking psutil>=3.1.1 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:27 INFO - Installing collected packages: psutil 04:59:27 INFO - Running setup.py install for psutil 04:59:28 INFO - building 'psutil._psutil_osx' extension 04:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:59:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:59:28 INFO - building 'psutil._psutil_posix' extension 04:59:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:59:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:59:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:59:29 INFO - ^ 04:59:29 INFO - 1 warning generated. 04:59:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:29 INFO - Successfully installed psutil 04:59:29 INFO - Cleaning up... 04:59:29 INFO - Return code: 0 04:59:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:30 INFO - 'HOME': '/Users/cltbld', 04:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:30 INFO - 'LOGNAME': 'cltbld', 04:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:30 INFO - 'MOZ_NO_REMOTE': '1', 04:59:30 INFO - 'NO_EM_RESTART': '1', 04:59:30 INFO - 'PAGER': '/bin/cat', 04:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:30 INFO - 'PWD': '/builds/slave/test', 04:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:30 INFO - 'SHELL': '/bin/bash', 04:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:30 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:30 INFO - 'USER': 'cltbld', 04:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:30 INFO - 'XPC_FLAGS': '0x0', 04:59:30 INFO - 'XPC_SERVICE_NAME': '0', 04:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:59:33 INFO - Installing collected packages: mozsystemmonitor 04:59:33 INFO - Running setup.py install for mozsystemmonitor 04:59:33 INFO - Successfully installed mozsystemmonitor 04:59:33 INFO - Cleaning up... 04:59:33 INFO - Return code: 0 04:59:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:33 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:33 INFO - 'HOME': '/Users/cltbld', 04:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:33 INFO - 'LOGNAME': 'cltbld', 04:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:33 INFO - 'MOZ_NO_REMOTE': '1', 04:59:33 INFO - 'NO_EM_RESTART': '1', 04:59:33 INFO - 'PAGER': '/bin/cat', 04:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:33 INFO - 'PWD': '/builds/slave/test', 04:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:33 INFO - 'SHELL': '/bin/bash', 04:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:33 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:33 INFO - 'USER': 'cltbld', 04:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:33 INFO - 'XPC_FLAGS': '0x0', 04:59:33 INFO - 'XPC_SERVICE_NAME': '0', 04:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:33 INFO - Downloading/unpacking jsonschema==2.5.1 04:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:59:36 INFO - warning: no files found matching '*.txt' 04:59:36 INFO - no previously-included directories found matching 'build' 04:59:36 INFO - no previously-included directories found matching 'dist' 04:59:36 INFO - no previously-included directories found matching '.git*' 04:59:36 INFO - Installing collected packages: jsonschema, functools32 04:59:37 INFO - Running setup.py install for functools32 04:59:37 INFO - warning: no files found matching '*.txt' 04:59:37 INFO - no previously-included directories found matching 'build' 04:59:37 INFO - no previously-included directories found matching 'dist' 04:59:37 INFO - no previously-included directories found matching '.git*' 04:59:37 INFO - Successfully installed jsonschema functools32 04:59:37 INFO - Cleaning up... 04:59:37 INFO - Return code: 0 04:59:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:37 INFO - 'HOME': '/Users/cltbld', 04:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:37 INFO - 'LOGNAME': 'cltbld', 04:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:37 INFO - 'MOZ_NO_REMOTE': '1', 04:59:37 INFO - 'NO_EM_RESTART': '1', 04:59:37 INFO - 'PAGER': '/bin/cat', 04:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:37 INFO - 'PWD': '/builds/slave/test', 04:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:37 INFO - 'SHELL': '/bin/bash', 04:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:37 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:37 INFO - 'USER': 'cltbld', 04:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:37 INFO - 'XPC_FLAGS': '0x0', 04:59:37 INFO - 'XPC_SERVICE_NAME': '0', 04:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:59:37 INFO - Cleaning up... 04:59:37 INFO - Return code: 0 04:59:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:37 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:37 INFO - 'HOME': '/Users/cltbld', 04:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:37 INFO - 'LOGNAME': 'cltbld', 04:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:37 INFO - 'MOZ_NO_REMOTE': '1', 04:59:37 INFO - 'NO_EM_RESTART': '1', 04:59:37 INFO - 'PAGER': '/bin/cat', 04:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:37 INFO - 'PWD': '/builds/slave/test', 04:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:37 INFO - 'SHELL': '/bin/bash', 04:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:37 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:37 INFO - 'USER': 'cltbld', 04:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:37 INFO - 'XPC_FLAGS': '0x0', 04:59:37 INFO - 'XPC_SERVICE_NAME': '0', 04:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:59:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59: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 04:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:41 INFO - Downloading docopt-0.6.1.tar.gz 04:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:59:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:59:41 INFO - Running setup.py install for blobuploader 04:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:59:42 INFO - Running setup.py install for requests 04:59:42 INFO - Running setup.py install for docopt 04:59:42 INFO - Successfully installed blobuploader requests docopt 04:59:42 INFO - Cleaning up... 04:59:42 INFO - Return code: 0 04:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:42 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:42 INFO - 'HOME': '/Users/cltbld', 04:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:42 INFO - 'LOGNAME': 'cltbld', 04:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:42 INFO - 'MOZ_NO_REMOTE': '1', 04:59:42 INFO - 'NO_EM_RESTART': '1', 04:59:42 INFO - 'PAGER': '/bin/cat', 04:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:42 INFO - 'PWD': '/builds/slave/test', 04:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:42 INFO - 'SHELL': '/bin/bash', 04:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:42 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:42 INFO - 'USER': 'cltbld', 04:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:42 INFO - 'XPC_FLAGS': '0x0', 04:59:42 INFO - 'XPC_SERVICE_NAME': '0', 04:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-mhMqv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-DWrZtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Hnnhr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-IGKp6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-4QQfEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-panWCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-TaVBBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:43 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-seAZSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-GZKguo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-rgk6zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-alpgLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-mmbKBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-3R9cVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-VQdp4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-BhLYQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hnxJOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:44 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-bIPmWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:59:45 INFO - Running setup.py install for manifestparser 04:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:59:45 INFO - Running setup.py install for mozcrash 04:59:45 INFO - Running setup.py install for mozdebug 04:59:45 INFO - Running setup.py install for mozdevice 04:59:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:59:45 INFO - Running setup.py install for mozfile 04:59:45 INFO - Running setup.py install for mozhttpd 04:59:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:59:45 INFO - Running setup.py install for mozinfo 04:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Running setup.py install for mozInstall 04:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Running setup.py install for mozleak 04:59:46 INFO - Running setup.py install for mozlog 04:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Running setup.py install for moznetwork 04:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:46 INFO - Running setup.py install for mozprocess 04:59:46 INFO - Running setup.py install for mozprofile 04:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:47 INFO - Running setup.py install for mozrunner 04:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:47 INFO - Running setup.py install for mozscreenshot 04:59:47 INFO - Running setup.py install for moztest 04:59:47 INFO - Running setup.py install for mozversion 04:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:47 INFO - Cleaning up... 04:59:47 INFO - Return code: 0 04:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:47 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:47 INFO - 'HOME': '/Users/cltbld', 04:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:47 INFO - 'LOGNAME': 'cltbld', 04:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:47 INFO - 'MOZ_NO_REMOTE': '1', 04:59:47 INFO - 'NO_EM_RESTART': '1', 04:59:47 INFO - 'PAGER': '/bin/cat', 04:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:47 INFO - 'PWD': '/builds/slave/test', 04:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:47 INFO - 'SHELL': '/bin/bash', 04:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:47 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:47 INFO - 'USER': 'cltbld', 04:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:47 INFO - 'XPC_FLAGS': '0x0', 04:59:47 INFO - 'XPC_SERVICE_NAME': '0', 04:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-VrditP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1trIfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-HQNVCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-TnII7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Bxnq92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-V7tfXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-6qBCbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-PQLooQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:48 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-D16hdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-I4DvlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-RVTSzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-rXp_Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-v4_oHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cBatgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1kE3rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-KKXKPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:49 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-18deqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:52 INFO - Downloading blessings-1.6.tar.gz 04:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:52 INFO - Installing collected packages: blessings 04:59:52 INFO - Running setup.py install for blessings 04:59:53 INFO - Successfully installed blessings 04:59:53 INFO - Cleaning up... 04:59:53 INFO - Return code: 0 04:59:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:53 INFO - Reading from file tmpfile_stdout 04:59:53 INFO - Current package versions: 04:59:53 INFO - blessings == 1.6 04:59:53 INFO - blobuploader == 1.2.4 04:59:53 INFO - docopt == 0.6.1 04:59:53 INFO - functools32 == 3.2.3-2 04:59:53 INFO - jsonschema == 2.5.1 04:59:53 INFO - manifestparser == 1.1 04:59:53 INFO - mozInstall == 1.12 04:59:53 INFO - mozcrash == 1.0 04:59:53 INFO - mozdebug == 0.1 04:59:53 INFO - mozdevice == 0.50 04:59:53 INFO - mozfile == 1.2 04:59:53 INFO - mozhttpd == 0.7 04:59:53 INFO - mozinfo == 0.9 04:59:53 INFO - mozleak == 0.1 04:59:53 INFO - mozlog == 3.4 04:59:53 INFO - moznetwork == 0.27 04:59:53 INFO - mozprocess == 0.25 04:59:53 INFO - mozprofile == 0.28 04:59:53 INFO - mozrunner == 6.13 04:59:53 INFO - mozscreenshot == 0.1 04:59:53 INFO - mozsystemmonitor == 0.3 04:59:53 INFO - moztest == 0.8 04:59:53 INFO - mozversion == 1.4 04:59:53 INFO - psutil == 3.1.1 04:59:53 INFO - requests == 1.2.3 04:59:53 INFO - wsgiref == 0.1.2 04:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:53 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:53 INFO - 'HOME': '/Users/cltbld', 04:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:53 INFO - 'LOGNAME': 'cltbld', 04:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:53 INFO - 'MOZ_NO_REMOTE': '1', 04:59:53 INFO - 'NO_EM_RESTART': '1', 04:59:53 INFO - 'PAGER': '/bin/cat', 04:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:53 INFO - 'PWD': '/builds/slave/test', 04:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:53 INFO - 'SHELL': '/bin/bash', 04:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:53 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:53 INFO - 'USER': 'cltbld', 04:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:53 INFO - 'XPC_FLAGS': '0x0', 04:59:53 INFO - 'XPC_SERVICE_NAME': '0', 04:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:59:53 INFO - Cleaning up... 04:59:53 INFO - Return code: 0 04:59:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:53 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 0x10f660b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f663768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a9d6f4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, '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.2botxLu1t5/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.j8N0D3c8CZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 04:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:53 INFO - 'HOME': '/Users/cltbld', 04:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:53 INFO - 'LOGNAME': 'cltbld', 04:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:53 INFO - 'MOZ_NO_REMOTE': '1', 04:59:53 INFO - 'NO_EM_RESTART': '1', 04:59:53 INFO - 'PAGER': '/bin/cat', 04:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:53 INFO - 'PWD': '/builds/slave/test', 04:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:53 INFO - 'SHELL': '/bin/bash', 04:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 04:59:53 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 04:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:53 INFO - 'USER': 'cltbld', 04:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:53 INFO - 'XPC_FLAGS': '0x0', 04:59:53 INFO - 'XPC_SERVICE_NAME': '0', 04:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:59:54 INFO - Cleaning up... 04:59:54 INFO - Return code: 0 04:59:54 INFO - Running post-action listener: _resource_record_post_action 04:59:54 INFO - Running post-action listener: _start_resource_monitoring 04:59:54 INFO - Starting resource monitoring. 04:59:54 INFO - [mozharness: 2017-04-28 11:59:54.074364Z] Finished create-virtualenv step (success) 04:59:54 INFO - [mozharness: 2017-04-28 11:59:54.075371Z] Running install step. 04:59:54 INFO - Running pre-action listener: _resource_record_pre_action 04:59:54 INFO - Running main action method: install 04:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:54 INFO - Reading from file tmpfile_stdout 04:59:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:59:54 INFO - Reading from file tmpfile_stdout 04:59:54 INFO - Output received: 04:59:54 INFO - Usage: mozinstall [options] installer 04:59:54 INFO - Options: 04:59:54 INFO - -h, --help show this help message and exit 04:59:54 INFO - -d DEST, --destination=DEST 04:59:54 INFO - Directory to install application into. [default: 04:59:54 INFO - "/builds/slave/test"] 04:59:54 INFO - --app=APP Application being installed. [default: firefox] 04:59:54 INFO - mkdir: /builds/slave/test/build/application 04:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:00:15 INFO - Reading from file tmpfile_stdout 05:00:15 INFO - Output received: 05:00:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:00:15 INFO - Running post-action listener: _resource_record_post_action 05:00:15 INFO - [mozharness: 2017-04-28 12:00:15.290788Z] Finished install step (success) 05:00:15 INFO - [mozharness: 2017-04-28 12:00:15.290930Z] Running run-tests step. 05:00:15 INFO - Running pre-action listener: _resource_record_pre_action 05:00:15 INFO - Running main action method: run_tests 05:00:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:00:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:00:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:00:15 INFO - 2017-04-28 05:00:15.305 screenresolution[1627:7412] starting screenresolution argv=screenresolution get 05:00:15 INFO - 2017-04-28 05:00:15.308 screenresolution[1627:7412] Display 0: 1600x1200x32@60 05:00:15 INFO - 2017-04-28 05:00:15.314 screenresolution[1628:7414] starting screenresolution argv=screenresolution list 05:00:15 INFO - Available Modes on Display 0 05:00:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:00:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:00:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:00:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:00:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:00:15 INFO - Intel Iris: 05:00:15 INFO - Chipset Model: Intel Iris 05:00:15 INFO - Type: GPU 05:00:15 INFO - Bus: Built-In 05:00:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:00:15 INFO - Vendor: Intel (0x8086) 05:00:15 INFO - Device ID: 0x0a2e 05:00:15 INFO - Revision ID: 0x0009 05:00:15 INFO - Displays: 05:00:15 INFO - Display: 05:00:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:00:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:00:15 INFO - Display Serial Number: 1600x1200 60 05:00:15 INFO - Main Display: Yes 05:00:15 INFO - Mirror: Off 05:00:15 INFO - Online: Yes 05:00:15 INFO - Rotation: Supported 05:00:15 INFO - Return code: 0 05:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:15 INFO - Python 2.7.3 05:00:15 INFO - Return code: 0 05:00:15 INFO - grabbing minidump binary from tooltool 05:00: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')]} 05:00:15 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 0x10f43ed30>, '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 0x10f364db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f433be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00:15 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 05:00:15 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 05:00:15 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 05:00:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:15 INFO - Return code: 0 05:00:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:00:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:15 INFO - ENV: RUST_BACKTRACE is now 1 05:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 05:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 05:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2botxLu1t5/Render', 05:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:15 INFO - 'HOME': '/Users/cltbld', 05:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:15 INFO - 'LOGNAME': 'cltbld', 05:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:15 INFO - 'MOZ_NO_REMOTE': '1', 05:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:15 INFO - 'NO_EM_RESTART': '1', 05:00:15 INFO - 'PAGER': '/bin/cat', 05:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:15 INFO - 'PWD': '/builds/slave/test', 05:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:15 INFO - 'RUST_BACKTRACE': '1', 05:00:15 INFO - 'SHELL': '/bin/bash', 05:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j8N0D3c8CZ/Listeners', 05:00:15 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 05:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:15 INFO - 'USER': 'cltbld', 05:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:15 INFO - 'XPC_FLAGS': '0x0', 05:00:15 INFO - 'XPC_SERVICE_NAME': '0', 05:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 05:00:15 INFO - mozversion application_buildid: 20170428030259 05:00:15 INFO - mozversion application_changeset: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 05:00:15 INFO - mozversion application_display_name: Nightly 05:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:15 INFO - mozversion application_name: Firefox 05:00:15 INFO - mozversion application_remotingname: firefox 05:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:00:15 INFO - mozversion application_vendor: Mozilla 05:00:15 INFO - mozversion application_version: 55.0a1 05:00:15 INFO - mozversion platform_buildid: 20170428030259 05:00:15 INFO - mozversion platform_changeset: 84762dbeb5380461fe27f0afa0e27e8ba9dd3b01 05:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:00:15 INFO - mozversion platform_version: 55.0a1 05:00:15 INFO - using testdate: 1493380815 05:00:15 INFO - actual date: 1493380815 05:00:15 INFO - starting webserver on 'localhost:49229' 05:00:15 INFO - SUITE-START | Running 2 tests 05:00:15 INFO - TEST-START | dromaeo_css 05:00:15 INFO - operating with platform_type : mac_ 05:00:15 INFO - Initialising browser for dromaeo_css test... 05:00:15 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpfE4A6f/profile http://localhost:49229/getInfo.html) 05:00:18 INFO - PID 1638 | 2017-04-28 05:00:18.906 plugin-container[1644:7651] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x993f, name = 'com.apple.tsm.portname' 05:00:18 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:00:18 INFO - PID 1638 | 2017-04-28 05:00:18.907 plugin-container[1644:7651] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e1f, name = 'com.apple.CFPasteboardClient' 05:00:18 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:00:18 INFO - PID 1638 | 2017-04-28 05:00:18.907 plugin-container[1644:7651] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:00:19 INFO - PID 1638 | __metrics Screen width/height:1600/1200 05:00:19 INFO - PID 1638 | colorDepth:24 05:00:19 INFO - PID 1638 | Browser inner width/height: 1024/689 05:00:19 INFO - PID 1638 | __metrics 05:00:19 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 05:00:20 INFO - TEST-INFO | 1638: exit 0 05:00:20 INFO - Browser initialized. 05:00:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:20 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpfE4A6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:22 INFO - PID 1645 | 2017-04-28 05:00:22.285 plugin-container[1646:7786] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 05:00:22 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:00:22 INFO - PID 1645 | 2017-04-28 05:00:22.286 plugin-container[1646:7786] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 05:00:22 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:00:22 INFO - PID 1645 | 2017-04-28 05:00:22.286 plugin-container[1646:7786] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:00:32 INFO - PID 1645 | RSS: Main: 236179456 05:00:32 INFO - PID 1645 | 05:03:35 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 05:03:37 INFO - PID 1645 | RSS: Main: 252411904 05:03:37 INFO - PID 1645 | 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:05:20 INFO - PID 1645 | 05:05:20 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:05:20 INFO - PID 1645 | Full stack: 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:05:20 INFO - PID 1645 | 05:05:20 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:05:20 INFO - PID 1645 | Full stack: 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:05:20 INFO - PID 1645 | 05:05:20 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:05:20 INFO - PID 1645 | Full stack: 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | ************************* 05:05:20 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 05:05:20 INFO - PID 1645 | 05:05:20 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:05:20 INFO - PID 1645 | Full stack: 05:05:20 INFO - PID 1645 | ************************* 05:06:39 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 05:06:40 INFO - PID 1645 | RSS: Main: 257708032 05:06:40 INFO - PID 1645 | 05:09:41 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 05:09:42 INFO - PID 1645 | RSS: Main: 266477568 05:09:42 INFO - PID 1645 | 05:12:44 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 05:12:45 INFO - PID 1645 | RSS: Main: 259411968 05:12:45 INFO - PID 1645 | 05:15:48 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 05:15:48 INFO - PID 1645 | RSS: Main: 268361728 05:15:48 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 05:18:50 INFO - PID 1645 | RSS: Main: 266248192 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | __start_tp_report 05:18:50 INFO - PID 1645 | _x_x_mozilla_page_load 05:18:50 INFO - PID 1645 | _x_x_mozilla_page_load_details 05:18:50 INFO - PID 1645 | |i|pagename|runs| 05:18:50 INFO - PID 1645 | |0;dojo.html;3077.4922137847257;3210.486322188449;3225.822579758112;3227.4836026235794;3274.705276525113;4157.646600038996;4567.680262381635;5205.672553498862;5510.035743744844;5566.749496272672;5425.945740542594;5433.8369848904595;5444;5525.392206857243;5623.184638227454;4787.257975013878;4787.593054590364;4876.0247950409885;4876.341693871317;4901.828436004741;3957.525096988351;4857.587105096071;4922.261660750898;4927.679700819435;5041.72270525121;4949.505049495057;5008.173651347523;5044.672096313746;5048.848534543951;5079.542841144296;4787.257975013878;4890.657653964224;4916.950830491685;4924.975375123137;4944.283078953567;4811.109944660249;4892.68197567157;4906.288588154734;4908.288298196777;4963.578095861856;5049.621278404097;5382.811601593926;5468.207109969032;5473.370562385337;5526.50261476469;4867.196912509432;5918.112283157518;6012.158297838306;6035.879282414371;6039.003564411867;6103.792276408629;6110.285381942539;6112.594670127729;6114.755409783604;6131.560175786004;5791.478766910914;5799.3620701722775;5815.331236907725;5825.475707186373;5827.796027139072;5984;6096.481799047131;6106.938930610726;6210.875782484415;6277.748890044347;5792.304923409218;5902.439268269508;5917.911231331534;5934.643921364732;5992.64044157352;4805.9759701201965;5998.940010599926;6064.818055458343;6085.08723691441;6100.633961962297;5881.823545293648;6041.6375017499095;6048.909266361008;6057.697115144225;6066.45401913821;5917.437843404869;5995.430434108753;6036.185115009505;6062.939370606326;6067;4803.95196048042;4834.685745426536;4899.730514821647;4900.019996000814;4912.459629440758;3517.56030496188;4189.72766770159;4271.807768650418;4283.7001409901;4390.824367025347;4178.331466965332;5691.459311365414;5717.971410142923;5741.368449470555;5762.711864406763;5110.821121260738;5844.422006058426;5990.011648078018;6033.5173186145;6088.786892458743;5666.943330566724;5673.744681489343;5714.285714285715;5730.083186690193;5753.194552762617;5309.415964244007;5335.359756829128;5352.57179425645;5390.757415916293;5391.56867450603;6254.3745625437095;6262.373762623702;6263.874722505524;6288.182536270256;6302.212223472066;5976.462118409364;5985.521158307412;6035.547333949883;6112.724927378367;6143.139960405636;6112.022076467744;6133.763142530502;6182.227221597301;6224.657643829632;6319.494440444845;4670.696404733681;5863.912041319299;5970.104484327212;6011.579189456696;6092.939070609237;4828.913494463858;6036.9094463582205;6079.118527813531;6105.664188469499;6115.3578874217565;5737.053386191232;5880.176775251382;5881.176635271151;5912.852178695567;5922.674252916131;4217.641500472494;5836.387179346108;5889.381614930542;5930.555208359304;5958.731857066529;5581.246531718166;5728.828135155952;5763.36602973681;5797.043487824461;5833.416658334133;5034.823781167642;5927.525797936069;5928.970355148197;5942.61373010753;6003.759849605967;5608.9158662619275;5669.7165141741925;5675.318961724454;5767.106098554731;5825.825225243249 05:18:50 INFO - PID 1645 | |1;ext.html;649.4933951517816;711.3277952335043;784.4665627373386;1141.7374003979085;1184.070504653847;35209.647903520956;35762;35793.82103089484;35845.64154358459;35847.4622880657;36286.45570316447;36572.08569785757;36624;36675.81662091692;36810.815945920236;7579.810504737385;7740.4968677036095;7905.644246008915;8136.75589732309;8158.265756081952;8251.29863961564;8278.958605206966;8309.501429914195;8316;8338.62476188573;7570.470067095305;7740;8307.293880020206;8354.415190936637;8358.623861926197;8267;8290.668373265062;8303.95848020759;8313.293370063551;8317.209865062809;8010.8798368023945;8078.555679437629;8085.757427277191;8095.299987002736;8097.392695547798;35300.64699352999;35497.82251088754;35639.82180089083;35714.64285357139;35862.924112276676;2979.7169268919633;3070.416620842033;3200.567923330367;3429.588449386065;3513.2622149348667;28952.565711514344;29262.853685731436;29296.56055159174;29425.11724648264;29470.705292947012;3022.199117233935;3036.0436462514235;3064.1573567268956;3064.4330798802293;3074.6003019607533;258752;259263;259401;276357;280926.1907380941;45177.41879034218;47036.52963470321;47226.5277347229;47284.7635761819;47394;39903.401448978286;40486.1902761949;42805;49127.75436122796;49294.75352623286;13544.187348759106;13593.796093058612;13873.930630346784;13875.37560809766;13919.930400347934;9188.770280743034;11115.333080015225;11122.61070862516;11142.665720028412;11194.992450679478;13346.933265333611;13401.530946417024;13427.798583021262;13471.191728496322;13491.797623035662;5680.11958146488;5745.569082318842;5776.1624564437925;5777.45791851584;5784.1902133701315;849.668629234599;856.4518708026743;878.1920633017639;889.7063968890251;922.8892532895961;19827.702584461244;23122.421939451648;24118;24174;24364.512709745704;1043.3479075577764;1050.9421981791074;1075.2741899217997;1082.626493859617;1097.3306283167262;9974.700758977096;11102.555897764;11976.520939162336;12224.449899754532;12375;324963;326673;326879;326945;329000;51921;52084.218736718976;52154.47845521572;52218.21672674913;52446.73776631092;1219.8902098810972;1401.341369556307;1429.6068581140269;1436.5115860607443;1441.819772528434;20171;20735.755854648167;20924.372268831958;21210.25764098311;23572.29283121509;38255.66105186305;38417;38703.61296387;40117.59882401139;40996.97507562335;238703.48427352167;241272;242373;243231;243421;33740.49389259114;34243.14392140217;34452;34468.48297275493;34523.4821477673;43253;44673;44808.327875081246;44855;45018.87452813706;27591.034313798922;29219.85390073036;29386.265343365732;30469.847650761603;30783;24140.51718965576;26556.203313900613;27496.862515687295;28748;30881.845590771904;32523;32759.525821337622;36273.911782646566;36332;36345;29319.41361172722;29466.821327147532;30643.701722371356;31040.393872649318;31054.53823631528;22220.66668999934;23805.761942380355;23927.16254931069;23949.521009579363;24295.149669761475 05:18:50 INFO - PID 1645 | |2;jquery.html;396.4133083037103;396.51625017478665;405.43239464749354;416.52724158080576;416.60645142;11615.186936914419;17740.911295443504;17948;19781;20701.792982070176;21077.051532681027;21112.683309750366;21937;22247.11011559536;22357.888210558925;5419.783208671648;5844.532437404998;5865.677387743673;5873.4420230078285;5894.351621321651;5003.374578177728;5661.726111624893;5733.913991290134;5796.884062318751;5854.414558544154;5612.887742245173;5836.854078648046;5849.912251316234;5852.795152169675;5856.619319744224;4926.950730492703;5802.274715660564;5808.564357673149;5822.301323841124;5866.706664666771;5074.3657042869645;5292.841214763564;5302.973485132549;5303.310569625924;5309.893802123975;24852.3786905327;24939;24968.00127994878;25008.374790630198;25313.240602781763;1824.79927208007;1894.6873765828623;2160.319499357697;2161.7189765330563;2168;13721.931390343085;16546.83453165465;17281.39515116965;17294.394696185573;17409.65180696379;1981.881087134762;1988.9602207955904;2001.5296405344732;2048.979510204894;2076.5431605046865;138069;138882;139742.90385644324;140330;140379;11580.247283926517;11887.10846686502;12046.216995895238;12067.57763478274;12143.14997950135;15313.387464501295;15484.148371839432;15511.844881551266;15516.456924007605;15522.611934701723;8429.915700843036;8686.305095592337;8828.984666763276;8868.733937981742;8870;6721.227058888193;8274.172582741678;8301.750947471586;8420.915790842135;8431.241188292961;7623.923760762433;7713.2286771322415;7734.071911370559;7780.610969451504;7808.843823123506;1806.5664240582166;2138.251611935841;2145.3671167005773;2149.8387620928493;2293.1728711062974;701.4073108223542;805.5126648377765;824.431142511665;850.1923172985564;851.1828644501348;17165.399211027805;18148.183331750104;18933;19900.50248743793;20249.39251822448;718.6119495472386;822.0258993093204;878.4509681449094;912.625823412411;921.5069937583361;9536.141747242782;9949.850752238723;10051.899481005243;10128.987101289813;10389.064984151462;467428;500095;509836;513957;514502;115317;132615.33692331475;134090.3295483536;134907.32546337205;138755.30622346824;1048.6172547020283;1068.257560995101;1135.4890299365318;1140.6692059302875;1142.948567314473;17968.91015544914;19309.841409515473;21361.78638213598;21658.566828663024;21692.91535423191;58110.41889581219;58535.536611583346;58871.41128588659;59333.70333148307;59349;75430.55395859621;77369;78416;81164.59417702873;81404;7869.449138560246;8063.596820158851;8344.749657510285;8803.955980220315;8914.55427228623;13628.454861805416;13788.724225515232;13886.305684715522;13994.510192143227;14205.573832785032;11512.712182195512;11752.529898804294;11774.646760597196;11870.109741769229;11929.582464613697;8922.73231803047;10390.22073344487;10589.099926506333;10721.035106840422;11165.776684466102;12107.33409662477;12159.696007599881;12315.93842030784;12321.383930803604;12426;7111.359977602041;8448.366372521963;8468.03618733463;8634.179752923463;8635.050144483976;11644.301341919512;11660.88339116598;11824.40877956116;11828.70428239301;11858.40707964581 05:18:50 INFO - PID 1645 | |3;mootools.html;1143.9256448330857;1225.8528976522819;1344.4958140697238;1358.110437663331;1375.6698392385824;9857.7535561611;10993.780124397506;11580.826287605682;11587;11688.415579221048;11237.101031917447;11510.712232194199;11532.423378831047;11579.42102894854;11583.957443830053;2384.153625462962;2408.9156879509133;2414.0705828256073;2415.9396015099587;2421.9757802422014;2331.3821837213154;2389.307100940725;2390.6492831550204;2392.437777122375;2406.7352591214953;2347.6361164019604;2363.9054437822465;2405.1341517053847;2409.3976505873534;2411.0837881604966;2321.454458202321;2338.695969523968;2372.58479766042;2373.8961382956923;2376.988115059431;1924.7305377247196;1947.269773834812;2261.412032871449;2347.0729062020578;2351.9412014699597;11278;11280.210385273034;11384.886151138466;11435.485403156878;11444.48499817502;6307.400796924285;6524.054012168209;6558.016297555358;6562.967185164043;6569.770058047993;3841.116543195053;4160.854370097062;4233.576642335773;4249.490061192677;4265.936010959838;1195.9893889663222;1203.3080978437347;1241.6585439004257;1253.9059570532156;1260.1934761752486;13086.934565327208;13419.798703019462;15936.964097333635;16229;16264.51206463808;5286.973565132226;5436.429174936575;5467.480589344006;5468.890622187613;5567.749451274703;11220.326780393203;11284.605038823602;11336.886631133582;11403.144764142722;11411.885881141248;5989.580729348903;6060.909086363708;6282.057691346243;6283.7800676976085;6342.112104305401;6055.182550355646;6075.908861367083;6145.293291271471;6159.291681456601;6165;3484.9477257841154;4126.834926602963;4213.052063285736;4216.430781844411;4293.098449325614;1219.5670536959428;1221.9205751626116;1232.5131573028602;1240.2496489623827;1248.3820508848178;660.5277226782873;686.7562015484531;696.5681277607915;700.2297472779901;708.8445833291702;6029.638221706711;6034.185384972972;6514.05546195799;6605.141331626954;6638.070670106189;723.6056349289545;798.4929569723151;838.8993320801543;873.6549063120032;876.2245412809709;3353.564036675217;4212.23086303747;4229.894252643647;4295.6778241632;4349.739015659071;14161.929190354189;14548.927255363655;14550.927245363917;14643.414263429557;14659.853401465849;14020.71958560823;14310;14465.349059292357;14750.336234869457;14763.852361476462;8000.439969202216;8156.714514991947;8163.877541836877;8210.261076503144;8220.136885627042;6393.808185754435;6421.422072013541;6441.194850643669;6604.933950660624;6700.195976482658;11893.870082342164;12038.097142714507;12904.8064279034;12912.741745164856;13423.060385772902;12146.453409596412;12392.504299828266;13218.867811322149;13245.072844900764;13621.318934053455;7967.760967170994;8029.919700802917;8153;8159.020917489939;8164.061132969785;10281.971802819658;10368.844467332845;10373.896261037293;10471.371717696962;10493.160547156362;8819.559022049;8823.69117080899;8837.513936733541;8946.194842464209;9020.954895225483;8675.045744967922;8705.260052895575;8742.431741936754;8750;8926.598303076507;7806.375489960903;7921.207879212263;7924.960375198087;7965.761027169194;7968.880466793119;4742.976285118552;5551.7779288828;5599.664020158803;5679.119736440858;5883.176355310175;5812.94187058124;5915.792947246826;6002.909956350745;6133.693315334126;6158.445739883253 05:18:50 INFO - PID 1645 | |4;prototype.html;356.38879321962827;360.3495690279045;369.3259800863425;370.78865046923255;374.4514286570174;4133.5659755725665;4336.696431249806;4407.757573333465;4758.405199350082;4872.196087645539;4644.653050615326;4741.762911854411;4753.47711751707;4757.357756702844;4822.4454187768415;3470.7743996640265;3580.9641903581023;3581.247937933037;3623.9456408153897;3638.2359704462096;3049.649290331607;3482.59700806444;3600.9099772505633;3622.355680353344;3626.4197728363465;3390.6606890278326;3585.9820700896457;3591.3535563598543;3602.081469225357;3602.675759181673;3209.9246752337995;3216.5175223716396;3594.19130695594;3603.459481077833;3615.9332996765884;3354.9832250838836;3378.2398960233995;3380.4253276942977;3384.560007199073;3396.5584474018465;4472.5303843096335;4534.773261336953;4556.134334476439;4559;4572.359869618256;4394.648428125743;4401.713888597231;4408.655360115164;4409.669274804402;4427.22523558376;4476.07528762632;4502.369668246448;4925.729084900329;5198.246254293144;5206.817761378372;3227;3916.843326266946;3922.7254092213557;3928.7839168845703;3929.980350098231;4642.328761645805;5181.533661970403;5265.605079619044;5325.7869685212545;5403.648762830403;3056.49567821307;3102.488089465258;3746.0822098586023;3768.3028639701743;3773.2453509298252;3804.410316400962;3824.8661296855034;3836.1368692044625;3849.9605106621057;3859.3824988001784;3926.842926282917;4108.91782164361;4271.380649805823;4325.805338759764;4350.390945267665;4216.620504154641;4866.294387313819;4982.77577509013;5137.101007323703;5162.277281180638;1349.6558377613646;1377.800218968264;1378.9931050344685;1381.8618138186303;1386.1890793885489;900.8513595256841;943.990560094404;982.9311948163703;996.7508122969258;1003.6085926488529;4746.477887432379;4747;4772.260299653559;4777.235642297285;4804.735739534359;5039.21892106724;5259.21111833228;5262.000219958196;5285.841424757264;5292.603054770908;3944.8422063117155;4126.525449573277;4565.315202719618;4782.928256076161;4809.883651193463;2403.182917807954;2714.945701086007;2749.766269867044;2755;2760.9447811043665;4990.900181996412;5488.231647569343;5517.3515913324345;5518.862028449321;5538.224648549126;4443.844465443759;4456.844010459683;4792.7363994980615;5269.657472264367;5373.919391209135;4344.479432198706;5426.453460763663;5454.4545545445135;5472.370677372073;5490.203920431515;5195.948040519546;5238.1618940969265;5259.395169555397;5269.209618557247;5278.76245568958;5105.974470127626;5127.179651255781;5178.524120625603;5180.61145414103;5219;5337.653052551572;5367.275417818544;5445.673259604437;5634.605577609528;5641.576881733804;2978.955315670223;3414.965850341564;3573.910652233715;3587.336342776595;3598.478220658042;5161.922571161361;5333.866653333697;5394.379646340564;5405.378381486179;5422.701751403711;4256.9783252019915;4500.987277862455;4909.576222895464;5038.546530812245;5202.271681964452;4649.558291962258;4704.035672687022;5120.385553733576;5178.378594568676;5214;5122.436531981404;5127.79488820443;5167.682241028514;5167.870803229949;5169.405518365285;4489.955100449084;5131.25596788471;5153.742312884266;5197.8440646780655;5241.449647786927;4942.925856112233;5086.593072554261;5110.642255042111;5132.384113906355;5172.948270517247 05:18:50 INFO - PID 1645 | |5;yui.html;782.9021372328459;787.4055088408254;798.1738900238254;826.9090400055993;831.8627426474632;15041.924790376046;15236;15424.460143894952;17544.561385965357;18776.436706898814;17235.052072136026;17340.306387744506;17634.647307053852;17638.38265660702;17981.19084641191;964.7539877331288;984.5372674842812;987.6345752071708;990.3612170150249;993.1855878179896;899.7795540092686;970.2141265574907;988.5205675247499;990.5790039233333;995.3977843404708;888.506878682331;1025.5180065369264;1031.1338475680427;1033.8139134955743;1036.0675392147052;1023.2581378500602;1025.4616326428684;1028.043919155189;1030.7577719235974;1031.432712008396;756.1946526948836;756.6216891554222;757.5454727163713;760.1562265884863;761.1095018827984;15818.367265309374;16017.35930562776;16261.593460163473;16709.749353759704;16913.7462938056;16281.348746050144;16658.33366665344;16917.154142292835;16953.57616059596;17084.145792710315;13226.338683065807;13266.73466530664;13391.598252052454;13668.453261869514;13856.93071534636;3378.5438965739554;3395.6943875051365;3397.8470968806214;3400.96599034009;3407.6081250656243;102578.74212578757;103540.48229758878;106649.73401064026;121187;127801.72198278084;9930.453825039547;11571.363575003288;12956.935215323863;13027.609171724864;13103.60689179326;18611.90694046548;20195.293164739163;21342.146314147572;22664;24438.877805610857;6462.192225971754;6465.967670161619;7603.2776886195725;7679.155292917774;7726;3742.6257374262354;3765.6234376562675;3811.676007539335;3822.4266360046217;3832.291026160169;4145.875623731233;4171.10321280926;4238.364245363158;4244.787760611957;4252.74483530983;902.6118768929292;925.8333499969935;929.2426672262085;930.3766476460787;936.2697096264924;564.4496615799644;570.6205373426708;582.1035605168079;589.5637228450915;608.9117078023751;10396.22028347877;10932.125429965583;11053.668389948154;11394.487248073856;11558.537658493566;569.3623142080896;573.4151165810849;581.7440326256434;585.4672248254068;598.5510866849862;4886.926696099561;5145.331106956071;5172;5240.554552862973;5347.491988261109;90823.54588227016;93616;93709;93803.53098234601;95961.0403895952;82443;91815.54092229629;94850.5257473722;96014.51992739992;98169.50915245521;44531.55468445339;74623.88064179041;75668.86496702443;75944.62027689937;76979.61510192526;11819;12321.69195770077;12336.3215023171;12417.689557761129;12463.937680311541;34843.477347839296;38982.80508597439;39480.21039579135;40653.39019914763;41065.7147428211;56359.154612680024;62867.6856615714;65766;68217;68851.31148688449;13627.773500385012;15620.687586247985;16071.11608861477;16467.505974820775;16558;14547.709045819236;17332;17881.552961176076;17958.10209489494;18055.277788888296;15845;16096.517104486884;16179.595510112342;16589.419370321983;16694;15300.540983770505;15510.302036408615;15848.841511584737;16020.198990050683;16043.037417754973;15417.537473875802;15676.372945082068;15804.130772807606;15833.445829395916;15907.204639768197;10798.946005269923;11284;11366.43167841588;11421.486033128363;11997.520099195934;11980.46087926028;12637.810432843698;12643.810342844681;12668.809967850673;12858.935705321413 05:18:50 INFO - PID 1645 | __end_tp_report 05:18:50 INFO - PID 1645 | __start_cc_report 05:18:50 INFO - PID 1645 | _x_x_mozilla_cycle_collect,438 05:18:50 INFO - PID 1645 | __end_cc_report 05:18:50 INFO - PID 1645 | __startTimestamp1493381930780__endTimestamp 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | ------- Summary: start ------- 05:18:50 INFO - PID 1645 | Number of tests: 6 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:5487.57 Median:5762.71 stddev:705.18 (12.2%) stddev-sans-first:681.53 05:18:50 INFO - PID 1645 | Values: 3077.5 3210.5 3225.8 3227.5 3274.7 4157.6 4567.7 5205.7 5510.0 5566.7 5425.9 5433.8 5444.0 5525.4 5623.2 4787.3 4787.6 4876.0 4876.3 4901.8 3957.5 4857.6 4922.3 4927.7 5041.7 4949.5 5008.2 5044.7 5048.8 5079.5 4787.3 4890.7 4917.0 4925.0 4944.3 4811.1 4892.7 4906.3 4908.3 4963.6 5049.6 5382.8 5468.2 5473.4 5526.5 4867.2 5918.1 6012.2 6035.9 6039.0 6103.8 6110.3 6112.6 6114.8 6131.6 5791.5 5799.4 5815.3 5825.5 5827.8 5984.0 6096.5 6106.9 6210.9 6277.7 5792.3 5902.4 5917.9 5934.6 5992.6 4806.0 5998.9 6064.8 6085.1 6100.6 5881.8 6041.6 6048.9 6057.7 6066.5 5917.4 5995.4 6036.2 6062.9 6067.0 4804.0 4834.7 4899.7 4900.0 4912.5 3517.6 4189.7 4271.8 4283.7 4390.8 4178.3 5691.5 5718.0 5741.4 5762.7 5110.8 5844.4 5990.0 6033.5 6088.8 5666.9 5673.7 5714.3 5730.1 5753.2 5309.4 5335.4 5352.6 5390.8 5391.6 6254.4 6262.4 6263.9 6288.2 6302.2 5976.5 5985.5 6035.5 6112.7 6143.1 6112.0 6133.8 6182.2 6224.7 6319.5 4670.7 5863.9 5970.1 6011.6 6092.9 4828.9 6036.9 6079.1 6105.7 6115.4 5737.1 5880.2 5881.2 5912.9 5922.7 4217.6 5836.4 5889.4 5930.6 5958.7 5581.2 5728.8 5763.4 5797.0 5833.4 5034.8 5927.5 5929.0 5942.6 6003.8 5608.9 5669.7 5675.3 5767.1 5825.8 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:42524.91 Median:33991.82 stddev:73661.26 (216.7%) stddev-sans-first:73800.80 05:18:50 INFO - PID 1645 | Values: 649.5 711.3 784.5 1141.7 1184.1 35209.6 35762.0 35793.8 35845.6 35847.5 36286.5 36572.1 36624.0 36675.8 36810.8 7579.8 7740.5 7905.6 8136.8 8158.3 8251.3 8279.0 8309.5 8316.0 8338.6 7570.5 7740.0 8307.3 8354.4 8358.6 8267.0 8290.7 8304.0 8313.3 8317.2 8010.9 8078.6 8085.8 8095.3 8097.4 35300.6 35497.8 35639.8 35714.6 35862.9 2979.7 3070.4 3200.6 3429.6 3513.3 28952.6 29262.9 29296.6 29425.1 29470.7 3022.2 3036.0 3064.2 3064.4 3074.6 258752.0 259263.0 259401.0 276357.0 280926.2 45177.4 47036.5 47226.5 47284.8 47394.0 39903.4 40486.2 42805.0 49127.8 49294.8 13544.2 13593.8 13873.9 13875.4 13919.9 9188.8 11115.3 11122.6 11142.7 11195.0 13346.9 13401.5 13427.8 13471.2 13491.8 5680.1 5745.6 5776.2 5777.5 5784.2 849.7 856.5 878.2 889.7 922.9 19827.7 23122.4 24118.0 24174.0 24364.5 1043.3 1050.9 1075.3 1082.6 1097.3 9974.7 11102.6 11976.5 12224.4 12375.0 324963.0 326673.0 326879.0 326945.0 329000.0 51921.0 52084.2 52154.5 52218.2 52446.7 1219.9 1401.3 1429.6 1436.5 1441.8 20171.0 20735.8 20924.4 21210.3 23572.3 38255.7 38417.0 38703.6 40117.6 40997.0 238703.5 241272.0 242373.0 243231.0 243421.0 33740.5 34243.1 34452.0 34468.5 34523.5 43253.0 44673.0 44808.3 44855.0 45018.9 27591.0 29219.9 29386.3 30469.8 30783.0 24140.5 26556.2 27496.9 28748.0 30881.8 32523.0 32759.5 36273.9 36332.0 36345.0 29319.4 29466.8 30643.7 31040.4 31054.5 22220.7 23805.8 23927.2 23949.5 24295.1 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:33486.05 Median:12325.53 stddev:85497.10 (693.7%) stddev-sans-first:85700.85 05:18:50 INFO - PID 1645 | Values: 396.4 396.5 405.4 416.5 416.6 11615.2 17740.9 17948.0 19781.0 20701.8 21077.1 21112.7 21937.0 22247.1 22357.9 5419.8 5844.5 5865.7 5873.4 5894.4 5003.4 5661.7 5733.9 5796.9 5854.4 5612.9 5836.9 5849.9 5852.8 5856.6 4927.0 5802.3 5808.6 5822.3 5866.7 5074.4 5292.8 5303.0 5303.3 5309.9 24852.4 24939.0 24968.0 25008.4 25313.2 1824.8 1894.7 2160.3 2161.7 2168.0 13721.9 16546.8 17281.4 17294.4 17409.7 1981.9 1989.0 2001.5 2049.0 2076.5 138069.0 138882.0 139742.9 140330.0 140379.0 11580.2 11887.1 12046.2 12067.6 12143.1 15313.4 15484.1 15511.8 15516.5 15522.6 8429.9 8686.3 8829.0 8868.7 8870.0 6721.2 8274.2 8301.8 8420.9 8431.2 7623.9 7713.2 7734.1 7780.6 7808.8 1806.6 2138.3 2145.4 2149.8 2293.2 701.4 805.5 824.4 850.2 851.2 17165.4 18148.2 18933.0 19900.5 20249.4 718.6 822.0 878.5 912.6 921.5 9536.1 9949.9 10051.9 10129.0 10389.1 467428.0 500095.0 509836.0 513957.0 514502.0 115317.0 132615.3 134090.3 134907.3 138755.3 1048.6 1068.3 1135.5 1140.7 1142.9 17968.9 19309.8 21361.8 21658.6 21692.9 58110.4 58535.5 58871.4 59333.7 59349.0 75430.6 77369.0 78416.0 81164.6 81404.0 7869.4 8063.6 8344.7 8804.0 8914.6 13628.5 13788.7 13886.3 13994.5 14205.6 11512.7 11752.5 11774.6 11870.1 11929.6 8922.7 10390.2 10589.1 10721.0 11165.8 12107.3 12159.7 12315.9 12321.4 12426.0 7111.4 8448.4 8468.0 8634.2 8635.1 11644.3 11660.9 11824.4 11828.7 11858.4 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:6804.59 Median:3663.03 stddev:4296.76 (117.3%) stddev-sans-first:4287.76 05:18:50 INFO - PID 1645 | Values: 1143.9 1225.9 1344.5 1358.1 1375.7 9857.8 10993.8 11580.8 11587.0 11688.4 11237.1 11510.7 11532.4 11579.4 11584.0 2384.2 2408.9 2414.1 2415.9 2422.0 2331.4 2389.3 2390.6 2392.4 2406.7 2347.6 2363.9 2405.1 2409.4 2411.1 2321.5 2338.7 2372.6 2373.9 2377.0 1924.7 1947.3 2261.4 2347.1 2351.9 11278.0 11280.2 11384.9 11435.5 11444.5 6307.4 6524.1 6558.0 6563.0 6569.8 3841.1 4160.9 4233.6 4249.5 4265.9 1196.0 1203.3 1241.7 1253.9 1260.2 13086.9 13419.8 15937.0 16229.0 16264.5 5287.0 5436.4 5467.5 5468.9 5567.7 11220.3 11284.6 11336.9 11403.1 11411.9 5989.6 6060.9 6282.1 6283.8 6342.1 6055.2 6075.9 6145.3 6159.3 6165.0 3484.9 4126.8 4213.1 4216.4 4293.1 1219.6 1221.9 1232.5 1240.2 1248.4 660.5 686.8 696.6 700.2 708.8 6029.6 6034.2 6514.1 6605.1 6638.1 723.6 798.5 838.9 873.7 876.2 3353.6 4212.2 4229.9 4295.7 4349.7 14161.9 14548.9 14550.9 14643.4 14659.9 14020.7 14310.0 14465.3 14750.3 14763.9 8000.4 8156.7 8163.9 8210.3 8220.1 6393.8 6421.4 6441.2 6604.9 6700.2 11893.9 12038.1 12904.8 12912.7 13423.1 12146.5 12392.5 13218.9 13245.1 13621.3 7967.8 8029.9 8153.0 8159.0 8164.1 10282.0 10368.8 10373.9 10471.4 10493.2 8819.6 8823.7 8837.5 8946.2 9021.0 8675.0 8705.3 8742.4 8750.0 8926.6 7806.4 7921.2 7925.0 7965.8 7968.9 4743.0 5551.8 5599.7 5679.1 5883.2 5812.9 5915.8 6002.9 6133.7 6158.4 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:4191.26 Median:4607.34 stddev:1252.20 (27.2%) stddev-sans-first:1222.18 05:18:50 INFO - PID 1645 | Values: 356.4 360.3 369.3 370.8 374.5 4133.6 4336.7 4407.8 4758.4 4872.2 4644.7 4741.8 4753.5 4757.4 4822.4 3470.8 3581.0 3581.2 3623.9 3638.2 3049.6 3482.6 3600.9 3622.4 3626.4 3390.7 3586.0 3591.4 3602.1 3602.7 3209.9 3216.5 3594.2 3603.5 3615.9 3355.0 3378.2 3380.4 3384.6 3396.6 4472.5 4534.8 4556.1 4559.0 4572.4 4394.6 4401.7 4408.7 4409.7 4427.2 4476.1 4502.4 4925.7 5198.2 5206.8 3227.0 3916.8 3922.7 3928.8 3930.0 4642.3 5181.5 5265.6 5325.8 5403.6 3056.5 3102.5 3746.1 3768.3 3773.2 3804.4 3824.9 3836.1 3850.0 3859.4 3926.8 4108.9 4271.4 4325.8 4350.4 4216.6 4866.3 4982.8 5137.1 5162.3 1349.7 1377.8 1379.0 1381.9 1386.2 900.9 944.0 982.9 996.8 1003.6 4746.5 4747.0 4772.3 4777.2 4804.7 5039.2 5259.2 5262.0 5285.8 5292.6 3944.8 4126.5 4565.3 4782.9 4809.9 2403.2 2714.9 2749.8 2755.0 2760.9 4990.9 5488.2 5517.4 5518.9 5538.2 4443.8 4456.8 4792.7 5269.7 5373.9 4344.5 5426.5 5454.5 5472.4 5490.2 5195.9 5238.2 5259.4 5269.2 5278.8 5106.0 5127.2 5178.5 5180.6 5219.0 5337.7 5367.3 5445.7 5634.6 5641.6 2979.0 3415.0 3573.9 3587.3 3598.5 5161.9 5333.9 5394.4 5405.4 5422.7 4257.0 4501.0 4909.6 5038.5 5202.3 4649.6 4704.0 5120.4 5178.4 5214.0 5122.4 5127.8 5167.7 5167.9 5169.4 4490.0 5131.3 5153.7 5197.8 5241.4 4942.9 5086.6 5110.6 5132.4 5172.9 05:18:50 INFO - PID 1645 | 05:18:50 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:20692.67 Median:22003.07 stddev:28605.93 (130.0%) stddev-sans-first:28647.11 05:18:50 INFO - PID 1645 | Values: 782.9 787.4 798.2 826.9 831.9 15041.9 15236.0 15424.5 17544.6 18776.4 17235.1 17340.3 17634.6 17638.4 17981.2 964.8 984.5 987.6 990.4 993.2 899.8 970.2 988.5 990.6 995.4 888.5 1025.5 1031.1 1033.8 1036.1 1023.3 1025.5 1028.0 1030.8 1031.4 756.2 756.6 757.5 760.2 761.1 15818.4 16017.4 16261.6 16709.7 16913.7 16281.3 16658.3 16917.2 16953.6 17084.1 13226.3 13266.7 13391.6 13668.5 13856.9 3378.5 3395.7 3397.8 3401.0 3407.6 102578.7 103540.5 106649.7 121187.0 127801.7 9930.5 11571.4 12956.9 13027.6 13103.6 18611.9 20195.3 21342.1 22664.0 24438.9 6462.2 6466.0 7603.3 7679.2 7726.0 3742.6 3765.6 3811.7 3822.4 3832.3 4145.9 4171.1 4238.4 4244.8 4252.7 902.6 925.8 929.2 930.4 936.3 564.4 570.6 582.1 589.6 608.9 10396.2 10932.1 11053.7 11394.5 11558.5 569.4 573.4 581.7 585.5 598.6 4886.9 5145.3 5172.0 5240.6 5347.5 90823.5 93616.0 93709.0 93803.5 95961.0 82443.0 91815.5 94850.5 96014.5 98169.5 44531.6 74623.9 75668.9 75944.6 76979.6 11819.0 12321.7 12336.3 12417.7 12463.9 34843.5 38982.8 39480.2 40653.4 41065.7 56359.2 62867.7 65766.0 68217.0 68851.3 13627.8 15620.7 16071.1 16467.5 16558.0 14547.7 17332.0 17881.6 17958.1 18055.3 15845.0 16096.5 16179.6 16589.4 16694.0 15300.5 15510.3 15848.8 16020.2 16043.0 15417.5 15676.4 15804.1 15833.4 15907.2 10798.9 11284.0 11366.4 11421.5 11997.5 11980.5 12637.8 12643.8 12668.8 12858.9 05:18:50 INFO - PID 1645 | -------- Summary: end -------- 05:18:50 INFO - PID 1645 | 05:18:51 INFO - TEST-INFO | 1645: exit 0 05:18:51 INFO - TEST-OK | dromaeo_css | took 1115548ms 05:18:51 INFO - TEST-START | kraken 05:18:51 INFO - operating with platform_type : mac_ 05:18:51 INFO - Initialising browser for kraken test... 05:18:51 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpcZHUlI/profile http://localhost:49229/getInfo.html) 05:18:54 INFO - PID 1654 | 2017-04-28 05:18:54.012 plugin-container[1656:10249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:18:54 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:54 INFO - PID 1654 | 2017-04-28 05:18:54.012 plugin-container[1656:10249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:18:54 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:54 INFO - PID 1654 | 2017-04-28 05:18:54.012 plugin-container[1656:10249] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:18:54 INFO - PID 1654 | __metrics Screen width/height:1600/1200 05:18:54 INFO - PID 1654 | colorDepth:24 05:18:54 INFO - PID 1654 | Browser inner width/height: 1024/689 05:18:54 INFO - PID 1654 | __metrics 05:18:54 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 05:18:55 INFO - TEST-INFO | 1654: exit 0 05:18:55 INFO - Browser initialized. 05:18:55 INFO - Running cycle 1/1 for kraken test... 05:18:55 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpcZHUlI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:57 INFO - PID 1657 | 2017-04-28 05:18:57.546 plugin-container[1658:10378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953b, name = 'com.apple.tsm.portname' 05:18:57 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:57 INFO - PID 1657 | 2017-04-28 05:18:57.546 plugin-container[1658:10378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 05:18:57 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:57 INFO - PID 1657 | 2017-04-28 05:18:57.546 plugin-container[1658:10378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:19:07 INFO - PID 1657 | RSS: Main: 250294272 05:19:07 INFO - PID 1657 | 05:19:10 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:11 INFO - PID 1657 | RSS: Main: 258314240 05:19:11 INFO - PID 1657 | 05:19:14 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 05:19:15 INFO - PID 1657 | RSS: Main: 265428992 05:19:15 INFO - PID 1657 | 05:19:18 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 05:19:19 INFO - PID 1657 | RSS: Main: 261713920 05:19:19 INFO - PID 1657 | 05:19:21 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 05:19:22 INFO - PID 1657 | RSS: Main: 262492160 05:19:22 INFO - PID 1657 | 05:19:24 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:24 INFO - PID 1657 | RSS: Main: 263041024 05:19:24 INFO - PID 1657 | 05:19:27 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:28 INFO - PID 1657 | RSS: Main: 269373440 05:19:28 INFO - PID 1657 | 05:19:31 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:32 INFO - PID 1657 | RSS: Main: 270454784 05:19:32 INFO - PID 1657 | 05:19:35 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 05:19:35 INFO - PID 1657 | RSS: Main: 270106624 05:19:35 INFO - PID 1657 | 05:19:37 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:38 INFO - PID 1657 | RSS: Main: 269893632 05:19:38 INFO - PID 1657 | 05:19:39 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:19:40 INFO - PID 1657 | RSS: Main: 269811712 05:19:40 INFO - PID 1657 | 05:19:42 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:19:43 INFO - PID 1657 | RSS: Main: 269615104 05:19:43 INFO - PID 1657 | 05:19:46 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:47 INFO - PID 1657 | RSS: Main: 270098432 05:19:47 INFO - PID 1657 | 05:19:50 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:51 INFO - PID 1657 | RSS: Main: 267239424 05:19:51 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 05:19:53 INFO - PID 1657 | RSS: Main: 270532608 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | __start_tp_report 05:19:53 INFO - PID 1657 | _x_x_mozilla_page_load 05:19:53 INFO - PID 1657 | _x_x_mozilla_page_load_details 05:19:53 INFO - PID 1657 | |i|pagename|runs| 05:19:53 INFO - PID 1657 | |0;ai-astar;108;119;132;97;170;176;173;119;118;119 05:19:53 INFO - PID 1657 | |1;audio-beat-detection;152;120;142;195;158;119;124;163;156;101 05:19:53 INFO - PID 1657 | |2;audio-dft;239;242;254;228;224;228;227;226;247;246 05:19:53 INFO - PID 1657 | |3;audio-fft;81;61;63;111;88;49;83;56;81;49 05:19:53 INFO - PID 1657 | |4;audio-oscillator;95;60;108;109;106;106;92;70;67;94 05:19:53 INFO - PID 1657 | |5;imaging-gaussian-blur;95;101;93;93;94;95;95;94;94;94 05:19:53 INFO - PID 1657 | |6;imaging-darkroom;100;105;105;103;100;103;101;101;100;104 05:19:53 INFO - PID 1657 | |7;imaging-desaturate;113;111;107;115;108;110;112;113;104;174 05:19:53 INFO - PID 1657 | |8;json-parse-financial;52;50;55;71;80;55;53;47;47;62 05:19:53 INFO - PID 1657 | |9;json-stringify-tinderbox;65;61;63;67;71;67;62;61;62;74 05:19:53 INFO - PID 1657 | |10;stanford-crypto-aes;90;90;88;88;87;90;78;103;115;114 05:19:53 INFO - PID 1657 | |11;stanford-crypto-ccm;168;169;154;145;145;158;147;149;200;180 05:19:53 INFO - PID 1657 | |12;stanford-crypto-pbkdf2;182;229;248;206;200;202;191;193;199;193 05:19:53 INFO - PID 1657 | |13;stanford-crypto-sha256-iterative;78;88;109;102;70;71;73;78;71;70 05:19:53 INFO - PID 1657 | __end_tp_report 05:19:53 INFO - PID 1657 | __start_cc_report 05:19:53 INFO - PID 1657 | _x_x_mozilla_cycle_collect,1058 05:19:53 INFO - PID 1657 | __end_cc_report 05:19:53 INFO - PID 1657 | __startTimestamp1493381993474__endTimestamp 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | ------- Summary: start ------- 05:19:53 INFO - PID 1657 | Number of tests: 14 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#0] ai-astar Cycles:10 Average:133.10 Median:151.00 stddev:28.97 (19.2%) stddev-sans-first:29.27 05:19:53 INFO - PID 1657 | Values: 108.0 119.0 132.0 97.0 170.0 176.0 173.0 119.0 118.0 119.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:154.00 stddev:27.51 (17.9%) stddev-sans-first:28.98 05:19:53 INFO - PID 1657 | Values: 152.0 120.0 142.0 195.0 158.0 119.0 124.0 163.0 156.0 101.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#2] audio-dft Cycles:10 Average:236.10 Median:240.50 stddev:10.76 (4.5%) stddev-sans-first:11.37 05:19:53 INFO - PID 1657 | Values: 239.0 242.0 254.0 228.0 224.0 228.0 227.0 226.0 247.0 246.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#3] audio-fft Cycles:10 Average:72.20 Median:72.00 stddev:19.93 (27.7%) stddev-sans-first:20.89 05:19:53 INFO - PID 1657 | Values: 81.0 61.0 63.0 111.0 88.0 49.0 83.0 56.0 81.0 49.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:68.50 stddev:18.46 (26.9%) stddev-sans-first:19.51 05:19:53 INFO - PID 1657 | Values: 95.0 60.0 108.0 109.0 106.0 106.0 92.0 70.0 67.0 94.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:94.00 stddev:2.30 (2.4%) stddev-sans-first:2.44 05:19:53 INFO - PID 1657 | Values: 95.0 101.0 93.0 93.0 94.0 95.0 95.0 94.0 94.0 94.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:103.00 stddev:2.04 (2.0%) stddev-sans-first:2.01 05:19:53 INFO - PID 1657 | Values: 100.0 105.0 105.0 103.0 100.0 103.0 101.0 101.0 100.0 104.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#7] imaging-desaturate Cycles:10 Average:116.70 Median:112.50 stddev:20.40 (18.1%) stddev-sans-first:21.59 05:19:53 INFO - PID 1657 | Values: 113.0 111.0 107.0 115.0 108.0 110.0 112.0 113.0 104.0 174.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.00 stddev:10.79 (19.6%) stddev-sans-first:11.28 05:19:53 INFO - PID 1657 | Values: 52.0 50.0 55.0 71.0 80.0 55.0 53.0 47.0 47.0 62.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.00 stddev:4.45 (6.7%) stddev-sans-first:4.72 05:19:53 INFO - PID 1657 | Values: 65.0 61.0 63.0 67.0 71.0 67.0 62.0 61.0 62.0 74.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:88.00 stddev:12.23 (13.9%) stddev-sans-first:12.87 05:19:53 INFO - PID 1657 | Values: 90.0 90.0 88.0 88.0 87.0 90.0 78.0 103.0 115.0 114.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:161.50 Median:163.00 stddev:17.96 (11.0%) stddev-sans-first:18.89 05:19:53 INFO - PID 1657 | Values: 168.0 169.0 154.0 145.0 145.0 158.0 147.0 149.0 200.0 180.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.30 Median:201.00 stddev:19.73 (9.8%) stddev-sans-first:19.21 05:19:53 INFO - PID 1657 | Values: 182.0 229.0 248.0 206.0 200.0 202.0 191.0 193.0 199.0 193.0 05:19:53 INFO - PID 1657 | 05:19:53 INFO - PID 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.00 Median:72.00 stddev:14.13 (19.6%) stddev-sans-first:14.95 05:19:53 INFO - PID 1657 | Values: 78.0 88.0 109.0 102.0 70.0 71.0 73.0 78.0 71.0 70.0 05:19:53 INFO - PID 1657 | -------- Summary: end -------- 05:19:53 INFO - PID 1657 | 05:19:54 INFO - TEST-INFO | 1657: exit 0 05:19:54 INFO - TEST-OK | kraken | took 63281ms 05:19:54 INFO - SUITE-END | took 1178s 05:19:55 INFO - Completed test suite (00:19:39) 05:19:55 INFO - javascript benchmark 05:19:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7219.2025820258705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.4922137847257, 3210.486322188449, 3225.822579758112, 3227.4836026235794, 3274.705276525113, 4157.646600038996, 4567.680262381635, 5205.672553498862, 5510.035743744844, 5566.749496272672, 5425.945740542594, 5433.8369848904595, 5444.0, 5525.392206857243, 5623.184638227454, 4787.257975013878, 4787.593054590364, 4876.0247950409885, 4876.341693871317, 4901.828436004741, 3957.525096988351, 4857.587105096071, 4922.261660750898, 4927.679700819435, 5041.72270525121, 4949.505049495057, 5008.173651347523, 5044.672096313746, 5048.848534543951, 5079.542841144296, 4787.257975013878, 4890.657653964224, 4916.950830491685, 4924.975375123137, 4944.283078953567, 4811.109944660249, 4892.68197567157, 4906.288588154734, 4908.288298196777, 4963.578095861856, 5049.621278404097, 5382.811601593926, 5468.207109969032, 5473.370562385337, 5526.50261476469, 4867.196912509432, 5918.112283157518, 6012.158297838306, 6035.879282414371, 6039.003564411867, 6103.792276408629, 6110.285381942539, 6112.594670127729, 6114.755409783604, 6131.560175786004, 5791.478766910914, 5799.3620701722775, 5815.331236907725, 5825.475707186373, 5827.796027139072, 5984.0, 6096.481799047131, 6106.938930610726, 6210.875782484415, 6277.748890044347, 5792.304923409218, 5902.439268269508, 5917.911231331534, 5934.643921364732, 5992.64044157352, 4805.9759701201965, 5998.940010599926, 6064.818055458343, 6085.08723691441, 6100.633961962297, 5881.823545293648, 6041.6375017499095, 6048.909266361008, 6057.697115144225, 6066.45401913821, 5917.437843404869, 5995.430434108753, 6036.185115009505, 6062.939370606326, 6067.0, 4803.95196048042, 4834.685745426536, 4899.730514821647, 4900.019996000814, 4912.459629440758, 3517.56030496188, 4189.72766770159, 4271.807768650418, 4283.7001409901, 4390.824367025347, 4178.331466965332, 5691.459311365414, 5717.971410142923, 5741.368449470555, 5762.711864406763, 5110.821121260738, 5844.422006058426, 5990.011648078018, 6033.5173186145, 6088.786892458743, 5666.943330566724, 5673.744681489343, 5714.285714285715, 5730.083186690193, 5753.194552762617, 5309.415964244007, 5335.359756829128, 5352.57179425645, 5390.757415916293, 5391.56867450603, 6254.3745625437095, 6262.373762623702, 6263.874722505524, 6288.182536270256, 6302.212223472066, 5976.462118409364, 5985.521158307412, 6035.547333949883, 6112.724927378367, 6143.139960405636, 6112.022076467744, 6133.763142530502, 6182.227221597301, 6224.657643829632, 6319.494440444845, 4670.696404733681, 5863.912041319299, 5970.104484327212, 6011.579189456696, 6092.939070609237, 4828.913494463858, 6036.9094463582205, 6079.118527813531, 6105.664188469499, 6115.3578874217565, 5737.053386191232, 5880.176775251382, 5881.176635271151, 5912.852178695567, 5922.674252916131, 4217.641500472494, 5836.387179346108, 5889.381614930542, 5930.555208359304, 5958.731857066529, 5581.246531718166, 5728.828135155952, 5763.36602973681, 5797.043487824461, 5833.416658334133, 5034.823781167642, 5927.525797936069, 5928.970355148197, 5942.61373010753, 6003.759849605967, 5608.9158662619275, 5669.7165141741925, 5675.318961724454, 5767.106098554731, 5825.825225243249], "value": 5443.5566828399615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.4933951517816, 711.3277952335043, 784.4665627373386, 1141.7374003979085, 1184.070504653847, 35209.647903520956, 35762.0, 35793.82103089484, 35845.64154358459, 35847.4622880657, 36286.45570316447, 36572.08569785757, 36624.0, 36675.81662091692, 36810.815945920236, 7579.810504737385, 7740.4968677036095, 7905.644246008915, 8136.75589732309, 8158.265756081952, 8251.29863961564, 8278.958605206966, 8309.501429914195, 8316.0, 8338.62476188573, 7570.470067095305, 7740.0, 8307.293880020206, 8354.415190936637, 8358.623861926197, 8267.0, 8290.668373265062, 8303.95848020759, 8313.293370063551, 8317.209865062809, 8010.8798368023945, 8078.555679437629, 8085.757427277191, 8095.299987002736, 8097.392695547798, 35300.64699352999, 35497.82251088754, 35639.82180089083, 35714.64285357139, 35862.924112276676, 2979.7169268919633, 3070.416620842033, 3200.567923330367, 3429.588449386065, 3513.2622149348667, 28952.565711514344, 29262.853685731436, 29296.56055159174, 29425.11724648264, 29470.705292947012, 3022.199117233935, 3036.0436462514235, 3064.1573567268956, 3064.4330798802293, 3074.6003019607533, 258752.0, 259263.0, 259401.0, 276357.0, 280926.1907380941, 45177.41879034218, 47036.52963470321, 47226.5277347229, 47284.7635761819, 47394.0, 39903.401448978286, 40486.1902761949, 42805.0, 49127.75436122796, 49294.75352623286, 13544.187348759106, 13593.796093058612, 13873.930630346784, 13875.37560809766, 13919.930400347934, 9188.770280743034, 11115.333080015225, 11122.61070862516, 11142.665720028412, 11194.992450679478, 13346.933265333611, 13401.530946417024, 13427.798583021262, 13471.191728496322, 13491.797623035662, 5680.11958146488, 5745.569082318842, 5776.1624564437925, 5777.45791851584, 5784.1902133701315, 849.668629234599, 856.4518708026743, 878.1920633017639, 889.7063968890251, 922.8892532895961, 19827.702584461244, 23122.421939451648, 24118.0, 24174.0, 24364.512709745704, 1043.3479075577764, 1050.9421981791074, 1075.2741899217997, 1082.626493859617, 1097.3306283167262, 9974.700758977096, 11102.555897764, 11976.520939162336, 12224.449899754532, 12375.0, 324963.0, 326673.0, 326879.0, 326945.0, 329000.0, 51921.0, 52084.218736718976, 52154.47845521572, 52218.21672674913, 52446.73776631092, 1219.8902098810972, 1401.341369556307, 1429.6068581140269, 1436.5115860607443, 1441.819772528434, 20171.0, 20735.755854648167, 20924.372268831958, 21210.25764098311, 23572.29283121509, 38255.66105186305, 38417.0, 38703.61296387, 40117.59882401139, 40996.97507562335, 238703.48427352167, 241272.0, 242373.0, 243231.0, 243421.0, 33740.49389259114, 34243.14392140217, 34452.0, 34468.48297275493, 34523.4821477673, 43253.0, 44673.0, 44808.327875081246, 44855.0, 45018.87452813706, 27591.034313798922, 29219.85390073036, 29386.265343365732, 30469.847650761603, 30783.0, 24140.51718965576, 26556.203313900613, 27496.862515687295, 28748.0, 30881.845590771904, 32523.0, 32759.525821337622, 36273.911782646566, 36332.0, 36345.0, 29319.41361172722, 29466.821327147532, 30643.701722371356, 31040.393872649318, 31054.53823631528, 22220.66668999934, 23805.761942380355, 23927.16254931069, 23949.521009579363, 24295.149669761475], "value": 16685.29492714393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.4133083037103, 396.51625017478665, 405.43239464749354, 416.52724158080576, 416.60645142, 11615.186936914419, 17740.911295443504, 17948.0, 19781.0, 20701.792982070176, 21077.051532681027, 21112.683309750366, 21937.0, 22247.11011559536, 22357.888210558925, 5419.783208671648, 5844.532437404998, 5865.677387743673, 5873.4420230078285, 5894.351621321651, 5003.374578177728, 5661.726111624893, 5733.913991290134, 5796.884062318751, 5854.414558544154, 5612.887742245173, 5836.854078648046, 5849.912251316234, 5852.795152169675, 5856.619319744224, 4926.950730492703, 5802.274715660564, 5808.564357673149, 5822.301323841124, 5866.706664666771, 5074.3657042869645, 5292.841214763564, 5302.973485132549, 5303.310569625924, 5309.893802123975, 24852.3786905327, 24939.0, 24968.00127994878, 25008.374790630198, 25313.240602781763, 1824.79927208007, 1894.6873765828623, 2160.319499357697, 2161.7189765330563, 2168.0, 13721.931390343085, 16546.83453165465, 17281.39515116965, 17294.394696185573, 17409.65180696379, 1981.881087134762, 1988.9602207955904, 2001.5296405344732, 2048.979510204894, 2076.5431605046865, 138069.0, 138882.0, 139742.90385644324, 140330.0, 140379.0, 11580.247283926517, 11887.10846686502, 12046.216995895238, 12067.57763478274, 12143.14997950135, 15313.387464501295, 15484.148371839432, 15511.844881551266, 15516.456924007605, 15522.611934701723, 8429.915700843036, 8686.305095592337, 8828.984666763276, 8868.733937981742, 8870.0, 6721.227058888193, 8274.172582741678, 8301.750947471586, 8420.915790842135, 8431.241188292961, 7623.923760762433, 7713.2286771322415, 7734.071911370559, 7780.610969451504, 7808.843823123506, 1806.5664240582166, 2138.251611935841, 2145.3671167005773, 2149.8387620928493, 2293.1728711062974, 701.4073108223542, 805.5126648377765, 824.431142511665, 850.1923172985564, 851.1828644501348, 17165.399211027805, 18148.183331750104, 18933.0, 19900.50248743793, 20249.39251822448, 718.6119495472386, 822.0258993093204, 878.4509681449094, 912.625823412411, 921.5069937583361, 9536.141747242782, 9949.850752238723, 10051.899481005243, 10128.987101289813, 10389.064984151462, 467428.0, 500095.0, 509836.0, 513957.0, 514502.0, 115317.0, 132615.33692331475, 134090.3295483536, 134907.32546337205, 138755.30622346824, 1048.6172547020283, 1068.257560995101, 1135.4890299365318, 1140.6692059302875, 1142.948567314473, 17968.91015544914, 19309.841409515473, 21361.78638213598, 21658.566828663024, 21692.91535423191, 58110.41889581219, 58535.536611583346, 58871.41128588659, 59333.70333148307, 59349.0, 75430.55395859621, 77369.0, 78416.0, 81164.59417702873, 81404.0, 7869.449138560246, 8063.596820158851, 8344.749657510285, 8803.955980220315, 8914.55427228623, 13628.454861805416, 13788.724225515232, 13886.305684715522, 13994.510192143227, 14205.573832785032, 11512.712182195512, 11752.529898804294, 11774.646760597196, 11870.109741769229, 11929.582464613697, 8922.73231803047, 10390.22073344487, 10589.099926506333, 10721.035106840422, 11165.776684466102, 12107.33409662477, 12159.696007599881, 12315.93842030784, 12321.383930803604, 12426.0, 7111.359977602041, 8448.366372521963, 8468.03618733463, 8634.179752923463, 8635.050144483976, 11644.301341919512, 11660.88339116598, 11824.40877956116, 11828.70428239301, 11858.40707964581], "value": 9884.753690806434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1143.9256448330857, 1225.8528976522819, 1344.4958140697238, 1358.110437663331, 1375.6698392385824, 9857.7535561611, 10993.780124397506, 11580.826287605682, 11587.0, 11688.415579221048, 11237.101031917447, 11510.712232194199, 11532.423378831047, 11579.42102894854, 11583.957443830053, 2384.153625462962, 2408.9156879509133, 2414.0705828256073, 2415.9396015099587, 2421.9757802422014, 2331.3821837213154, 2389.307100940725, 2390.6492831550204, 2392.437777122375, 2406.7352591214953, 2347.6361164019604, 2363.9054437822465, 2405.1341517053847, 2409.3976505873534, 2411.0837881604966, 2321.454458202321, 2338.695969523968, 2372.58479766042, 2373.8961382956923, 2376.988115059431, 1924.7305377247196, 1947.269773834812, 2261.412032871449, 2347.0729062020578, 2351.9412014699597, 11278.0, 11280.210385273034, 11384.886151138466, 11435.485403156878, 11444.48499817502, 6307.400796924285, 6524.054012168209, 6558.016297555358, 6562.967185164043, 6569.770058047993, 3841.116543195053, 4160.854370097062, 4233.576642335773, 4249.490061192677, 4265.936010959838, 1195.9893889663222, 1203.3080978437347, 1241.6585439004257, 1253.9059570532156, 1260.1934761752486, 13086.934565327208, 13419.798703019462, 15936.964097333635, 16229.0, 16264.51206463808, 5286.973565132226, 5436.429174936575, 5467.480589344006, 5468.890622187613, 5567.749451274703, 11220.326780393203, 11284.605038823602, 11336.886631133582, 11403.144764142722, 11411.885881141248, 5989.580729348903, 6060.909086363708, 6282.057691346243, 6283.7800676976085, 6342.112104305401, 6055.182550355646, 6075.908861367083, 6145.293291271471, 6159.291681456601, 6165.0, 3484.9477257841154, 4126.834926602963, 4213.052063285736, 4216.430781844411, 4293.098449325614, 1219.5670536959428, 1221.9205751626116, 1232.5131573028602, 1240.2496489623827, 1248.3820508848178, 660.5277226782873, 686.7562015484531, 696.5681277607915, 700.2297472779901, 708.8445833291702, 6029.638221706711, 6034.185384972972, 6514.05546195799, 6605.141331626954, 6638.070670106189, 723.6056349289545, 798.4929569723151, 838.8993320801543, 873.6549063120032, 876.2245412809709, 3353.564036675217, 4212.23086303747, 4229.894252643647, 4295.6778241632, 4349.739015659071, 14161.929190354189, 14548.927255363655, 14550.927245363917, 14643.414263429557, 14659.853401465849, 14020.71958560823, 14310.0, 14465.349059292357, 14750.336234869457, 14763.852361476462, 8000.439969202216, 8156.714514991947, 8163.877541836877, 8210.261076503144, 8220.136885627042, 6393.808185754435, 6421.422072013541, 6441.194850643669, 6604.933950660624, 6700.195976482658, 11893.870082342164, 12038.097142714507, 12904.8064279034, 12912.741745164856, 13423.060385772902, 12146.453409596412, 12392.504299828266, 13218.867811322149, 13245.072844900764, 13621.318934053455, 7967.760967170994, 8029.919700802917, 8153.0, 8159.020917489939, 8164.061132969785, 10281.971802819658, 10368.844467332845, 10373.896261037293, 10471.371717696962, 10493.160547156362, 8819.559022049, 8823.69117080899, 8837.513936733541, 8946.194842464209, 9020.954895225483, 8675.045744967922, 8705.260052895575, 8742.431741936754, 8750.0, 8926.598303076507, 7806.375489960903, 7921.207879212263, 7924.960375198087, 7965.761027169194, 7968.880466793119, 4742.976285118552, 5551.7779288828, 5599.664020158803, 5679.119736440858, 5883.176355310175, 5812.94187058124, 5915.792947246826, 6002.909956350745, 6133.693315334126, 6158.445739883253], "value": 5124.825260428877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.38879321962827, 360.3495690279045, 369.3259800863425, 370.78865046923255, 374.4514286570174, 4133.5659755725665, 4336.696431249806, 4407.757573333465, 4758.405199350082, 4872.196087645539, 4644.653050615326, 4741.762911854411, 4753.47711751707, 4757.357756702844, 4822.4454187768415, 3470.7743996640265, 3580.9641903581023, 3581.247937933037, 3623.9456408153897, 3638.2359704462096, 3049.649290331607, 3482.59700806444, 3600.9099772505633, 3622.355680353344, 3626.4197728363465, 3390.6606890278326, 3585.9820700896457, 3591.3535563598543, 3602.081469225357, 3602.675759181673, 3209.9246752337995, 3216.5175223716396, 3594.19130695594, 3603.459481077833, 3615.9332996765884, 3354.9832250838836, 3378.2398960233995, 3380.4253276942977, 3384.560007199073, 3396.5584474018465, 4472.5303843096335, 4534.773261336953, 4556.134334476439, 4559.0, 4572.359869618256, 4394.648428125743, 4401.713888597231, 4408.655360115164, 4409.669274804402, 4427.22523558376, 4476.07528762632, 4502.369668246448, 4925.729084900329, 5198.246254293144, 5206.817761378372, 3227.0, 3916.843326266946, 3922.7254092213557, 3928.7839168845703, 3929.980350098231, 4642.328761645805, 5181.533661970403, 5265.605079619044, 5325.7869685212545, 5403.648762830403, 3056.49567821307, 3102.488089465258, 3746.0822098586023, 3768.3028639701743, 3773.2453509298252, 3804.410316400962, 3824.8661296855034, 3836.1368692044625, 3849.9605106621057, 3859.3824988001784, 3926.842926282917, 4108.91782164361, 4271.380649805823, 4325.805338759764, 4350.390945267665, 4216.620504154641, 4866.294387313819, 4982.77577509013, 5137.101007323703, 5162.277281180638, 1349.6558377613646, 1377.800218968264, 1378.9931050344685, 1381.8618138186303, 1386.1890793885489, 900.8513595256841, 943.990560094404, 982.9311948163703, 996.7508122969258, 1003.6085926488529, 4746.477887432379, 4747.0, 4772.260299653559, 4777.235642297285, 4804.735739534359, 5039.21892106724, 5259.21111833228, 5262.000219958196, 5285.841424757264, 5292.603054770908, 3944.8422063117155, 4126.525449573277, 4565.315202719618, 4782.928256076161, 4809.883651193463, 2403.182917807954, 2714.945701086007, 2749.766269867044, 2755.0, 2760.9447811043665, 4990.900181996412, 5488.231647569343, 5517.3515913324345, 5518.862028449321, 5538.224648549126, 4443.844465443759, 4456.844010459683, 4792.7363994980615, 5269.657472264367, 5373.919391209135, 4344.479432198706, 5426.453460763663, 5454.4545545445135, 5472.370677372073, 5490.203920431515, 5195.948040519546, 5238.1618940969265, 5259.395169555397, 5269.209618557247, 5278.76245568958, 5105.974470127626, 5127.179651255781, 5178.524120625603, 5180.61145414103, 5219.0, 5337.653052551572, 5367.275417818544, 5445.673259604437, 5634.605577609528, 5641.576881733804, 2978.955315670223, 3414.965850341564, 3573.910652233715, 3587.336342776595, 3598.478220658042, 5161.922571161361, 5333.866653333697, 5394.379646340564, 5405.378381486179, 5422.701751403711, 4256.9783252019915, 4500.987277862455, 4909.576222895464, 5038.546530812245, 5202.271681964452, 4649.558291962258, 4704.035672687022, 5120.385553733576, 5178.378594568676, 5214.0, 5122.436531981404, 5127.79488820443, 5167.682241028514, 5167.870803229949, 5169.405518365285, 4489.955100449084, 5131.25596788471, 5153.742312884266, 5197.8440646780655, 5241.449647786927, 4942.925856112233, 5086.593072554261, 5110.642255042111, 5132.384113906355, 5172.948270517247], "value": 3828.8917572691817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.9021372328459, 787.4055088408254, 798.1738900238254, 826.9090400055993, 831.8627426474632, 15041.924790376046, 15236.0, 15424.460143894952, 17544.561385965357, 18776.436706898814, 17235.052072136026, 17340.306387744506, 17634.647307053852, 17638.38265660702, 17981.19084641191, 964.7539877331288, 984.5372674842812, 987.6345752071708, 990.3612170150249, 993.1855878179896, 899.7795540092686, 970.2141265574907, 988.5205675247499, 990.5790039233333, 995.3977843404708, 888.506878682331, 1025.5180065369264, 1031.1338475680427, 1033.8139134955743, 1036.0675392147052, 1023.2581378500602, 1025.4616326428684, 1028.043919155189, 1030.7577719235974, 1031.432712008396, 756.1946526948836, 756.6216891554222, 757.5454727163713, 760.1562265884863, 761.1095018827984, 15818.367265309374, 16017.35930562776, 16261.593460163473, 16709.749353759704, 16913.7462938056, 16281.348746050144, 16658.33366665344, 16917.154142292835, 16953.57616059596, 17084.145792710315, 13226.338683065807, 13266.73466530664, 13391.598252052454, 13668.453261869514, 13856.93071534636, 3378.5438965739554, 3395.6943875051365, 3397.8470968806214, 3400.96599034009, 3407.6081250656243, 102578.74212578757, 103540.48229758878, 106649.73401064026, 121187.0, 127801.72198278084, 9930.453825039547, 11571.363575003288, 12956.935215323863, 13027.609171724864, 13103.60689179326, 18611.90694046548, 20195.293164739163, 21342.146314147572, 22664.0, 24438.877805610857, 6462.192225971754, 6465.967670161619, 7603.2776886195725, 7679.155292917774, 7726.0, 3742.6257374262354, 3765.6234376562675, 3811.676007539335, 3822.4266360046217, 3832.291026160169, 4145.875623731233, 4171.10321280926, 4238.364245363158, 4244.787760611957, 4252.74483530983, 902.6118768929292, 925.8333499969935, 929.2426672262085, 930.3766476460787, 936.2697096264924, 564.4496615799644, 570.6205373426708, 582.1035605168079, 589.5637228450915, 608.9117078023751, 10396.22028347877, 10932.125429965583, 11053.668389948154, 11394.487248073856, 11558.537658493566, 569.3623142080896, 573.4151165810849, 581.7440326256434, 585.4672248254068, 598.5510866849862, 4886.926696099561, 5145.331106956071, 5172.0, 5240.554552862973, 5347.491988261109, 90823.54588227016, 93616.0, 93709.0, 93803.53098234601, 95961.0403895952, 82443.0, 91815.54092229629, 94850.5257473722, 96014.51992739992, 98169.50915245521, 44531.55468445339, 74623.88064179041, 75668.86496702443, 75944.62027689937, 76979.61510192526, 11819.0, 12321.69195770077, 12336.3215023171, 12417.689557761129, 12463.937680311541, 34843.477347839296, 38982.80508597439, 39480.21039579135, 40653.39019914763, 41065.7147428211, 56359.154612680024, 62867.6856615714, 65766.0, 68217.0, 68851.31148688449, 13627.773500385012, 15620.687586247985, 16071.11608861477, 16467.505974820775, 16558.0, 14547.709045819236, 17332.0, 17881.552961176076, 17958.10209489494, 18055.277788888296, 15845.0, 16096.517104486884, 16179.595510112342, 16589.419370321983, 16694.0, 15300.540983770505, 15510.302036408615, 15848.841511584737, 16020.198990050683, 16043.037417754973, 15417.537473875802, 15676.372945082068, 15804.130772807606, 15833.445829395916, 15907.204639768197, 10798.946005269923, 11284.0, 11366.43167841588, 11421.486033128363, 11997.520099195934, 11980.46087926028, 12637.810432843698, 12643.810342844681, 12668.809967850673, 12858.935705321413], "value": 8034.516122866369, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1652.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 132.0, 97.0, 170.0, 176.0, 173.0, 119.0, 118.0, 119.0], "value": 133.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 142.0, 195.0, 158.0, 119.0, 124.0, 163.0, 156.0, 101.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [239.0, 242.0, 254.0, 228.0, 224.0, 228.0, 227.0, 226.0, 247.0, 246.0], "value": 236.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 63.0, 111.0, 88.0, 49.0, 83.0, 56.0, 81.0, 49.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 60.0, 108.0, 109.0, 106.0, 106.0, 92.0, 70.0, 67.0, 94.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 93.0, 93.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 105.0, 105.0, 103.0, 100.0, 103.0, 101.0, 101.0, 100.0, 104.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 107.0, 115.0, 108.0, 110.0, 112.0, 113.0, 104.0, 174.0], "value": 116.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 55.0, 71.0, 80.0, 55.0, 53.0, 47.0, 47.0, 62.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 63.0, 67.0, 71.0, 67.0, 62.0, 61.0, 62.0, 74.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 88.0, 88.0, 87.0, 90.0, 78.0, 103.0, 115.0, 114.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 154.0, 145.0, 145.0, 158.0, 147.0, 149.0, 200.0, 180.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 229.0, 248.0, 206.0, 200.0, 202.0, 191.0, 193.0, 199.0, 193.0], "value": 204.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 88.0, 109.0, 102.0, 70.0, 71.0, 73.0, 78.0, 71.0, 70.0], "value": 81.0, "unit": "score"}]}]} 05:19:55 INFO - Return code: 0 05:19:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:19:55 ERROR - # TBPL SUCCESS # 05:19:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:55 INFO - 2017-04-28 05:19:55.303 screenresolution[1662:10758] starting screenresolution argv=screenresolution get 05:19:55 INFO - 2017-04-28 05:19:55.306 screenresolution[1662:10758] Display 0: 1600x1200x32@60 05:19:55 INFO - 2017-04-28 05:19:55.312 screenresolution[1663:10761] starting screenresolution argv=screenresolution list 05:19:55 INFO - Available Modes on Display 0 05:19:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:55 INFO - Intel Iris: 05:19:55 INFO - Chipset Model: Intel Iris 05:19:55 INFO - Type: GPU 05:19:55 INFO - Bus: Built-In 05:19:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:55 INFO - Vendor: Intel (0x8086) 05:19:55 INFO - Device ID: 0x0a2e 05:19:55 INFO - Revision ID: 0x0009 05:19:55 INFO - Displays: 05:19:55 INFO - Display: 05:19:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:55 INFO - Display Serial Number: 1600x1200 60 05:19:55 INFO - Main Display: Yes 05:19:55 INFO - Mirror: Off 05:19:55 INFO - Online: Yes 05:19:55 INFO - Rotation: Supported 05:19:55 INFO - Return code: 0 05:19:55 INFO - Running post-action listener: _resource_record_post_action 05:19:55 INFO - [mozharness: 2017-04-28 12:19:55.556867Z] Finished run-tests step (success) 05:19:55 INFO - Running post-run listener: _resource_record_post_run 05:19:55 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39983104; Write bytes: 514080768; Read time: 396; Write time: 1736 05:19:55 INFO - TinderboxPrint: CPU usage
54.2% 05:19:55 INFO - TinderboxPrint: I/O read bytes / time
39,983,104 / 396 05:19:55 INFO - TinderboxPrint: I/O write bytes / time
514,080,768 / 1,736 05:19:55 INFO - TinderboxPrint: CPU idle
2,200.1 (45.8%) 05:19:55 INFO - TinderboxPrint: CPU system
968.1 (20.1%) 05:19:55 INFO - TinderboxPrint: CPU user
1,637.5 (34.1%) 05:19:55 INFO - TinderboxPrint: Swap in / out
248,692,736 / 0 05:19:55 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 208417280; Write bytes: 203866112; Read time: 16771; Write time: 371 05:19:55 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37861376; Write bytes: 303087616; Read time: 370; Write time: 1336 05:19:56 INFO - Running post-run listener: _upload_blobber_files 05:19:56 INFO - Blob upload gear active. 05:19:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:19:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:19:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:19:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:57 INFO - (blobuploader) - INFO - Done attempting. 05:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:19:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:58 INFO - (blobuploader) - INFO - Done attempting. 05:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:59 INFO - (blobuploader) - INFO - Done attempting. 05:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:01 INFO - (blobuploader) - INFO - Done attempting. 05:20:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:01 INFO - Return code: 0 05:20:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bba9e299f57676f0c2f82bf8f850af8b05cea487ed8b940b2956cf4b80cf5d7dba6232d28d692aacf358ab80b2776d5fa6f64bf4bed4e3f8a78bcfc9499015", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d2b01486ea6b796b174d3cd5f5dcf41d2fba3a8d505fde98542a289a50f49d82f93b9335d22c9ed2bca510f3908ec0c2c56bfb36c2b8439a6cf23c15fda3764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b15b3ed6618910f450e8217e2a96aea6d27a0e9e28976dbf00816f2793228093d5951d73f545072547f51f072cfa128eb0237111da2c340349bc7e92e19baf68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d581941835ed7bbac450bc07b0a1e0f709b1df5e3c2258f8eec9b7fab96090b08f130c8f1399d0b9a3ef4412e124a46fd80d8bf80bd905980837c58d514133"} 05:20:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:01 INFO - Contents: 05:20:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bba9e299f57676f0c2f82bf8f850af8b05cea487ed8b940b2956cf4b80cf5d7dba6232d28d692aacf358ab80b2776d5fa6f64bf4bed4e3f8a78bcfc9499015", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d2b01486ea6b796b174d3cd5f5dcf41d2fba3a8d505fde98542a289a50f49d82f93b9335d22c9ed2bca510f3908ec0c2c56bfb36c2b8439a6cf23c15fda3764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b15b3ed6618910f450e8217e2a96aea6d27a0e9e28976dbf00816f2793228093d5951d73f545072547f51f072cfa128eb0237111da2c340349bc7e92e19baf68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d581941835ed7bbac450bc07b0a1e0f709b1df5e3c2258f8eec9b7fab96090b08f130c8f1399d0b9a3ef4412e124a46fd80d8bf80bd905980837c58d514133"} 05:20:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:01 INFO - Copying logs to upload dir... 05:20:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.035653 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-28 05:20:01.484388) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 05:20:01.489920) ========= 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.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/c0bba9e299f57676f0c2f82bf8f850af8b05cea487ed8b940b2956cf4b80cf5d7dba6232d28d692aacf358ab80b2776d5fa6f64bf4bed4e3f8a78bcfc9499015", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d2b01486ea6b796b174d3cd5f5dcf41d2fba3a8d505fde98542a289a50f49d82f93b9335d22c9ed2bca510f3908ec0c2c56bfb36c2b8439a6cf23c15fda3764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b15b3ed6618910f450e8217e2a96aea6d27a0e9e28976dbf00816f2793228093d5951d73f545072547f51f072cfa128eb0237111da2c340349bc7e92e19baf68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d581941835ed7bbac450bc07b0a1e0f709b1df5e3c2258f8eec9b7fab96090b08f130c8f1399d0b9a3ef4412e124a46fd80d8bf80bd905980837c58d514133"} build_url:https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011983 build_url: 'https://queue.taskcluster.net/v1/task/XBfrIYqgSbCr3x8fpIo7ZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0bba9e299f57676f0c2f82bf8f850af8b05cea487ed8b940b2956cf4b80cf5d7dba6232d28d692aacf358ab80b2776d5fa6f64bf4bed4e3f8a78bcfc9499015", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d2b01486ea6b796b174d3cd5f5dcf41d2fba3a8d505fde98542a289a50f49d82f93b9335d22c9ed2bca510f3908ec0c2c56bfb36c2b8439a6cf23c15fda3764", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b15b3ed6618910f450e8217e2a96aea6d27a0e9e28976dbf00816f2793228093d5951d73f545072547f51f072cfa128eb0237111da2c340349bc7e92e19baf68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d581941835ed7bbac450bc07b0a1e0f709b1df5e3c2258f8eec9b7fab96090b08f130c8f1399d0b9a3ef4412e124a46fd80d8bf80bd905980837c58d514133"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 05:20:01.530414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:20:01.530953) ========= 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.2botxLu1t5/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.j8N0D3c8CZ/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005482 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:20:01.580334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 05:20:01.580691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 05:20:01.581015) ========= ========= Total master_lag: 0.18 =========