builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0186 starttime: 1483285061.15 results: success (0) buildid: 20170101070619 builduid: 83585c330eb1466cbb33bae705631343 revision: 9bdd486afbd663f005a76f0af0a466d4d297c7ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.161304) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.161844) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.162153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.188461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.188846) ========= 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.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-01-01 07:37:41-- 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% 7.82M=0.001s 2017-01-01 07:37:41 (7.82 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163057 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.379737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.380046) ========= 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.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.019672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:41.429312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-01 07:37:41.429676) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9bdd486afbd663f005a76f0af0a466d4d297c7ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9bdd486afbd663f005a76f0af0a466d4d297c7ef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-01-01 07:37:41,505 truncating revision to first 12 chars 2017-01-01 07:37:41,505 Setting DEBUG logging. 2017-01-01 07:37:41,505 attempt 1/10 2017-01-01 07:37:41,505 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9bdd486afbd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-01 07:37:42,269 unpacking tar archive at: mozilla-central-9bdd486afbd6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.022095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-01 07:37:42.475021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:42.475313) ========= script_repo_revision: 9bdd486afbd663f005a76f0af0a466d4d297c7ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:42.475701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:42.475965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 07:37:42.497121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-01 07:37:42.497762) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:37:42 INFO - MultiFileLogger online at 20170101 07:37:42 in /builds/slave/test 07:37:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:37:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:42 INFO - {'append_to_log': False, 07:37:42 INFO - 'base_work_dir': '/builds/slave/test', 07:37:42 INFO - 'blob_upload_branch': 'Firefox', 07:37:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:42 INFO - 'branch': 'Firefox', 07:37:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:42 INFO - 'config_files': ('talos/mac_config.py',), 07:37:42 INFO - 'default_actions': ('clobber', 07:37:42 INFO - 'read-buildbot-config', 07:37:42 INFO - 'download-and-extract', 07:37:42 INFO - 'populate-webroot', 07:37:42 INFO - 'create-virtualenv', 07:37:42 INFO - 'install', 07:37:42 INFO - 'run-tests'), 07:37:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:42 INFO - 'download_minidump_stackwalk': True, 07:37:42 INFO - 'download_symbols': 'ondemand', 07:37:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:42 INFO - 'installer_path': 'installer.exe', 07:37:42 INFO - 'log_level': 'info', 07:37:42 INFO - 'log_name': 'talos', 07:37:42 INFO - 'log_to_console': True, 07:37:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:37:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:37:42 INFO - 'opt_config_files': (), 07:37:42 INFO - 'pip_index': False, 07:37:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:42 INFO - 'cmd': ('bash', 07:37:42 INFO - '-c', 07:37:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:42 INFO - 'enabled': True, 07:37:42 INFO - 'halt_on_failure': False, 07:37:42 INFO - 'name': 'check_screen_resolution'},), 07:37:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:42 INFO - 'cmd': ('bash', 07:37:42 INFO - '-c', 07:37:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:42 INFO - 'enabled': True, 07:37:42 INFO - 'halt_on_failure': False, 07:37:42 INFO - 'name': 'check_screen_resolution'},), 07:37:42 INFO - 'run_cmd_checks_enabled': True, 07:37:42 INFO - 'sps_profile': False, 07:37:42 INFO - 'sps_profile_interval': 0, 07:37:42 INFO - 'suite': 'dromaeojs-e10s', 07:37:42 INFO - 'system_bits': '32', 07:37:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:42 INFO - 'title': 't-yosemite-r7-0186', 07:37:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:42 INFO - 'use_talos_json': True, 07:37:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:42 INFO - 'work_dir': 'build'} 07:37:42 INFO - [mozharness: 2017-01-01 15:37:42.697044Z] Running clobber step. 07:37:42 INFO - Running pre-action listener: _resource_record_pre_action 07:37:42 INFO - Running main action method: clobber 07:37:42 INFO - rmtree: /builds/slave/test/build 07:37:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:43 INFO - Running post-action listener: _resource_record_post_action 07:37:43 INFO - [mozharness: 2017-01-01 15:37:43.663377Z] Finished clobber step (success) 07:37:43 INFO - [mozharness: 2017-01-01 15:37:43.663658Z] Running read-buildbot-config step. 07:37:43 INFO - Running pre-action listener: _resource_record_pre_action 07:37:43 INFO - Running main action method: read_buildbot_config 07:37:43 INFO - Using buildbot properties: 07:37:43 INFO - { 07:37:43 INFO - "project": "", 07:37:43 INFO - "product": "firefox", 07:37:43 INFO - "script_repo_revision": "production", 07:37:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:37:43 INFO - "repository": "", 07:37:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:37:43 INFO - "buildid": "20170101070619", 07:37:43 INFO - "pgo_build": "False", 07:37:43 INFO - "basedir": "/builds/slave/test", 07:37:43 INFO - "buildnumber": 30, 07:37:43 INFO - "slavename": "t-yosemite-r7-0186", 07:37:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:37:43 INFO - "platform": "yosemite_r7", 07:37:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:37:43 INFO - "branch": "mozilla-central", 07:37:43 INFO - "repo_path": "mozilla-central", 07:37:43 INFO - "revision": "9bdd486afbd663f005a76f0af0a466d4d297c7ef", 07:37:43 INFO - "stage_platform": "macosx64", 07:37:43 INFO - "builduid": "83585c330eb1466cbb33bae705631343", 07:37:43 INFO - "slavebuilddir": "test" 07:37:43 INFO - } 07:37:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:37:43 INFO - Running post-action listener: _resource_record_post_action 07:37:43 INFO - [mozharness: 2017-01-01 15:37:43.668613Z] Finished read-buildbot-config step (success) 07:37:43 INFO - [mozharness: 2017-01-01 15:37:43.668725Z] Running download-and-extract step. 07:37:43 INFO - Running pre-action listener: _resource_record_pre_action 07:37:43 INFO - Running main action method: download_and_extract 07:37:43 INFO - mkdir: /builds/slave/test/build/tests 07:37:43 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')]} 07:37:43 INFO - trying https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:37:43 INFO - Downloading https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:37:44 INFO - Downloaded 1199 bytes. 07:37:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:37:44 INFO - Using the following test package requirements: 07:37:44 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:37:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:37:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:37:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'jsshell-mac.zip'], 07:37:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:37:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:37:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:37:44 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:37:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:37:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:44 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:37:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:37:45 INFO - Expected file size: 16299746 07:37:45 INFO - Obtained file size: 16299746 07:37:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:37:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:37:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:51 INFO - Fetch https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:37:52 INFO - Expected file size: 16299746 07:37:52 INFO - Obtained file size: 16299746 07:37:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:37:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:37:59 INFO - Fetch https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:37:59 INFO - Expected file size: 14409776 07:37:59 INFO - Obtained file size: 14409776 07:38:00 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')]} 07:38:00 INFO - trying https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:38:00 INFO - Downloading https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:38:02 INFO - Downloaded 69754525 bytes. 07:38:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:38:02 INFO - mkdir: /builds/slave/test/properties 07:38:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:02 INFO - Contents: 07:38:02 INFO - build_url:https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:38:03 INFO - Running post-action listener: _resource_record_post_action 07:38:03 INFO - Running post-action listener: set_extra_try_arguments 07:38:03 INFO - [mozharness: 2017-01-01 15:38:03.348572Z] Finished download-and-extract step (success) 07:38:03 INFO - [mozharness: 2017-01-01 15:38:03.348730Z] Running populate-webroot step. 07:38:03 INFO - Running pre-action listener: _resource_record_pre_action 07:38:03 INFO - Running main action method: populate_webroot 07:38:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:03 INFO - '--tppagecycles', 07:38:03 INFO - '7'], 07:38:03 INFO - 'tests': ['tsvgm']}}, 07:38:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['damp', 'tps']}, 07:38:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'tests': ['damp', 'tps']}, 07:38:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['dromaeo_dom']}, 07:38:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['basic_compositor_video']}, 07:38:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['a11yr', 07:38:03 INFO - 'ts_paint', 07:38:03 INFO - 'tpaint', 07:38:03 INFO - 'sessionrestore', 07:38:03 INFO - 'sessionrestore_no_auto_restore', 07:38:03 INFO - 'tabpaint']}, 07:38:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['tsvgx', 07:38:03 INFO - 'tsvgr_opacity', 07:38:03 INFO - 'tart', 07:38:03 INFO - 'tscrollx', 07:38:03 INFO - 'cart', 07:38:03 INFO - 'tsvg_static']}, 07:38:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:03 INFO - 'tsvgr_opacity', 07:38:03 INFO - 'tart', 07:38:03 INFO - 'tscrollx', 07:38:03 INFO - 'cart', 07:38:03 INFO - 'tsvg_static']}, 07:38:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'talos_options': ['--disable-e10s'], 07:38:03 INFO - 'tests': ['tp5o']}, 07:38:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:38:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'talos_options': ['--disable-e10s', 07:38:03 INFO - '--xperf_path', 07:38:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:03 INFO - 'tests': ['tp5n']}, 07:38:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:38:03 INFO - 'talos_options': ['--xperf_path', 07:38:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:03 INFO - 'tests': ['tp5n']}}, 07:38:03 INFO - 'talos.zip': {'path': '', 07:38:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:03 INFO - Running post-action listener: _resource_record_post_action 07:38:03 INFO - [mozharness: 2017-01-01 15:38:03.367005Z] Finished populate-webroot step (success) 07:38:03 INFO - [mozharness: 2017-01-01 15:38:03.367133Z] Running create-virtualenv step. 07:38:03 INFO - Running pre-action listener: _resource_record_pre_action 07:38:03 INFO - Running main action method: create_virtualenv 07:38:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:03 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 07:38:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:03 INFO - Using real prefix '/tools/python27' 07:38:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:04 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:07 INFO - Installing pip.................done. 07:38:07 INFO - Return code: 0 07:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:07 INFO - Reading from file tmpfile_stdout 07:38:07 INFO - Output received: 07:38:07 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) 07:38:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:07 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')]} 07:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 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')]} 07:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:07 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 07:38:07 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 07:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:07 INFO - 'HOME': '/Users/cltbld', 07:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:07 INFO - 'LOGNAME': 'cltbld', 07:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:07 INFO - 'MOZ_NO_REMOTE': '1', 07:38:07 INFO - 'NO_EM_RESTART': '1', 07:38:07 INFO - 'PAGER': '/bin/cat', 07:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:07 INFO - 'PWD': '/builds/slave/test', 07:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:07 INFO - 'SHELL': '/bin/bash', 07:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:07 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:07 INFO - 'USER': 'cltbld', 07:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:07 INFO - 'XPC_FLAGS': '0x0', 07:38:07 INFO - 'XPC_SERVICE_NAME': '0', 07:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:07 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 07:38:07 INFO - Cleaning up... 07:38:07 INFO - Return code: 0 07:38:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:07 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')]} 07:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 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')]} 07:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:07 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:07 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 07:38:07 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 07:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:07 INFO - 'HOME': '/Users/cltbld', 07:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:07 INFO - 'LOGNAME': 'cltbld', 07:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:07 INFO - 'MOZ_NO_REMOTE': '1', 07:38:07 INFO - 'NO_EM_RESTART': '1', 07:38:07 INFO - 'PAGER': '/bin/cat', 07:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:07 INFO - 'PWD': '/builds/slave/test', 07:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:07 INFO - 'SHELL': '/bin/bash', 07:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:07 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:07 INFO - 'USER': 'cltbld', 07:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:07 INFO - 'XPC_FLAGS': '0x0', 07:38:07 INFO - 'XPC_SERVICE_NAME': '0', 07:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:07 INFO - Downloading/unpacking psutil>=3.1.1 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:11 INFO - Installing collected packages: psutil 07:38:11 INFO - Running setup.py install for psutil 07:38:11 INFO - building 'psutil._psutil_osx' extension 07:38:11 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 INFO - building 'psutil._psutil_posix' extension 07:38:12 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 07:38:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:38:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:38:12 INFO - ^ 07:38:12 INFO - 1 warning generated. 07:38:12 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 07:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:12 INFO - Successfully installed psutil 07:38:12 INFO - Cleaning up... 07:38:12 INFO - Return code: 0 07:38:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:12 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:12 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 07:38:12 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 07:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:12 INFO - 'HOME': '/Users/cltbld', 07:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:12 INFO - 'LOGNAME': 'cltbld', 07:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:12 INFO - 'MOZ_NO_REMOTE': '1', 07:38:12 INFO - 'NO_EM_RESTART': '1', 07:38:12 INFO - 'PAGER': '/bin/cat', 07:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:12 INFO - 'PWD': '/builds/slave/test', 07:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:12 INFO - 'SHELL': '/bin/bash', 07:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:12 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:12 INFO - 'USER': 'cltbld', 07:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:12 INFO - 'XPC_FLAGS': '0x0', 07:38:12 INFO - 'XPC_SERVICE_NAME': '0', 07:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:15 INFO - Installing collected packages: mozsystemmonitor 07:38:15 INFO - Running setup.py install for mozsystemmonitor 07:38:15 INFO - Successfully installed mozsystemmonitor 07:38:15 INFO - Cleaning up... 07:38:15 INFO - Return code: 0 07:38:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:15 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 07:38:15 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 07:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:15 INFO - 'HOME': '/Users/cltbld', 07:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PAGER': '/bin/cat', 07:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:15 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - 'XPC_FLAGS': '0x0', 07:38:15 INFO - 'XPC_SERVICE_NAME': '0', 07:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:16 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:16 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 07:38:16 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 07:38:16 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 07:38:16 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 07:38:16 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 07:38:16 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 07:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:18 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 07:38:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:19 INFO - warning: no files found matching '*.txt' 07:38:19 INFO - no previously-included directories found matching 'build' 07:38:19 INFO - no previously-included directories found matching 'dist' 07:38:19 INFO - no previously-included directories found matching '.git*' 07:38:19 INFO - Installing collected packages: jsonschema, functools32 07:38:19 INFO - Running setup.py install for functools32 07:38:19 INFO - warning: no files found matching '*.txt' 07:38:19 INFO - no previously-included directories found matching 'build' 07:38:19 INFO - no previously-included directories found matching 'dist' 07:38:19 INFO - no previously-included directories found matching '.git*' 07:38:19 INFO - Successfully installed jsonschema functools32 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:19 INFO - 'HOME': '/Users/cltbld', 07:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PAGER': '/bin/cat', 07:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - 'XPC_FLAGS': '0x0', 07:38:19 INFO - 'XPC_SERVICE_NAME': '0', 07:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:19 INFO - 'HOME': '/Users/cltbld', 07:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PAGER': '/bin/cat', 07:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - 'XPC_FLAGS': '0x0', 07:38:19 INFO - 'XPC_SERVICE_NAME': '0', 07:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:22 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 07:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:23 INFO - Downloading docopt-0.6.1.tar.gz 07:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:24 INFO - Running setup.py install for blobuploader 07:38:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:24 INFO - Running setup.py install for requests 07:38:24 INFO - Running setup.py install for docopt 07:38:24 INFO - Successfully installed blobuploader requests docopt 07:38:24 INFO - Cleaning up... 07:38:24 INFO - Return code: 0 07:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:24 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:24 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 07:38:24 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 07:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:24 INFO - 'HOME': '/Users/cltbld', 07:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:24 INFO - 'LOGNAME': 'cltbld', 07:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:24 INFO - 'MOZ_NO_REMOTE': '1', 07:38:24 INFO - 'NO_EM_RESTART': '1', 07:38:24 INFO - 'PAGER': '/bin/cat', 07:38:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:24 INFO - 'PWD': '/builds/slave/test', 07:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:24 INFO - 'SHELL': '/bin/bash', 07:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:24 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:24 INFO - 'USER': 'cltbld', 07:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:24 INFO - 'XPC_FLAGS': '0x0', 07:38:24 INFO - 'XPC_SERVICE_NAME': '0', 07:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-MXFCXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-sZkSB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-LQ1BGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KHy1VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-x_UlWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vvUcbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-mfM_Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Z_xU8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:25 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-fdNU39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qjbmU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-CKAJqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-1fCEUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-M85Zqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vdda1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ELBB9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-9jY5Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:26 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-DWl0ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:26 INFO - Running setup.py install for manifestparser 07:38:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:27 INFO - Running setup.py install for mozcrash 07:38:27 INFO - Running setup.py install for mozdebug 07:38:27 INFO - Running setup.py install for mozdevice 07:38:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:27 INFO - Running setup.py install for mozfile 07:38:27 INFO - Running setup.py install for mozhttpd 07:38:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:27 INFO - Running setup.py install for mozinfo 07:38:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:27 INFO - Running setup.py install for mozInstall 07:38:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Running setup.py install for mozleak 07:38:28 INFO - Running setup.py install for mozlog 07:38:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Running setup.py install for moznetwork 07:38:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Running setup.py install for mozprocess 07:38:28 INFO - Running setup.py install for mozprofile 07:38:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:28 INFO - Running setup.py install for mozrunner 07:38:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:29 INFO - Running setup.py install for mozscreenshot 07:38:29 INFO - Running setup.py install for moztest 07:38:29 INFO - Running setup.py install for mozversion 07:38:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:29 INFO - Cleaning up... 07:38:29 INFO - Return code: 0 07:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:29 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:29 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 07:38:29 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 07:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:29 INFO - 'HOME': '/Users/cltbld', 07:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:29 INFO - 'LOGNAME': 'cltbld', 07:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:29 INFO - 'MOZ_NO_REMOTE': '1', 07:38:29 INFO - 'NO_EM_RESTART': '1', 07:38:29 INFO - 'PAGER': '/bin/cat', 07:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:29 INFO - 'PWD': '/builds/slave/test', 07:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:29 INFO - 'SHELL': '/bin/bash', 07:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:29 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:29 INFO - 'USER': 'cltbld', 07:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:29 INFO - 'XPC_FLAGS': '0x0', 07:38:29 INFO - 'XPC_SERVICE_NAME': '0', 07:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:29 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-XbWblG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:29 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)) 07:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:29 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-v3mVSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:29 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)) 07:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:29 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-TcMGVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-2Tdf21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-JWZSCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KgCyX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-HhKe5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Sks6mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-nVp1NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-0py0Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RvVdAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:30 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)) 07:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:30 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-pSjGiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-j978_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:31 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)) 07:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vRaSbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:31 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)) 07:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Q9gaRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:31 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)) 07:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-6iJgwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:31 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)) 07:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-pB7xxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:31 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)) 07:38:31 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)) 07:38:31 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)) 07:38:31 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)) 07:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:34 INFO - Downloading blessings-1.6.tar.gz 07:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:34 INFO - Installing collected packages: blessings 07:38:34 INFO - Running setup.py install for blessings 07:38:34 INFO - Successfully installed blessings 07:38:34 INFO - Cleaning up... 07:38:34 INFO - Return code: 0 07:38:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:34 INFO - Reading from file tmpfile_stdout 07:38:34 INFO - Current package versions: 07:38:34 INFO - blessings == 1.6 07:38:34 INFO - blobuploader == 1.2.4 07:38:34 INFO - docopt == 0.6.1 07:38:34 INFO - functools32 == 3.2.3-2 07:38:34 INFO - jsonschema == 2.5.1 07:38:34 INFO - manifestparser == 1.1 07:38:34 INFO - mozInstall == 1.12 07:38:34 INFO - mozcrash == 1.0 07:38:34 INFO - mozdebug == 0.1 07:38:34 INFO - mozdevice == 0.49 07:38:34 INFO - mozfile == 1.2 07:38:34 INFO - mozhttpd == 0.7 07:38:34 INFO - mozinfo == 0.9 07:38:34 INFO - mozleak == 0.1 07:38:34 INFO - mozlog == 3.4 07:38:34 INFO - moznetwork == 0.27 07:38:34 INFO - mozprocess == 0.23 07:38:34 INFO - mozprofile == 0.28 07:38:34 INFO - mozrunner == 6.13 07:38:34 INFO - mozscreenshot == 0.1 07:38:34 INFO - mozsystemmonitor == 0.3 07:38:34 INFO - moztest == 0.8 07:38:34 INFO - mozversion == 1.4 07:38:34 INFO - psutil == 3.1.1 07:38:34 INFO - requests == 1.2.3 07:38:34 INFO - wsgiref == 0.1.2 07:38:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:34 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')]} 07:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:34 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')]} 07:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:34 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:34 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 07:38:34 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 07:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:34 INFO - 'HOME': '/Users/cltbld', 07:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:34 INFO - 'LOGNAME': 'cltbld', 07:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:34 INFO - 'MOZ_NO_REMOTE': '1', 07:38:34 INFO - 'NO_EM_RESTART': '1', 07:38:34 INFO - 'PAGER': '/bin/cat', 07:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:34 INFO - 'PWD': '/builds/slave/test', 07:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:34 INFO - 'SHELL': '/bin/bash', 07:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:34 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:34 INFO - 'USER': 'cltbld', 07:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:34 INFO - 'XPC_FLAGS': '0x0', 07:38:34 INFO - 'XPC_SERVICE_NAME': '0', 07:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 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)) 07:38:35 INFO - Cleaning up... 07:38:35 INFO - Return code: 0 07:38:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:35 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 0x10aa81b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa84768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8df25b5520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, '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.6X02jw6w0H/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.pau69VXPtU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 07:38:35 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 07:38:35 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 07:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:35 INFO - 'HOME': '/Users/cltbld', 07:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:35 INFO - 'LOGNAME': 'cltbld', 07:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:35 INFO - 'MOZ_NO_REMOTE': '1', 07:38:35 INFO - 'NO_EM_RESTART': '1', 07:38:35 INFO - 'PAGER': '/bin/cat', 07:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:35 INFO - 'PWD': '/builds/slave/test', 07:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:35 INFO - 'SHELL': '/bin/bash', 07:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:35 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:35 INFO - 'USER': 'cltbld', 07:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:35 INFO - 'XPC_FLAGS': '0x0', 07:38:35 INFO - 'XPC_SERVICE_NAME': '0', 07:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:35 INFO - Cleaning up... 07:38:35 INFO - Return code: 0 07:38:35 INFO - Running post-action listener: _resource_record_post_action 07:38:35 INFO - Running post-action listener: _start_resource_monitoring 07:38:35 INFO - Starting resource monitoring. 07:38:35 INFO - [mozharness: 2017-01-01 15:38:35.490684Z] Finished create-virtualenv step (success) 07:38:35 INFO - [mozharness: 2017-01-01 15:38:35.491622Z] Running install step. 07:38:35 INFO - Running pre-action listener: _resource_record_pre_action 07:38:35 INFO - Running main action method: install 07:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:35 INFO - Reading from file tmpfile_stdout 07:38:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:35 INFO - Reading from file tmpfile_stdout 07:38:35 INFO - Output received: 07:38:35 INFO - Usage: mozinstall [options] installer 07:38:35 INFO - Options: 07:38:35 INFO - -h, --help show this help message and exit 07:38:35 INFO - -d DEST, --destination=DEST 07:38:35 INFO - Directory to install application into. [default: 07:38:35 INFO - "/builds/slave/test"] 07:38:35 INFO - --app=APP Application being installed. [default: firefox] 07:38:35 INFO - mkdir: /builds/slave/test/build/application 07:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:38:57 INFO - Reading from file tmpfile_stdout 07:38:57 INFO - Output received: 07:38:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:38:57 INFO - Running post-action listener: _resource_record_post_action 07:38:57 INFO - [mozharness: 2017-01-01 15:38:57.967813Z] Finished install step (success) 07:38:57 INFO - [mozharness: 2017-01-01 15:38:57.967928Z] Running run-tests step. 07:38:57 INFO - Running pre-action listener: _resource_record_pre_action 07:38:57 INFO - Running main action method: run_tests 07:38:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:38:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:38:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:38:57 INFO - 2017-01-01 07:38:57.982 screenresolution[1927:15878] starting screenresolution argv=screenresolution get 07:38:57 INFO - 2017-01-01 07:38:57.985 screenresolution[1927:15878] Display 0: 1600x1200x32@60 07:38:57 INFO - 2017-01-01 07:38:57.991 screenresolution[1928:15880] starting screenresolution argv=screenresolution list 07:38:57 INFO - Available Modes on Display 0 07:38:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:38:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:38:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:38:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:38:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:38:58 INFO - Intel Iris: 07:38:58 INFO - Chipset Model: Intel Iris 07:38:58 INFO - Type: GPU 07:38:58 INFO - Bus: Built-In 07:38:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:38:58 INFO - Vendor: Intel (0x8086) 07:38:58 INFO - Device ID: 0x0a2e 07:38:58 INFO - Revision ID: 0x0009 07:38:58 INFO - Displays: 07:38:58 INFO - Display: 07:38:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:38:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:38:58 INFO - Display Serial Number: 1600x1200 60 07:38:58 INFO - Main Display: Yes 07:38:58 INFO - Mirror: Off 07:38:58 INFO - Online: Yes 07:38:58 INFO - Rotation: Supported 07:38:58 INFO - Return code: 0 07:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:58 INFO - Python 2.7.3 07:38:58 INFO - Return code: 0 07:38:58 INFO - grabbing minidump binary from tooltool 07:38:58 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')]} 07:38:58 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 0x10a85fd30>, '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 0x10a786db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a854be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:58 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 07:38:58 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 07:38:58 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 07:38:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:58 INFO - Return code: 0 07:38:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:38:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:38:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 07:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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 07:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6X02jw6w0H/Render', 07:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:58 INFO - 'HOME': '/Users/cltbld', 07:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:58 INFO - 'LOGNAME': 'cltbld', 07:38:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:58 INFO - 'MOZ_NO_REMOTE': '1', 07:38:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:58 INFO - 'NO_EM_RESTART': '1', 07:38:58 INFO - 'PAGER': '/bin/cat', 07:38:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:58 INFO - 'PWD': '/builds/slave/test', 07:38:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:58 INFO - 'SHELL': '/bin/bash', 07:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pau69VXPtU/Listeners', 07:38:58 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 07:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:58 INFO - 'USER': 'cltbld', 07:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:58 INFO - 'XPC_FLAGS': '0x0', 07:38:58 INFO - 'XPC_SERVICE_NAME': '0', 07:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 07:38:58 INFO - mozversion application_buildid: 20170101070619 07:38:58 INFO - mozversion application_changeset: 9bdd486afbd663f005a76f0af0a466d4d297c7ef 07:38:58 INFO - mozversion application_display_name: Nightly 07:38:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:58 INFO - mozversion application_name: Firefox 07:38:58 INFO - mozversion application_remotingname: firefox 07:38:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:58 INFO - mozversion application_vendor: Mozilla 07:38:58 INFO - mozversion application_version: 53.0a1 07:38:58 INFO - mozversion platform_buildid: 20170101070619 07:38:58 INFO - mozversion platform_changeset: 9bdd486afbd663f005a76f0af0a466d4d297c7ef 07:38:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:58 INFO - mozversion platform_version: 53.0a1 07:38:58 INFO - using testdate: 1483285138 07:38:58 INFO - actual date: 1483285138 07:38:58 INFO - starting webserver on 'localhost:49482' 07:38:58 INFO - SUITE-START | Running 2 tests 07:38:58 INFO - TEST-START | dromaeo_css 07:38:58 INFO - operating with platform_type : mac_ 07:38:58 INFO - Initialising browser for dromaeo_css test... 07:38:58 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpq92pI3/profile http://localhost:49482/getInfo.html) 07:38:59 INFO - PROCESS | 1938 | 1483285139110 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:39:01 INFO - PROCESS | 1938 | 2017-01-01 07:39:01.624 plugin-container[1940:16034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 07:39:01 INFO - PROCESS | 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:39:01 INFO - PROCESS | 1938 | 2017-01-01 07:39:01.627 plugin-container[1940:16034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1f, name = 'com.apple.CFPasteboardClient' 07:39:01 INFO - PROCESS | 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:39:01 INFO - PROCESS | 1938 | 2017-01-01 07:39:01.627 plugin-container[1940:16034] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:39:01 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 07:39:01 INFO - PROCESS | 1938 | colorDepth:24 07:39:01 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 07:39:01 INFO - PROCESS | 1938 | __metrics 07:39:01 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:39:02 INFO - TEST-INFO | 1938: exit 0 07:39:02 INFO - Browser initialized. 07:39:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:02 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpq92pI3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:04 INFO - PROCESS | 1941 | 2017-01-01 07:39:04.915 plugin-container[1942:16156] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:39:04 INFO - PROCESS | 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:39:04 INFO - PROCESS | 1941 | 2017-01-01 07:39:04.916 plugin-container[1942:16156] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 07:39:04 INFO - PROCESS | 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:39:04 INFO - PROCESS | 1941 | 2017-01-01 07:39:04.916 plugin-container[1942:16156] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:39:14 INFO - PROCESS | 1941 | RSS: Main: 231825408 07:39:14 INFO - PROCESS | 1941 | 07:40:04 INFO - PROCESS | 1941 | 1483285204145 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:42:17 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49482/tests/dromaeo/cssquery-ext.html) 07:42:19 INFO - PROCESS | 1941 | RSS: Main: 254074880 07:42:19 INFO - PROCESS | 1941 | 07:44:02 INFO - PROCESS | 1941 | ************************* 07:44:02 INFO - PROCESS | 1941 | A coding exception was thrown and uncaught in a Task. 07:44:02 INFO - PROCESS | 1941 | 07:44:02 INFO - PROCESS | 1941 | Full message: ReferenceError: fetch is not defined 07:44:02 INFO - PROCESS | 1941 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:44:02 INFO - PROCESS | 1941 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:44:02 INFO - PROCESS | 1941 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:44:02 INFO - PROCESS | 1941 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:44:02 INFO - PROCESS | 1941 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:44:02 INFO - PROCESS | 1941 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:44:02 INFO - PROCESS | 1941 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:44:02 INFO - PROCESS | 1941 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:44:02 INFO - PROCESS | 1941 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:44:02 INFO - PROCESS | 1941 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:44:02 INFO - PROCESS | 1941 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:44:02 INFO - PROCESS | 1941 | 07:44:02 INFO - PROCESS | 1941 | ************************* 07:45:22 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-ext.html (next: http://localhost:49482/tests/dromaeo/cssquery-jquery.html) 07:45:22 INFO - PROCESS | 1941 | RSS: Main: 264544256 07:45:22 INFO - PROCESS | 1941 | 07:48:24 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49482/tests/dromaeo/cssquery-mootools.html) 07:48:25 INFO - PROCESS | 1941 | RSS: Main: 271900672 07:48:25 INFO - PROCESS | 1941 | 07:51:27 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49482/tests/dromaeo/cssquery-prototype.html) 07:51:27 INFO - PROCESS | 1941 | RSS: Main: 269524992 07:51:27 INFO - PROCESS | 1941 | 07:54:30 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49482/tests/dromaeo/cssquery-yui.html) 07:54:31 INFO - PROCESS | 1941 | RSS: Main: 274042880 07:54:31 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49482/tests/dromaeo/cssquery-yui.html (next: http://localhost:49482/tests/dromaeo/cssquery-dojo.html) 07:57:34 INFO - PROCESS | 1941 | RSS: Main: 276267008 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | __start_tp_report 07:57:34 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 07:57:34 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 07:57:34 INFO - PROCESS | 1941 | |i|pagename|runs| 07:57:34 INFO - PROCESS | 1941 | |0;dojo.html;2827.618271533344;3009.428208640358;3396.7452441066926;3422.4010798110326;3454.136465883529;5600.355959064709;5747.51146152577;5808.809194115207;5811.1283307503845;5855.707214639272;5641.351244606872;5686.232358631583;5741.052726300156;5753.993051216042;5778.739956701948;5217.243499692542;5266.710330931797;5274.472552744734;5292.550133238679;5302.655327403706;5203.739813009353;5304.655197412175;5308.389535203462;5310.575153987672;5321.760520776555;5291.497307755757;5305.363356397238;5342.706151161685;5361.892762144775;5420.430854760233;4237.025484138635;4566.406367172246;5099.648593122825;5214.45248248936;5276.9736151319385;5062.392512898439;5169.198774190007;5202.739863006872;5217.243499692523;5219.973900130513;4652.534746525354;5668.4614961579;5712.914306285409;5734.655920644733;5761;6218.129461875341;6223.968880155616;6228.252609686821;6235.812925612239;6247.562670613059;6118.95422233728;6200.131981522591;6207.844803879894;6225.190725205694;6232.906506402408;5851.61964472308;5862.12068189775;5870.5890587659305;5879.882402351972;5886.529077673776;6150.231221097363;6260.812175634738;6269.404406581368;6280.089387038854;6289.622622642656;5832.212651292106;5841.970790146022;5858.326292476335;6106.816795496142;6209.223847019122;5584.413636568183;6120.846978825565;6126.448619624255;6127.754889804358;6137.407629318989;5434.538064264502;5908.20239267702;6089.2997305310455;6130.141780150782;6238.532110091671;6109.435031337442;6128.747575574743;6138.235132557318;6188.319284878659;6231.096491008779;4923.630727695366;4939.5554400104165;4948.752562371867;4964.67729597575;4966.602671786249;3641.672249497558;4360.803763830635;4367.06108186735;4380.408644832971;4435.223835828717;5928.584999050111;5950.940490595125;5951.315598706205;5954;5989.970050149721;6218.751249950042;6233.438990490878;6242.250929888442;6262.1546091278005;6267.717952692049;5708.885822283614;5742.971285143631;5766.625169363978;5851.502622277069;5853.560982926298;5335.919961200585;5358.196270559447;5363.812266570651;5375.381831089475;5380.784768609212;6176.073588961692;6194.969025154845;6207.286162091327;6211.503079753699;6219.036049412348;6161.691915404302;6209.751609935552;6232.407921247474;6234.501239900887;6245.937540624535;6290.339514350927;6300.180976473029;6310.810675679737;6321.33625969285;6323.873522529431;6040.577159598786;6097.420745029215;6109.991851344478;6165.907511387422;6219.813405597839;6189.535784816067;6194.442500175006;6194.566380353332;6210.441060304594;6222.875542489034;6062.181605483203;6064.363241859542;6082.635041897501;6152.354002829638;6153.784617538365;6118.082287656887;6121.239585875234;6125.479643195438;6128.60984216165;6145.740123274807;5798.797042103506;5881.176635271151;6009.278886533644;6024.277086749618;6038.969805150946;6037.63774173551;6079;6115.235595550556;6144;6148.692565371803;5095.184770436712;5765.4522820332;5962.52299816005;5965.9105113422465;5971.731272092853 07:57:34 INFO - PROCESS | 1941 | |1;ext.html;430.58663682864454;440.4626355845867;444.16718652526515;466.2726147210352;496.3101289208;28698.713012869866;37974;38119.61880381195;38128.80935595325;38234.23531529368;38639;39136.41295380572;39192.80403597978;39224.60775392245;39224.80387598065;8351.83296334073;9061.048589898048;9308.115729005734;9310.487923164223;9327.20718738908;8467.195616416431;11085.889141108606;11311.547538098508;11314;11451.312921224753;11256.493457794379;11298.548058077708;11303.321800691943;11304.321740695543;11308.830367544453;11277.718057048598;11352.035077018463;11359.602413915514;11361.204715669906;11402;11139.443027848656;11214.66356009321;11216.831747523795;11242;11256.606018789304;38186.618133818585;38291.042723931845;38433.61566384328;38433.80783096095;38441.61558384408;3933;3988.541317748438;3988.6210809973004;4017.35722284436;4021.2560676274984;29244;29640.110796676134;29855.25361865949;29984.700152998408;30350.54474182889;2855.1577284700857;3180.1731549796987;3254.1864533866533;3266.9346613067605;3313.1717070732316;425009;425629;428058;428423;428886.8555657233;54233.72883135559;54502;54601.45398546043;54669.72665136649;54772.72613636986;57293.85412291814;57736.71131644315;57925.8414831701;57967;58114.709426453446;15073.623159421102;15260.923695381452;15280.923595381952;15306.387744490095;15312.464063757938;10599.311044782064;10986.890131098588;11875.703107422383;11944.462499187384;12031.398430078461;15801.604959876095;17680.60493403835;19978.500537486387;20080.59838803216;20134.496637583885;8247.793805154919;8271.669133234604;8286.58567071644;8365.790855228546;8391.790205244795;669.8024082895557;836.8702851058096;845.6321500147333;867.2758246863939;872.1714371347118;28769.71230287712;28842.711572884422;29292.267693307836;29480.705192947797;29555.556666650016;1001.484235618657;1014.7463134216446;1032.9690109296732;1040.38617215843;1154.6362895687832;14538.418463261563;14889.70220595582;15003.574660407245;15042.02226855251;15502.612434689223;634506;636763;637422;638398;639736;55330.72334638301;55474;55679.721601391735;55796.72101639466;55950;1335.545914389093;1366.1188533396103;1392.3803907261172;1393.2337214531967;1393.540131756518;25791;28507.857460712563;28672.713272867004;29139.854300728362;29147;46119.538804611526;46506;46660.53339466562;46711.76644116758;46863;559856;560774;561810;562449;562598;24119.51760964806;24609;30571.694283056884;31276.687233128287;37496.437553436175;38796.80601596974;40145.39781903215;40304.3954340691;42250.15499690051;42993.355099674154;34056.65943340535;34179.14552136217;34769.65230347664;34812.30375392427;35088.29823403569;33559;33875.66124338725;34405;34674.826625866706;34826.303473930886;32151.67848321487;32904.34191316208;33117;33223.83388083141;33303.83348083244;24259;26034.869825650752;26624.866875666274;30121.849390752905;30370.392592148477;22595.322140335815;22824.77175228293;22993.052587637674;22995.0908345585;23443.882780585987 07:57:34 INFO - PROCESS | 1941 | |2;jquery.html;314.3210664963678;358.3281347473487;359.7194188532944;364.0407526168545;388.61915322983475;18177.81822181778;18500.16749246284;18740.625187496258;19701.50746231345;20042;16565.337386504525;18728.531786705338;19430;19571;19583.510412239666;5188.71462069587;5420.5934554908345;5427.701476418795;5431.972840135793;5443.374011988632;5078.923816142761;5314.7608357624;5361.5978801589845;5362.249285100089;5363.436839131893;5327.760250788704;5348.812791552296;5366.973165134169;5370.812021579245;5377.623566350357;5233.319668443116;5861.824145275648;5896.204012458306;5932.822015339547;5945.851353716149;5013.849584512471;5231.189165679326;5240.711760853152;5247.239150323182;5249.527542521191;12959;13142.145760525631;13234.205947643171;13239.801402978866;13244.337783110903;2798.3423895384567;2968.154076088326;2970.910872673823;2972.063799903045;2979.121159258024;9536.189423898908;10290.125339346165;10976.957189067025;12348;15445;1787.356551641408;1788.5975655477414;1825.5071130794745;1849.426677729908;1858.3402891973426;98587;116713;120228.39885800515;120853;122733.77266227313;9321.44071355721;11267.718307042389;11317.49071291794;11489.425528723697;11641.243319184396;14019.859801402059;14106.506272280421;14217.644558885904;14238.145711257357;14257.714845703027;6992.510524263253;7938.126806051329;8110.878336824952;8148.633311500878;8316.792080197922;7234.891476627855;7409.777386731237;7878.409119316074;7959;7959.442839001214;4089.3661482470266;4228.4080228768;4477.238869392211;4492.977535112369;4523.705959112647;1614.5317857821335;1916.7124931260144;1924.8171423715005;1928.1104517572858;1938.2053358123103;817.9489356177284;920.8351435434181;964.2382517810851;994.5126887824914;1018.7962407518526;19997.400077997685;20447.8977605114;20513.48716282075;20615.381538553567;20711;974.3325821812082;981.9656312029044;1006.1950439648252;1015.0813513769903;1019.576875596634;10569.260151789302;10793.244472886823;10827.971342722429;10831.566737330577;10880.945595271973;432371.5721320913;434610;547350;551970;553300.969417604;104794;118009;125114.37442812728;134448.3277583606;136929;838.7190291252376;988.4365911430559;996.8255555277798;998.6005597760953;999.4453078541479;18714.625707486048;19175.137118829964;19275.903620481808;19436.90281548583;19465.902670487125;48851;48943.28698495535;49774.00451991012;50173.745656358886;50793.96824126993;73669;74248;74958.62520687362;75383;76053;6911.93088069133;7990.880136798069;8018.879716804136;8153.673853046049;8171.509709417454;10826.89173108259;12474.501019959464;12611.81082283748;12638.684032899251;12854.871451285368;9425.57584908667;10929.781404372026;11293;11350.148738844784;11422.657320280405;9236.353455258068;10916.890831091587;10940.179486538382;10956.56173753041;11276;10410.271281010257;11055.281406708538;11396.430178491208;11444.542218311175;11609.129315301556;7889.092754333095;7910.920890791249;8084.676612935416;8306.584670766559;8313.958430208053;8184.631691574013;10004.149647279772;10900.618478353219;11241.325520468798;11330.773384532427 07:57:34 INFO - PROCESS | 1941 | |3;mootools.html;1370.6230786533702;1380.7790753479446;1395.7069015506743;1395.9232242226676;1408.4295860176626;7166;7426.183119856812;7728.188540203282;8434.620442080106;8445.324374050077;7899.881501777478;8171.632276547555;8183.631736571853;8339.457935234206;8350.91649083509;2118.756343020557;2145.367116700569;2246.1240116354593;2286.9885650571723;2301.5166814968875;2055.239561362298;2137.2092325839385;2299.183789754638;2339.7660233976635;2346.4603141277516;2188.7592364839857;2265.1958554713087;2269.8978545965388;2286.3483907086484;2288.7367952685404;2288.9198878039274;2300.551392478476;2311.167979527369;2311.90752369905;2321.93034208974;2286.965695514569;2303.8617682939075;2334.8599084055013;2341.1337805012085;2345.460544074855;6765.966170169167;7663.5785031823225;8337.583120843934;8340.833183336299;8391.11893251206;4175.874723758292;4335.761533115678;4455.309427038814;4603;5057.797688092472;3288.8610145010275;3400.8129552874584;3439.5872495300723;3476.2526056897636;3518.1204698825295;1058.3861360410942;1108.3460758152728;1154.6940060883871;1193.1230545549015;1246.6322434881731;9112.681056163003;10606.9469652652;10742.78514429707;10750.462476876124;10789.759177694508;3817.1983883384246;4402.977985110054;4521.61566266871;4616.1229366420275;4628.421447319085;8624.439411438236;9323.533823308808;9325.393849399767;9365.250779937589;9366.157045865904;5099.745012749348;5165.354330708661;5183;5183.740812959337;5200.739963001834;4653.953460465352;4670.136024835417;4697.577218050392;4718.150732868048;4729.4797572267025;3698.130939229279;3732.4774531565604;3758.361078616642;3811.5045044144085;3819.961800382016;1057.6562617149457;1133.5182547417314;1169.7134202120535;1194.2237545595433;1236.863944966071;820.8030072782609;835.1898658301438;853.117023880281;881.4402854187637;882.7704796752762;5135.871603209875;5250.159974404077;5393.892122157535;5413.621046526784;5537.501624853702;855.8844555984987;868.7046404222468;873.7073080518097;914.2411798207472;919.4483310013939;3182.7294679952;3607.8737244196327;3669.94495082574;3710.22085362077;3717.683996860297;7750.379969602418;9227.90772092284;9883.555240014073;9891.950540247397;9896.950515247521;9495.38280011797;9777.951110244403;9779.755506112262;9784.168345690554;9829;6515.576487528296;7518.887216691754;7684.462087653922;7730.265624765639;7802.804929876685;5332.893342133213;5435.374931882884;5437.157240627709;5485.369182544058;5598.748056337556;9214.078592140731;9301.906980930104;9309.534523273946;9342.719718408458;9352.392094513834;9185.173334399937;9252.722418327461;9310.95344523273;9428.717138485856;9430.952845236005;7042.154941407064;7135.393491553276;7154.141503019671;7179.712811487482;7184.137903451619;6496.577722448026;6526.641034743135;7602.087749469878;7688.038995125609;7718.073831140299;6941.826454338682;6955.478339124687;7041.155061392666;7065.328793764585;7182.820429489305;6810.455163586802;6862.451003919575;6876;7008.789736307919;7019.859602808017;6137.877242455215;6300.621962682254;6312.053192021233;6312.7159277833525;6341.048842673636;4659.836905708284;4720.268358404453;4727.739974301309;4762.428508578854;4845.370101886732;4607.331936869202;4653.930191047205;4751.904961900812;4826;4902.852914412573 07:57:34 INFO - PROCESS | 1941 | |4;prototype.html;301.8128760168695;334.11459631975276;337.6050021474874;351.3166890398175;360.22371788795147;4891.682040667354;5177.792888284464;5292.576593872491;5386.973065134674;5423.620346575736;4215.28340182169;4318.330658747891;5241.689577605599;5288.202011316152;5319.5478384337375;3163.462211424058;3815.751976121557;3967.841286348543;4180.895477613054;4210.3894935234375;3652.652997965189;4045.231406032859;4181.975416023079;4210.736778966298;4255.5318914919335;4116.876493705194;4119.146384127155;4128;4160.4383408239955;4187.853425130121;3593.4070878305047;4118.279301122321;4128.566500517432;4133.607307305816;4164.9583504164875;3249.3338865532746;3585.354636165489;3704.1850792825803;3713.442983552489;3720.274546463441;4180.623743863037;4311.956880431187;5099.209622508517;5154.329937108189;5258.842234732964;4793.7363445010515;4794.7842347094465;4795.952040479586;4804.903901921942;4836.637252206098;5109.41241757199;5518;5589.832305030855;5600;5650.6892120933335;3193.6007999000126;3884.31032500863;3995.720299579031;4056.2293164298985;4086.9182616347803;5335.253064570963;5858.443447872445;5872.471477566996;5886.587938844283;5900.822975310747;3670.596234414212;3783.451399547105;4128.298189307825;4139.606737359946;4170.769622961234;3483.3729928613093;3716.535433070866;4038.576853887644;4080.897977550585;4227.7463352198965;3965.6827453803626;4512.954870451319;4517.480489743722;4759.762911431621;4762.547557981986;4959.68568329393;5542.8337149885565;5606.523445507096;5619.157126431068;5632.5502852746695;1130.6438471881331;1185.057878986208;1300.74635446089;1319.973600527984;1338.4579245405625;937.5124935033881;969.3263182088522;971.3734641156415;976.3751199232497;978.9510524473748;4369.650427965755;4662.6269898408045;4952.331435256267;5070.504201260637;5171.4311425743135;4750.168720473903;4816.8073277069225;5471.23402723619;5502.642328248731;5534.778608855681;4886.413630364379;4951.45000324833;4999.875003124878;5000.374953130859;5075.335448889363;2571.8071144664227;2740.5204089284293;2842.834437880459;2922.547005214195;2990.775691823122;5263.947210557903;5715.742791574306;5736.713164341766;5828.6794226317115;5850.3564607893095;4721.811127554859;4801.863170888991;5071.594272458195;5327.244292773586;5379.718371793203;4860.281884358468;5245.318108645928;5422.5119739223655;5808.605934575671;5849.795257165979;4577.6795624307315;5277;5486.600916766199;5639.954424610664;5668.291463567054;4710.6231501479115;4962.798994648359;5299.89224244462;5516.9448305516435;5547.306586676666;4572.862814115582;5207.401148867777;5762.5389968801555;5792.2230989741265;5801.071828507418;3290.9521288814412;3579.1231148368815;3681.9079523012138;3684.465752465931;3718.5165928429133;5352.00987817255;5468.62114979985;5515.352630737349;5777.7977770777825;5811.76752929895;5024.899502009866;5502.202180683858;5519.641223320471;5682.374938756816;5684.431556844283;5493.956148331804;5559.6664200148125;5632.774689012557;5651.547876169979;5670.149477578396;4834.830780922651;4950.490100519376;5509.834704958857;5597.80407685729;5707.343655479507;4904.8773780655765;5132.230165475208;5258.50044245796;5306.257124002565;5619.297587801525;4505.670827105946;4979.875503112451;5438.510534051954;5479.958807826501;5490.725463726878 07:57:34 INFO - PROCESS | 1941 | |5;yui.html;647.9773207937723;688.5593220338981;746.0189850346793;796.4225936196257;801.5711594297051;12007.819882701755;12841.65162657919;14138.929305353471;14705.264736763173;15111.848881511181;14014.789778153336;14077.648058798535;14174.362153703083;14191.077579957295;14203.360848761804;661.7187695229533;685.2804555217027;798.7643645124673;809.6032943857512;839.3914412051275;846.2257034813139;849.1678155407704;850.2432834777053;850.9021462531795;851.7359618518279;878.7275944457207;903.8779764731743;910.886139232596;912.3567884641312;912.5893347993397;890.1587999340626;903.5211337990876;904.1275169461468;904.4754042655244;905.7645012296784;662.5858838226109;666.7233098264214;667.4693618573245;668.1114118222752;668.9732410703566;14725.895557833206;14761.77857332141;14942.775858362133;14992;15146.924265378713;14114;14413.71172576553;14427.422903083863;14447.422103115969;14521.636959076002;11689;11713.94143029288;11776.470058847286;11781;11854.525818967231;3666.5233519642543;3684.889453316405;3717.089313118276;3723.1064544509395;3783.129880127586;73175;80813.19186808175;102730.94538109197;105733;106407;9788.804223915482;10998.06516446111;11026.724331891606;11028.613998510014;11176.720581985353;22791.772082278963;22800.771992280195;22803.657945130835;22876.542469150525;22879.88560057189;7495.250474952461;7743.186965368555;7754.883676744853;7817.687292508236;7983.481073730189;4158.189153115174;4236.491621005499;4269.380939763779;4329.285667864767;4391.890202744893;3520.5423294972;3623.3659109655705;3630.2920930418845;3633.800140992218;3684.447332900033;604.8911195984765;696.2863065358049;702.6311186627062;709.9503034787515;720.2149656873928;562.5836880708329;586.3052283044606;604.0727483313093;605.9550757443792;627.5575719118011;9125.087491250822;9194.310426718022;9233.953830230806;9292.674756383629;9409.294302927308;603.9637621742621;623.5759683415321;625.0717684238901;638.7572722365471;657.1063353838775;4348.978255108705;4562.24722920721;4633.443986721615;4715.599174070242;4859.416869975626;103431.4828425853;107964;108518;108553;110772;67855.32144678589;92587;93020.06979930114;93565.5321723387;96803;64961.67519162469;65142.67428662921;66216.33783662198;70141.64929175322;84022;9727.36772109839;9732.659356922757;9869.161121304482;10002.549885255326;10009.949950250202;49318.26022609736;50268.49731502638;50556.94430556915;50966.74516627393;52260;66699.99800012015;66766.66616666886;68101;68739;69410.30589694038;10789.86706395817;11951.641450756491;12513.124081314585;12515.687107822378;12718.173318734252;12897.226166430044;13258.86741132615;13595.932020339835;13745;13947.860521394656;13183.67040823987;13345.599632011055;13348.265845378597;13447.348938432397;13603.047786654839;13554.322283885569;13573;13589.52436664712;13779;14004.649883752987;12954.676133096747;12977;13136;13674.974376921571;13895.513657021957;10311.639092631722;10507.737306567396;10850.240483166102;11233.550657973916;11301.039411650101;10275.211127670143;10837.458127093456;10843.728906777078;10903.34579925207;10911.807925082876 07:57:34 INFO - PROCESS | 1941 | __end_tp_report 07:57:34 INFO - PROCESS | 1941 | __start_cc_report 07:57:34 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,372 07:57:34 INFO - PROCESS | 1941 | __end_cc_report 07:57:34 INFO - PROCESS | 1941 | __startTimestamp1483286254864__endTimestamp 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | ------- Summary: start ------- 07:57:34 INFO - PROCESS | 1941 | Number of tests: 6 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5710.79 Median:5951.32 stddev:672.32 (11.3%) stddev-sans-first:635.20 07:57:34 INFO - PROCESS | 1941 | Values: 2827.6 3009.4 3396.7 3422.4 3454.1 5600.4 5747.5 5808.8 5811.1 5855.7 5641.4 5686.2 5741.1 5754.0 5778.7 5217.2 5266.7 5274.5 5292.6 5302.7 5203.7 5304.7 5308.4 5310.6 5321.8 5291.5 5305.4 5342.7 5361.9 5420.4 4237.0 4566.4 5099.6 5214.5 5277.0 5062.4 5169.2 5202.7 5217.2 5220.0 4652.5 5668.5 5712.9 5734.7 5761.0 6218.1 6224.0 6228.3 6235.8 6247.6 6119.0 6200.1 6207.8 6225.2 6232.9 5851.6 5862.1 5870.6 5879.9 5886.5 6150.2 6260.8 6269.4 6280.1 6289.6 5832.2 5842.0 5858.3 6106.8 6209.2 5584.4 6120.8 6126.4 6127.8 6137.4 5434.5 5908.2 6089.3 6130.1 6238.5 6109.4 6128.7 6138.2 6188.3 6231.1 4923.6 4939.6 4948.8 4964.7 4966.6 3641.7 4360.8 4367.1 4380.4 4435.2 5928.6 5950.9 5951.3 5954.0 5990.0 6218.8 6233.4 6242.3 6262.2 6267.7 5708.9 5743.0 5766.6 5851.5 5853.6 5335.9 5358.2 5363.8 5375.4 5380.8 6176.1 6195.0 6207.3 6211.5 6219.0 6161.7 6209.8 6232.4 6234.5 6245.9 6290.3 6300.2 6310.8 6321.3 6323.9 6040.6 6097.4 6110.0 6165.9 6219.8 6189.5 6194.4 6194.6 6210.4 6222.9 6062.2 6064.4 6082.6 6152.4 6153.8 6118.1 6121.2 6125.5 6128.6 6145.7 5798.8 5881.2 6009.3 6024.3 6039.0 6037.6 6079.0 6115.2 6144.0 6148.7 5095.2 5765.5 5962.5 5965.9 5971.7 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:66600.66 Median:33966.16 stddev:146822.23 (432.3%) stddev-sans-first:147150.05 07:57:34 INFO - PROCESS | 1941 | Values: 430.6 440.5 444.2 466.3 496.3 28698.7 37974.0 38119.6 38128.8 38234.2 38639.0 39136.4 39192.8 39224.6 39224.8 8351.8 9061.0 9308.1 9310.5 9327.2 8467.2 11085.9 11311.5 11314.0 11451.3 11256.5 11298.5 11303.3 11304.3 11308.8 11277.7 11352.0 11359.6 11361.2 11402.0 11139.4 11214.7 11216.8 11242.0 11256.6 38186.6 38291.0 38433.6 38433.8 38441.6 3933.0 3988.5 3988.6 4017.4 4021.3 29244.0 29640.1 29855.3 29984.7 30350.5 2855.2 3180.2 3254.2 3266.9 3313.2 425009.0 425629.0 428058.0 428423.0 428886.9 54233.7 54502.0 54601.5 54669.7 54772.7 57293.9 57736.7 57925.8 57967.0 58114.7 15073.6 15260.9 15280.9 15306.4 15312.5 10599.3 10986.9 11875.7 11944.5 12031.4 15801.6 17680.6 19978.5 20080.6 20134.5 8247.8 8271.7 8286.6 8365.8 8391.8 669.8 836.9 845.6 867.3 872.2 28769.7 28842.7 29292.3 29480.7 29555.6 1001.5 1014.7 1033.0 1040.4 1154.6 14538.4 14889.7 15003.6 15042.0 15502.6 634506.0 636763.0 637422.0 638398.0 639736.0 55330.7 55474.0 55679.7 55796.7 55950.0 1335.5 1366.1 1392.4 1393.2 1393.5 25791.0 28507.9 28672.7 29139.9 29147.0 46119.5 46506.0 46660.5 46711.8 46863.0 559856.0 560774.0 561810.0 562449.0 562598.0 24119.5 24609.0 30571.7 31276.7 37496.4 38796.8 40145.4 40304.4 42250.2 42993.4 34056.7 34179.1 34769.7 34812.3 35088.3 33559.0 33875.7 34405.0 34674.8 34826.3 32151.7 32904.3 33117.0 33223.8 33303.8 24259.0 26034.9 26624.9 30121.8 30370.4 22595.3 22824.8 22993.1 22995.1 23443.9 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:31517.62 Median:2971.49 stddev:85522.12 (2878.1%) stddev-sans-first:85729.94 07:57:34 INFO - PROCESS | 1941 | Values: 314.3 358.3 359.7 364.0 388.6 18177.8 18500.2 18740.6 19701.5 20042.0 16565.3 18728.5 19430.0 19571.0 19583.5 5188.7 5420.6 5427.7 5432.0 5443.4 5078.9 5314.8 5361.6 5362.2 5363.4 5327.8 5348.8 5367.0 5370.8 5377.6 5233.3 5861.8 5896.2 5932.8 5945.9 5013.8 5231.2 5240.7 5247.2 5249.5 12959.0 13142.1 13234.2 13239.8 13244.3 2798.3 2968.2 2970.9 2972.1 2979.1 9536.2 10290.1 10977.0 12348.0 15445.0 1787.4 1788.6 1825.5 1849.4 1858.3 98587.0 116713.0 120228.4 120853.0 122733.8 9321.4 11267.7 11317.5 11489.4 11641.2 14019.9 14106.5 14217.6 14238.1 14257.7 6992.5 7938.1 8110.9 8148.6 8316.8 7234.9 7409.8 7878.4 7959.0 7959.4 4089.4 4228.4 4477.2 4493.0 4523.7 1614.5 1916.7 1924.8 1928.1 1938.2 817.9 920.8 964.2 994.5 1018.8 19997.4 20447.9 20513.5 20615.4 20711.0 974.3 982.0 1006.2 1015.1 1019.6 10569.3 10793.2 10828.0 10831.6 10880.9 432371.6 434610.0 547350.0 551970.0 553301.0 104794.0 118009.0 125114.4 134448.3 136929.0 838.7 988.4 996.8 998.6 999.4 18714.6 19175.1 19275.9 19436.9 19465.9 48851.0 48943.3 49774.0 50173.7 50794.0 73669.0 74248.0 74958.6 75383.0 76053.0 6911.9 7990.9 8018.9 8153.7 8171.5 10826.9 12474.5 12611.8 12638.7 12854.9 9425.6 10929.8 11293.0 11350.1 11422.7 9236.4 10916.9 10940.2 10956.6 11276.0 10410.3 11055.3 11396.4 11444.5 11609.1 7889.1 7910.9 8084.7 8306.6 8314.0 8184.6 10004.1 10900.6 11241.3 11330.8 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5274.47 Median:5291.53 stddev:2885.15 (54.5%) stddev-sans-first:2878.32 07:57:34 INFO - PROCESS | 1941 | Values: 1370.6 1380.8 1395.7 1395.9 1408.4 7166.0 7426.2 7728.2 8434.6 8445.3 7899.9 8171.6 8183.6 8339.5 8350.9 2118.8 2145.4 2246.1 2287.0 2301.5 2055.2 2137.2 2299.2 2339.8 2346.5 2188.8 2265.2 2269.9 2286.3 2288.7 2288.9 2300.6 2311.2 2311.9 2321.9 2287.0 2303.9 2334.9 2341.1 2345.5 6766.0 7663.6 8337.6 8340.8 8391.1 4175.9 4335.8 4455.3 4603.0 5057.8 3288.9 3400.8 3439.6 3476.3 3518.1 1058.4 1108.3 1154.7 1193.1 1246.6 9112.7 10606.9 10742.8 10750.5 10789.8 3817.2 4403.0 4521.6 4616.1 4628.4 8624.4 9323.5 9325.4 9365.3 9366.2 5099.7 5165.4 5183.0 5183.7 5200.7 4654.0 4670.1 4697.6 4718.2 4729.5 3698.1 3732.5 3758.4 3811.5 3820.0 1057.7 1133.5 1169.7 1194.2 1236.9 820.8 835.2 853.1 881.4 882.8 5135.9 5250.2 5393.9 5413.6 5537.5 855.9 868.7 873.7 914.2 919.4 3182.7 3607.9 3669.9 3710.2 3717.7 7750.4 9227.9 9883.6 9892.0 9897.0 9495.4 9778.0 9779.8 9784.2 9829.0 6515.6 7518.9 7684.5 7730.3 7802.8 5332.9 5435.4 5437.2 5485.4 5598.7 9214.1 9301.9 9309.5 9342.7 9352.4 9185.2 9252.7 9311.0 9428.7 9431.0 7042.2 7135.4 7154.1 7179.7 7184.1 6496.6 6526.6 7602.1 7688.0 7718.1 6941.8 6955.5 7041.2 7065.3 7182.8 6810.5 6862.5 6876.0 7008.8 7019.9 6137.9 6300.6 6312.1 6312.7 6341.0 4659.8 4720.3 4727.7 4762.4 4845.4 4607.3 4653.9 4751.9 4826.0 4902.9 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4470.86 Median:4951.89 stddev:1341.47 (27.1%) stddev-sans-first:1308.23 07:57:34 INFO - PROCESS | 1941 | Values: 301.8 334.1 337.6 351.3 360.2 4891.7 5177.8 5292.6 5387.0 5423.6 4215.3 4318.3 5241.7 5288.2 5319.5 3163.5 3815.8 3967.8 4180.9 4210.4 3652.7 4045.2 4182.0 4210.7 4255.5 4116.9 4119.1 4128.0 4160.4 4187.9 3593.4 4118.3 4128.6 4133.6 4165.0 3249.3 3585.4 3704.2 3713.4 3720.3 4180.6 4312.0 5099.2 5154.3 5258.8 4793.7 4794.8 4796.0 4804.9 4836.6 5109.4 5518.0 5589.8 5600.0 5650.7 3193.6 3884.3 3995.7 4056.2 4086.9 5335.3 5858.4 5872.5 5886.6 5900.8 3670.6 3783.5 4128.3 4139.6 4170.8 3483.4 3716.5 4038.6 4080.9 4227.7 3965.7 4513.0 4517.5 4759.8 4762.5 4959.7 5542.8 5606.5 5619.2 5632.6 1130.6 1185.1 1300.7 1320.0 1338.5 937.5 969.3 971.4 976.4 979.0 4369.7 4662.6 4952.3 5070.5 5171.4 4750.2 4816.8 5471.2 5502.6 5534.8 4886.4 4951.5 4999.9 5000.4 5075.3 2571.8 2740.5 2842.8 2922.5 2990.8 5263.9 5715.7 5736.7 5828.7 5850.4 4721.8 4801.9 5071.6 5327.2 5379.7 4860.3 5245.3 5422.5 5808.6 5849.8 4577.7 5277.0 5486.6 5640.0 5668.3 4710.6 4962.8 5299.9 5516.9 5547.3 4572.9 5207.4 5762.5 5792.2 5801.1 3291.0 3579.1 3681.9 3684.5 3718.5 5352.0 5468.6 5515.4 5777.8 5811.8 5024.9 5502.2 5519.6 5682.4 5684.4 5494.0 5559.7 5632.8 5651.5 5670.1 4834.8 4950.5 5509.8 5597.8 5707.3 4904.9 5132.2 5258.5 5306.3 5619.3 4505.7 4979.9 5438.5 5480.0 5490.7 07:57:34 INFO - PROCESS | 1941 | 07:57:34 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:19975.77 Median:4252.94 stddev:28667.39 (674.1%) stddev-sans-first:28711.08 07:57:34 INFO - PROCESS | 1941 | Values: 648.0 688.6 746.0 796.4 801.6 12007.8 12841.7 14138.9 14705.3 15111.8 14014.8 14077.6 14174.4 14191.1 14203.4 661.7 685.3 798.8 809.6 839.4 846.2 849.2 850.2 850.9 851.7 878.7 903.9 910.9 912.4 912.6 890.2 903.5 904.1 904.5 905.8 662.6 666.7 667.5 668.1 669.0 14725.9 14761.8 14942.8 14992.0 15146.9 14114.0 14413.7 14427.4 14447.4 14521.6 11689.0 11713.9 11776.5 11781.0 11854.5 3666.5 3684.9 3717.1 3723.1 3783.1 73175.0 80813.2 102730.9 105733.0 106407.0 9788.8 10998.1 11026.7 11028.6 11176.7 22791.8 22800.8 22803.7 22876.5 22879.9 7495.3 7743.2 7754.9 7817.7 7983.5 4158.2 4236.5 4269.4 4329.3 4391.9 3520.5 3623.4 3630.3 3633.8 3684.4 604.9 696.3 702.6 710.0 720.2 562.6 586.3 604.1 606.0 627.6 9125.1 9194.3 9234.0 9292.7 9409.3 604.0 623.6 625.1 638.8 657.1 4349.0 4562.2 4633.4 4715.6 4859.4 103431.5 107964.0 108518.0 108553.0 110772.0 67855.3 92587.0 93020.1 93565.5 96803.0 64961.7 65142.7 66216.3 70141.6 84022.0 9727.4 9732.7 9869.2 10002.5 10009.9 49318.3 50268.5 50556.9 50966.7 52260.0 66700.0 66766.7 68101.0 68739.0 69410.3 10789.9 11951.6 12513.1 12515.7 12718.2 12897.2 13258.9 13595.9 13745.0 13947.9 13183.7 13345.6 13348.3 13447.3 13603.0 13554.3 13573.0 13589.5 13779.0 14004.6 12954.7 12977.0 13136.0 13675.0 13895.5 10311.6 10507.7 10850.2 11233.6 11301.0 10275.2 10837.5 10843.7 10903.3 10911.8 07:57:34 INFO - PROCESS | 1941 | -------- Summary: end -------- 07:57:34 INFO - PROCESS | 1941 | 07:57:35 INFO - TEST-INFO | 1941: exit 0 07:57:35 INFO - TEST-OK | dromaeo_css | took 1117055ms 07:57:35 INFO - TEST-START | kraken 07:57:35 INFO - operating with platform_type : mac_ 07:57:35 INFO - Initialising browser for kraken test... 07:57:35 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpWO6CVc/profile http://localhost:49482/getInfo.html) 07:57:36 INFO - PROCESS | 1945 | 1483286256143 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:57:38 INFO - PROCESS | 1945 | 2017-01-01 07:57:38.378 plugin-container[1946:18169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 07:57:38 INFO - PROCESS | 1945 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:38 INFO - PROCESS | 1945 | 2017-01-01 07:57:38.381 plugin-container[1946:18169] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4807, name = 'com.apple.CFPasteboardClient' 07:57:38 INFO - PROCESS | 1945 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:38 INFO - PROCESS | 1945 | 2017-01-01 07:57:38.381 plugin-container[1946:18169] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:38 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 07:57:38 INFO - PROCESS | 1945 | colorDepth:24 07:57:38 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 07:57:38 INFO - PROCESS | 1945 | __metrics 07:57:38 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:57:39 INFO - TEST-INFO | 1945: exit 0 07:57:39 INFO - Browser initialized. 07:57:39 INFO - Running cycle 1/1 for kraken test... 07:57:39 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpWO6CVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:41 INFO - PROCESS | 1947 | 2017-01-01 07:57:41.728 plugin-container[1948:18285] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:57:41 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:41 INFO - PROCESS | 1947 | 2017-01-01 07:57:41.728 plugin-container[1948:18285] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:57:41 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:41 INFO - PROCESS | 1947 | 2017-01-01 07:57:41.728 plugin-container[1948:18285] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:51 INFO - PROCESS | 1947 | RSS: Main: 232075264 07:57:51 INFO - PROCESS | 1947 | 07:57:54 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:55 INFO - PROCESS | 1947 | RSS: Main: 245014528 07:57:55 INFO - PROCESS | 1947 | 07:57:58 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-dft) 07:57:58 INFO - PROCESS | 1947 | RSS: Main: 252903424 07:57:58 INFO - PROCESS | 1947 | 07:58:02 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-fft) 07:58:02 INFO - PROCESS | 1947 | RSS: Main: 255541248 07:58:02 INFO - PROCESS | 1947 | 07:58:04 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49482/tests/kraken/driver.html?testName=audio-oscillator) 07:58:05 INFO - PROCESS | 1947 | RSS: Main: 257736704 07:58:05 INFO - PROCESS | 1947 | 07:58:07 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:08 INFO - PROCESS | 1947 | RSS: Main: 258371584 07:58:08 INFO - PROCESS | 1947 | 07:58:11 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:11 INFO - PROCESS | 1947 | RSS: Main: 263745536 07:58:11 INFO - PROCESS | 1947 | 07:58:15 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49482/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:15 INFO - PROCESS | 1947 | RSS: Main: 262541312 07:58:15 INFO - PROCESS | 1947 | 07:58:18 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49482/tests/kraken/driver.html?testName=json-parse-financial) 07:58:19 INFO - PROCESS | 1947 | RSS: Main: 262594560 07:58:19 INFO - PROCESS | 1947 | 07:58:21 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:21 INFO - PROCESS | 1947 | RSS: Main: 262217728 07:58:21 INFO - PROCESS | 1947 | 07:58:23 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:24 INFO - PROCESS | 1947 | RSS: Main: 262221824 07:58:24 INFO - PROCESS | 1947 | 07:58:26 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:27 INFO - PROCESS | 1947 | RSS: Main: 262311936 07:58:27 INFO - PROCESS | 1947 | 07:58:30 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:31 INFO - PROCESS | 1947 | RSS: Main: 262651904 07:58:31 INFO - PROCESS | 1947 | 07:58:34 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:34 INFO - PROCESS | 1947 | RSS: Main: 262701056 07:58:34 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49482/tests/kraken/driver.html?testName=ai-astar) 07:58:36 INFO - PROCESS | 1947 | RSS: Main: 265576448 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | __start_tp_report 07:58:36 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 07:58:36 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 07:58:36 INFO - PROCESS | 1947 | |i|pagename|runs| 07:58:36 INFO - PROCESS | 1947 | |0;ai-astar;143;119;119;119;117;123;160;117;118;117 07:58:36 INFO - PROCESS | 1947 | |1;audio-beat-detection;145;119;144;156;112;113;118;115;133;119 07:58:36 INFO - PROCESS | 1947 | |2;audio-dft;197;206;224;202;198;239;275;239;239;272 07:58:36 INFO - PROCESS | 1947 | |3;audio-fft;84;58;59;86;60;61;63;76;71;82 07:58:36 INFO - PROCESS | 1947 | |4;audio-oscillator;89;70;84;70;71;74;109;99;99;97 07:58:36 INFO - PROCESS | 1947 | |5;imaging-gaussian-blur;91;128;94;96;134;89;92;96;115;88 07:58:36 INFO - PROCESS | 1947 | |6;imaging-darkroom;96;98;98;121;98;99;99;133;148;152 07:58:36 INFO - PROCESS | 1947 | |7;imaging-desaturate;105;92;104;85;140;151;89;146;126;93 07:58:36 INFO - PROCESS | 1947 | |8;json-parse-financial;63;63;62;63;64;63;63;63;63;63 07:58:36 INFO - PROCESS | 1947 | |9;json-stringify-tinderbox;69;74;70;80;107;97;97;75;73;72 07:58:36 INFO - PROCESS | 1947 | |10;stanford-crypto-aes;92;92;89;90;89;89;117;108;108;108 07:58:36 INFO - PROCESS | 1947 | |11;stanford-crypto-ccm;143;144;154;152;151;161;156;146;186;197 07:58:36 INFO - PROCESS | 1947 | |12;stanford-crypto-pbkdf2;176;176;179;213;175;173;175;173;187;239 07:58:36 INFO - PROCESS | 1947 | |13;stanford-crypto-sha256-iterative;69;69;71;67;79;81;88;85;86;80 07:58:36 INFO - PROCESS | 1947 | __end_tp_report 07:58:36 INFO - PROCESS | 1947 | __start_cc_report 07:58:36 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,930 07:58:36 INFO - PROCESS | 1947 | __end_cc_report 07:58:36 INFO - PROCESS | 1947 | __startTimestamp1483286316939__endTimestamp 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | ------- Summary: start ------- 07:58:36 INFO - PROCESS | 1947 | Number of tests: 14 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#0] ai-astar Cycles:10 Average:125.20 Median:119.00 stddev:14.54 (12.2%) stddev-sans-first:13.92 07:58:36 INFO - PROCESS | 1947 | Values: 143.0 119.0 119.0 119.0 117.0 123.0 160.0 117.0 118.0 117.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:126.00 stddev:15.85 (12.6%) stddev-sans-first:15.48 07:58:36 INFO - PROCESS | 1947 | Values: 145.0 119.0 144.0 156.0 112.0 113.0 118.0 115.0 133.0 119.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#2] audio-dft Cycles:10 Average:229.10 Median:239.00 stddev:28.93 (12.1%) stddev-sans-first:28.26 07:58:36 INFO - PROCESS | 1947 | Values: 197.0 206.0 224.0 202.0 198.0 239.0 275.0 239.0 239.0 272.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#3] audio-fft Cycles:10 Average:70.00 Median:73.50 stddev:11.20 (15.2%) stddev-sans-first:10.67 07:58:36 INFO - PROCESS | 1947 | Values: 84.0 58.0 59.0 86.0 60.0 61.0 63.0 76.0 71.0 82.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:86.50 stddev:14.46 (16.7%) stddev-sans-first:15.30 07:58:36 INFO - PROCESS | 1947 | Values: 89.0 70.0 84.0 70.0 71.0 74.0 109.0 99.0 99.0 97.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#5] imaging-gaussian-blur Cycles:10 Average:102.30 Median:91.50 stddev:16.96 (18.5%) stddev-sans-first:17.49 07:58:36 INFO - PROCESS | 1947 | Values: 91.0 128.0 94.0 96.0 134.0 89.0 92.0 96.0 115.0 88.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#6] imaging-darkroom Cycles:10 Average:114.20 Median:98.00 stddev:22.49 (22.9%) stddev-sans-first:22.87 07:58:36 INFO - PROCESS | 1947 | Values: 96.0 98.0 98.0 121.0 98.0 99.0 99.0 133.0 148.0 152.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:118.00 stddev:25.34 (21.5%) stddev-sans-first:26.70 07:58:36 INFO - PROCESS | 1947 | Values: 105.0 92.0 104.0 85.0 140.0 151.0 89.0 146.0 126.0 93.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 07:58:36 INFO - PROCESS | 1947 | Values: 63.0 63.0 62.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:74.50 stddev:13.67 (18.4%) stddev-sans-first:13.75 07:58:36 INFO - PROCESS | 1947 | Values: 69.0 74.0 70.0 80.0 107.0 97.0 97.0 75.0 73.0 72.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#10] stanford-crypto-aes Cycles:10 Average:98.20 Median:89.00 stddev:10.75 (12.1%) stddev-sans-first:11.16 07:58:36 INFO - PROCESS | 1947 | Values: 92.0 92.0 89.0 90.0 89.0 89.0 117.0 108.0 108.0 108.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:155.00 stddev:18.18 (11.7%) stddev-sans-first:18.34 07:58:36 INFO - PROCESS | 1947 | Values: 143.0 144.0 154.0 152.0 151.0 161.0 156.0 146.0 186.0 197.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:177.50 stddev:22.02 (12.4%) stddev-sans-first:23.02 07:58:36 INFO - PROCESS | 1947 | Values: 176.0 176.0 179.0 213.0 175.0 173.0 175.0 173.0 187.0 239.0 07:58:36 INFO - PROCESS | 1947 | 07:58:36 INFO - PROCESS | 1947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:80.50 stddev:7.86 (9.8%) stddev-sans-first:7.72 07:58:36 INFO - PROCESS | 1947 | Values: 69.0 69.0 71.0 67.0 79.0 81.0 88.0 85.0 86.0 80.0 07:58:36 INFO - PROCESS | 1947 | -------- Summary: end -------- 07:58:36 INFO - PROCESS | 1947 | 07:58:37 INFO - TEST-INFO | 1947: exit 0 07:58:37 INFO - TEST-OK | kraken | took 62172ms 07:58:37 INFO - SUITE-END | took 1179s 07:58:38 INFO - Completed test suite (00:19:39) 07:58:38 INFO - javascript benchmark 07:58:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7098.199773812307, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2827.618271533344, 3009.428208640358, 3396.7452441066926, 3422.4010798110326, 3454.136465883529, 5600.355959064709, 5747.51146152577, 5808.809194115207, 5811.1283307503845, 5855.707214639272, 5641.351244606872, 5686.232358631583, 5741.052726300156, 5753.993051216042, 5778.739956701948, 5217.243499692542, 5266.710330931797, 5274.472552744734, 5292.550133238679, 5302.655327403706, 5203.739813009353, 5304.655197412175, 5308.389535203462, 5310.575153987672, 5321.760520776555, 5291.497307755757, 5305.363356397238, 5342.706151161685, 5361.892762144775, 5420.430854760233, 4237.025484138635, 4566.406367172246, 5099.648593122825, 5214.45248248936, 5276.9736151319385, 5062.392512898439, 5169.198774190007, 5202.739863006872, 5217.243499692523, 5219.973900130513, 4652.534746525354, 5668.4614961579, 5712.914306285409, 5734.655920644733, 5761.0, 6218.129461875341, 6223.968880155616, 6228.252609686821, 6235.812925612239, 6247.562670613059, 6118.95422233728, 6200.131981522591, 6207.844803879894, 6225.190725205694, 6232.906506402408, 5851.61964472308, 5862.12068189775, 5870.5890587659305, 5879.882402351972, 5886.529077673776, 6150.231221097363, 6260.812175634738, 6269.404406581368, 6280.089387038854, 6289.622622642656, 5832.212651292106, 5841.970790146022, 5858.326292476335, 6106.816795496142, 6209.223847019122, 5584.413636568183, 6120.846978825565, 6126.448619624255, 6127.754889804358, 6137.407629318989, 5434.538064264502, 5908.20239267702, 6089.2997305310455, 6130.141780150782, 6238.532110091671, 6109.435031337442, 6128.747575574743, 6138.235132557318, 6188.319284878659, 6231.096491008779, 4923.630727695366, 4939.5554400104165, 4948.752562371867, 4964.67729597575, 4966.602671786249, 3641.672249497558, 4360.803763830635, 4367.06108186735, 4380.408644832971, 4435.223835828717, 5928.584999050111, 5950.940490595125, 5951.315598706205, 5954.0, 5989.970050149721, 6218.751249950042, 6233.438990490878, 6242.250929888442, 6262.1546091278005, 6267.717952692049, 5708.885822283614, 5742.971285143631, 5766.625169363978, 5851.502622277069, 5853.560982926298, 5335.919961200585, 5358.196270559447, 5363.812266570651, 5375.381831089475, 5380.784768609212, 6176.073588961692, 6194.969025154845, 6207.286162091327, 6211.503079753699, 6219.036049412348, 6161.691915404302, 6209.751609935552, 6232.407921247474, 6234.501239900887, 6245.937540624535, 6290.339514350927, 6300.180976473029, 6310.810675679737, 6321.33625969285, 6323.873522529431, 6040.577159598786, 6097.420745029215, 6109.991851344478, 6165.907511387422, 6219.813405597839, 6189.535784816067, 6194.442500175006, 6194.566380353332, 6210.441060304594, 6222.875542489034, 6062.181605483203, 6064.363241859542, 6082.635041897501, 6152.354002829638, 6153.784617538365, 6118.082287656887, 6121.239585875234, 6125.479643195438, 6128.60984216165, 6145.740123274807, 5798.797042103506, 5881.176635271151, 6009.278886533644, 6024.277086749618, 6038.969805150946, 6037.63774173551, 6079.0, 6115.235595550556, 6144.0, 6148.692565371803, 5095.184770436712, 5765.4522820332, 5962.52299816005, 5965.9105113422465, 5971.731272092853], "value": 5665.3576893522895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.58663682864454, 440.4626355845867, 444.16718652526515, 466.2726147210352, 496.3101289208, 28698.713012869866, 37974.0, 38119.61880381195, 38128.80935595325, 38234.23531529368, 38639.0, 39136.41295380572, 39192.80403597978, 39224.60775392245, 39224.80387598065, 8351.83296334073, 9061.048589898048, 9308.115729005734, 9310.487923164223, 9327.20718738908, 8467.195616416431, 11085.889141108606, 11311.547538098508, 11314.0, 11451.312921224753, 11256.493457794379, 11298.548058077708, 11303.321800691943, 11304.321740695543, 11308.830367544453, 11277.718057048598, 11352.035077018463, 11359.602413915514, 11361.204715669906, 11402.0, 11139.443027848656, 11214.66356009321, 11216.831747523795, 11242.0, 11256.606018789304, 38186.618133818585, 38291.042723931845, 38433.61566384328, 38433.80783096095, 38441.61558384408, 3933.0, 3988.541317748438, 3988.6210809973004, 4017.35722284436, 4021.2560676274984, 29244.0, 29640.110796676134, 29855.25361865949, 29984.700152998408, 30350.54474182889, 2855.1577284700857, 3180.1731549796987, 3254.1864533866533, 3266.9346613067605, 3313.1717070732316, 425009.0, 425629.0, 428058.0, 428423.0, 428886.8555657233, 54233.72883135559, 54502.0, 54601.45398546043, 54669.72665136649, 54772.72613636986, 57293.85412291814, 57736.71131644315, 57925.8414831701, 57967.0, 58114.709426453446, 15073.623159421102, 15260.923695381452, 15280.923595381952, 15306.387744490095, 15312.464063757938, 10599.311044782064, 10986.890131098588, 11875.703107422383, 11944.462499187384, 12031.398430078461, 15801.604959876095, 17680.60493403835, 19978.500537486387, 20080.59838803216, 20134.496637583885, 8247.793805154919, 8271.669133234604, 8286.58567071644, 8365.790855228546, 8391.790205244795, 669.8024082895557, 836.8702851058096, 845.6321500147333, 867.2758246863939, 872.1714371347118, 28769.71230287712, 28842.711572884422, 29292.267693307836, 29480.705192947797, 29555.556666650016, 1001.484235618657, 1014.7463134216446, 1032.9690109296732, 1040.38617215843, 1154.6362895687832, 14538.418463261563, 14889.70220595582, 15003.574660407245, 15042.02226855251, 15502.612434689223, 634506.0, 636763.0, 637422.0, 638398.0, 639736.0, 55330.72334638301, 55474.0, 55679.721601391735, 55796.72101639466, 55950.0, 1335.545914389093, 1366.1188533396103, 1392.3803907261172, 1393.2337214531967, 1393.540131756518, 25791.0, 28507.857460712563, 28672.713272867004, 29139.854300728362, 29147.0, 46119.538804611526, 46506.0, 46660.53339466562, 46711.76644116758, 46863.0, 559856.0, 560774.0, 561810.0, 562449.0, 562598.0, 24119.51760964806, 24609.0, 30571.694283056884, 31276.687233128287, 37496.437553436175, 38796.80601596974, 40145.39781903215, 40304.3954340691, 42250.15499690051, 42993.355099674154, 34056.65943340535, 34179.14552136217, 34769.65230347664, 34812.30375392427, 35088.29823403569, 33559.0, 33875.66124338725, 34405.0, 34674.826625866706, 34826.303473930886, 32151.67848321487, 32904.34191316208, 33117.0, 33223.83388083141, 33303.83348083244, 24259.0, 26034.869825650752, 26624.866875666274, 30121.849390752905, 30370.392592148477, 22595.322140335815, 22824.77175228293, 22993.052587637674, 22995.0908345585, 23443.882780585987], "value": 19312.788362905772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.3210664963678, 358.3281347473487, 359.7194188532944, 364.0407526168545, 388.61915322983475, 18177.81822181778, 18500.16749246284, 18740.625187496258, 19701.50746231345, 20042.0, 16565.337386504525, 18728.531786705338, 19430.0, 19571.0, 19583.510412239666, 5188.71462069587, 5420.5934554908345, 5427.701476418795, 5431.972840135793, 5443.374011988632, 5078.923816142761, 5314.7608357624, 5361.5978801589845, 5362.249285100089, 5363.436839131893, 5327.760250788704, 5348.812791552296, 5366.973165134169, 5370.812021579245, 5377.623566350357, 5233.319668443116, 5861.824145275648, 5896.204012458306, 5932.822015339547, 5945.851353716149, 5013.849584512471, 5231.189165679326, 5240.711760853152, 5247.239150323182, 5249.527542521191, 12959.0, 13142.145760525631, 13234.205947643171, 13239.801402978866, 13244.337783110903, 2798.3423895384567, 2968.154076088326, 2970.910872673823, 2972.063799903045, 2979.121159258024, 9536.189423898908, 10290.125339346165, 10976.957189067025, 12348.0, 15445.0, 1787.356551641408, 1788.5975655477414, 1825.5071130794745, 1849.426677729908, 1858.3402891973426, 98587.0, 116713.0, 120228.39885800515, 120853.0, 122733.77266227313, 9321.44071355721, 11267.718307042389, 11317.49071291794, 11489.425528723697, 11641.243319184396, 14019.859801402059, 14106.506272280421, 14217.644558885904, 14238.145711257357, 14257.714845703027, 6992.510524263253, 7938.126806051329, 8110.878336824952, 8148.633311500878, 8316.792080197922, 7234.891476627855, 7409.777386731237, 7878.409119316074, 7959.0, 7959.442839001214, 4089.3661482470266, 4228.4080228768, 4477.238869392211, 4492.977535112369, 4523.705959112647, 1614.5317857821335, 1916.7124931260144, 1924.8171423715005, 1928.1104517572858, 1938.2053358123103, 817.9489356177284, 920.8351435434181, 964.2382517810851, 994.5126887824914, 1018.7962407518526, 19997.400077997685, 20447.8977605114, 20513.48716282075, 20615.381538553567, 20711.0, 974.3325821812082, 981.9656312029044, 1006.1950439648252, 1015.0813513769903, 1019.576875596634, 10569.260151789302, 10793.244472886823, 10827.971342722429, 10831.566737330577, 10880.945595271973, 432371.5721320913, 434610.0, 547350.0, 551970.0, 553300.969417604, 104794.0, 118009.0, 125114.37442812728, 134448.3277583606, 136929.0, 838.7190291252376, 988.4365911430559, 996.8255555277798, 998.6005597760953, 999.4453078541479, 18714.625707486048, 19175.137118829964, 19275.903620481808, 19436.90281548583, 19465.902670487125, 48851.0, 48943.28698495535, 49774.00451991012, 50173.745656358886, 50793.96824126993, 73669.0, 74248.0, 74958.62520687362, 75383.0, 76053.0, 6911.93088069133, 7990.880136798069, 8018.879716804136, 8153.673853046049, 8171.509709417454, 10826.89173108259, 12474.501019959464, 12611.81082283748, 12638.684032899251, 12854.871451285368, 9425.57584908667, 10929.781404372026, 11293.0, 11350.148738844784, 11422.657320280405, 9236.353455258068, 10916.890831091587, 10940.179486538382, 10956.56173753041, 11276.0, 10410.271281010257, 11055.281406708538, 11396.430178491208, 11444.542218311175, 11609.129315301556, 7889.092754333095, 7910.920890791249, 8084.676612935416, 8306.584670766559, 8313.958430208053, 8184.631691574013, 10004.149647279772, 10900.618478353219, 11241.325520468798, 11330.773384532427], "value": 9148.669498666583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.6230786533702, 1380.7790753479446, 1395.7069015506743, 1395.9232242226676, 1408.4295860176626, 7166.0, 7426.183119856812, 7728.188540203282, 8434.620442080106, 8445.324374050077, 7899.881501777478, 8171.632276547555, 8183.631736571853, 8339.457935234206, 8350.91649083509, 2118.756343020557, 2145.367116700569, 2246.1240116354593, 2286.9885650571723, 2301.5166814968875, 2055.239561362298, 2137.2092325839385, 2299.183789754638, 2339.7660233976635, 2346.4603141277516, 2188.7592364839857, 2265.1958554713087, 2269.8978545965388, 2286.3483907086484, 2288.7367952685404, 2288.9198878039274, 2300.551392478476, 2311.167979527369, 2311.90752369905, 2321.93034208974, 2286.965695514569, 2303.8617682939075, 2334.8599084055013, 2341.1337805012085, 2345.460544074855, 6765.966170169167, 7663.5785031823225, 8337.583120843934, 8340.833183336299, 8391.11893251206, 4175.874723758292, 4335.761533115678, 4455.309427038814, 4603.0, 5057.797688092472, 3288.8610145010275, 3400.8129552874584, 3439.5872495300723, 3476.2526056897636, 3518.1204698825295, 1058.3861360410942, 1108.3460758152728, 1154.6940060883871, 1193.1230545549015, 1246.6322434881731, 9112.681056163003, 10606.9469652652, 10742.78514429707, 10750.462476876124, 10789.759177694508, 3817.1983883384246, 4402.977985110054, 4521.61566266871, 4616.1229366420275, 4628.421447319085, 8624.439411438236, 9323.533823308808, 9325.393849399767, 9365.250779937589, 9366.157045865904, 5099.745012749348, 5165.354330708661, 5183.0, 5183.740812959337, 5200.739963001834, 4653.953460465352, 4670.136024835417, 4697.577218050392, 4718.150732868048, 4729.4797572267025, 3698.130939229279, 3732.4774531565604, 3758.361078616642, 3811.5045044144085, 3819.961800382016, 1057.6562617149457, 1133.5182547417314, 1169.7134202120535, 1194.2237545595433, 1236.863944966071, 820.8030072782609, 835.1898658301438, 853.117023880281, 881.4402854187637, 882.7704796752762, 5135.871603209875, 5250.159974404077, 5393.892122157535, 5413.621046526784, 5537.501624853702, 855.8844555984987, 868.7046404222468, 873.7073080518097, 914.2411798207472, 919.4483310013939, 3182.7294679952, 3607.8737244196327, 3669.94495082574, 3710.22085362077, 3717.683996860297, 7750.379969602418, 9227.90772092284, 9883.555240014073, 9891.950540247397, 9896.950515247521, 9495.38280011797, 9777.951110244403, 9779.755506112262, 9784.168345690554, 9829.0, 6515.576487528296, 7518.887216691754, 7684.462087653922, 7730.265624765639, 7802.804929876685, 5332.893342133213, 5435.374931882884, 5437.157240627709, 5485.369182544058, 5598.748056337556, 9214.078592140731, 9301.906980930104, 9309.534523273946, 9342.719718408458, 9352.392094513834, 9185.173334399937, 9252.722418327461, 9310.95344523273, 9428.717138485856, 9430.952845236005, 7042.154941407064, 7135.393491553276, 7154.141503019671, 7179.712811487482, 7184.137903451619, 6496.577722448026, 6526.641034743135, 7602.087749469878, 7688.038995125609, 7718.073831140299, 6941.826454338682, 6955.478339124687, 7041.155061392666, 7065.328793764585, 7182.820429489305, 6810.455163586802, 6862.451003919575, 6876.0, 7008.789736307919, 7019.859602808017, 6137.877242455215, 6300.621962682254, 6312.053192021233, 6312.7159277833525, 6341.048842673636, 4659.836905708284, 4720.268358404453, 4727.739974301309, 4762.428508578854, 4845.370101886732, 4607.331936869202, 4653.930191047205, 4751.904961900812, 4826.0, 4902.852914412573], "value": 4283.358963828507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.8128760168695, 334.11459631975276, 337.6050021474874, 351.3166890398175, 360.22371788795147, 4891.682040667354, 5177.792888284464, 5292.576593872491, 5386.973065134674, 5423.620346575736, 4215.28340182169, 4318.330658747891, 5241.689577605599, 5288.202011316152, 5319.5478384337375, 3163.462211424058, 3815.751976121557, 3967.841286348543, 4180.895477613054, 4210.3894935234375, 3652.652997965189, 4045.231406032859, 4181.975416023079, 4210.736778966298, 4255.5318914919335, 4116.876493705194, 4119.146384127155, 4128.0, 4160.4383408239955, 4187.853425130121, 3593.4070878305047, 4118.279301122321, 4128.566500517432, 4133.607307305816, 4164.9583504164875, 3249.3338865532746, 3585.354636165489, 3704.1850792825803, 3713.442983552489, 3720.274546463441, 4180.623743863037, 4311.956880431187, 5099.209622508517, 5154.329937108189, 5258.842234732964, 4793.7363445010515, 4794.7842347094465, 4795.952040479586, 4804.903901921942, 4836.637252206098, 5109.41241757199, 5518.0, 5589.832305030855, 5600.0, 5650.6892120933335, 3193.6007999000126, 3884.31032500863, 3995.720299579031, 4056.2293164298985, 4086.9182616347803, 5335.253064570963, 5858.443447872445, 5872.471477566996, 5886.587938844283, 5900.822975310747, 3670.596234414212, 3783.451399547105, 4128.298189307825, 4139.606737359946, 4170.769622961234, 3483.3729928613093, 3716.535433070866, 4038.576853887644, 4080.897977550585, 4227.7463352198965, 3965.6827453803626, 4512.954870451319, 4517.480489743722, 4759.762911431621, 4762.547557981986, 4959.68568329393, 5542.8337149885565, 5606.523445507096, 5619.157126431068, 5632.5502852746695, 1130.6438471881331, 1185.057878986208, 1300.74635446089, 1319.973600527984, 1338.4579245405625, 937.5124935033881, 969.3263182088522, 971.3734641156415, 976.3751199232497, 978.9510524473748, 4369.650427965755, 4662.6269898408045, 4952.331435256267, 5070.504201260637, 5171.4311425743135, 4750.168720473903, 4816.8073277069225, 5471.23402723619, 5502.642328248731, 5534.778608855681, 4886.413630364379, 4951.45000324833, 4999.875003124878, 5000.374953130859, 5075.335448889363, 2571.8071144664227, 2740.5204089284293, 2842.834437880459, 2922.547005214195, 2990.775691823122, 5263.947210557903, 5715.742791574306, 5736.713164341766, 5828.6794226317115, 5850.3564607893095, 4721.811127554859, 4801.863170888991, 5071.594272458195, 5327.244292773586, 5379.718371793203, 4860.281884358468, 5245.318108645928, 5422.5119739223655, 5808.605934575671, 5849.795257165979, 4577.6795624307315, 5277.0, 5486.600916766199, 5639.954424610664, 5668.291463567054, 4710.6231501479115, 4962.798994648359, 5299.89224244462, 5516.9448305516435, 5547.306586676666, 4572.862814115582, 5207.401148867777, 5762.5389968801555, 5792.2230989741265, 5801.071828507418, 3290.9521288814412, 3579.1231148368815, 3681.9079523012138, 3684.465752465931, 3718.5165928429133, 5352.00987817255, 5468.62114979985, 5515.352630737349, 5777.7977770777825, 5811.76752929895, 5024.899502009866, 5502.202180683858, 5519.641223320471, 5682.374938756816, 5684.431556844283, 5493.956148331804, 5559.6664200148125, 5632.774689012557, 5651.547876169979, 5670.149477578396, 4834.830780922651, 4950.490100519376, 5509.834704958857, 5597.80407685729, 5707.343655479507, 4904.8773780655765, 5132.230165475208, 5258.50044245796, 5306.257124002565, 5619.297587801525, 4505.670827105946, 4979.875503112451, 5438.510534051954, 5479.958807826501, 5490.725463726878], "value": 4057.603270543326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9773207937723, 688.5593220338981, 746.0189850346793, 796.4225936196257, 801.5711594297051, 12007.819882701755, 12841.65162657919, 14138.929305353471, 14705.264736763173, 15111.848881511181, 14014.789778153336, 14077.648058798535, 14174.362153703083, 14191.077579957295, 14203.360848761804, 661.7187695229533, 685.2804555217027, 798.7643645124673, 809.6032943857512, 839.3914412051275, 846.2257034813139, 849.1678155407704, 850.2432834777053, 850.9021462531795, 851.7359618518279, 878.7275944457207, 903.8779764731743, 910.886139232596, 912.3567884641312, 912.5893347993397, 890.1587999340626, 903.5211337990876, 904.1275169461468, 904.4754042655244, 905.7645012296784, 662.5858838226109, 666.7233098264214, 667.4693618573245, 668.1114118222752, 668.9732410703566, 14725.895557833206, 14761.77857332141, 14942.775858362133, 14992.0, 15146.924265378713, 14114.0, 14413.71172576553, 14427.422903083863, 14447.422103115969, 14521.636959076002, 11689.0, 11713.94143029288, 11776.470058847286, 11781.0, 11854.525818967231, 3666.5233519642543, 3684.889453316405, 3717.089313118276, 3723.1064544509395, 3783.129880127586, 73175.0, 80813.19186808175, 102730.94538109197, 105733.0, 106407.0, 9788.804223915482, 10998.06516446111, 11026.724331891606, 11028.613998510014, 11176.720581985353, 22791.772082278963, 22800.771992280195, 22803.657945130835, 22876.542469150525, 22879.88560057189, 7495.250474952461, 7743.186965368555, 7754.883676744853, 7817.687292508236, 7983.481073730189, 4158.189153115174, 4236.491621005499, 4269.380939763779, 4329.285667864767, 4391.890202744893, 3520.5423294972, 3623.3659109655705, 3630.2920930418845, 3633.800140992218, 3684.447332900033, 604.8911195984765, 696.2863065358049, 702.6311186627062, 709.9503034787515, 720.2149656873928, 562.5836880708329, 586.3052283044606, 604.0727483313093, 605.9550757443792, 627.5575719118011, 9125.087491250822, 9194.310426718022, 9233.953830230806, 9292.674756383629, 9409.294302927308, 603.9637621742621, 623.5759683415321, 625.0717684238901, 638.7572722365471, 657.1063353838775, 4348.978255108705, 4562.24722920721, 4633.443986721615, 4715.599174070242, 4859.416869975626, 103431.4828425853, 107964.0, 108518.0, 108553.0, 110772.0, 67855.32144678589, 92587.0, 93020.06979930114, 93565.5321723387, 96803.0, 64961.67519162469, 65142.67428662921, 66216.33783662198, 70141.64929175322, 84022.0, 9727.36772109839, 9732.659356922757, 9869.161121304482, 10002.549885255326, 10009.949950250202, 49318.26022609736, 50268.49731502638, 50556.94430556915, 50966.74516627393, 52260.0, 66699.99800012015, 66766.66616666886, 68101.0, 68739.0, 69410.30589694038, 10789.86706395817, 11951.641450756491, 12513.124081314585, 12515.687107822378, 12718.173318734252, 12897.226166430044, 13258.86741132615, 13595.932020339835, 13745.0, 13947.860521394656, 13183.67040823987, 13345.599632011055, 13348.265845378597, 13447.348938432397, 13603.047786654839, 13554.322283885569, 13573.0, 13589.52436664712, 13779.0, 14004.649883752987, 12954.676133096747, 12977.0, 13136.0, 13674.974376921571, 13895.513657021957, 10311.639092631722, 10507.737306567396, 10850.240483166102, 11233.550657973916, 11301.039411650101, 10275.211127670143, 10837.458127093456, 10843.728906777078, 10903.34579925207, 10911.807925082876], "value": 7351.195932540512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1633.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 119.0, 119.0, 117.0, 123.0, 160.0, 117.0, 118.0, 117.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 144.0, 156.0, 112.0, 113.0, 118.0, 115.0, 133.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 206.0, 224.0, 202.0, 198.0, 239.0, 275.0, 239.0, 239.0, 272.0], "value": 229.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 86.0, 60.0, 61.0, 63.0, 76.0, 71.0, 82.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 84.0, 70.0, 71.0, 74.0, 109.0, 99.0, 99.0, 97.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 128.0, 94.0, 96.0, 134.0, 89.0, 92.0, 96.0, 115.0, 88.0], "value": 102.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 98.0, 121.0, 98.0, 99.0, 99.0, 133.0, 148.0, 152.0], "value": 114.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 92.0, 104.0, 85.0, 140.0, 151.0, 89.0, 146.0, 126.0, 93.0], "value": 113.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 70.0, 80.0, 107.0, 97.0, 97.0, 75.0, 73.0, 72.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 89.0, 90.0, 89.0, 89.0, 117.0, 108.0, 108.0, 108.0], "value": 98.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 154.0, 152.0, 151.0, 161.0, 156.0, 146.0, 186.0, 197.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 179.0, 213.0, 175.0, 173.0, 175.0, 173.0, 187.0, 239.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 67.0, 79.0, 81.0, 88.0, 85.0, 86.0, 80.0], "value": 77.5, "unit": "score"}]}]} 07:58:38 INFO - Return code: 0 07:58:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:38 ERROR - # TBPL SUCCESS # 07:58:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:38 INFO - 2017-01-01 07:58:38.256 screenresolution[1952:18678] starting screenresolution argv=screenresolution get 07:58:38 INFO - 2017-01-01 07:58:38.258 screenresolution[1952:18678] Display 0: 1600x1200x32@60 07:58:38 INFO - 2017-01-01 07:58:38.264 screenresolution[1953:18681] starting screenresolution argv=screenresolution list 07:58:38 INFO - Available Modes on Display 0 07:58:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:38 INFO - Intel Iris: 07:58:38 INFO - Chipset Model: Intel Iris 07:58:38 INFO - Type: GPU 07:58:38 INFO - Bus: Built-In 07:58:38 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:38 INFO - Vendor: Intel (0x8086) 07:58:38 INFO - Device ID: 0x0a2e 07:58:38 INFO - Revision ID: 0x0009 07:58:38 INFO - Displays: 07:58:38 INFO - Display: 07:58:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:38 INFO - Display Serial Number: 1600x1200 60 07:58:38 INFO - Main Display: Yes 07:58:38 INFO - Mirror: Off 07:58:38 INFO - Online: Yes 07:58:38 INFO - Rotation: Supported 07:58:38 INFO - Return code: 0 07:58:38 INFO - Running post-action listener: _resource_record_post_action 07:58:38 INFO - [mozharness: 2017-01-01 15:58:38.500084Z] Finished run-tests step (success) 07:58:38 INFO - Running post-run listener: _resource_record_post_run 07:58:38 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 3450368; Write bytes: 555337728; Read time: 23; Write time: 1722 07:58:38 INFO - TinderboxPrint: CPU usage
54.7% 07:58:38 INFO - TinderboxPrint: I/O read bytes / time
3,450,368 / 23 07:58:38 INFO - TinderboxPrint: I/O write bytes / time
555,337,728 / 1,722 07:58:38 INFO - TinderboxPrint: CPU idle
2,179.6 (45.3%) 07:58:38 INFO - TinderboxPrint: CPU system
972.6 (20.2%) 07:58:38 INFO - TinderboxPrint: CPU user
1,657.5 (34.5%) 07:58:38 INFO - TinderboxPrint: Swap in / out
252,952,576 / 0 07:58:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 241322496; Write bytes: 235824640; Read time: 17921; Write time: 480 07:58:38 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 3446272; Write bytes: 302121472; Read time: 22; Write time: 1163 07:58:38 INFO - Running post-run listener: _upload_blobber_files 07:58:38 INFO - Blob upload gear active. 07:58:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:38 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 07:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:40 INFO - (blobuploader) - INFO - Done attempting. 07:58:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:41 INFO - (blobuploader) - INFO - Done attempting. 07:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:42 INFO - (blobuploader) - INFO - Done attempting. 07:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:44 INFO - (blobuploader) - INFO - Done attempting. 07:58:44 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:44 INFO - Return code: 0 07:58:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1314cb5365d06037f205a5a0b4f04cc3896aa7c2d4c6b7da52109b2a9a97929c020e408337647f9f45d4bb2ae3635e665718379687e25795ece2b66e86b0b14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4fbe468adb77e64330bd93fed62b9900e7257a7a09db3c6c64912bcfa38793433676c01f7302180de10f79fa9c31f4dd43a2eb24138b34901abcb2f6440182", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594cb38ceba5b17b3db88af651ed433f3b29a79fa95112cfa481224be859a0e2838100e9fb14a7a336d054a631bf2d7f8da86e48f899a58b7be663f66c805a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c4a9caa79cdc420dd99f3fe419666da2726c6503d617335d8c115ed64125abdd938496a0c3ffb6e0696c3c2fce0023a1ac414a183383c23b1332fe014e20d8"} 07:58:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:44 INFO - Contents: 07:58:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1314cb5365d06037f205a5a0b4f04cc3896aa7c2d4c6b7da52109b2a9a97929c020e408337647f9f45d4bb2ae3635e665718379687e25795ece2b66e86b0b14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4fbe468adb77e64330bd93fed62b9900e7257a7a09db3c6c64912bcfa38793433676c01f7302180de10f79fa9c31f4dd43a2eb24138b34901abcb2f6440182", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594cb38ceba5b17b3db88af651ed433f3b29a79fa95112cfa481224be859a0e2838100e9fb14a7a336d054a631bf2d7f8da86e48f899a58b7be663f66c805a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c4a9caa79cdc420dd99f3fe419666da2726c6503d617335d8c115ed64125abdd938496a0c3ffb6e0696c3c2fce0023a1ac414a183383c23b1332fe014e20d8"} 07:58:44 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:44 INFO - Copying logs to upload dir... 07:58:44 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.908570 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-01 07:58:44.445876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 07:58:44.449767) ========= 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.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1314cb5365d06037f205a5a0b4f04cc3896aa7c2d4c6b7da52109b2a9a97929c020e408337647f9f45d4bb2ae3635e665718379687e25795ece2b66e86b0b14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4fbe468adb77e64330bd93fed62b9900e7257a7a09db3c6c64912bcfa38793433676c01f7302180de10f79fa9c31f4dd43a2eb24138b34901abcb2f6440182", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594cb38ceba5b17b3db88af651ed433f3b29a79fa95112cfa481224be859a0e2838100e9fb14a7a336d054a631bf2d7f8da86e48f899a58b7be663f66c805a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c4a9caa79cdc420dd99f3fe419666da2726c6503d617335d8c115ed64125abdd938496a0c3ffb6e0696c3c2fce0023a1ac414a183383c23b1332fe014e20d8"} build_url:https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/U20uEWgzQYed-gaCE-gR5g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1314cb5365d06037f205a5a0b4f04cc3896aa7c2d4c6b7da52109b2a9a97929c020e408337647f9f45d4bb2ae3635e665718379687e25795ece2b66e86b0b14", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4fbe468adb77e64330bd93fed62b9900e7257a7a09db3c6c64912bcfa38793433676c01f7302180de10f79fa9c31f4dd43a2eb24138b34901abcb2f6440182", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594cb38ceba5b17b3db88af651ed433f3b29a79fa95112cfa481224be859a0e2838100e9fb14a7a336d054a631bf2d7f8da86e48f899a58b7be663f66c805a4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93c4a9caa79cdc420dd99f3fe419666da2726c6503d617335d8c115ed64125abdd938496a0c3ffb6e0696c3c2fce0023a1ac414a183383c23b1332fe014e20d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 07:58:44.485563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:58:44.485973) ========= 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.6X02jw6w0H/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.pau69VXPtU/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 07:58:44.534242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 07:58:44.534556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 07:58:44.534891) ========= ========= Total master_lag: 0.19 =========