builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0109 starttime: 1492078834.59 results: success (0) buildid: 20170412201513 builduid: 515324dbf433411291eb914102ff66b0 revision: 2491cacba780598847e92e713b50d81734eeee3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:34.586647) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:34.587266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:34.589721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:34.636767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-13 03:20:34.637162) ========= 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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-13 03:20:34-- 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% 147M=0s 2017-04-13 03:20:34 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174705 ========= master_lag: 2.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-13 03:20:37.485735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:37.486078) ========= 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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.037142 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:37.547380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 03:20:37.547755) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 2491cacba780598847e92e713b50d81734eeee3a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 2491cacba780598847e92e713b50d81734eeee3a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-13 03:20:37,653 truncating revision to first 12 chars 2017-04-13 03:20:37,653 Setting DEBUG logging. 2017-04-13 03:20:37,654 attempt 1/10 2017-04-13 03:20:37,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/2491cacba780?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 03:20:38,543 unpacking tar archive at: pine-2491cacba780/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 03:20:38.736363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:38.736707) ========= script_repo_revision: 2491cacba780598847e92e713b50d81734eeee3a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:38.737149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:38.737427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 03:20:38.757359) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-13 03:20:38.757760) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:20:38 INFO - MultiFileLogger online at 20170413 03:20:38 in /builds/slave/test 03:20:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 03:20:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:38 INFO - {'append_to_log': False, 03:20:38 INFO - 'base_work_dir': '/builds/slave/test', 03:20:38 INFO - 'blob_upload_branch': 'Pine', 03:20:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:38 INFO - 'branch': 'Pine', 03:20:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:38 INFO - 'config_files': ('talos/mac_config.py',), 03:20:38 INFO - 'default_actions': ('clobber', 03:20:38 INFO - 'read-buildbot-config', 03:20:38 INFO - 'download-and-extract', 03:20:38 INFO - 'populate-webroot', 03:20:38 INFO - 'create-virtualenv', 03:20:38 INFO - 'install', 03:20:38 INFO - 'run-tests'), 03:20:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:38 INFO - 'download_minidump_stackwalk': True, 03:20:38 INFO - 'download_symbols': 'ondemand', 03:20:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:38 INFO - 'gecko_profile': False, 03:20:38 INFO - 'gecko_profile_interval': 0, 03:20:38 INFO - 'installer_path': 'installer.exe', 03:20:38 INFO - 'log_level': 'info', 03:20:38 INFO - 'log_name': 'talos', 03:20:38 INFO - 'log_to_console': True, 03:20:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:38 INFO - 'opt_config_files': (), 03:20:38 INFO - 'pip_index': False, 03:20:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:38 INFO - 'cmd': ('bash', 03:20:38 INFO - '-c', 03:20:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:38 INFO - 'enabled': True, 03:20:38 INFO - 'halt_on_failure': False, 03:20:38 INFO - 'name': 'check_screen_resolution'},), 03:20:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:38 INFO - 'cmd': ('bash', 03:20:38 INFO - '-c', 03:20:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:38 INFO - 'enabled': True, 03:20:38 INFO - 'halt_on_failure': False, 03:20:38 INFO - 'name': 'check_screen_resolution'},), 03:20:38 INFO - 'run_cmd_checks_enabled': True, 03:20:38 INFO - 'suite': 'dromaeojs-e10s', 03:20:38 INFO - 'system_bits': '32', 03:20:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:38 INFO - 'title': 't-yosemite-r7-0109', 03:20:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:38 INFO - 'use_talos_json': True, 03:20:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:38 INFO - 'work_dir': 'build'} 03:20:38 INFO - [mozharness: 2017-04-13 10:20:38.976817Z] Running clobber step. 03:20:38 INFO - Running pre-action listener: _resource_record_pre_action 03:20:38 INFO - Running main action method: clobber 03:20:38 INFO - rmtree: /builds/slave/test/build 03:20:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:41 INFO - Running post-action listener: _resource_record_post_action 03:20:41 INFO - [mozharness: 2017-04-13 10:20:41.576698Z] Finished clobber step (success) 03:20:41 INFO - [mozharness: 2017-04-13 10:20:41.576897Z] Running read-buildbot-config step. 03:20:41 INFO - Running pre-action listener: _resource_record_pre_action 03:20:41 INFO - Running main action method: read_buildbot_config 03:20:41 INFO - Using buildbot properties: 03:20:41 INFO - { 03:20:41 INFO - "project": "", 03:20:41 INFO - "product": "firefox", 03:20:41 INFO - "script_repo_revision": "default", 03:20:41 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 03:20:41 INFO - "repository": "", 03:20:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 03:20:41 INFO - "buildid": "20170412201513", 03:20:41 INFO - "stage_platform": "macosx64", 03:20:41 INFO - "basedir": "/builds/slave/test", 03:20:41 INFO - "buildnumber": 12, 03:20:41 INFO - "platform": "yosemite_r7", 03:20:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:20:41 INFO - "slavebuilddir": "test", 03:20:41 INFO - "branch": "pine", 03:20:41 INFO - "revision": "2491cacba780598847e92e713b50d81734eeee3a", 03:20:41 INFO - "slavename": "t-yosemite-r7-0109", 03:20:41 INFO - "builduid": "515324dbf433411291eb914102ff66b0", 03:20:41 INFO - "repo_path": "projects/pine" 03:20:41 INFO - } 03:20:41 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg. 03:20:41 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.test_packages.json. 03:20:41 INFO - Running post-action listener: _resource_record_post_action 03:20:41 INFO - [mozharness: 2017-04-13 10:20:41.580928Z] Finished read-buildbot-config step (success) 03:20:41 INFO - [mozharness: 2017-04-13 10:20:41.581077Z] Running download-and-extract step. 03:20:41 INFO - Running pre-action listener: _resource_record_pre_action 03:20:41 INFO - Running main action method: download_and_extract 03:20:41 INFO - mkdir: /builds/slave/test/build/tests 03:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.test_packages.json 03:20:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/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 03:20:41 INFO - Downloaded 1325 bytes. 03:20:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:20:41 INFO - Using the following test package requirements: 03:20:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:20:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:20:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:20:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:20:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'jsshell-mac.zip'], 03:20:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:20:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:20:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:20:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:20:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:20:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:20:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:20:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip 03:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:20:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:20:42 INFO - Expected file size: 52594465 03:20:42 INFO - Obtained file size: 52594465 03:20:59 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 03:20:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip 03:20:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:20:59 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:21:00 INFO - Expected file size: 52594465 03:21:00 INFO - Obtained file size: 52594465 03:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.talos.tests.zip 03:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:21:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:21:16 INFO - Expected file size: 14405596 03:21:16 INFO - Obtained file size: 14405596 03:21: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')]} 03:21:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg 03:21:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:21:18 INFO - Downloaded 71020951 bytes. 03:21:18 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg 03:21:18 INFO - mkdir: /builds/slave/test/properties 03:21:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:18 INFO - Contents: 03:21:18 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg 03:21:18 INFO - Running post-action listener: _resource_record_post_action 03:21:18 INFO - Running post-action listener: set_extra_try_arguments 03:21:18 INFO - [mozharness: 2017-04-13 10:21:18.693163Z] Finished download-and-extract step (success) 03:21:18 INFO - [mozharness: 2017-04-13 10:21:18.693280Z] Running populate-webroot step. 03:21:18 INFO - Running pre-action listener: _resource_record_pre_action 03:21:18 INFO - Running main action method: populate_webroot 03:21:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:18 INFO - '--tppagecycles', 03:21:18 INFO - '7'], 03:21:18 INFO - 'tests': ['tsvgm']}}, 03:21:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['damp', 'tps']}, 03:21:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'tests': ['damp', 'tps']}, 03:21:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['dromaeo_dom']}, 03:21:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['basic_compositor_video']}, 03:21:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:21:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['a11yr', 03:21:18 INFO - 'ts_paint', 03:21:18 INFO - 'tpaint', 03:21:18 INFO - 'sessionrestore', 03:21:18 INFO - 'sessionrestore_no_auto_restore', 03:21:18 INFO - 'tabpaint']}, 03:21:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['tsvgx', 03:21:18 INFO - 'tsvgr_opacity', 03:21:18 INFO - 'tart', 03:21:18 INFO - 'tscrollx', 03:21:18 INFO - 'cart', 03:21:18 INFO - 'tsvg_static']}, 03:21:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:18 INFO - 'tsvgr_opacity', 03:21:18 INFO - 'tart', 03:21:18 INFO - 'tscrollx', 03:21:18 INFO - 'cart', 03:21:18 INFO - 'tsvg_static']}, 03:21:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'talos_options': ['--disable-e10s'], 03:21:18 INFO - 'tests': ['tp5o']}, 03:21:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:21:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'talos_options': ['--disable-e10s', 03:21:18 INFO - '--xperf_path', 03:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:18 INFO - 'tests': ['tp5n']}, 03:21:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:21:18 INFO - 'talos_options': ['--xperf_path', 03:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:18 INFO - 'tests': ['tp5n']}}, 03:21:18 INFO - 'talos.zip': {'path': '', 03:21:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:18 INFO - Running post-action listener: _resource_record_post_action 03:21:18 INFO - [mozharness: 2017-04-13 10:21:18.711586Z] Finished populate-webroot step (success) 03:21:18 INFO - [mozharness: 2017-04-13 10:21:18.711694Z] Running create-virtualenv step. 03:21:18 INFO - Running pre-action listener: _resource_record_pre_action 03:21:18 INFO - Running main action method: create_virtualenv 03:21:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:21:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:18 INFO - Using real prefix '/tools/python27' 03:21:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:22 INFO - Installing pip.................done. 03:21:22 INFO - Return code: 0 03:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:21:22 INFO - Reading from file tmpfile_stdout 03:21:22 INFO - Output received: 03:21:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:21:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:22 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 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:22 INFO - 'HOME': '/Users/cltbld', 03:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:22 INFO - 'LOGNAME': 'cltbld', 03:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:22 INFO - 'MOZ_NO_REMOTE': '1', 03:21:22 INFO - 'NO_EM_RESTART': '1', 03:21:22 INFO - 'PAGER': '/bin/cat', 03:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:22 INFO - 'PWD': '/builds/slave/test', 03:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:22 INFO - 'SHELL': '/bin/bash', 03:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:22 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:22 INFO - 'USER': 'cltbld', 03:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:22 INFO - 'XPC_FLAGS': '0x0', 03:21:22 INFO - 'XPC_SERVICE_NAME': '0', 03:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:21:22 INFO - Cleaning up... 03:21:22 INFO - Return code: 0 03:21:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:22 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 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:22 INFO - 'HOME': '/Users/cltbld', 03:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:22 INFO - 'LOGNAME': 'cltbld', 03:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:22 INFO - 'MOZ_NO_REMOTE': '1', 03:21:22 INFO - 'NO_EM_RESTART': '1', 03:21:22 INFO - 'PAGER': '/bin/cat', 03:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:22 INFO - 'PWD': '/builds/slave/test', 03:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:22 INFO - 'SHELL': '/bin/bash', 03:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:22 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:22 INFO - 'USER': 'cltbld', 03:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:22 INFO - 'XPC_FLAGS': '0x0', 03:21:22 INFO - 'XPC_SERVICE_NAME': '0', 03:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:23 INFO - Downloading/unpacking psutil>=3.1.1 03:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:27 INFO - Installing collected packages: psutil 03:21:27 INFO - Running setup.py install for psutil 03:21:27 INFO - building 'psutil._psutil_osx' extension 03:21:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:21:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:21: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 03:21: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 03:21:28 INFO - building 'psutil._psutil_posix' extension 03:21: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 03:21:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:28 INFO - ^ 03:21:28 INFO - 1 warning generated. 03:21:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:28 INFO - Successfully installed psutil 03:21:28 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:28 INFO - 'HOME': '/Users/cltbld', 03:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:28 INFO - 'LOGNAME': 'cltbld', 03:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:28 INFO - 'MOZ_NO_REMOTE': '1', 03:21:28 INFO - 'NO_EM_RESTART': '1', 03:21:28 INFO - 'PAGER': '/bin/cat', 03:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:28 INFO - 'PWD': '/builds/slave/test', 03:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:28 INFO - 'SHELL': '/bin/bash', 03:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:28 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:28 INFO - 'USER': 'cltbld', 03:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:28 INFO - 'XPC_FLAGS': '0x0', 03:21:28 INFO - 'XPC_SERVICE_NAME': '0', 03:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:31 INFO - Installing collected packages: mozsystemmonitor 03:21:31 INFO - Running setup.py install for mozsystemmonitor 03:21:31 INFO - Successfully installed mozsystemmonitor 03:21:31 INFO - Cleaning up... 03:21:31 INFO - Return code: 0 03:21:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:32 INFO - 'HOME': '/Users/cltbld', 03:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:32 INFO - 'LOGNAME': 'cltbld', 03:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:32 INFO - 'MOZ_NO_REMOTE': '1', 03:21:32 INFO - 'NO_EM_RESTART': '1', 03:21:32 INFO - 'PAGER': '/bin/cat', 03:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:32 INFO - 'PWD': '/builds/slave/test', 03:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:32 INFO - 'SHELL': '/bin/bash', 03:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:32 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:32 INFO - 'USER': 'cltbld', 03:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:32 INFO - 'XPC_FLAGS': '0x0', 03:21:32 INFO - 'XPC_SERVICE_NAME': '0', 03:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:36 INFO - warning: no files found matching '*.txt' 03:21:36 INFO - no previously-included directories found matching 'build' 03:21:36 INFO - no previously-included directories found matching 'dist' 03:21:36 INFO - no previously-included directories found matching '.git*' 03:21:36 INFO - Installing collected packages: jsonschema, functools32 03:21:36 INFO - Running setup.py install for functools32 03:21:36 INFO - warning: no files found matching '*.txt' 03:21:36 INFO - no previously-included directories found matching 'build' 03:21:36 INFO - no previously-included directories found matching 'dist' 03:21:36 INFO - no previously-included directories found matching '.git*' 03:21:36 INFO - Successfully installed jsonschema functools32 03:21:36 INFO - Cleaning up... 03:21:36 INFO - Return code: 0 03:21:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:36 INFO - 'HOME': '/Users/cltbld', 03:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:36 INFO - 'LOGNAME': 'cltbld', 03:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:36 INFO - 'MOZ_NO_REMOTE': '1', 03:21:36 INFO - 'NO_EM_RESTART': '1', 03:21:36 INFO - 'PAGER': '/bin/cat', 03:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:36 INFO - 'PWD': '/builds/slave/test', 03:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:36 INFO - 'SHELL': '/bin/bash', 03:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:36 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:36 INFO - 'USER': 'cltbld', 03:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:36 INFO - 'XPC_FLAGS': '0x0', 03:21:36 INFO - 'XPC_SERVICE_NAME': '0', 03:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:36 INFO - Cleaning up... 03:21:36 INFO - Return code: 0 03:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:36 INFO - 'HOME': '/Users/cltbld', 03:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:36 INFO - 'LOGNAME': 'cltbld', 03:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:36 INFO - 'MOZ_NO_REMOTE': '1', 03:21:36 INFO - 'NO_EM_RESTART': '1', 03:21:36 INFO - 'PAGER': '/bin/cat', 03:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:36 INFO - 'PWD': '/builds/slave/test', 03:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:36 INFO - 'SHELL': '/bin/bash', 03:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:36 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:36 INFO - 'USER': 'cltbld', 03:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:36 INFO - 'XPC_FLAGS': '0x0', 03:21:36 INFO - 'XPC_SERVICE_NAME': '0', 03:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:40 INFO - Downloading docopt-0.6.1.tar.gz 03:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:41 INFO - Running setup.py install for blobuploader 03:21:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:41 INFO - Running setup.py install for requests 03:21:41 INFO - Running setup.py install for docopt 03:21:41 INFO - Successfully installed blobuploader requests docopt 03:21:41 INFO - Cleaning up... 03:21:42 INFO - Return code: 0 03:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21: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 03:21: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 03:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:42 INFO - 'HOME': '/Users/cltbld', 03:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:42 INFO - 'LOGNAME': 'cltbld', 03:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:42 INFO - 'MOZ_NO_REMOTE': '1', 03:21:42 INFO - 'NO_EM_RESTART': '1', 03:21:42 INFO - 'PAGER': '/bin/cat', 03:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:42 INFO - 'PWD': '/builds/slave/test', 03:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:42 INFO - 'SHELL': '/bin/bash', 03:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:42 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:42 INFO - 'USER': 'cltbld', 03:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:42 INFO - 'XPC_FLAGS': '0x0', 03:21:42 INFO - 'XPC_SERVICE_NAME': '0', 03:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-_pgK8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-926Fw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-QH22xZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-1wZCuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-sxsW2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-RnOgh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-YNB6UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-TBxitE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-CL4LWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-v81__t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-MW6T5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-I4Crja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-pvAEpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-VOpgUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-aGHqQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Pzqysg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-FbXhW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:44 INFO - Running setup.py install for manifestparser 03:21:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:44 INFO - Running setup.py install for mozcrash 03:21:44 INFO - Running setup.py install for mozdebug 03:21:44 INFO - Running setup.py install for mozdevice 03:21:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:44 INFO - Running setup.py install for mozfile 03:21:44 INFO - Running setup.py install for mozhttpd 03:21:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:44 INFO - Running setup.py install for mozinfo 03:21:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Running setup.py install for mozInstall 03:21:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Running setup.py install for mozleak 03:21:45 INFO - Running setup.py install for mozlog 03:21:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Running setup.py install for moznetwork 03:21:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Running setup.py install for mozprocess 03:21:45 INFO - Running setup.py install for mozprofile 03:21:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:45 INFO - Running setup.py install for mozrunner 03:21:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:46 INFO - Running setup.py install for mozscreenshot 03:21:46 INFO - Running setup.py install for moztest 03:21:46 INFO - Running setup.py install for mozversion 03:21:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:46 INFO - Cleaning up... 03:21:46 INFO - Return code: 0 03:21:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:46 INFO - 'HOME': '/Users/cltbld', 03:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:46 INFO - 'LOGNAME': 'cltbld', 03:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:46 INFO - 'MOZ_NO_REMOTE': '1', 03:21:46 INFO - 'NO_EM_RESTART': '1', 03:21:46 INFO - 'PAGER': '/bin/cat', 03:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:46 INFO - 'PWD': '/builds/slave/test', 03:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:46 INFO - 'SHELL': '/bin/bash', 03:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:46 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:46 INFO - 'USER': 'cltbld', 03:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:46 INFO - 'XPC_FLAGS': '0x0', 03:21:46 INFO - 'XPC_SERVICE_NAME': '0', 03:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-b4oNqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-sPYycI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-iIPIzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-z1M6Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:47 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)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-9pqCba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-79idbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-506w0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ALFJTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Wxj7y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vNhmKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-feX_WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-UjEIJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:48 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)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-io4eEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-g0jnWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-AgmFIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-MU0AJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-hKxax7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:51 INFO - Downloading blessings-1.6.tar.gz 03:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:51 INFO - Installing collected packages: blessings 03:21:51 INFO - Running setup.py install for blessings 03:21:51 INFO - Successfully installed blessings 03:21:51 INFO - Cleaning up... 03:21:51 INFO - Return code: 0 03:21:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:52 INFO - Reading from file tmpfile_stdout 03:21:52 INFO - Current package versions: 03:21:52 INFO - blessings == 1.6 03:21:52 INFO - blobuploader == 1.2.4 03:21:52 INFO - docopt == 0.6.1 03:21:52 INFO - functools32 == 3.2.3-2 03:21:52 INFO - jsonschema == 2.5.1 03:21:52 INFO - manifestparser == 1.1 03:21:52 INFO - mozInstall == 1.12 03:21:52 INFO - mozcrash == 1.0 03:21:52 INFO - mozdebug == 0.1 03:21:52 INFO - mozdevice == 0.50 03:21:52 INFO - mozfile == 1.2 03:21:52 INFO - mozhttpd == 0.7 03:21:52 INFO - mozinfo == 0.9 03:21:52 INFO - mozleak == 0.1 03:21:52 INFO - mozlog == 3.4 03:21:52 INFO - moznetwork == 0.27 03:21:52 INFO - mozprocess == 0.25 03:21:52 INFO - mozprofile == 0.28 03:21:52 INFO - mozrunner == 6.13 03:21:52 INFO - mozscreenshot == 0.1 03:21:52 INFO - mozsystemmonitor == 0.3 03:21:52 INFO - moztest == 0.8 03:21:52 INFO - mozversion == 1.4 03:21:52 INFO - psutil == 3.1.1 03:21:52 INFO - requests == 1.2.3 03:21:52 INFO - wsgiref == 0.1.2 03:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 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 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:52 INFO - 'HOME': '/Users/cltbld', 03:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:52 INFO - 'LOGNAME': 'cltbld', 03:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:52 INFO - 'MOZ_NO_REMOTE': '1', 03:21:52 INFO - 'NO_EM_RESTART': '1', 03:21:52 INFO - 'PAGER': '/bin/cat', 03:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:52 INFO - 'PWD': '/builds/slave/test', 03:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:52 INFO - 'SHELL': '/bin/bash', 03:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:52 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:52 INFO - 'USER': 'cltbld', 03:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:52 INFO - 'XPC_FLAGS': '0x0', 03:21:52 INFO - 'XPC_SERVICE_NAME': '0', 03:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:52 INFO - Cleaning up... 03:21:52 INFO - Return code: 0 03:21:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 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 0x10aacfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5bd6ecc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, '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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:52 INFO - 'HOME': '/Users/cltbld', 03:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:52 INFO - 'LOGNAME': 'cltbld', 03:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:52 INFO - 'MOZ_NO_REMOTE': '1', 03:21:52 INFO - 'NO_EM_RESTART': '1', 03:21:52 INFO - 'PAGER': '/bin/cat', 03:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:52 INFO - 'PWD': '/builds/slave/test', 03:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:52 INFO - 'SHELL': '/bin/bash', 03:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:21:52 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:52 INFO - 'USER': 'cltbld', 03:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:52 INFO - 'XPC_FLAGS': '0x0', 03:21:52 INFO - 'XPC_SERVICE_NAME': '0', 03:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:52 INFO - Cleaning up... 03:21:52 INFO - Return code: 0 03:21:52 INFO - Running post-action listener: _resource_record_post_action 03:21:52 INFO - Running post-action listener: _start_resource_monitoring 03:21:52 INFO - Starting resource monitoring. 03:21:52 INFO - [mozharness: 2017-04-13 10:21:52.589928Z] Finished create-virtualenv step (success) 03:21:52 INFO - [mozharness: 2017-04-13 10:21:52.590880Z] Running install step. 03:21:52 INFO - Running pre-action listener: _resource_record_pre_action 03:21:52 INFO - Running main action method: install 03:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:52 INFO - Reading from file tmpfile_stdout 03:21:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:52 INFO - Reading from file tmpfile_stdout 03:21:52 INFO - Output received: 03:21:52 INFO - Usage: mozinstall [options] installer 03:21:52 INFO - Options: 03:21:52 INFO - -h, --help show this help message and exit 03:21:52 INFO - -d DEST, --destination=DEST 03:21:52 INFO - Directory to install application into. [default: 03:21:52 INFO - "/builds/slave/test"] 03:21:52 INFO - --app=APP Application being installed. [default: firefox] 03:21:52 INFO - mkdir: /builds/slave/test/build/application 03:21:52 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'] 03:21:52 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 03:22:12 INFO - Reading from file tmpfile_stdout 03:22:12 INFO - Output received: 03:22:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:22:12 INFO - Running post-action listener: _resource_record_post_action 03:22:12 INFO - [mozharness: 2017-04-13 10:22:12.687745Z] Finished install step (success) 03:22:12 INFO - [mozharness: 2017-04-13 10:22:12.687866Z] Running run-tests step. 03:22:12 INFO - Running pre-action listener: _resource_record_pre_action 03:22:12 INFO - Running main action method: run_tests 03:22:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:12 INFO - 2017-04-13 03:22:12.702 screenresolution[1622:7295] starting screenresolution argv=screenresolution get 03:22:12 INFO - 2017-04-13 03:22:12.705 screenresolution[1622:7295] Display 0: 1600x1200x32@60 03:22:12 INFO - 2017-04-13 03:22:12.711 screenresolution[1623:7297] starting screenresolution argv=screenresolution list 03:22:12 INFO - Available Modes on Display 0 03:22:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:12 INFO - Intel Iris: 03:22:12 INFO - Chipset Model: Intel Iris 03:22:12 INFO - Type: GPU 03:22:12 INFO - Bus: Built-In 03:22:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:12 INFO - Vendor: Intel (0x8086) 03:22:12 INFO - Device ID: 0x0a2e 03:22:12 INFO - Revision ID: 0x0009 03:22:12 INFO - Displays: 03:22:12 INFO - Display: 03:22:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:12 INFO - Display Serial Number: 1600x1200 60 03:22:12 INFO - Main Display: Yes 03:22:12 INFO - Mirror: Off 03:22:12 INFO - Online: Yes 03:22:12 INFO - Rotation: Supported 03:22:12 INFO - Return code: 0 03:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:12 INFO - Python 2.7.3 03:22:12 INFO - Return code: 0 03:22:12 INFO - grabbing minidump binary from tooltool 03:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:12 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 0x10a8add30>, '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 0x10a7d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:22:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:22:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:22:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:13 INFO - Return code: 0 03:22:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:13 INFO - ENV: RUST_BACKTRACE is now 1 03:22:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5TkrZtJFt/Render', 03:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:13 INFO - 'HOME': '/Users/cltbld', 03:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:13 INFO - 'LOGNAME': 'cltbld', 03:22:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:13 INFO - 'MOZ_NO_REMOTE': '1', 03:22:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:13 INFO - 'NO_EM_RESTART': '1', 03:22:13 INFO - 'PAGER': '/bin/cat', 03:22:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:13 INFO - 'PWD': '/builds/slave/test', 03:22:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:13 INFO - 'RUST_BACKTRACE': '1', 03:22:13 INFO - 'SHELL': '/bin/bash', 03:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ucaq30SB0v/Listeners', 03:22:13 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 03:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:13 INFO - 'USER': 'cltbld', 03:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:13 INFO - 'XPC_FLAGS': '0x0', 03:22:13 INFO - 'XPC_SERVICE_NAME': '0', 03:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:22:13 INFO - mozversion application_buildid: 20170412134809 03:22:13 INFO - mozversion application_changeset: 2491cacba780598847e92e713b50d81734eeee3a 03:22:13 INFO - mozversion application_display_name: Nightly 03:22:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:13 INFO - mozversion application_name: Firefox 03:22:13 INFO - mozversion application_remotingname: firefox 03:22:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 03:22:13 INFO - mozversion application_vendor: Mozilla 03:22:13 INFO - mozversion application_version: 55.0a1 03:22:13 INFO - mozversion platform_buildid: 20170412134809 03:22:13 INFO - mozversion platform_changeset: 2491cacba780598847e92e713b50d81734eeee3a 03:22:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 03:22:13 INFO - mozversion platform_version: 55.0a1 03:22:13 INFO - using testdate: 1492078933 03:22:13 INFO - actual date: 1492078933 03:22:13 INFO - starting webserver on 'localhost:49230' 03:22:13 INFO - SUITE-START | Running 2 tests 03:22:13 INFO - TEST-START | dromaeo_css 03:22:13 INFO - operating with platform_type : mac_ 03:22:13 INFO - Initialising browser for dromaeo_css test... 03:22:13 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpX1pOJe/profile http://localhost:49230/getInfo.html) 03:22:16 INFO - PID 1633 | 2017-04-13 03:22:16.663 plugin-container[1635:7481] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 03:22:16 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:16 INFO - PID 1633 | 2017-04-13 03:22:16.669 plugin-container[1635:7481] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9513, name = 'com.apple.CFPasteboardClient' 03:22:16 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:16 INFO - PID 1633 | 2017-04-13 03:22:16.669 plugin-container[1635:7481] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:22:16 INFO - PID 1633 | __metrics Screen width/height:1600/1200 03:22:16 INFO - PID 1633 | colorDepth:24 03:22:16 INFO - PID 1633 | Browser inner width/height: 1024/689 03:22:16 INFO - PID 1633 | __metrics 03:22:16 ERROR - PID 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 03:22:17 INFO - TEST-INFO | 1633: exit 0 03:22:17 INFO - Browser initialized. 03:22:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:17 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpX1pOJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:20 INFO - PID 1636 | 2017-04-13 03:22:20.278 plugin-container[1637:7614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 03:22:20 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:20 INFO - PID 1636 | 2017-04-13 03:22:20.278 plugin-container[1637:7614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 03:22:20 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:20 INFO - PID 1636 | 2017-04-13 03:22:20.278 plugin-container[1637:7614] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:22:30 INFO - PID 1636 | RSS: Main: 236511232 03:22:30 INFO - PID 1636 | 03:25:33 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49230/tests/dromaeo/cssquery-ext.html) 03:25:35 INFO - PID 1636 | RSS: Main: 253685760 03:25:35 INFO - PID 1636 | 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:27:18 INFO - PID 1636 | 03:27:18 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:18 INFO - PID 1636 | Full stack: 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:27:18 INFO - PID 1636 | 03:27:18 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:18 INFO - PID 1636 | Full stack: 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:27:18 INFO - PID 1636 | 03:27:18 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:18 INFO - PID 1636 | Full stack: 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | ************************* 03:27:18 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 03:27:18 INFO - PID 1636 | 03:27:18 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:18 INFO - PID 1636 | Full stack: 03:27:18 INFO - PID 1636 | ************************* 03:28:37 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-ext.html (next: http://localhost:49230/tests/dromaeo/cssquery-jquery.html) 03:28:38 INFO - PID 1636 | RSS: Main: 261517312 03:28:38 INFO - PID 1636 | 03:31:40 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49230/tests/dromaeo/cssquery-mootools.html) 03:31:40 INFO - PID 1636 | RSS: Main: 273903616 03:31:40 INFO - PID 1636 | 03:34:42 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49230/tests/dromaeo/cssquery-prototype.html) 03:34:43 INFO - PID 1636 | RSS: Main: 267096064 03:34:43 INFO - PID 1636 | 03:37:45 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49230/tests/dromaeo/cssquery-yui.html) 03:37:46 INFO - PID 1636 | RSS: Main: 280633344 03:37:46 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-yui.html (next: http://localhost:49230/tests/dromaeo/cssquery-dojo.html) 03:40:48 INFO - PID 1636 | RSS: Main: 274288640 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | __start_tp_report 03:40:48 INFO - PID 1636 | _x_x_mozilla_page_load 03:40:48 INFO - PID 1636 | _x_x_mozilla_page_load_details 03:40:48 INFO - PID 1636 | |i|pagename|runs| 03:40:48 INFO - PID 1636 | |0;dojo.html;3468.7051600613945;3598.910027249317;3634.418493041114;3637.1270894985196;3639.927201455971;5190.506901844324;5303.946960530394;6131.8773624527485;6200.224971878515;6261.467775239099;5918.437748413905;5923.607952131246;6142.867137759741;6155.907661385083;6258.311585725566;5507.146392309189;5520.475554822286;5540.418256083114;5560.221568980346;5666.54667626591;4984.22744474607;5413.83758487246;5507.146392309179;5566.387697353288;5706.087026075828;5368.087425137736;5446.833172622946;5514.255575497316;5514.724263786795;5536.529395001429;5470.2888624478965;5487.067198576252;5502.614816962814;5517.531009864167;5520.861978450531;5427.131658934591;5433.0763770159165;5437.809676661298;5440.075187218143;5503;4928.457869634337;5524.392316845144;6112.381899552462;6162.599431037013;6184.412480814315;6711.4295284900845;6714.362135597159;6728.9570116632;6754.3921047105505;6756.729730810762;6724.52060546679;6787.2534021257625;6799.52403331767;6810.28492008337;6812.080369150151;6196.070589411579;6270.717817698214;6274.1843560337775;6298.685065746694;6308.905366419507;6914.412274956584;6957.582545047212;6980.371766541036;7013.894791578028;7095.226193451637;5372.516473517402;6340.968295158587;6386.425221730066;6509.44669703071;6630.83422914431;5293.735313234323;6527.804165875032;6724.831879203059;6758.594484330956;6776.457883369319;6406.615603063831;6481.611103333815;6657.267700552935;6657.367550082734;6679.499037572202;5795.8551036224435;6129.5289130608335;6547.443467305237;6565.24499682533;6591.472682185414;5339.652922560099;5346.037713211659;5355.7054362009685;5365.0342938270705;5371.597130215249;4551.954480455153;4740.881477963078;4741.691790033637;4745.1695953208055;4765.714057156512;5263.3947096083675;6108.8581424937165;6219.47134493564;6320.367963203643;6343.619382837044;6787.796366109024;6790.7623233186605;6803.421709154777;6804.081449004321;6818.693158807866;6303.212098487689;6341.8097457076365;6361.522885783585;6367.745290188341;6404.263509696445;5657.2928383952;5742.626729262584;5745.339285982165;5758.222639943638;5763.7982670606325;6697.229818570927;6713.0937323461685;6811.625360605214;6881.036654868222;6918.896216556655;6733.6296503692765;6760.526763126534;6784.830379240361;6791.3548212919695;6792.898106528505;6878.621675807879;6902.275261097512;6910.274421185703;6935.618540980295;6942.791716248521;6365.681715914093;6427.742890284337;6456.386643268882;6554.541182117206;6655.534112612071;5200.401953775213;6396.936030639634;6737.59574425536;6753.527253092433;7025.437964962688;6181.918164321316;6466.773662921775;6475.449586785176;6576.638284894377;6603.273639899703;5241.947580524298;6137.232845894263;6500.122483464861;6567.934320656732;6590.70341834609;6072.514198863992;6173.876522469615;6258.155149054819;6276;6440.872847251806;6506.3818937200895;6558.704858281484;6578.079068930258;6601.603903765789;6605.603663779996;5239.66388570912;5268.446813084571;6396.552241343062;6396.71214795326;6403.775867844603 03:40:48 INFO - PID 1636 | |1;ext.html;801.3268854162504;826.4793180296413;1081.632245036688;1293.4761421624246;1306.5884246462358;32198.873039443624;37967.81016094919;38217.044573885665;38227.04432389192;38372.61627383725;37902.8104859476;38044.80977595108;38046.61953380465;38076.61923380765;38113.428298575476;8035.598220088987;8511.978562572469;8548.70079547216;8633.050364459905;8768.473891566526;8676.436031657953;8804.163604457599;8804.779880502974;8810.427322224066;8813.515256660881;8755.3871229014;8774.473531588093;8825.205731484166;8833.469991800512;8848.690295839648;8758.781030474225;8770.3422243332;8807.911920880837;8815.294776417872;8823.735287941372;8557.529335886524;8569.143085691443;8577.185167409087;8590.398672092955;8625.309975202032;37643.43534846979;37694.057648559006;37989.10054497264;38059.80970095159;38107.04732381685;3618.6019537850816;3654.1595433050284;3666.1018050577777;3668.52309199805;3668.614795446493;30878;30996.225094372596;31123;31262.90579829718;31280.061598152093;3146.040457660413;3151.700588444094;3155.25851424915;3157.621085469735;3173.904782856518;241518;289523;290804;290856.091439085;291498;39207.62773302921;40004;47525.04949900982;48344.75827620839;48479.515204848205;50251.9697636286;50458.74770626123;50533.98932021339;50574.24138637923;50778.74610626997;14501.709965800836;14582.41670333196;14716.779248311284;14741.631459213391;14743.483978060716;11672.649820505398;11844.822327665092;11883.88116118845;12057.758844823054;12119.272843629411;13477.730445391036;13563.321833908265;13566.932165339307;13571.117877337942;13655.658608534866;5160.251763494272;5819.301683797971;5879.647221166658;5881.647101173943;5949.583529153005;978.9265805064649;1030.4126647810676;1037.227265687068;1074.5594306334365;1079.8434227037035;22948.65577016346;23093.422664433525;24072.555646660905;24276.271711848673;24318.635220471708;1032.6385764982347;1094.5621751299543;1140.9030232430337;1149.7585507043614;1195.6950977500856;14934.551963441114;16070.678586428206;16555.420560280334;16674.249658765384;16811.495655130366;355078.4492155045;355898;381379;386118;386766;57128.14307785386;57407.27778166662;57498.13752793711;57582.71208644014;57738.845223095304;1410.675544624742;1490.2027415332745;1547.2882474061832;1553.2001019474978;1561.352038903865;29720.405591887607;29855.95504157344;30098.548521771754;30650;30759;38636.03409914775;38708.6129138705;38845.41731874081;38947.6105238944;38975.8307250783;347046;347203;347651;348086;348707;29028.419431611674;29410.558841616967;33086.503702444;33854;34016;42337.364939525316;42624.7212583623;43214.91962700958;43283;43642.34536481892;29929.55105673373;29935;30151.698483015767;30170.84914575413;30372.32952187651;29335.413291734472;29651.590067141693;29782.851085744434;29927.55108673328;30098.69901300959;25675.97296108135;28752.568711469765;35161.47257791186;35717.82141089278;36129;29796;30840;30913.227169320948;31056.689433106283;31874.362512750078;22681.43296417537;22743.976521056262;23828.642570361804;23971.921263542834;24026.87986560056 03:40:48 INFO - PID 1636 | |2;jquery.html;407.4458736118878;424.43550078395737;442.6428782441508;444.4577615309324;461.66759932848356;21265.362039138832;21683.45791355215;22132.122824032875;22502.54994900101;22728.43178920528;22387.992540335723;23001.76998230017;23066.731329776856;23247.953842077106;23415.882920585416;6166.537509686769;6189.16446279751;6394.840128996766;6445.355464453564;6447;6149.938500614981;6293.244810622732;6335.30749431492;6342.4926005919415;6351.809445716613;6125.111858780474;6273.435390814826;6310.873782524347;6324.778632747832;6341;6145.293291271494;6232.283287421937;6244.2819075805955;6262.6868656566985;6269.592476489013;5494.670319780826;5528.336599608073;5544.695041772701;5573.8606534836545;5596.804111856106;27229.319267018283;27267.863660681767;27431.022501737138;27533.586996195074;27552.862235688895;2185.7923497267734;2238.29493709481;2251.617225071742;2252.4706693926914;2256.9210077647203;14775.113493190336;18135.546611334823;18289.817101828943;18367.265309387607;18698.345557905544;2172.478605134772;2173.5218251984697;2217.368050105712;2218.4786575154826;2218.7781221877844;107758;135239;135615;136262;137243;12374.257544547176;12485.375731213584;12535.498580056877;12687.619371418872;12731.363431828371;16224;16440.75338869918;16457.506274811534;16469.011859288483;16496.917515412348;8893.333000024895;9095.226905712956;9137.269018478506;9186.77033074165;9225.400348977295;8646.394752367274;8737.946582553095;8741.956290218508;8872.8669069964;8902.198802107841;6548.803535893836;7493.363064139609;7948.721794737156;7954.659043201869;7969.442139050327;2023.7976202379643;2197.4726065744426;2197.9010944507536;2202.531013653502;2215.268961242786;1014.9543270552842;1017.867677201959;1022.1260821997085;1052.726291164303;1053.136428128927;20341.898290508452;21738.347849564223;21793.782062179176;21829.321313097735;22049.448763781034;1032.4270030133198;1048.4705223862054;1061.7398737309409;1068.759529105945;1083.2092572422175;10786.676399708022;10927.781444371227;11125.276857004268;11135.554577816796;11144.33134011962;631794;732627;738399;743886;781003;153382;158249;159560;160546;162299;1182.7102359921873;1243.2975368916714;1268.6003908768707;1268.7462507498353;1271.0848189303686;18559.721604175676;21739.782602173775;22092.39520928404;22314;22326.553468930204;61577.69211153915;63407.36592634015;63429.68285158544;63783.681081594295;63960.68019659872;84760.57619711861;85507;87719.6842047357;89154.66268005855;90828.54585727029;8646.870296945677;9030.232430243503;9123.452592844185;9209.309301802527;9262.768430789285;12585.496580136693;13317.400716967566;14363.066400683922;14590.92704536513;14877.851221487646;10217.029382208679;11961.760764784829;12196.207246528948;12199;12435.440405181607;11099.833502497308;11519.366434845828;11605.129615279056;11635.301881887113;11958.04335653163;10543.683689489328;12194.268343899039;12605.43275552584;12636.43136058898;12736.85368316856;8846.955765221133;8917.509536975269;8921.464712117293;9168.44989300644;9217.308701847254;12100.334481603597;12162.635120946386;12228.266304021787;12405.379731013594;12446.315452650191 03:40:48 INFO - PID 1636 | |3;mootools.html;1160.2400427719845;1383.813185219995;1390.9513167039156;1393.6655202751342;1410.0904916328964;9862.704118876436;11368.317900925951;11850.170488065838;11885;12040.458179381927;11650.650480485578;11704.770999045106;11880.346580938045;11886.989605883511;11909.464074116664;2481.801455883534;2513.6606558114604;2533.7719605235525;2534.911278105267;2535.467551814121;2453.754624537541;2467.346153269376;2495.3886297857052;2502.2118032819694;2519.1686743374644;2445.4864478459544;2469.555480013597;2488.6515887775727;2492.1651246832334;2496.113879572744;2376.3741066121947;2452.6198439241766;2465.0386349323776;2478.962815557759;2490.6674928913126;2061.742282214723;2111.8521703480765;2141.3254824730316;2412.601920683085;2504.173622704521;10010.349327293703;11882.930536251692;11901.166918315721;11965;11981.101417393731;6452.580582262138;6657.7669781557415;6723.865522689568;6730.562513436611;6739.59562426256;4040.575739547364;4311.525732169459;4317.136572685444;4369.847055353048;4381.737095774264;1095.2924154210068;1247.4386526063308;1273.1342686972855;1280.4302085571924;1297.7469393468277;13962.813160881336;15674.294656740474;15925.601859953478;16185.271662775203;16186.595335116715;5385;5509.862253443615;5563.749631266603;5773.1051686988585;5793.391693872083;10202.33684810485;11898.881011189951;12259.957903578295;12271.693207669701;12336.568220112433;5479.4520547944885;6508.414242718083;6535.248446428626;6580.539362244597;6587.538872278895;6016.849578760566;6041.063635136561;6086.756529738761;6102.816915492543;6183.0107182850525;4344.196323680129;4438.977805110953;4442.244818380883;4468.195724769507;4502.617277531446;1160.8316794064983;1288.84533855936;1297.3253907967992;1313.5796545105666;1320.9537666181639;781.4881252779438;789.057076793238;798.9920100799034;801.7274126796917;807.3137832842037;6630.1049358336;6898.862022759517;6973.686184121625;7024;7111.431085513146;921.9904204895763;942.5249484556647;944.9338546301831;949.8052899155656;961.956711947964;3486.773359731609;4124.257633625916;4214.831406743696;4512.593866552026;4697.600703940203;14697.41210351574;15243.618909527351;15314.387424503118;15523.301451434712;15525.45660901863;14456.85543144555;14590.708185836223;14753.92623036878;15024.248787560578;15055.698886022437;9357.344985850925;10963.122950163968;11261.38062406559;11267.887321126847;11292.435378231055;6955.756548520778;7166.805539022958;7171.569705817667;7194.956731274041;7201.783946481614;13615.387307571382;13925.512607058705;14192.21942793115;14254.786178207543;14284.142951422948;14003.439862405798;14010.089344193002;14130.858691412954;14271.714565708835;14431.3505892233;9228.446293222429;9417.058294170529;9512.09635084666;9513.809723805623;9516.095970882756;10734.41566489032;10758.51586678617;10812.945935270587;10960.616378426717;10975.615853445091;9277;9280.860787088333;9301.813963720553;9355.5789989452;9472;7671;7695.422843286888;9060.818783624423;9150.725478235663;9173.724788256362;7998.360131189607;8057.5165490070785;8076.919230807616;8181.100078991187;8197.385196110436;5024.547790698854;5962.642241465526;6069.51443884497;6126.356732543197;6200.286966998853;6030.879382412415;6165.352637972948;6207.379262073757;6211.534134939988;6268.153799237045 03:40:48 INFO - PID 1636 | |4;prototype.html;387.3666555182276;402.5069290119602;405.3797689535011;411.5329101469833;414.94190813286144;5149;6144;6154.230721159855;6324.778632747861;6337.9542375508045;5994.640321580709;6080.604760690563;6159.630422174672;6163.229596300463;6183.845403864894;4717.457492388385;4719.362886010387;4728.40894888139;4731.668783185179;4777.235642297233;4052.4398106728827;4545.250033744428;4719.339292499053;4738.455077666078;4742.85771426856;3854.8242785950274;4636.953630463703;4651.302244698084;4657.138429390557;4667.369905062807;4624.005838744669;4682.391289132391;4689.624830013608;4726.291056341542;4742.596879265267;3656.3966945453967;3824.8087595620386;3846.0577158596325;4145.440365550642;4157.958420415787;4513.390692256569;5405.5135037846385;5479.68487562986;5912.4974377178;5960.374160713106;4731.905361892777;5170.25031370453;5350.090484617585;5372.113601255788;5386.973065134649;5941.9601569725555;6269.404406581368;6467.83830404239;6520.706568204442;6578.079068930354;3759.0038639760487;4352.260115780293;4408.955910440886;4414.161309351213;4424.756638384888;5342.759575819136;6681.76613818514;6826.962001909153;6950.965245173792;7014.964925175393;3896.980515097406;3915.4126880967515;3958.8614398495915;4375.912481750411;4409.889752756207;3892.384660365973;4254.446921900195;4474.172278128557;4474.440694913136;4529.184746745617;4827.372441582572;5087;5265.6840589564745;5310.6813591184655;5334.733263336818;6231.657258850807;6491.350864913566;6506.551527690332;6510.934890651033;6531.640759758164;1397.1267957526545;1421.9360128794228;1535.9462418815287;1536.5390382885314;1538.7614919687467;923.3490389275545;942.4816351007056;963.4893506441597;1026.7997740440542;1036.5905467340358;5306.734663266821;5598.328200615871;6283.465905398092;6311.368863113744;6313.715882785285;5626.465485778845;5747.827565172968;6304.432601065926;6742.865142697118;6856.41720453767;5667.829965100971;6183.196184496077;6249.375062493805;6259.937400626027;6321.525885558602;3318.9336213276083;3330.4504756715355;3503.4409687689244;3527.153483164022;3544.8404821783083;5662.546996240291;5766.913496297559;6716.388066864015;6876.140482439695;7007.159140903124;5842.707864606838;6291.528135389773;6939.23668396476;6944.340287672663;6987.615681137485;5959.404059594092;6487.286398496161;6921.377076063179;6930.27232140618;6972.79081627552;6289.9371006291185;6434.613923164625;6787.321267873173;6789.947558128498;6837.213720422215;5599.580031497572;6491.772787952399;6678.7328506859185;6703.631300278336;6783.18601767791;6954.408875245661;7028.929710702828;7052.82367940785;7057.717691292496;7059.729248735277;4298.161858437575;4434.490033646172;4451.577100175478;4463.486699029523;4464.754438505784;5712.685802280748;6549.561480222921;6784.253732089565;6788.49086318538;6796.184457865088;6568.94896816507;6577.375149360994;6580.8354791130605;6594.769183078761;6598.304949228447;5144.382674079135;5271.947280527145;6531.706073226621;6578.736850525926;6600.933990660032;6486.772962946275;6489.772857949949;6496.70764815575;6525.445337146396;6546.607203567801;5148.43367229597;6588.374104460068;6658.600483970978;6665.266820649627;6685.565438246498;5568.972155139199;6349.14286571307;6383.457181264257;6462.224533056064;6463.289038205888 03:40:48 INFO - PID 1636 | |5;yui.html;788.6529926832197;840.5881118252058;852.9488230706158;862.3959435450064;868.1665601023019;13573.796393054112;17271.22279497424;17296.74054889176;18222.088895555236;18908.43274701761;17770.555736106602;17804.82195178048;18213.36253231137;18314.90842545789;18521.351752688657;994.378513429105;1033.4367769565567;1036.4869389652133;1037.6523864505361;1039.2777019971122;1020.2807021050179;1032.3186696780126;1032.5611615063606;1034.4724190662741;1039.3348257115451;1082.0856376361962;1089.7384627689337;1097.9733948757896;1098.7033500954738;1101.5263436722207;1075.67192006438;1081.3511892864296;1091.5633746501383;1095.5727266366084;1096.3257596578046;773.0259872560558;777.5179388778937;780.5004796929912;781.7263957614846;781.8358144789544;16746.66506669872;17140.742888856676;17281.395151169774;17297.962122272704;17312.22095005728;13503.459861605525;16960.66078678432;17297.827021729747;17299.913500432416;17322.48032559025;13081.411336489786;13744.725105497933;14048.454669986395;14096.365663545062;14119.576412707635;3399.3201359727905;3454.5509083819193;3467.4452087665854;3481.582210134775;3484.6515348465205;93487.53256233744;109720.90279097267;112356;113415;113644;11319.547218111184;13510.324483775968;13629.727405451835;13720.451181952809;13738.175709457464;23546.52906941886;25307;25748;25751.484970300487;25907.611385829226;8881.689140880038;9152.267818574499;9201.723948281562;9233.076692330847;9285.535723213812;4741.241401375763;4829.203181475087;4856.247281671346;4862.562369386772;4871.220604703301;4237.660987121023;4320.3519472078815;4348.695591308578;4496.64026877849;4686.7656617169005;933.9953300233456;946.9668561600449;947.9004704505927;961.4711908450324;961.485605201214;609.8565190268247;638.2978723404218;646.3116780628616;670.792054463118;672.909157263773;11059.170562207866;11873.228240164362;12024.105843133115;12185.207961482476;12190.878091219152;649.1009951217503;658.3975662269066;670.6009924095156;676.67857767561;693.7467824244216;5468.945310546923;5536.667799932017;5680.8863822723315;5712.542996560265;5778.768849245983;104992;105107.54032137145;105219;105324.47337763262;106850.46574767077;93102.67243318971;93388.0661193393;94036;94233.0576694238;94922.52538737262;77209.61395192987;80442;82023;83057;83783.58108209542;11004.339739615649;11147.331160130418;11380.658580242605;11389.259698119597;11558.711032223926;41812.163756725306;41851;41879.371809423494;42288.577114228465;42341.36487952621;37967.81016094902;54189.18716219339;54205.45794542004;54251.72874135604;54712.726436367564;14022.789658154932;14165.929170354082;14302.856971430569;14328;14404.783928241295;15672;15714.607134821721;15778;15882.523524294289;15945.123018234108;14632.707345853236;14656;14719.779203311744;14751.557453276419;14831.777523336943;14344.49794257196;14419.567412977627;14452.349644265823;14657.633559161106;14720;14352.928235358757;14366.928165359106;14443.133411995314;14491;14552.636184095481;8800.60397282111;10451.21615878797;10525.105366043972;10731.248812583044;11003;11670.124740644316;11682.4742886572;11750.942415182675;11815.527378905092;11836.053115750547 03:40:48 INFO - PID 1636 | __end_tp_report 03:40:48 INFO - PID 1636 | __start_cc_report 03:40:48 INFO - PID 1636 | _x_x_mozilla_cycle_collect,427 03:40:48 INFO - PID 1636 | __end_cc_report 03:40:48 INFO - PID 1636 | __startTimestamp1492080048475__endTimestamp 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | ------- Summary: start ------- 03:40:48 INFO - PID 1636 | Number of tests: 6 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6087.22 Median:6308.91 stddev:747.46 (11.8%) stddev-sans-first:720.98 03:40:48 INFO - PID 1636 | Values: 3468.7 3598.9 3634.4 3637.1 3639.9 5190.5 5303.9 6131.9 6200.2 6261.5 5918.4 5923.6 6142.9 6155.9 6258.3 5507.1 5520.5 5540.4 5560.2 5666.5 4984.2 5413.8 5507.1 5566.4 5706.1 5368.1 5446.8 5514.3 5514.7 5536.5 5470.3 5487.1 5502.6 5517.5 5520.9 5427.1 5433.1 5437.8 5440.1 5503.0 4928.5 5524.4 6112.4 6162.6 6184.4 6711.4 6714.4 6729.0 6754.4 6756.7 6724.5 6787.3 6799.5 6810.3 6812.1 6196.1 6270.7 6274.2 6298.7 6308.9 6914.4 6957.6 6980.4 7013.9 7095.2 5372.5 6341.0 6386.4 6509.4 6630.8 5293.7 6527.8 6724.8 6758.6 6776.5 6406.6 6481.6 6657.3 6657.4 6679.5 5795.9 6129.5 6547.4 6565.2 6591.5 5339.7 5346.0 5355.7 5365.0 5371.6 4552.0 4740.9 4741.7 4745.2 4765.7 5263.4 6108.9 6219.5 6320.4 6343.6 6787.8 6790.8 6803.4 6804.1 6818.7 6303.2 6341.8 6361.5 6367.7 6404.3 5657.3 5742.6 5745.3 5758.2 5763.8 6697.2 6713.1 6811.6 6881.0 6918.9 6733.6 6760.5 6784.8 6791.4 6792.9 6878.6 6902.3 6910.3 6935.6 6942.8 6365.7 6427.7 6456.4 6554.5 6655.5 5200.4 6396.9 6737.6 6753.5 7025.4 6181.9 6466.8 6475.4 6576.6 6603.3 5241.9 6137.2 6500.1 6567.9 6590.7 6072.5 6173.9 6258.2 6276.0 6440.9 6506.4 6558.7 6578.1 6601.6 6605.6 5239.7 5268.4 6396.6 6396.7 6403.8 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:48046.11 Median:347124.50 stddev:88596.68 (25.5%) stddev-sans-first:88774.20 03:40:48 INFO - PID 1636 | Values: 801.3 826.5 1081.6 1293.5 1306.6 32198.9 37967.8 38217.0 38227.0 38372.6 37902.8 38044.8 38046.6 38076.6 38113.4 8035.6 8512.0 8548.7 8633.1 8768.5 8676.4 8804.2 8804.8 8810.4 8813.5 8755.4 8774.5 8825.2 8833.5 8848.7 8758.8 8770.3 8807.9 8815.3 8823.7 8557.5 8569.1 8577.2 8590.4 8625.3 37643.4 37694.1 37989.1 38059.8 38107.0 3618.6 3654.2 3666.1 3668.5 3668.6 30878.0 30996.2 31123.0 31262.9 31280.1 3146.0 3151.7 3155.3 3157.6 3173.9 241518.0 289523.0 290804.0 290856.1 291498.0 39207.6 40004.0 47525.0 48344.8 48479.5 50252.0 50458.7 50534.0 50574.2 50778.7 14501.7 14582.4 14716.8 14741.6 14743.5 11672.6 11844.8 11883.9 12057.8 12119.3 13477.7 13563.3 13566.9 13571.1 13655.7 5160.3 5819.3 5879.6 5881.6 5949.6 978.9 1030.4 1037.2 1074.6 1079.8 22948.7 23093.4 24072.6 24276.3 24318.6 1032.6 1094.6 1140.9 1149.8 1195.7 14934.6 16070.7 16555.4 16674.2 16811.5 355078.4 355898.0 381379.0 386118.0 386766.0 57128.1 57407.3 57498.1 57582.7 57738.8 1410.7 1490.2 1547.3 1553.2 1561.4 29720.4 29856.0 30098.5 30650.0 30759.0 38636.0 38708.6 38845.4 38947.6 38975.8 347046.0 347203.0 347651.0 348086.0 348707.0 29028.4 29410.6 33086.5 33854.0 34016.0 42337.4 42624.7 43214.9 43283.0 43642.3 29929.6 29935.0 30151.7 30170.8 30372.3 29335.4 29651.6 29782.9 29927.6 30098.7 25676.0 28752.6 35161.5 35717.8 36129.0 29796.0 30840.0 30913.2 31056.7 31874.4 22681.4 22744.0 23828.6 23971.9 24026.9 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:41250.60 Median:2218.63 stddev:121281.90 (5466.5%) stddev-sans-first:121583.36 03:40:48 INFO - PID 1636 | Values: 407.4 424.4 442.6 444.5 461.7 21265.4 21683.5 22132.1 22502.5 22728.4 22388.0 23001.8 23066.7 23248.0 23415.9 6166.5 6189.2 6394.8 6445.4 6447.0 6149.9 6293.2 6335.3 6342.5 6351.8 6125.1 6273.4 6310.9 6324.8 6341.0 6145.3 6232.3 6244.3 6262.7 6269.6 5494.7 5528.3 5544.7 5573.9 5596.8 27229.3 27267.9 27431.0 27533.6 27552.9 2185.8 2238.3 2251.6 2252.5 2256.9 14775.1 18135.5 18289.8 18367.3 18698.3 2172.5 2173.5 2217.4 2218.5 2218.8 107758.0 135239.0 135615.0 136262.0 137243.0 12374.3 12485.4 12535.5 12687.6 12731.4 16224.0 16440.8 16457.5 16469.0 16496.9 8893.3 9095.2 9137.3 9186.8 9225.4 8646.4 8737.9 8742.0 8872.9 8902.2 6548.8 7493.4 7948.7 7954.7 7969.4 2023.8 2197.5 2197.9 2202.5 2215.3 1015.0 1017.9 1022.1 1052.7 1053.1 20341.9 21738.3 21793.8 21829.3 22049.4 1032.4 1048.5 1061.7 1068.8 1083.2 10786.7 10927.8 11125.3 11135.6 11144.3 631794.0 732627.0 738399.0 743886.0 781003.0 153382.0 158249.0 159560.0 160546.0 162299.0 1182.7 1243.3 1268.6 1268.7 1271.1 18559.7 21739.8 22092.4 22314.0 22326.6 61577.7 63407.4 63429.7 63783.7 63960.7 84760.6 85507.0 87719.7 89154.7 90828.5 8646.9 9030.2 9123.5 9209.3 9262.8 12585.5 13317.4 14363.1 14590.9 14877.9 10217.0 11961.8 12196.2 12199.0 12435.4 11099.8 11519.4 11605.1 11635.3 11958.0 10543.7 12194.3 12605.4 12636.4 12736.9 8847.0 8917.5 8921.5 9168.4 9217.3 12100.3 12162.6 12228.3 12405.4 12446.3 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7195.27 Median:2534.34 stddev:4551.83 (179.6%) stddev-sans-first:4542.01 03:40:48 INFO - PID 1636 | Values: 1160.2 1383.8 1391.0 1393.7 1410.1 9862.7 11368.3 11850.2 11885.0 12040.5 11650.7 11704.8 11880.3 11887.0 11909.5 2481.8 2513.7 2533.8 2534.9 2535.5 2453.8 2467.3 2495.4 2502.2 2519.2 2445.5 2469.6 2488.7 2492.2 2496.1 2376.4 2452.6 2465.0 2479.0 2490.7 2061.7 2111.9 2141.3 2412.6 2504.2 10010.3 11882.9 11901.2 11965.0 11981.1 6452.6 6657.8 6723.9 6730.6 6739.6 4040.6 4311.5 4317.1 4369.8 4381.7 1095.3 1247.4 1273.1 1280.4 1297.7 13962.8 15674.3 15925.6 16185.3 16186.6 5385.0 5509.9 5563.7 5773.1 5793.4 10202.3 11898.9 12260.0 12271.7 12336.6 5479.5 6508.4 6535.2 6580.5 6587.5 6016.8 6041.1 6086.8 6102.8 6183.0 4344.2 4439.0 4442.2 4468.2 4502.6 1160.8 1288.8 1297.3 1313.6 1321.0 781.5 789.1 799.0 801.7 807.3 6630.1 6898.9 6973.7 7024.0 7111.4 922.0 942.5 944.9 949.8 962.0 3486.8 4124.3 4214.8 4512.6 4697.6 14697.4 15243.6 15314.4 15523.3 15525.5 14456.9 14590.7 14753.9 15024.2 15055.7 9357.3 10963.1 11261.4 11267.9 11292.4 6955.8 7166.8 7171.6 7195.0 7201.8 13615.4 13925.5 14192.2 14254.8 14284.1 14003.4 14010.1 14130.9 14271.7 14431.4 9228.4 9417.1 9512.1 9513.8 9516.1 10734.4 10758.5 10812.9 10960.6 10975.6 9277.0 9280.9 9301.8 9355.6 9472.0 7671.0 7695.4 9060.8 9150.7 9173.7 7998.4 8057.5 8076.9 8181.1 8197.4 5024.5 5962.6 6069.5 6126.4 6200.3 6030.9 6165.4 6207.4 6211.5 6268.2 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5265.29 Median:5877.60 stddev:1652.88 (28.1%) stddev-sans-first:1616.46 03:40:48 INFO - PID 1636 | Values: 387.4 402.5 405.4 411.5 414.9 5149.0 6144.0 6154.2 6324.8 6338.0 5994.6 6080.6 6159.6 6163.2 6183.8 4717.5 4719.4 4728.4 4731.7 4777.2 4052.4 4545.3 4719.3 4738.5 4742.9 3854.8 4637.0 4651.3 4657.1 4667.4 4624.0 4682.4 4689.6 4726.3 4742.6 3656.4 3824.8 3846.1 4145.4 4158.0 4513.4 5405.5 5479.7 5912.5 5960.4 4731.9 5170.3 5350.1 5372.1 5387.0 5942.0 6269.4 6467.8 6520.7 6578.1 3759.0 4352.3 4409.0 4414.2 4424.8 5342.8 6681.8 6827.0 6951.0 7015.0 3897.0 3915.4 3958.9 4375.9 4409.9 3892.4 4254.4 4474.2 4474.4 4529.2 4827.4 5087.0 5265.7 5310.7 5334.7 6231.7 6491.4 6506.6 6510.9 6531.6 1397.1 1421.9 1535.9 1536.5 1538.8 923.3 942.5 963.5 1026.8 1036.6 5306.7 5598.3 6283.5 6311.4 6313.7 5626.5 5747.8 6304.4 6742.9 6856.4 5667.8 6183.2 6249.4 6259.9 6321.5 3318.9 3330.5 3503.4 3527.2 3544.8 5662.5 5766.9 6716.4 6876.1 7007.2 5842.7 6291.5 6939.2 6944.3 6987.6 5959.4 6487.3 6921.4 6930.3 6972.8 6289.9 6434.6 6787.3 6789.9 6837.2 5599.6 6491.8 6678.7 6703.6 6783.2 6954.4 7028.9 7052.8 7057.7 7059.7 4298.2 4434.5 4451.6 4463.5 4464.8 5712.7 6549.6 6784.3 6788.5 6796.2 6568.9 6577.4 6580.8 6594.8 6598.3 5144.4 5271.9 6531.7 6578.7 6600.9 6486.8 6489.8 6496.7 6525.4 6546.6 5148.4 6588.4 6658.6 6665.3 6685.6 5569.0 6349.1 6383.5 6462.2 6463.3 03:40:48 INFO - PID 1636 | 03:40:48 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21055.33 Median:17297.89 stddev:29350.30 (169.7%) stddev-sans-first:29393.18 03:40:48 INFO - PID 1636 | Values: 788.7 840.6 852.9 862.4 868.2 13573.8 17271.2 17296.7 18222.1 18908.4 17770.6 17804.8 18213.4 18314.9 18521.4 994.4 1033.4 1036.5 1037.7 1039.3 1020.3 1032.3 1032.6 1034.5 1039.3 1082.1 1089.7 1098.0 1098.7 1101.5 1075.7 1081.4 1091.6 1095.6 1096.3 773.0 777.5 780.5 781.7 781.8 16746.7 17140.7 17281.4 17298.0 17312.2 13503.5 16960.7 17297.8 17299.9 17322.5 13081.4 13744.7 14048.5 14096.4 14119.6 3399.3 3454.6 3467.4 3481.6 3484.7 93487.5 109720.9 112356.0 113415.0 113644.0 11319.5 13510.3 13629.7 13720.5 13738.2 23546.5 25307.0 25748.0 25751.5 25907.6 8881.7 9152.3 9201.7 9233.1 9285.5 4741.2 4829.2 4856.2 4862.6 4871.2 4237.7 4320.4 4348.7 4496.6 4686.8 934.0 947.0 947.9 961.5 961.5 609.9 638.3 646.3 670.8 672.9 11059.2 11873.2 12024.1 12185.2 12190.9 649.1 658.4 670.6 676.7 693.7 5468.9 5536.7 5680.9 5712.5 5778.8 104992.0 105107.5 105219.0 105324.5 106850.5 93102.7 93388.1 94036.0 94233.1 94922.5 77209.6 80442.0 82023.0 83057.0 83783.6 11004.3 11147.3 11380.7 11389.3 11558.7 41812.2 41851.0 41879.4 42288.6 42341.4 37967.8 54189.2 54205.5 54251.7 54712.7 14022.8 14165.9 14302.9 14328.0 14404.8 15672.0 15714.6 15778.0 15882.5 15945.1 14632.7 14656.0 14719.8 14751.6 14831.8 14344.5 14419.6 14452.3 14657.6 14720.0 14352.9 14366.9 14443.1 14491.0 14552.6 8800.6 10451.2 10525.1 10731.2 11003.0 11670.1 11682.5 11750.9 11815.5 11836.1 03:40:48 INFO - PID 1636 | -------- Summary: end -------- 03:40:48 INFO - PID 1636 | 03:40:49 INFO - TEST-INFO | 1636: exit 0 03:40:49 INFO - TEST-OK | dromaeo_css | took 1115935ms 03:40:49 INFO - TEST-START | kraken 03:40:49 INFO - operating with platform_type : mac_ 03:40:49 INFO - Initialising browser for kraken test... 03:40:49 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmp9DBpzd/profile http://localhost:49230/getInfo.html) 03:40:52 INFO - PID 1672 | 2017-04-13 03:40:52.265 plugin-container[1673:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 03:40:52 INFO - PID 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:52 INFO - PID 1672 | 2017-04-13 03:40:52.267 plugin-container[1673:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:40:52 INFO - PID 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:52 INFO - PID 1672 | 2017-04-13 03:40:52.267 plugin-container[1673:10129] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:40:52 INFO - PID 1672 | __metrics Screen width/height:1600/1200 03:40:52 INFO - PID 1672 | colorDepth:24 03:40:52 INFO - PID 1672 | Browser inner width/height: 1024/689 03:40:52 INFO - PID 1672 | __metrics 03:40:52 ERROR - PID 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 03:40:53 INFO - TEST-INFO | 1672: exit 0 03:40:53 INFO - Browser initialized. 03:40:53 INFO - Running cycle 1/1 for kraken test... 03:40:53 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmp9DBpzd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:56 INFO - PID 1674 | 2017-04-13 03:40:56.215 plugin-container[1675:10251] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 03:40:56 INFO - PID 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:56 INFO - PID 1674 | 2017-04-13 03:40:56.216 plugin-container[1675:10251] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:40:56 INFO - PID 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:56 INFO - PID 1674 | 2017-04-13 03:40:56.216 plugin-container[1675:10251] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:41:06 INFO - PID 1674 | RSS: Main: 235184128 03:41:06 INFO - PID 1674 | 03:41:08 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:09 INFO - PID 1674 | RSS: Main: 250417152 03:41:09 INFO - PID 1674 | 03:41:12 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-dft) 03:41:13 INFO - PID 1674 | RSS: Main: 258916352 03:41:13 INFO - PID 1674 | 03:41:16 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-fft) 03:41:17 INFO - PID 1674 | RSS: Main: 261312512 03:41:17 INFO - PID 1674 | 03:41:19 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator) 03:41:19 INFO - PID 1674 | RSS: Main: 263303168 03:41:19 INFO - PID 1674 | 03:41:21 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:22 INFO - PID 1674 | RSS: Main: 264003584 03:41:22 INFO - PID 1674 | 03:41:25 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:26 INFO - PID 1674 | RSS: Main: 269631488 03:41:26 INFO - PID 1674 | 03:41:29 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:29 INFO - PID 1674 | RSS: Main: 269795328 03:41:29 INFO - PID 1674 | 03:41:33 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial) 03:41:33 INFO - PID 1674 | RSS: Main: 269844480 03:41:33 INFO - PID 1674 | 03:41:35 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:36 INFO - PID 1674 | RSS: Main: 269135872 03:41:36 INFO - PID 1674 | 03:41:37 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:38 INFO - PID 1674 | RSS: Main: 269234176 03:41:38 INFO - PID 1674 | 03:41:41 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:41 INFO - PID 1674 | RSS: Main: 269254656 03:41:41 INFO - PID 1674 | 03:41:44 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:45 INFO - PID 1674 | RSS: Main: 269795328 03:41:45 INFO - PID 1674 | 03:41:49 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:49 INFO - PID 1674 | RSS: Main: 267358208 03:41:49 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49230/tests/kraken/driver.html?testName=ai-astar) 03:41:51 INFO - PID 1674 | RSS: Main: 270684160 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | __start_tp_report 03:41:51 INFO - PID 1674 | _x_x_mozilla_page_load 03:41:51 INFO - PID 1674 | _x_x_mozilla_page_load_details 03:41:51 INFO - PID 1674 | |i|pagename|runs| 03:41:51 INFO - PID 1674 | |0;ai-astar;121;183;121;124;122;122;128;146;121;123 03:41:51 INFO - PID 1674 | |1;audio-beat-detection;147;119;121;192;122;121;121;122;138;122 03:41:51 INFO - PID 1674 | |2;audio-dft;224;226;221;220;221;216;216;211;213;210 03:41:51 INFO - PID 1674 | |3;audio-fft;80;57;69;84;63;66;61;59;73;60 03:41:51 INFO - PID 1674 | |4;audio-oscillator;85;72;88;74;72;96;124;73;71;86 03:41:51 INFO - PID 1674 | |5;imaging-gaussian-blur;90;91;91;107;91;91;89;93;90;90 03:41:51 INFO - PID 1674 | |6;imaging-darkroom;148;100;100;102;101;100;111;100;101;101 03:41:51 INFO - PID 1674 | |7;imaging-desaturate;102;148;105;105;117;117;126;165;138;102 03:41:51 INFO - PID 1674 | |8;json-parse-financial;52;51;50;53;52;55;51;52;51;52 03:41:51 INFO - PID 1674 | |9;json-stringify-tinderbox;60;69;66;67;78;87;85;69;58;61 03:41:51 INFO - PID 1674 | |10;stanford-crypto-aes;86;101;117;80;113;116;111;84;114;113 03:41:51 INFO - PID 1674 | |11;stanford-crypto-ccm;145;144;153;165;162;174;156;169;214;174 03:41:51 INFO - PID 1674 | |12;stanford-crypto-pbkdf2;245;215;197;198;197;208;281;250;188;244 03:41:51 INFO - PID 1674 | |13;stanford-crypto-sha256-iterative;73;74;88;92;87;70;70;78;82;73 03:41:51 INFO - PID 1674 | __end_tp_report 03:41:51 INFO - PID 1674 | __start_cc_report 03:41:51 INFO - PID 1674 | _x_x_mozilla_cycle_collect,1021 03:41:51 INFO - PID 1674 | __end_cc_report 03:41:51 INFO - PID 1674 | __startTimestamp1492080111942__endTimestamp 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | ------- Summary: start ------- 03:41:51 INFO - PID 1674 | Number of tests: 14 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#0] ai-astar Cycles:10 Average:131.10 Median:123.50 stddev:19.76 (16.0%) stddev-sans-first:20.61 03:41:51 INFO - PID 1674 | Values: 121.0 183.0 121.0 124.0 122.0 122.0 128.0 146.0 121.0 123.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:122.00 stddev:22.83 (18.7%) stddev-sans-first:23.60 03:41:51 INFO - PID 1674 | Values: 147.0 119.0 121.0 192.0 122.0 121.0 121.0 122.0 138.0 122.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#2] audio-dft Cycles:10 Average:217.80 Median:220.50 stddev:5.45 (2.5%) stddev-sans-first:5.30 03:41:51 INFO - PID 1674 | Values: 224.0 226.0 221.0 220.0 221.0 216.0 216.0 211.0 213.0 210.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#3] audio-fft Cycles:10 Average:67.20 Median:67.50 stddev:9.21 (13.6%) stddev-sans-first:8.53 03:41:51 INFO - PID 1674 | Values: 80.0 57.0 69.0 84.0 63.0 66.0 61.0 59.0 73.0 60.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:79.50 stddev:16.48 (20.7%) stddev-sans-first:17.47 03:41:51 INFO - PID 1674 | Values: 85.0 72.0 88.0 74.0 72.0 96.0 124.0 73.0 71.0 86.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:91.00 stddev:5.27 (5.8%) stddev-sans-first:5.53 03:41:51 INFO - PID 1674 | Values: 90.0 91.0 91.0 107.0 91.0 91.0 89.0 93.0 90.0 90.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:101.00 stddev:14.99 (14.8%) stddev-sans-first:3.53 03:41:51 INFO - PID 1674 | Values: 148.0 100.0 100.0 102.0 101.0 100.0 111.0 100.0 101.0 101.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#7] imaging-desaturate Cycles:10 Average:122.50 Median:121.50 stddev:21.66 (17.8%) stddev-sans-first:21.67 03:41:51 INFO - PID 1674 | Values: 102.0 148.0 105.0 105.0 117.0 117.0 126.0 165.0 138.0 102.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.37 (2.6%) stddev-sans-first:1.45 03:41:51 INFO - PID 1674 | Values: 52.0 51.0 50.0 53.0 52.0 55.0 51.0 52.0 51.0 52.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.00 stddev:10.17 (14.7%) stddev-sans-first:10.12 03:41:51 INFO - PID 1674 | Values: 60.0 69.0 66.0 67.0 78.0 87.0 85.0 69.0 58.0 61.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#10] stanford-crypto-aes Cycles:10 Average:103.50 Median:116.50 stddev:14.65 (12.6%) stddev-sans-first:14.10 03:41:51 INFO - PID 1674 | Values: 86.0 101.0 117.0 80.0 113.0 116.0 111.0 84.0 114.0 113.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:165.60 Median:167.00 stddev:20.14 (12.1%) stddev-sans-first:19.93 03:41:51 INFO - PID 1674 | Values: 145.0 144.0 153.0 165.0 162.0 174.0 156.0 169.0 214.0 174.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.30 Median:229.50 stddev:30.74 (13.4%) stddev-sans-first:31.49 03:41:51 INFO - PID 1674 | Values: 245.0 215.0 197.0 198.0 197.0 208.0 281.0 250.0 188.0 244.0 03:41:51 INFO - PID 1674 | 03:41:51 INFO - PID 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:80.00 stddev:8.04 (10.1%) stddev-sans-first:8.26 03:41:51 INFO - PID 1674 | Values: 73.0 74.0 88.0 92.0 87.0 70.0 70.0 78.0 82.0 73.0 03:41:51 INFO - PID 1674 | -------- Summary: end -------- 03:41:51 INFO - PID 1674 | 03:41:52 INFO - TEST-INFO | 1674: exit 0 03:41:52 INFO - TEST-OK | kraken | took 63763ms 03:41:52 INFO - SUITE-END | took 1179s 03:41:53 INFO - Completed test suite (00:19:39) 03:41:53 INFO - javascript benchmark 03:41:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7938.267805104175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3468.7051600613945, 3598.910027249317, 3634.418493041114, 3637.1270894985196, 3639.927201455971, 5190.506901844324, 5303.946960530394, 6131.8773624527485, 6200.224971878515, 6261.467775239099, 5918.437748413905, 5923.607952131246, 6142.867137759741, 6155.907661385083, 6258.311585725566, 5507.146392309189, 5520.475554822286, 5540.418256083114, 5560.221568980346, 5666.54667626591, 4984.22744474607, 5413.83758487246, 5507.146392309179, 5566.387697353288, 5706.087026075828, 5368.087425137736, 5446.833172622946, 5514.255575497316, 5514.724263786795, 5536.529395001429, 5470.2888624478965, 5487.067198576252, 5502.614816962814, 5517.531009864167, 5520.861978450531, 5427.131658934591, 5433.0763770159165, 5437.809676661298, 5440.075187218143, 5503.0, 4928.457869634337, 5524.392316845144, 6112.381899552462, 6162.599431037013, 6184.412480814315, 6711.4295284900845, 6714.362135597159, 6728.9570116632, 6754.3921047105505, 6756.729730810762, 6724.52060546679, 6787.2534021257625, 6799.52403331767, 6810.28492008337, 6812.080369150151, 6196.070589411579, 6270.717817698214, 6274.1843560337775, 6298.685065746694, 6308.905366419507, 6914.412274956584, 6957.582545047212, 6980.371766541036, 7013.894791578028, 7095.226193451637, 5372.516473517402, 6340.968295158587, 6386.425221730066, 6509.44669703071, 6630.83422914431, 5293.735313234323, 6527.804165875032, 6724.831879203059, 6758.594484330956, 6776.457883369319, 6406.615603063831, 6481.611103333815, 6657.267700552935, 6657.367550082734, 6679.499037572202, 5795.8551036224435, 6129.5289130608335, 6547.443467305237, 6565.24499682533, 6591.472682185414, 5339.652922560099, 5346.037713211659, 5355.7054362009685, 5365.0342938270705, 5371.597130215249, 4551.954480455153, 4740.881477963078, 4741.691790033637, 4745.1695953208055, 4765.714057156512, 5263.3947096083675, 6108.8581424937165, 6219.47134493564, 6320.367963203643, 6343.619382837044, 6787.796366109024, 6790.7623233186605, 6803.421709154777, 6804.081449004321, 6818.693158807866, 6303.212098487689, 6341.8097457076365, 6361.522885783585, 6367.745290188341, 6404.263509696445, 5657.2928383952, 5742.626729262584, 5745.339285982165, 5758.222639943638, 5763.7982670606325, 6697.229818570927, 6713.0937323461685, 6811.625360605214, 6881.036654868222, 6918.896216556655, 6733.6296503692765, 6760.526763126534, 6784.830379240361, 6791.3548212919695, 6792.898106528505, 6878.621675807879, 6902.275261097512, 6910.274421185703, 6935.618540980295, 6942.791716248521, 6365.681715914093, 6427.742890284337, 6456.386643268882, 6554.541182117206, 6655.534112612071, 5200.401953775213, 6396.936030639634, 6737.59574425536, 6753.527253092433, 7025.437964962688, 6181.918164321316, 6466.773662921775, 6475.449586785176, 6576.638284894377, 6603.273639899703, 5241.947580524298, 6137.232845894263, 6500.122483464861, 6567.934320656732, 6590.70341834609, 6072.514198863992, 6173.876522469615, 6258.155149054819, 6276.0, 6440.872847251806, 6506.3818937200895, 6558.704858281484, 6578.079068930258, 6601.603903765789, 6605.603663779996, 5239.66388570912, 5268.446813084571, 6396.552241343062, 6396.71214795326, 6403.775867844603], "value": 6041.165268468188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.3268854162504, 826.4793180296413, 1081.632245036688, 1293.4761421624246, 1306.5884246462358, 32198.873039443624, 37967.81016094919, 38217.044573885665, 38227.04432389192, 38372.61627383725, 37902.8104859476, 38044.80977595108, 38046.61953380465, 38076.61923380765, 38113.428298575476, 8035.598220088987, 8511.978562572469, 8548.70079547216, 8633.050364459905, 8768.473891566526, 8676.436031657953, 8804.163604457599, 8804.779880502974, 8810.427322224066, 8813.515256660881, 8755.3871229014, 8774.473531588093, 8825.205731484166, 8833.469991800512, 8848.690295839648, 8758.781030474225, 8770.3422243332, 8807.911920880837, 8815.294776417872, 8823.735287941372, 8557.529335886524, 8569.143085691443, 8577.185167409087, 8590.398672092955, 8625.309975202032, 37643.43534846979, 37694.057648559006, 37989.10054497264, 38059.80970095159, 38107.04732381685, 3618.6019537850816, 3654.1595433050284, 3666.1018050577777, 3668.52309199805, 3668.614795446493, 30878.0, 30996.225094372596, 31123.0, 31262.90579829718, 31280.061598152093, 3146.040457660413, 3151.700588444094, 3155.25851424915, 3157.621085469735, 3173.904782856518, 241518.0, 289523.0, 290804.0, 290856.091439085, 291498.0, 39207.62773302921, 40004.0, 47525.04949900982, 48344.75827620839, 48479.515204848205, 50251.9697636286, 50458.74770626123, 50533.98932021339, 50574.24138637923, 50778.74610626997, 14501.709965800836, 14582.41670333196, 14716.779248311284, 14741.631459213391, 14743.483978060716, 11672.649820505398, 11844.822327665092, 11883.88116118845, 12057.758844823054, 12119.272843629411, 13477.730445391036, 13563.321833908265, 13566.932165339307, 13571.117877337942, 13655.658608534866, 5160.251763494272, 5819.301683797971, 5879.647221166658, 5881.647101173943, 5949.583529153005, 978.9265805064649, 1030.4126647810676, 1037.227265687068, 1074.5594306334365, 1079.8434227037035, 22948.65577016346, 23093.422664433525, 24072.555646660905, 24276.271711848673, 24318.635220471708, 1032.6385764982347, 1094.5621751299543, 1140.9030232430337, 1149.7585507043614, 1195.6950977500856, 14934.551963441114, 16070.678586428206, 16555.420560280334, 16674.249658765384, 16811.495655130366, 355078.4492155045, 355898.0, 381379.0, 386118.0, 386766.0, 57128.14307785386, 57407.27778166662, 57498.13752793711, 57582.71208644014, 57738.845223095304, 1410.675544624742, 1490.2027415332745, 1547.2882474061832, 1553.2001019474978, 1561.352038903865, 29720.405591887607, 29855.95504157344, 30098.548521771754, 30650.0, 30759.0, 38636.03409914775, 38708.6129138705, 38845.41731874081, 38947.6105238944, 38975.8307250783, 347046.0, 347203.0, 347651.0, 348086.0, 348707.0, 29028.419431611674, 29410.558841616967, 33086.503702444, 33854.0, 34016.0, 42337.364939525316, 42624.7212583623, 43214.91962700958, 43283.0, 43642.34536481892, 29929.55105673373, 29935.0, 30151.698483015767, 30170.84914575413, 30372.32952187651, 29335.413291734472, 29651.590067141693, 29782.851085744434, 29927.55108673328, 30098.69901300959, 25675.97296108135, 28752.568711469765, 35161.47257791186, 35717.82141089278, 36129.0, 29796.0, 30840.0, 30913.227169320948, 31056.689433106283, 31874.362512750078, 22681.43296417537, 22743.976521056262, 23828.642570361804, 23971.921263542834, 24026.87986560056], "value": 17981.814809654385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.4458736118878, 424.43550078395737, 442.6428782441508, 444.4577615309324, 461.66759932848356, 21265.362039138832, 21683.45791355215, 22132.122824032875, 22502.54994900101, 22728.43178920528, 22387.992540335723, 23001.76998230017, 23066.731329776856, 23247.953842077106, 23415.882920585416, 6166.537509686769, 6189.16446279751, 6394.840128996766, 6445.355464453564, 6447.0, 6149.938500614981, 6293.244810622732, 6335.30749431492, 6342.4926005919415, 6351.809445716613, 6125.111858780474, 6273.435390814826, 6310.873782524347, 6324.778632747832, 6341.0, 6145.293291271494, 6232.283287421937, 6244.2819075805955, 6262.6868656566985, 6269.592476489013, 5494.670319780826, 5528.336599608073, 5544.695041772701, 5573.8606534836545, 5596.804111856106, 27229.319267018283, 27267.863660681767, 27431.022501737138, 27533.586996195074, 27552.862235688895, 2185.7923497267734, 2238.29493709481, 2251.617225071742, 2252.4706693926914, 2256.9210077647203, 14775.113493190336, 18135.546611334823, 18289.817101828943, 18367.265309387607, 18698.345557905544, 2172.478605134772, 2173.5218251984697, 2217.368050105712, 2218.4786575154826, 2218.7781221877844, 107758.0, 135239.0, 135615.0, 136262.0, 137243.0, 12374.257544547176, 12485.375731213584, 12535.498580056877, 12687.619371418872, 12731.363431828371, 16224.0, 16440.75338869918, 16457.506274811534, 16469.011859288483, 16496.917515412348, 8893.333000024895, 9095.226905712956, 9137.269018478506, 9186.77033074165, 9225.400348977295, 8646.394752367274, 8737.946582553095, 8741.956290218508, 8872.8669069964, 8902.198802107841, 6548.803535893836, 7493.363064139609, 7948.721794737156, 7954.659043201869, 7969.442139050327, 2023.7976202379643, 2197.4726065744426, 2197.9010944507536, 2202.531013653502, 2215.268961242786, 1014.9543270552842, 1017.867677201959, 1022.1260821997085, 1052.726291164303, 1053.136428128927, 20341.898290508452, 21738.347849564223, 21793.782062179176, 21829.321313097735, 22049.448763781034, 1032.4270030133198, 1048.4705223862054, 1061.7398737309409, 1068.759529105945, 1083.2092572422175, 10786.676399708022, 10927.781444371227, 11125.276857004268, 11135.554577816796, 11144.33134011962, 631794.0, 732627.0, 738399.0, 743886.0, 781003.0, 153382.0, 158249.0, 159560.0, 160546.0, 162299.0, 1182.7102359921873, 1243.2975368916714, 1268.6003908768707, 1268.7462507498353, 1271.0848189303686, 18559.721604175676, 21739.782602173775, 22092.39520928404, 22314.0, 22326.553468930204, 61577.69211153915, 63407.36592634015, 63429.68285158544, 63783.681081594295, 63960.68019659872, 84760.57619711861, 85507.0, 87719.6842047357, 89154.66268005855, 90828.54585727029, 8646.870296945677, 9030.232430243503, 9123.452592844185, 9209.309301802527, 9262.768430789285, 12585.496580136693, 13317.400716967566, 14363.066400683922, 14590.92704536513, 14877.851221487646, 10217.029382208679, 11961.760764784829, 12196.207246528948, 12199.0, 12435.440405181607, 11099.833502497308, 11519.366434845828, 11605.129615279056, 11635.301881887113, 11958.04335653163, 10543.683689489328, 12194.268343899039, 12605.43275552584, 12636.43136058898, 12736.85368316856, 8846.955765221133, 8917.509536975269, 8921.464712117293, 9168.44989300644, 9217.308701847254, 12100.334481603597, 12162.635120946386, 12228.266304021787, 12405.379731013594, 12446.315452650191], "value": 10811.360267606651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1160.2400427719845, 1383.813185219995, 1390.9513167039156, 1393.6655202751342, 1410.0904916328964, 9862.704118876436, 11368.317900925951, 11850.170488065838, 11885.0, 12040.458179381927, 11650.650480485578, 11704.770999045106, 11880.346580938045, 11886.989605883511, 11909.464074116664, 2481.801455883534, 2513.6606558114604, 2533.7719605235525, 2534.911278105267, 2535.467551814121, 2453.754624537541, 2467.346153269376, 2495.3886297857052, 2502.2118032819694, 2519.1686743374644, 2445.4864478459544, 2469.555480013597, 2488.6515887775727, 2492.1651246832334, 2496.113879572744, 2376.3741066121947, 2452.6198439241766, 2465.0386349323776, 2478.962815557759, 2490.6674928913126, 2061.742282214723, 2111.8521703480765, 2141.3254824730316, 2412.601920683085, 2504.173622704521, 10010.349327293703, 11882.930536251692, 11901.166918315721, 11965.0, 11981.101417393731, 6452.580582262138, 6657.7669781557415, 6723.865522689568, 6730.562513436611, 6739.59562426256, 4040.575739547364, 4311.525732169459, 4317.136572685444, 4369.847055353048, 4381.737095774264, 1095.2924154210068, 1247.4386526063308, 1273.1342686972855, 1280.4302085571924, 1297.7469393468277, 13962.813160881336, 15674.294656740474, 15925.601859953478, 16185.271662775203, 16186.595335116715, 5385.0, 5509.862253443615, 5563.749631266603, 5773.1051686988585, 5793.391693872083, 10202.33684810485, 11898.881011189951, 12259.957903578295, 12271.693207669701, 12336.568220112433, 5479.4520547944885, 6508.414242718083, 6535.248446428626, 6580.539362244597, 6587.538872278895, 6016.849578760566, 6041.063635136561, 6086.756529738761, 6102.816915492543, 6183.0107182850525, 4344.196323680129, 4438.977805110953, 4442.244818380883, 4468.195724769507, 4502.617277531446, 1160.8316794064983, 1288.84533855936, 1297.3253907967992, 1313.5796545105666, 1320.9537666181639, 781.4881252779438, 789.057076793238, 798.9920100799034, 801.7274126796917, 807.3137832842037, 6630.1049358336, 6898.862022759517, 6973.686184121625, 7024.0, 7111.431085513146, 921.9904204895763, 942.5249484556647, 944.9338546301831, 949.8052899155656, 961.956711947964, 3486.773359731609, 4124.257633625916, 4214.831406743696, 4512.593866552026, 4697.600703940203, 14697.41210351574, 15243.618909527351, 15314.387424503118, 15523.301451434712, 15525.45660901863, 14456.85543144555, 14590.708185836223, 14753.92623036878, 15024.248787560578, 15055.698886022437, 9357.344985850925, 10963.122950163968, 11261.38062406559, 11267.887321126847, 11292.435378231055, 6955.756548520778, 7166.805539022958, 7171.569705817667, 7194.956731274041, 7201.783946481614, 13615.387307571382, 13925.512607058705, 14192.21942793115, 14254.786178207543, 14284.142951422948, 14003.439862405798, 14010.089344193002, 14130.858691412954, 14271.714565708835, 14431.3505892233, 9228.446293222429, 9417.058294170529, 9512.09635084666, 9513.809723805623, 9516.095970882756, 10734.41566489032, 10758.51586678617, 10812.945935270587, 10960.616378426717, 10975.615853445091, 9277.0, 9280.860787088333, 9301.813963720553, 9355.5789989452, 9472.0, 7671.0, 7695.422843286888, 9060.818783624423, 9150.725478235663, 9173.724788256362, 7998.360131189607, 8057.5165490070785, 8076.919230807616, 8181.100078991187, 8197.385196110436, 5024.547790698854, 5962.642241465526, 6069.51443884497, 6126.356732543197, 6200.286966998853, 6030.879382412415, 6165.352637972948, 6207.379262073757, 6211.534134939988, 6268.153799237045], "value": 5417.888690153221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3666555182276, 402.5069290119602, 405.3797689535011, 411.5329101469833, 414.94190813286144, 5149.0, 6144.0, 6154.230721159855, 6324.778632747861, 6337.9542375508045, 5994.640321580709, 6080.604760690563, 6159.630422174672, 6163.229596300463, 6183.845403864894, 4717.457492388385, 4719.362886010387, 4728.40894888139, 4731.668783185179, 4777.235642297233, 4052.4398106728827, 4545.250033744428, 4719.339292499053, 4738.455077666078, 4742.85771426856, 3854.8242785950274, 4636.953630463703, 4651.302244698084, 4657.138429390557, 4667.369905062807, 4624.005838744669, 4682.391289132391, 4689.624830013608, 4726.291056341542, 4742.596879265267, 3656.3966945453967, 3824.8087595620386, 3846.0577158596325, 4145.440365550642, 4157.958420415787, 4513.390692256569, 5405.5135037846385, 5479.68487562986, 5912.4974377178, 5960.374160713106, 4731.905361892777, 5170.25031370453, 5350.090484617585, 5372.113601255788, 5386.973065134649, 5941.9601569725555, 6269.404406581368, 6467.83830404239, 6520.706568204442, 6578.079068930354, 3759.0038639760487, 4352.260115780293, 4408.955910440886, 4414.161309351213, 4424.756638384888, 5342.759575819136, 6681.76613818514, 6826.962001909153, 6950.965245173792, 7014.964925175393, 3896.980515097406, 3915.4126880967515, 3958.8614398495915, 4375.912481750411, 4409.889752756207, 3892.384660365973, 4254.446921900195, 4474.172278128557, 4474.440694913136, 4529.184746745617, 4827.372441582572, 5087.0, 5265.6840589564745, 5310.6813591184655, 5334.733263336818, 6231.657258850807, 6491.350864913566, 6506.551527690332, 6510.934890651033, 6531.640759758164, 1397.1267957526545, 1421.9360128794228, 1535.9462418815287, 1536.5390382885314, 1538.7614919687467, 923.3490389275545, 942.4816351007056, 963.4893506441597, 1026.7997740440542, 1036.5905467340358, 5306.734663266821, 5598.328200615871, 6283.465905398092, 6311.368863113744, 6313.715882785285, 5626.465485778845, 5747.827565172968, 6304.432601065926, 6742.865142697118, 6856.41720453767, 5667.829965100971, 6183.196184496077, 6249.375062493805, 6259.937400626027, 6321.525885558602, 3318.9336213276083, 3330.4504756715355, 3503.4409687689244, 3527.153483164022, 3544.8404821783083, 5662.546996240291, 5766.913496297559, 6716.388066864015, 6876.140482439695, 7007.159140903124, 5842.707864606838, 6291.528135389773, 6939.23668396476, 6944.340287672663, 6987.615681137485, 5959.404059594092, 6487.286398496161, 6921.377076063179, 6930.27232140618, 6972.79081627552, 6289.9371006291185, 6434.613923164625, 6787.321267873173, 6789.947558128498, 6837.213720422215, 5599.580031497572, 6491.772787952399, 6678.7328506859185, 6703.631300278336, 6783.18601767791, 6954.408875245661, 7028.929710702828, 7052.82367940785, 7057.717691292496, 7059.729248735277, 4298.161858437575, 4434.490033646172, 4451.577100175478, 4463.486699029523, 4464.754438505784, 5712.685802280748, 6549.561480222921, 6784.253732089565, 6788.49086318538, 6796.184457865088, 6568.94896816507, 6577.375149360994, 6580.8354791130605, 6594.769183078761, 6598.304949228447, 5144.382674079135, 5271.947280527145, 6531.706073226621, 6578.736850525926, 6600.933990660032, 6486.772962946275, 6489.772857949949, 6496.70764815575, 6525.445337146396, 6546.607203567801, 5148.43367229597, 6588.374104460068, 6658.600483970978, 6665.266820649627, 6685.565438246498, 5568.972155139199, 6349.14286571307, 6383.457181264257, 6462.224533056064, 6463.289038205888], "value": 4749.847726925779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.6529926832197, 840.5881118252058, 852.9488230706158, 862.3959435450064, 868.1665601023019, 13573.796393054112, 17271.22279497424, 17296.74054889176, 18222.088895555236, 18908.43274701761, 17770.555736106602, 17804.82195178048, 18213.36253231137, 18314.90842545789, 18521.351752688657, 994.378513429105, 1033.4367769565567, 1036.4869389652133, 1037.6523864505361, 1039.2777019971122, 1020.2807021050179, 1032.3186696780126, 1032.5611615063606, 1034.4724190662741, 1039.3348257115451, 1082.0856376361962, 1089.7384627689337, 1097.9733948757896, 1098.7033500954738, 1101.5263436722207, 1075.67192006438, 1081.3511892864296, 1091.5633746501383, 1095.5727266366084, 1096.3257596578046, 773.0259872560558, 777.5179388778937, 780.5004796929912, 781.7263957614846, 781.8358144789544, 16746.66506669872, 17140.742888856676, 17281.395151169774, 17297.962122272704, 17312.22095005728, 13503.459861605525, 16960.66078678432, 17297.827021729747, 17299.913500432416, 17322.48032559025, 13081.411336489786, 13744.725105497933, 14048.454669986395, 14096.365663545062, 14119.576412707635, 3399.3201359727905, 3454.5509083819193, 3467.4452087665854, 3481.582210134775, 3484.6515348465205, 93487.53256233744, 109720.90279097267, 112356.0, 113415.0, 113644.0, 11319.547218111184, 13510.324483775968, 13629.727405451835, 13720.451181952809, 13738.175709457464, 23546.52906941886, 25307.0, 25748.0, 25751.484970300487, 25907.611385829226, 8881.689140880038, 9152.267818574499, 9201.723948281562, 9233.076692330847, 9285.535723213812, 4741.241401375763, 4829.203181475087, 4856.247281671346, 4862.562369386772, 4871.220604703301, 4237.660987121023, 4320.3519472078815, 4348.695591308578, 4496.64026877849, 4686.7656617169005, 933.9953300233456, 946.9668561600449, 947.9004704505927, 961.4711908450324, 961.485605201214, 609.8565190268247, 638.2978723404218, 646.3116780628616, 670.792054463118, 672.909157263773, 11059.170562207866, 11873.228240164362, 12024.105843133115, 12185.207961482476, 12190.878091219152, 649.1009951217503, 658.3975662269066, 670.6009924095156, 676.67857767561, 693.7467824244216, 5468.945310546923, 5536.667799932017, 5680.8863822723315, 5712.542996560265, 5778.768849245983, 104992.0, 105107.54032137145, 105219.0, 105324.47337763262, 106850.46574767077, 93102.67243318971, 93388.0661193393, 94036.0, 94233.0576694238, 94922.52538737262, 77209.61395192987, 80442.0, 82023.0, 83057.0, 83783.58108209542, 11004.339739615649, 11147.331160130418, 11380.658580242605, 11389.259698119597, 11558.711032223926, 41812.163756725306, 41851.0, 41879.371809423494, 42288.577114228465, 42341.36487952621, 37967.81016094902, 54189.18716219339, 54205.45794542004, 54251.72874135604, 54712.726436367564, 14022.789658154932, 14165.929170354082, 14302.856971430569, 14328.0, 14404.783928241295, 15672.0, 15714.607134821721, 15778.0, 15882.523524294289, 15945.123018234108, 14632.707345853236, 14656.0, 14719.779203311744, 14751.557453276419, 14831.777523336943, 14344.49794257196, 14419.567412977627, 14452.349644265823, 14657.633559161106, 14720.0, 14352.928235358757, 14366.928165359106, 14443.133411995314, 14491.0, 14552.636184095481, 8800.60397282111, 10451.21615878797, 10525.105366043972, 10731.248812583044, 11003.0, 11670.124740644316, 11682.4742886572, 11750.942415182675, 11815.527378905092, 11836.053115750547], "value": 8279.004812598605, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1645.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 183.0, 121.0, 124.0, 122.0, 122.0, 128.0, 146.0, 121.0, 123.0], "value": 131.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 121.0, 192.0, 122.0, 121.0, 121.0, 122.0, 138.0, 122.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 226.0, 221.0, 220.0, 221.0, 216.0, 216.0, 211.0, 213.0, 210.0], "value": 217.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 69.0, 84.0, 63.0, 66.0, 61.0, 59.0, 73.0, 60.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 88.0, 74.0, 72.0, 96.0, 124.0, 73.0, 71.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 91.0, 107.0, 91.0, 91.0, 89.0, 93.0, 90.0, 90.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 100.0, 100.0, 102.0, 101.0, 100.0, 111.0, 100.0, 101.0, 101.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 148.0, 105.0, 105.0, 117.0, 117.0, 126.0, 165.0, 138.0, 102.0], "value": 122.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 53.0, 52.0, 55.0, 51.0, 52.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 69.0, 66.0, 67.0, 78.0, 87.0, 85.0, 69.0, 58.0, 61.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 101.0, 117.0, 80.0, 113.0, 116.0, 111.0, 84.0, 114.0, 113.0], "value": 103.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 153.0, 165.0, 162.0, 174.0, 156.0, 169.0, 214.0, 174.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [245.0, 215.0, 197.0, 198.0, 197.0, 208.0, 281.0, 250.0, 188.0, 244.0], "value": 222.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 88.0, 92.0, 87.0, 70.0, 70.0, 78.0, 82.0, 73.0], "value": 78.7, "unit": "score"}]}]} 03:41:53 INFO - Return code: 0 03:41:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:53 ERROR - # TBPL SUCCESS # 03:41:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:53 INFO - 2017-04-13 03:41:53.289 screenresolution[1679:10647] starting screenresolution argv=screenresolution get 03:41:53 INFO - 2017-04-13 03:41:53.292 screenresolution[1679:10647] Display 0: 1600x1200x32@60 03:41:53 INFO - 2017-04-13 03:41:53.299 screenresolution[1680:10650] starting screenresolution argv=screenresolution list 03:41:53 INFO - Available Modes on Display 0 03:41:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:53 INFO - Intel Iris: 03:41:53 INFO - Chipset Model: Intel Iris 03:41:53 INFO - Type: GPU 03:41:53 INFO - Bus: Built-In 03:41:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:53 INFO - Vendor: Intel (0x8086) 03:41:53 INFO - Device ID: 0x0a2e 03:41:53 INFO - Revision ID: 0x0009 03:41:53 INFO - Displays: 03:41:53 INFO - Display: 03:41:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:53 INFO - Display Serial Number: 1600x1200 60 03:41:53 INFO - Main Display: Yes 03:41:53 INFO - Mirror: Off 03:41:53 INFO - Online: Yes 03:41:53 INFO - Rotation: Supported 03:41:53 INFO - Return code: 0 03:41:53 INFO - Running post-action listener: _resource_record_post_action 03:41:53 INFO - [mozharness: 2017-04-13 10:41:53.540116Z] Finished run-tests step (success) 03:41:53 INFO - Running post-run listener: _resource_record_post_run 03:41:53 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 51596800; Write bytes: 533993984; Read time: 560; Write time: 2121 03:41:53 INFO - TinderboxPrint: CPU usage
54.2% 03:41:53 INFO - TinderboxPrint: I/O read bytes / time
51,596,800 / 560 03:41:53 INFO - TinderboxPrint: I/O write bytes / time
533,993,984 / 2,121 03:41:53 INFO - TinderboxPrint: CPU idle
2,197.9 (45.8%) 03:41:53 INFO - TinderboxPrint: CPU system
963.4 (20.1%) 03:41:53 INFO - TinderboxPrint: CPU user
1,640.4 (34.2%) 03:41:53 INFO - TinderboxPrint: Swap in / out
252,395,520 / 0 03:41:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209080832; Write bytes: 211929088; Read time: 16112; Write time: 522 03:41:53 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 46722560; Write bytes: 320680448; Read time: 520; Write time: 1593 03:41:54 INFO - Running post-run listener: _upload_blobber_files 03:41:54 INFO - Blob upload gear active. 03:41:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:55 INFO - (blobuploader) - INFO - Done attempting. 03:41:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:56 INFO - (blobuploader) - INFO - Done attempting. 03:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:58 INFO - (blobuploader) - INFO - Done attempting. 03:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:00 INFO - (blobuploader) - INFO - Done attempting. 03:42:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:00 INFO - Return code: 0 03:42:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/dfaad138a869d4762a3243364bd34453f6b6a6a0478b27da350bf3eff24fa2dc2871a29957416904c364c0124accd0fd6d304d042ded59913d1ac563995e3236", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/062e768293c21e841b913f572b6d8b91fa77e8859403b81e0f1a724665009c07f968d903955af3265816e0d065b5f6b25d790e3657d5e25750f4f0ad52bfc4bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b2d0a1e0691a2a040defba7d8178fee6e990439e253f3d81ec1077f76b30041b47734583b0064c42865060b7ce0ad7842df884538b0cea83b00d3eb9cb7ef609", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8ffdb1227686acc17ab07c1713136850356591bf16d3ea30508c772e5318279bf23ea9aa85cd337c7671c4fc326ed04839bec2fcd9e166e911e1935bf74b6b96"} 03:42:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:00 INFO - Contents: 03:42:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/dfaad138a869d4762a3243364bd34453f6b6a6a0478b27da350bf3eff24fa2dc2871a29957416904c364c0124accd0fd6d304d042ded59913d1ac563995e3236", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/062e768293c21e841b913f572b6d8b91fa77e8859403b81e0f1a724665009c07f968d903955af3265816e0d065b5f6b25d790e3657d5e25750f4f0ad52bfc4bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b2d0a1e0691a2a040defba7d8178fee6e990439e253f3d81ec1077f76b30041b47734583b0064c42865060b7ce0ad7842df884538b0cea83b00d3eb9cb7ef609", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8ffdb1227686acc17ab07c1713136850356591bf16d3ea30508c772e5318279bf23ea9aa85cd337c7671c4fc326ed04839bec2fcd9e166e911e1935bf74b6b96"} 03:42:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:00 INFO - Copying logs to upload dir... 03:42:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.517597 ========= master_lag: 1.35 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-13 03:42:01.624498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 03:42:01.625622) ========= 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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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/Pine/sha512/dfaad138a869d4762a3243364bd34453f6b6a6a0478b27da350bf3eff24fa2dc2871a29957416904c364c0124accd0fd6d304d042ded59913d1ac563995e3236", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/062e768293c21e841b913f572b6d8b91fa77e8859403b81e0f1a724665009c07f968d903955af3265816e0d065b5f6b25d790e3657d5e25750f4f0ad52bfc4bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b2d0a1e0691a2a040defba7d8178fee6e990439e253f3d81ec1077f76b30041b47734583b0064c42865060b7ce0ad7842df884538b0cea83b00d3eb9cb7ef609", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8ffdb1227686acc17ab07c1713136850356591bf16d3ea30508c772e5318279bf23ea9aa85cd337c7671c4fc326ed04839bec2fcd9e166e911e1935bf74b6b96"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/pine-macosx64/1492030089/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/dfaad138a869d4762a3243364bd34453f6b6a6a0478b27da350bf3eff24fa2dc2871a29957416904c364c0124accd0fd6d304d042ded59913d1ac563995e3236", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/062e768293c21e841b913f572b6d8b91fa77e8859403b81e0f1a724665009c07f968d903955af3265816e0d065b5f6b25d790e3657d5e25750f4f0ad52bfc4bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b2d0a1e0691a2a040defba7d8178fee6e990439e253f3d81ec1077f76b30041b47734583b0064c42865060b7ce0ad7842df884538b0cea83b00d3eb9cb7ef609", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8ffdb1227686acc17ab07c1713136850356591bf16d3ea30508c772e5318279bf23ea9aa85cd337c7671c4fc326ed04839bec2fcd9e166e911e1935bf74b6b96"}' ========= master_lag: 0.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 03:42:02.163368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:42:02.163654) ========= 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.m5TkrZtJFt/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.Ucaq30SB0v/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 03:42:02.207096) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2017-04-13 03:42:02.207367) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2017-04-13 03:42:04.035493) ========= ========= Total master_lag: 4.64 =========