builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0177 starttime: 1493728299.3 results: success (0) buildid: 20170502030211 builduid: 5b4c31aedf1c48e09309ae87d394a862 revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.296728) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.297206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.297488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.323475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.323883) ========= 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.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-05-02 05:31:39-- 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.58M=0.002s 2017-05-02 05:31:39 (7.58 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.440895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.441235) ========= 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.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.022742 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.490042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:39.490409) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --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 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-05-02 05:31:39,569 truncating revision to first 12 chars 2017-05-02 05:31:39,569 Setting DEBUG logging. 2017-05-02 05:31:39,569 attempt 1/10 2017-05-02 05:31:39,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48c0fd9c9ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 05:31:40,195 unpacking tar archive at: mozilla-central-48c0fd9c9ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:40.401889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:40.402253) ========= script_repo_revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:40.402689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:40.402983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:40.423725) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-02 05:31:40.424202) ========= /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.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:31:40 INFO - MultiFileLogger online at 20170502 05:31:40 in /builds/slave/test 05:31:40 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 05:31:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:40 INFO - {'append_to_log': False, 05:31:40 INFO - 'base_work_dir': '/builds/slave/test', 05:31:40 INFO - 'blob_upload_branch': 'Firefox', 05:31:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:40 INFO - 'branch': 'Firefox', 05:31:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:40 INFO - 'config_files': ('talos/mac_config.py',), 05:31:40 INFO - 'default_actions': ('clobber', 05:31:40 INFO - 'read-buildbot-config', 05:31:40 INFO - 'download-and-extract', 05:31:40 INFO - 'populate-webroot', 05:31:40 INFO - 'create-virtualenv', 05:31:40 INFO - 'install', 05:31:40 INFO - 'run-tests'), 05:31:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:40 INFO - 'download_minidump_stackwalk': True, 05:31:40 INFO - 'download_symbols': 'ondemand', 05:31:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:40 INFO - 'gecko_profile': False, 05:31:40 INFO - 'gecko_profile_interval': 0, 05:31:40 INFO - 'installer_path': 'installer.exe', 05:31:40 INFO - 'log_level': 'info', 05:31:40 INFO - 'log_name': 'talos', 05:31:40 INFO - 'log_to_console': True, 05:31:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:40 INFO - 'opt_config_files': (), 05:31:40 INFO - 'pip_index': False, 05:31:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:40 INFO - 'cmd': ('bash', 05:31:40 INFO - '-c', 05:31:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:40 INFO - 'enabled': True, 05:31:40 INFO - 'halt_on_failure': False, 05:31:40 INFO - 'name': 'check_screen_resolution'},), 05:31:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:40 INFO - 'cmd': ('bash', 05:31:40 INFO - '-c', 05:31:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:40 INFO - 'enabled': True, 05:31:40 INFO - 'halt_on_failure': False, 05:31:40 INFO - 'name': 'check_screen_resolution'},), 05:31:40 INFO - 'run_cmd_checks_enabled': True, 05:31:40 INFO - 'suite': 'dromaeojs-e10s', 05:31:40 INFO - 'system_bits': '32', 05:31:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:40 INFO - 'title': 't-yosemite-r7-0177', 05:31:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:40 INFO - 'use_talos_json': True, 05:31:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:40 INFO - 'work_dir': 'build'} 05:31:40 INFO - [mozharness: 2017-05-02 12:31:40.631911Z] Running clobber step. 05:31:40 INFO - Running pre-action listener: _resource_record_pre_action 05:31:40 INFO - Running main action method: clobber 05:31:40 INFO - rmtree: /builds/slave/test/build 05:31:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:42 INFO - Running post-action listener: _resource_record_post_action 05:31:42 INFO - [mozharness: 2017-05-02 12:31:42.368767Z] Finished clobber step (success) 05:31:42 INFO - [mozharness: 2017-05-02 12:31:42.368934Z] Running read-buildbot-config step. 05:31:42 INFO - Running pre-action listener: _resource_record_pre_action 05:31:42 INFO - Running main action method: read_buildbot_config 05:31:42 INFO - Using buildbot properties: 05:31:42 INFO - { 05:31:42 INFO - "project": "", 05:31:42 INFO - "product": "firefox", 05:31:42 INFO - "script_repo_revision": "production", 05:31:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:31:42 INFO - "repository": "", 05:31:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:31:42 INFO - "buildid": "20170502030211", 05:31:42 INFO - "stage_platform": "macosx64", 05:31:42 INFO - "basedir": "/builds/slave/test", 05:31:42 INFO - "nightly_build": "True", 05:31:42 INFO - "buildnumber": 58, 05:31:42 INFO - "slavename": "t-yosemite-r7-0177", 05:31:42 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:31:42 INFO - "platform": "yosemite_r7", 05:31:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:42 INFO - "branch": "mozilla-central", 05:31:42 INFO - "repo_path": "mozilla-central", 05:31:42 INFO - "revision": "48c0fd9c9ec5d68061ea7b59358874ae8da72572", 05:31:42 INFO - "pgo_build": "False", 05:31:42 INFO - "builduid": "5b4c31aedf1c48e09309ae87d394a862", 05:31:42 INFO - "slavebuilddir": "test" 05:31:42 INFO - } 05:31:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:31:42 INFO - Running post-action listener: _resource_record_post_action 05:31:42 INFO - [mozharness: 2017-05-02 12:31:42.375009Z] Finished read-buildbot-config step (success) 05:31:42 INFO - [mozharness: 2017-05-02 12:31:42.375234Z] Running download-and-extract step. 05:31:42 INFO - Running pre-action listener: _resource_record_pre_action 05:31:42 INFO - Running main action method: download_and_extract 05:31:42 INFO - mkdir: /builds/slave/test/build/tests 05:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:42 INFO - trying https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:42 INFO - Downloading https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:31:43 INFO - Downloaded 1325 bytes. 05:31:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:43 INFO - Using the following test package requirements: 05:31:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:31:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:31:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:31:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'jsshell-mac.zip'], 05:31:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:31:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:31:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:31:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:31:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:31:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:31:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:31:45 INFO - Content-Length response header: 52700225 05:31:45 INFO - Bytes received: 52700225 05:32:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:32:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:32:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:01 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:32:03 INFO - Content-Length response header: 52700225 05:32:03 INFO - Bytes received: 52700225 05:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:32:19 INFO - Content-Length response header: 14408811 05:32:19 INFO - Bytes received: 14408811 05:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:20 INFO - trying https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:20 INFO - Downloading https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:32:22 INFO - Downloaded 71320366 bytes. 05:32:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:22 INFO - mkdir: /builds/slave/test/properties 05:32:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:22 INFO - Contents: 05:32:22 INFO - build_url:https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:22 INFO - Running post-action listener: _resource_record_post_action 05:32:22 INFO - Running post-action listener: set_extra_try_arguments 05:32:22 INFO - [mozharness: 2017-05-02 12:32:22.895587Z] Finished download-and-extract step (success) 05:32:22 INFO - [mozharness: 2017-05-02 12:32:22.895729Z] Running populate-webroot step. 05:32:22 INFO - Running pre-action listener: _resource_record_pre_action 05:32:22 INFO - Running main action method: populate_webroot 05:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:22 INFO - '--tppagecycles', 05:32:22 INFO - '7'], 05:32:22 INFO - 'tests': ['tsvgm']}}, 05:32:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['damp', 'tps']}, 05:32:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'tests': ['damp', 'tps']}, 05:32:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['dromaeo_dom']}, 05:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:32:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:32:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['a11yr', 05:32:22 INFO - 'ts_paint', 05:32:22 INFO - 'tpaint', 05:32:22 INFO - 'sessionrestore', 05:32:22 INFO - 'sessionrestore_no_auto_restore', 05:32:22 INFO - 'tabpaint']}, 05:32:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:32:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:32:22 INFO - 'bloom_basic_ref']}, 05:32:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['tsvgx', 05:32:22 INFO - 'tsvgr_opacity', 05:32:22 INFO - 'tart', 05:32:22 INFO - 'tscrollx', 05:32:22 INFO - 'cart', 05:32:22 INFO - 'tsvg_static']}, 05:32:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:22 INFO - 'tsvgr_opacity', 05:32:22 INFO - 'tart', 05:32:22 INFO - 'tscrollx', 05:32:22 INFO - 'cart', 05:32:22 INFO - 'tsvg_static']}, 05:32:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'talos_options': ['--disable-e10s'], 05:32:22 INFO - 'tests': ['tp5o']}, 05:32:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:32:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'talos_options': ['--disable-e10s', 05:32:22 INFO - '--xperf_path', 05:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:22 INFO - 'tests': ['tp5n']}, 05:32:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:32:22 INFO - 'talos_options': ['--xperf_path', 05:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:22 INFO - 'tests': ['tp5n']}}, 05:32:22 INFO - 'talos.zip': {'path': '', 05:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:22 INFO - Running post-action listener: _resource_record_post_action 05:32:22 INFO - [mozharness: 2017-05-02 12:32:22.915583Z] Finished populate-webroot step (success) 05:32:22 INFO - [mozharness: 2017-05-02 12:32:22.915692Z] Running create-virtualenv step. 05:32:22 INFO - Running pre-action listener: _resource_record_pre_action 05:32:22 INFO - Running main action method: create_virtualenv 05:32:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:22 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 05:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:23 INFO - Using real prefix '/tools/python27' 05:32:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:26 INFO - Installing pip.................done. 05:32:26 INFO - Return code: 0 05:32:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:26 INFO - Reading from file tmpfile_stdout 05:32:26 INFO - Output received: 05:32:26 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) 05:32:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:26 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:26 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 05:32:26 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 05:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:26 INFO - 'HOME': '/Users/cltbld', 05:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:26 INFO - 'LOGNAME': 'cltbld', 05:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:26 INFO - 'MOZ_NO_REMOTE': '1', 05:32:26 INFO - 'NO_EM_RESTART': '1', 05:32:26 INFO - 'PAGER': '/bin/cat', 05:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:26 INFO - 'PWD': '/builds/slave/test', 05:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:26 INFO - 'SHELL': '/bin/bash', 05:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:26 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:26 INFO - 'USER': 'cltbld', 05:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:26 INFO - 'XPC_FLAGS': '0x0', 05:32:26 INFO - 'XPC_SERVICE_NAME': '0', 05:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 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 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:27 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 05:32:27 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 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking psutil>=3.1.1 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:31 INFO - Installing collected packages: psutil 05:32:31 INFO - Running setup.py install for psutil 05:32:31 INFO - building 'psutil._psutil_osx' extension 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 INFO - building 'psutil._psutil_posix' extension 05:32:31 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 05:32:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:31 INFO - ^ 05:32:31 INFO - 1 warning generated. 05:32:31 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 05:32:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:31 INFO - Successfully installed psutil 05:32:31 INFO - Cleaning up... 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:35 INFO - Installing collected packages: mozsystemmonitor 05:32:35 INFO - Running setup.py install for mozsystemmonitor 05:32:35 INFO - Successfully installed mozsystemmonitor 05:32:35 INFO - Cleaning up... 05:32:35 INFO - Return code: 0 05:32:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32: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==2.5.1'] in /builds/slave/test/build 05:32: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==2.5.1 05:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:35 INFO - 'HOME': '/Users/cltbld', 05:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:35 INFO - 'LOGNAME': 'cltbld', 05:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:35 INFO - 'MOZ_NO_REMOTE': '1', 05:32:35 INFO - 'NO_EM_RESTART': '1', 05:32:35 INFO - 'PAGER': '/bin/cat', 05:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:35 INFO - 'PWD': '/builds/slave/test', 05:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:35 INFO - 'SHELL': '/bin/bash', 05:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:35 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:35 INFO - 'USER': 'cltbld', 05:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:35 INFO - 'XPC_FLAGS': '0x0', 05:32:35 INFO - 'XPC_SERVICE_NAME': '0', 05:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:38 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 05:32:38 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 05:32:38 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 05:32:38 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 05:32:38 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 05:32:38 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 05:32:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:39 INFO - warning: no files found matching '*.txt' 05:32:39 INFO - no previously-included directories found matching 'build' 05:32:39 INFO - no previously-included directories found matching 'dist' 05:32:39 INFO - no previously-included directories found matching '.git*' 05:32:39 INFO - Installing collected packages: jsonschema, functools32 05:32:39 INFO - Running setup.py install for functools32 05:32:39 INFO - warning: no files found matching '*.txt' 05:32:39 INFO - no previously-included directories found matching 'build' 05:32:39 INFO - no previously-included directories found matching 'dist' 05:32:39 INFO - no previously-included directories found matching '.git*' 05:32:39 INFO - Successfully installed jsonschema functools32 05:32:39 INFO - Cleaning up... 05:32:39 INFO - Return code: 0 05:32:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:39 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 05:32:39 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 05:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:39 INFO - 'HOME': '/Users/cltbld', 05:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:39 INFO - 'LOGNAME': 'cltbld', 05:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:39 INFO - 'MOZ_NO_REMOTE': '1', 05:32:39 INFO - 'NO_EM_RESTART': '1', 05:32:39 INFO - 'PAGER': '/bin/cat', 05:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:39 INFO - 'PWD': '/builds/slave/test', 05:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:39 INFO - 'SHELL': '/bin/bash', 05:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:39 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:39 INFO - 'USER': 'cltbld', 05:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:39 INFO - 'XPC_FLAGS': '0x0', 05:32:39 INFO - 'XPC_SERVICE_NAME': '0', 05:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:39 INFO - Cleaning up... 05:32:39 INFO - Return code: 0 05:32:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:39 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 05:32:39 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 05:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:39 INFO - 'HOME': '/Users/cltbld', 05:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:39 INFO - 'LOGNAME': 'cltbld', 05:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:39 INFO - 'MOZ_NO_REMOTE': '1', 05:32:39 INFO - 'NO_EM_RESTART': '1', 05:32:39 INFO - 'PAGER': '/bin/cat', 05:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:39 INFO - 'PWD': '/builds/slave/test', 05:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:39 INFO - 'SHELL': '/bin/bash', 05:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:39 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:39 INFO - 'USER': 'cltbld', 05:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:39 INFO - 'XPC_FLAGS': '0x0', 05:32:39 INFO - 'XPC_SERVICE_NAME': '0', 05:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:42 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 05:32:42 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 05:32:42 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 05:32:42 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 05:32:42 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 05:32:42 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 05:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 INFO - Downloading docopt-0.6.1.tar.gz 05:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:44 INFO - Running setup.py install for blobuploader 05:32:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:44 INFO - Running setup.py install for requests 05:32:44 INFO - Running setup.py install for docopt 05:32:44 INFO - Successfully installed blobuploader requests docopt 05:32:44 INFO - Cleaning up... 05:32:44 INFO - Return code: 0 05:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:44 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:44 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 05:32:44 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 05:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:44 INFO - 'HOME': '/Users/cltbld', 05:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:44 INFO - 'LOGNAME': 'cltbld', 05:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:44 INFO - 'MOZ_NO_REMOTE': '1', 05:32:44 INFO - 'NO_EM_RESTART': '1', 05:32:44 INFO - 'PAGER': '/bin/cat', 05:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:44 INFO - 'PWD': '/builds/slave/test', 05:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:44 INFO - 'SHELL': '/bin/bash', 05:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:44 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:44 INFO - 'USER': 'cltbld', 05:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:44 INFO - 'XPC_FLAGS': '0x0', 05:32:44 INFO - 'XPC_SERVICE_NAME': '0', 05:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-mBnAvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-lZGeOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-CPwYGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-s7Yw_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-4Rjedh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LJWWm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-2lUl5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ICJyJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-pkMQ26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-1HTpiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-d7rmx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xvoD_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0oDQ48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-VODlRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-uxnysS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-BkaFUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Wnwhcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:46 INFO - Running setup.py install for manifestparser 05:32:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozcrash 05:32:47 INFO - Running setup.py install for mozdebug 05:32:47 INFO - Running setup.py install for mozdevice 05:32:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozfile 05:32:47 INFO - Running setup.py install for mozhttpd 05:32:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozinfo 05:32:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozInstall 05:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozleak 05:32:48 INFO - Running setup.py install for mozlog 05:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for moznetwork 05:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozprocess 05:32:48 INFO - Running setup.py install for mozprofile 05:32:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozrunner 05:32:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:49 INFO - Running setup.py install for mozscreenshot 05:32:49 INFO - Running setup.py install for moztest 05:32:49 INFO - Running setup.py install for mozversion 05:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:49 INFO - Cleaning up... 05:32:49 INFO - Return code: 0 05:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:49 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 05:32:49 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 05:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:49 INFO - 'HOME': '/Users/cltbld', 05:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:49 INFO - 'LOGNAME': 'cltbld', 05:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:49 INFO - 'MOZ_NO_REMOTE': '1', 05:32:49 INFO - 'NO_EM_RESTART': '1', 05:32:49 INFO - 'PAGER': '/bin/cat', 05:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:49 INFO - 'PWD': '/builds/slave/test', 05:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:49 INFO - 'SHELL': '/bin/bash', 05:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:49 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:49 INFO - 'USER': 'cltbld', 05:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:49 INFO - 'XPC_FLAGS': '0x0', 05:32:49 INFO - 'XPC_SERVICE_NAME': '0', 05:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-30BEfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:49 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)) 05:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fCHjXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:49 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)) 05:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-q1G9wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-9dZ50p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-1bcfCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-My5JXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xu0j3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-lBPdZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-UtAVus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-EcA_r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-NfMKj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:50 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)) 05:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-XAQ3ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-s6wQIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:51 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)) 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rLx8uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:51 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)) 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-cgFGPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:51 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)) 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-IYis87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:51 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)) 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-brbDzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:51 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)) 05:32:51 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)) 05:32:51 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)) 05:32:51 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)) 05:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:51 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 05:32:51 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 05:32:51 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 05:32:51 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 05:32:51 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 05:32:51 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 05:32:54 INFO - Downloading blessings-1.6.tar.gz 05:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:54 INFO - Installing collected packages: blessings 05:32:54 INFO - Running setup.py install for blessings 05:32:54 INFO - Successfully installed blessings 05:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:54 INFO - Reading from file tmpfile_stdout 05:32:54 INFO - Current package versions: 05:32:54 INFO - blessings == 1.6 05:32:54 INFO - blobuploader == 1.2.4 05:32:54 INFO - docopt == 0.6.1 05:32:54 INFO - functools32 == 3.2.3-2 05:32:54 INFO - jsonschema == 2.5.1 05:32:54 INFO - manifestparser == 1.1 05:32:54 INFO - mozInstall == 1.12 05:32:54 INFO - mozcrash == 1.0 05:32:54 INFO - mozdebug == 0.1 05:32:54 INFO - mozdevice == 0.50 05:32:54 INFO - mozfile == 1.2 05:32:54 INFO - mozhttpd == 0.7 05:32:54 INFO - mozinfo == 0.9 05:32:54 INFO - mozleak == 0.1 05:32:54 INFO - mozlog == 3.4 05:32:54 INFO - moznetwork == 0.27 05:32:54 INFO - mozprocess == 0.25 05:32:54 INFO - mozprofile == 0.28 05:32:54 INFO - mozrunner == 6.13 05:32:54 INFO - mozscreenshot == 0.1 05:32:54 INFO - mozsystemmonitor == 0.3 05:32:54 INFO - moztest == 0.8 05:32:54 INFO - mozversion == 1.4 05:32:54 INFO - psutil == 3.1.1 05:32:54 INFO - requests == 1.2.3 05:32:54 INFO - wsgiref == 0.1.2 05:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:54 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:54 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 05:32:54 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 05:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:54 INFO - 'HOME': '/Users/cltbld', 05:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PAGER': '/bin/cat', 05:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - 'XPC_FLAGS': '0x0', 05:32:54 INFO - 'XPC_SERVICE_NAME': '0', 05:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 INFO - Cleaning up... 05:32:55 INFO - Return code: 0 05:32:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:55 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 0x10ff4bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff4e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae6157bea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, '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.OLfVdZAYes/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.mOTUlaEfox/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 05:32:55 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 05:32:55 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 05:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:55 INFO - 'HOME': '/Users/cltbld', 05:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:55 INFO - 'LOGNAME': 'cltbld', 05:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:55 INFO - 'MOZ_NO_REMOTE': '1', 05:32:55 INFO - 'NO_EM_RESTART': '1', 05:32:55 INFO - 'PAGER': '/bin/cat', 05:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:55 INFO - 'PWD': '/builds/slave/test', 05:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:55 INFO - 'SHELL': '/bin/bash', 05:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:32:55 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:55 INFO - 'USER': 'cltbld', 05:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:55 INFO - 'XPC_FLAGS': '0x0', 05:32:55 INFO - 'XPC_SERVICE_NAME': '0', 05:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:55 INFO - Cleaning up... 05:32:55 INFO - Return code: 0 05:32:55 INFO - Running post-action listener: _resource_record_post_action 05:32:55 INFO - Running post-action listener: _start_resource_monitoring 05:32:55 INFO - Starting resource monitoring. 05:32:55 INFO - [mozharness: 2017-05-02 12:32:55.449762Z] Finished create-virtualenv step (success) 05:32:55 INFO - [mozharness: 2017-05-02 12:32:55.450833Z] Running install step. 05:32:55 INFO - Running pre-action listener: _resource_record_pre_action 05:32:55 INFO - Running main action method: install 05:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:55 INFO - Reading from file tmpfile_stdout 05:32:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:55 INFO - Reading from file tmpfile_stdout 05:32:55 INFO - Output received: 05:32:55 INFO - Usage: mozinstall [options] installer 05:32:55 INFO - Options: 05:32:55 INFO - -h, --help show this help message and exit 05:32:55 INFO - -d DEST, --destination=DEST 05:32:55 INFO - Directory to install application into. [default: 05:32:55 INFO - "/builds/slave/test"] 05:32:55 INFO - --app=APP Application being installed. [default: firefox] 05:32:55 INFO - mkdir: /builds/slave/test/build/application 05:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:15 INFO - Reading from file tmpfile_stdout 05:33:15 INFO - Output received: 05:33:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:15 INFO - Running post-action listener: _resource_record_post_action 05:33:15 INFO - [mozharness: 2017-05-02 12:33:15.467283Z] Finished install step (success) 05:33:15 INFO - [mozharness: 2017-05-02 12:33:15.467422Z] Running run-tests step. 05:33:15 INFO - Running pre-action listener: _resource_record_pre_action 05:33:15 INFO - Running main action method: run_tests 05:33:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:15 INFO - 2017-05-02 05:33:15.482 screenresolution[2599:36342] starting screenresolution argv=screenresolution get 05:33:15 INFO - 2017-05-02 05:33:15.484 screenresolution[2599:36342] Display 0: 1600x1200x32@60 05:33:15 INFO - 2017-05-02 05:33:15.490 screenresolution[2600:36345] starting screenresolution argv=screenresolution list 05:33:15 INFO - Available Modes on Display 0 05:33:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:15 INFO - Intel Iris: 05:33:15 INFO - Chipset Model: Intel Iris 05:33:15 INFO - Type: GPU 05:33:15 INFO - Bus: Built-In 05:33:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:15 INFO - Vendor: Intel (0x8086) 05:33:15 INFO - Device ID: 0x0a2e 05:33:15 INFO - Revision ID: 0x0009 05:33:15 INFO - Displays: 05:33:15 INFO - Display: 05:33:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:15 INFO - Display Serial Number: 1600x1200 60 05:33:15 INFO - Main Display: Yes 05:33:15 INFO - Mirror: Off 05:33:15 INFO - Online: Yes 05:33:15 INFO - Rotation: Supported 05:33:15 INFO - Return code: 0 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:15 INFO - Python 2.7.3 05:33:15 INFO - Return code: 0 05:33:15 INFO - grabbing minidump binary from tooltool 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd29d30>, '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 0x10fc4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:33:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:33:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:33:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:15 INFO - Return code: 0 05:33:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: RUST_BACKTRACE is now 1 05:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:33:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLfVdZAYes/Render', 05:33:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:15 INFO - 'HOME': '/Users/cltbld', 05:33:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:15 INFO - 'LOGNAME': 'cltbld', 05:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:15 INFO - 'MOZ_NO_REMOTE': '1', 05:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'NO_EM_RESTART': '1', 05:33:15 INFO - 'PAGER': '/bin/cat', 05:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:15 INFO - 'PWD': '/builds/slave/test', 05:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:15 INFO - 'RUST_BACKTRACE': '1', 05:33:15 INFO - 'SHELL': '/bin/bash', 05:33:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mOTUlaEfox/Listeners', 05:33:15 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:33:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:15 INFO - 'USER': 'cltbld', 05:33:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:15 INFO - 'XPC_FLAGS': '0x0', 05:33:15 INFO - 'XPC_SERVICE_NAME': '0', 05:33:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:33:16 INFO - mozversion application_buildid: 20170502030211 05:33:16 INFO - mozversion application_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 05:33:16 INFO - mozversion application_display_name: Nightly 05:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:16 INFO - mozversion application_name: Firefox 05:33:16 INFO - mozversion application_remotingname: firefox 05:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:16 INFO - mozversion application_vendor: Mozilla 05:33:16 INFO - mozversion application_version: 55.0a1 05:33:16 INFO - mozversion platform_buildid: 20170502030211 05:33:16 INFO - mozversion platform_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 05:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:16 INFO - mozversion platform_version: 55.0a1 05:33:16 INFO - using testdate: 1493728396 05:33:16 INFO - actual date: 1493728396 05:33:16 INFO - starting webserver on 'localhost:61110' 05:33:16 INFO - SUITE-START | Running 2 tests 05:33:16 INFO - TEST-START | dromaeo_css 05:33:16 INFO - operating with platform_type : mac_ 05:33:16 INFO - Initialising browser for dromaeo_css test... 05:33:16 INFO - TEST-INFO | started process 2610 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpCzFnK2/profile http://localhost:61110/getInfo.html) 05:33:19 INFO - PID 2610 | 2017-05-02 05:33:19.153 plugin-container[2613:36520] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c57, name = 'com.apple.tsm.portname' 05:33:19 INFO - PID 2610 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:19 INFO - PID 2610 | 2017-05-02 05:33:19.154 plugin-container[2613:36520] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa10b, name = 'com.apple.CFPasteboardClient' 05:33:19 INFO - PID 2610 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:19 INFO - PID 2610 | 2017-05-02 05:33:19.154 plugin-container[2613:36520] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:19 INFO - PID 2610 | __metrics Screen width/height:1600/1200 05:33:19 INFO - PID 2610 | colorDepth:24 05:33:19 INFO - PID 2610 | Browser inner width/height: 1024/689 05:33:19 INFO - PID 2610 | __metrics 05:33:20 INFO - TEST-INFO | 2610: exit 0 05:33:20 INFO - Browser initialized. 05:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:20 INFO - TEST-INFO | started process 2614 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpCzFnK2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:22 INFO - PID 2614 | 2017-05-02 05:33:22.663 plugin-container[2615:36650] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9343, name = 'com.apple.tsm.portname' 05:33:22 INFO - PID 2614 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:22 INFO - PID 2614 | 2017-05-02 05:33:22.664 plugin-container[2615:36650] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 05:33:22 INFO - PID 2614 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:22 INFO - PID 2614 | 2017-05-02 05:33:22.664 plugin-container[2615:36650] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:32 INFO - PID 2614 | RSS: Main: 234541056 05:33:32 INFO - PID 2614 | 05:36:36 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61110/tests/dromaeo/cssquery-ext.html) 05:36:37 INFO - PID 2614 | RSS: Main: 254611456 05:36:37 INFO - PID 2614 | 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | A coding exception was thrown and uncaught in a Task. 05:38:20 INFO - PID 2614 | 05:38:20 ERROR - PID 2614 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:20 INFO - PID 2614 | Full stack: 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | A coding exception was thrown and uncaught in a Task. 05:38:20 INFO - PID 2614 | 05:38:20 ERROR - PID 2614 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:20 INFO - PID 2614 | Full stack: 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | A coding exception was thrown and uncaught in a Task. 05:38:20 INFO - PID 2614 | 05:38:20 ERROR - PID 2614 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:20 INFO - PID 2614 | Full stack: 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | ************************* 05:38:20 INFO - PID 2614 | A coding exception was thrown and uncaught in a Task. 05:38:20 INFO - PID 2614 | 05:38:20 ERROR - PID 2614 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:20 INFO - PID 2614 | Full stack: 05:38:20 INFO - PID 2614 | ************************* 05:39:39 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-ext.html (next: http://localhost:61110/tests/dromaeo/cssquery-jquery.html) 05:39:40 INFO - PID 2614 | RSS: Main: 259522560 05:39:40 INFO - PID 2614 | 05:42:41 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61110/tests/dromaeo/cssquery-mootools.html) 05:42:42 INFO - PID 2614 | RSS: Main: 269701120 05:42:42 INFO - PID 2614 | 05:45:44 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61110/tests/dromaeo/cssquery-prototype.html) 05:45:44 INFO - PID 2614 | RSS: Main: 262123520 05:45:44 INFO - PID 2614 | 05:48:47 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61110/tests/dromaeo/cssquery-yui.html) 05:48:48 INFO - PID 2614 | RSS: Main: 272723968 05:48:48 INFO - PID 2614 | 05:51:49 INFO - PID 2614 | Cycle 1(1): loaded http://localhost:61110/tests/dromaeo/cssquery-yui.html (next: http://localhost:61110/tests/dromaeo/cssquery-dojo.html) 05:51:50 INFO - PID 2614 | RSS: Main: 267321344 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | __start_tp_report 05:51:50 INFO - PID 2614 | _x_x_mozilla_page_load 05:51:50 INFO - PID 2614 | _x_x_mozilla_page_load_details 05:51:50 INFO - PID 2614 | |i|pagename|runs| 05:51:50 INFO - PID 2614 | |0;dojo.html;3050.420420120177;3613.476045973334;3664.0473476896;3670.7797532148074;3698.0569954661555;5158.974205128974;6172.413620706037;6298.779542716006;6333.20834895638;6363.936360636392;6243.56295059346;6255.249370075586;6328.810135695937;6329.1772069631;6389.169407976968;4646.977664913714;5350;5513.476219759116;5515.503604675579;5545.251391062216;4531.841385551506;5527.060399732035;5611.3546942101775;5632.662040277576;5647.491725744682;5381.650192737498;5478.808241711561;5510.752016159283;5587.441255874421;5620.690862002588;5412.323459567554;5435.374931882805;5457.617966742329;5498.1752737089755;5569.721513924287;5499.917501237484;5513.641613295123;5543.1408131739645;5550.972245138789;5569.164625306196;6110.63336199825;6305.621662700207;6313.210848643919;6333.46165575922;6343.238811342622;6535.117759102508;6753.561018533779;6823.897641535381;6825.1127353444235;6841.281665425108;6644.568103073333;6853.725850965955;6955.582665040114;6956.582605043663;6964.4428445724225;6407.455366293824;6462.063000864942;6468.094466774655;6472.514561407913;6499.122618446449;7025.083887179902;7078.469114816409;7091.574505529685;7111.217766045731;7112.075430194145;6024.427679370453;6326.734653069405;6393.6163830170335;6551.148350714377;6740.4270636995425;6045.486133678599;6770.661466926733;6795.286494918061;6805.727770889208;6808.557443766139;6639.834004149935;6684.16447944007;6728.629925354153;6735.528513004043;6746.291639377893;5518.944810551923;6290.119383286344;6374.394432528902;6720.8319792005595;6785.762498312634;5375.3280839895015;5413.945860541423;5417.729113544386;5419.972900135474;5444.945550544444;4730.739809310521;4823;4830.492798256132;4833.4441539222735;4869.245266983623;4667;6346.333634968354;6368.4586810121655;6403.519736019817;6450.6774661266745;6883.862322753617;6894.551854129466;6925.376716095576;6951.5481493703755;6956.165260168812;6421.486281097501;6422.165118534561;6422.839429014219;6423.42189202974;6426;5814.941850581525;5890.617109887844;6021.337652858182;6077.3314935357075;6093.025115981422;6063.908496470678;6872.725090996404;7041.260667629826;7093.609851458013;7132.714691412493;6634.270230274762;6753.358430949052;6844.726210951506;6854.862902741817;6877.1747390313485;6914.412274956685;6999.545029573062;7047.154341479055;7143.178534468602;7153.248908864494;6190.7214175363115;6527.184101987252;6554.80335589933;6821.420179284816;6848.520603557703;6725.8991115134295;6838.521303508706;6840.931590684029;6942.8611427772175;6948.930510694829;6656.73373065072;6670.533062685759;6691.498137639794;6703.765368212089;6717.429018533479;6662.100616416722;6688.7324507019175;6706.731730730716;6712.832179195364;6719.899201512079;6202;6349;6441.677916104082;6474.935250647622;6514.73941042353;6623.834404139935;6624.436922861418;6634.402903738686;6669.032990216295;6690.83272918181;4995.925061124159;6480.351964803482;6489.480841532761;6499.350064993463;6517.9348206517325 05:51:50 INFO - PID 2614 | |1;ext.html;664.7108507799106;757.1860250231003;811.5860910935423;1206.0592737664613;1252.067209928602;36686.89939301822;37530.24939501212;37564.248715025715;37609.435858462144;37668.43497347542;37612.05969850755;37823.81088094556;37855;37893.052673683174;37941.43087853684;7830.412719046066;7998.360131189491;8262.669493220264;8474.915250847474;8502.489850608952;8433.072362040171;8515.489070655749;8529.360297977646;8537.658493660247;8584.527850968194;8490.150984901522;8555.828883422328;8557.614907329154;8573.95713021434;8575.742727718178;8477.10990346011;8507.829843403128;8528.914710852874;8540.999999999969;8545.829083418297;8234.629441675139;8305.37709671771;8305.584720763938;8320.417570770049;8326.167383261685;29354.70645293541;36457;36525.08687282839;36650.083747906516;36820.63179368199;3627.3470775260444;3679.816009199556;3681.263747250534;3682.429223470366;3686.3733165361955;30109.397812043855;30424.695753042408;30516.542251866238;30523.542146867814;30604.469776511087;3155.1165673611426;3189.1070500259966;3207.5028370602595;3227.080282119608;3238.6923242291946;243621;247568;270508;271873.64063179557;281725.5913720439;46842.06315873664;47140.7642961783;47178;47249;47303.763481182374;48798.51201488011;49072.509274907505;49249;49301.75349123303;49331.013379732205;11471.483783229774;12784.872151278369;13260.07179497426;14258.928705356408;14296.57110286693;11654.825177622342;11677.591284305008;11678.941605291919;11684.70788230301;11744.060475161967;13003.869961300456;13211.14127581704;13215.933920330337;13243.536476223479;13351.265680387673;5918.733656985446;5920.31916329619;5936.673482958478;5947.970260148758;5961.165436838846;1031.896810318962;1033.9844902326472;1042.2287507244585;1067.4876059491332;1084.5228099636136;23377.649335259986;24281.514369712506;24568.508629827662;24662.136825211033;24698.382540436633;992.3103443106971;1133.6769020829024;1179.2334982261427;1185.7747028064641;1191.7318603314186;12605.369731513387;12622.936885315698;12623.93688031554;12666.050046246568;12722.936385318199;314462;318349;320859;320929;321359;52973.470265296855;53492.73253633785;53709;53780.731096344265;53845.730771345894;1437.2813593203398;1501.2568778454518;1502.9549113526612;1525.054466230966;1572.2138930534732;24105;24142;24264.63603045991;24302.87848560746;24345.26964191077;37781.622183777814;37813.05467363338;37895.81052094722;37927.62072379241;37935.62064379431;287071;288255.55872220505;290122;290244;290440;29405.55891661584;29842.104736857927;32648.51027234546;33664.15839604029;33882.8305858479;42735.3589696161;43489;44583.77708111569;44763.55236447594;44814.3277850826;29283.85358073196;29572;30367.696323036485;30584.08247752571;30809.845950771;29616.555751663313;29655.85172074126;30384.696153038185;30434.934777282688;30748.231294217825;36267.81866090652;36332.45501317535;36457.63542364648;36537;36552.90341289766;25634.359141021625;25779.355516112246;28476.715232848233;30664;30937.0718878434;21726.45683857916;23415.531689365776;24072.638910416706;24261.49257281013;24518.14186503464 05:51:50 INFO - PID 2614 | |2;jquery.html;395.3318891074085;436.971596846205;439.59776804224134;445.98983302819113;460.2796623284559;19271.903640481796;21005.054772535233;21577;21798.89100554497;21863.562728745415;21535.6769648455;21909;22234.777652223474;22261.109555617757;22271.109155633756;5857.355690874;6111.816645500642;6119.082137679339;6119.3574674659185;6123.8162855114415;5698.344690360599;5963.373845746178;5971.581989260753;6045.969770151165;6046.818595442144;5792.82621521355;5938.673372964486;5978.671173085479;6004.699765011754;6006.879862402771;5805.303363596353;5941.346451890288;5952;5966.3138739045135;5968.31364393096;5113.258577506278;5305.991861546294;5306.257124002643;5317.46825317469;5328.014317351302;25818;25833.354166145808;25898.35254118662;25939.481210375874;26156.953721851103;2119.724435823333;2146.3453646637768;2164.404788683109;2178.041661668861;2179.455136215946;16802.411915582896;16871.493855184362;16978.575535611584;17157.142142892804;17290.91354543232;1702.770126032982;2096.916123355064;2121.618108740426;2145.774693657175;2147.259195577539;144544;145279.2736036313;146014;146307;156428.2178589111;11846.111541634413;12355.505779768708;12389.442475088643;12460.252384856938;12493.500259989498;13261;14158.929205354114;15897.761533577006;15914.442994495368;15924.363025478851;8680.609372578248;8931.330150238759;8957.417767845069;9030.729078127666;9102.86345704815;8577.923213348888;8622.439541429912;8632.568371581521;8724;8855.60149793248;6289.874202516015;7712.151663317143;7817;7859.685612575433;7887.723929662434;2237.966430503544;2247.550489902026;2254.3011666383472;2261.7172853393326;2430.805535557151;873.2315562305131;983.409954027592;991.375433476905;994.7712026234007;1023.8617786598862;20067;20314.796852031584;20314.882681452367;20456.897715511328;20722.274720384714;1027.6454623155;1030.340582027503;1052.921030922684;1056.746380868586;1059.0838924330399;10247.282690211763;10485.475726213659;10492.475376231157;10529.894701053045;10534.473276336306;480032.79950800765;538805;542955;546755;549431;96114;119625.20562191574;120451;121325.18012229823;122874;1184.5853951117213;1193.0634451955173;1196.3061424373843;1213.6905089202373;1214.0833670578656;17635;17692.646147077245;17777.555561111076;17802.198901049742;17937.282508699507;56345.71827140838;56350.718246408505;56820.71589642025;56860.715696421255;56925.71537142288;72226.55546888927;72986.85722852303;73996.52006959938;74190.62904685442;75468.62265688636;7091.432685385053;8399.916000839914;8729.563521823757;8764.123587641185;8916.86624700617;13522.18866867991;13566.86433135656;13698.931505342409;13958.930205349314;13968.161910285415;11706.590269340531;11802.403471236314;11928.701782455508;12003.879961200277;12100.394980251129;10163.7459063524;10696.304740191863;10838.349699017768;10967.616133435291;11114.888851111386;11575.363355015555;11937.28376297425;12073.464572439534;12137.939310303393;12139.939300303442;7350.338469537767;8567.914320856711;8763.649454021768;8816.779580510538;8831.425957312755;11651;11689.649310520697;12022.27866328023;12025.654997275447;12080.697982550506 05:51:50 INFO - PID 2614 | |3;mootools.html;1193.9462724177413;1445.508527100785;1460.5691321060285;1461.5980605333532;1474.3586539855164;9397.436153830775;11340.319580825146;11853.703657408569;11895.643130706081;12267.325297108655;11707.473163707633;11796.82304765427;11911.463984120714;11916.702082447942;11932.64202073937;2543.2751665775213;2574.691037075544;2578.265194419591;2581.7547333003336;2591.3780692633823;2481.2308184462786;2527.128140791424;2537.606670966003;2537.6701028866223;2537.860417677027;2479.710550513732;2503.8748062596887;2529.051605647882;2542.580474221751;2551.655526503917;2157.6439887418555;2490.3027152397267;2521.3066406738203;2523.470071285032;2527.8609676467786;2431.367844360479;2486.2168416948784;2500.3374105861963;2505.649209110708;2550.744925507453;11663.183577149603;11668;11797.056235501139;11798.41007949599;11804.93755561995;6521.543491955565;6742.145909874775;6787.72849086036;6793.728250869959;6799.320067993211;3904.39481880309;4165.062860856283;4265.914681706379;4269.67977401693;4277.636400905927;1275.8915492183176;1283.4096315694792;1300.8829205371467;1308.5485507499993;1320.7094439223356;14851.183184924825;15349.155796431192;16453.42413015551;16571.768505141503;16579.17104144788;4445.977770111129;5405.162199859028;5639.984802735465;5671.319441666944;5674.744636491368;10563.94718026405;11098.892310153171;11988.98093662031;11998.820017699742;12004.699882502833;6490;6559.8032059038305;6566.047923051131;6570.671466426755;6572.6056436613;6057.42454466825;6063.204922365024;6116.755329786759;6180.227471566054;6221.564490485713;3832.4442955771256;4284.057507348379;4298.3552467130185;4490.3040028795585;4506.571875671806;1253.254313683357;1260.7163388237757;1278.6419802455327;1280.692633767889;1283.9679008024686;804.9597520123971;809.6356639512243;831.7130589946458;837.1837458477935;862.9913700863036;4954.653174277838;6201.10084037812;6315;6358;6546.639934803631;471.9315699223662;571.2744814086087;596.4661627843057;609.6799180430221;613.8404014956144;4451.287793952952;4494.977525112354;4513.142502924499;4647.233206520954;4773.785179666923;14877;14954.177520236492;15080.170590617621;15183;15243.847561524464;12031.699207519707;14406.855931440761;14755.852441475448;15067.773983390258;15094.698106037818;7322.890156647654;8585.098564650621;8673.956630216808;8693.956530217434;8697.434666746642;6236.656983865931;7159.427245820218;7306.817329566591;7356.926430735838;7411.4070874331;13138.014648901179;13194.934025329812;13335.66660833487;13422.194668319931;13702.65743356424;11345.319280843176;13619.79570306466;13646.113002654796;13922.164670119826;14049.524799896273;9195;9420.152186303265;9454.290928180551;9495.335326527076;9519.714408567754;10798.190135739695;11078.612248571262;11081.058110060736;11089.722756931142;11098.445077746243;9072.50101244438;9183.448993060438;9291.67479138227;9297.209737172145;9341.159295663423;8988.775280617776;9092.727218183465;9102.772430689285;9114.680986165453;9188.770280743034;8237.382196335178;8378.790530236549;8414.410991230556;8419.95790021046;8425.578721064045;6078;6092.208012958287;6177.2587289525545;6205.379462053939;6278.937210628018;6128.448439640454;6232.940400132079;6312.747490100344;6361.650109244036;6457.418832305115 05:51:50 INFO - PID 2614 | |4;prototype.html;411.9979400103;414.48092740107506;415.48894859323053;421.4373810962365;426.69278119753784;5629.465200805922;5857.3849745776715;6092.268927728668;6280.623162610241;6443.742250309993;5073.771680274387;5174;6062.42406971337;6224.906626400608;6282.465990390822;4326.156399502099;4442.2004039272915;4545.3637090327775;4569.126658070192;4740.952590474103;4546.772661366935;4558.247889098295;4568.314752787075;4575.839845605405;4583.449986001685;4127.979360103211;4539.45526536816;4539.931901021488;4547.909041819162;4556.794944227501;4047.028713108862;4401.163778882018;4509.7970591323465;4512.075024619945;4521.321801729734;3818.8663396781258;3835.983464381941;3837.57786643469;3847.6537111660086;3849.441830934527;6174.969125154345;6194.955664630661;6197.101420294032;6218;6241.7191226394925;5348.545373643206;5349.5720342372515;5359.598030147716;5414.864628384283;5422.481705122533;5936.684692969745;6250.718717657671;6352.824727425441;6602.420954293614;6629.138212032453;4182.958170418287;4354.825806967718;4372.519022907478;4386.978065109686;4410.62509686677;6964.2589352661835;7034.261402552761;7188.424926005907;7197.640117994079;7241.131064272268;3672.9532083356116;4387.407699960529;4397.912041759211;4441.1347234161085;4468.061707041557;4134.793260337031;4432.312991486325;4517.164324599959;4518.385291766574;4520.638348932078;4562.771861406916;5325.068113080273;5357.223202635596;5382.03123437785;5394.811181608703;6378.553501254868;6761;6762.83092922671;6767.172863326874;6770.559913605698;1515.9393624254906;1523.2688309611449;1527.8701310388742;1529.6023034011237;1536.216529569905;869.517417833096;978.7406337320616;981.4405788700373;990.3711143423977;1006.1196453103535;5226.477352264819;6362.727454509117;6414.871702566016;6439.871202575922;6459.61242325462;5844.486870645578;6170.691465426711;7022.40309573692;7104.538205016657;7114.50198486101;5763.682997435181;5898.941010589925;6414.775482858077;6431.742730290736;6443.74712689632;3608.386574282378;3635.473101297461;3638.3450978824067;3679.6136405677016;3687.170386663033;6035.426634469718;6811.523193376416;7187.38907192884;7194.316539928698;7209.5127181122425;5531.446855314436;7197.568145911262;7204.135503739585;7204.495685302083;7239.601821899741;6038.516918646497;6199.845003874939;7154.892676609855;7235.529690570096;7300.817479563053;5501;7005.334493223136;7062.576245425291;7063.611501367474;7181.245969173162;5105.1576489880235;6266.480223731449;6509.414152726088;6930.584164950119;6935.618540980093;6513.902291465726;6522.412982831568;6888.827779305558;7085.964570177116;7282.927170728225;4399.868003959887;4415.668824838086;4424.358468022055;4428.2029234736765;4439.8890027748275;6836.555623884432;6971.337722916315;7028.929710702828;7054.788356349318;7093.32613401726;5983;6186.752529898934;6766.391024807791;6790.117284752951;6794.694238759169;6588.978708300221;6697.292190491394;6702.162229721285;6791.2190098139345;6796.456283497209;6225.782097626561;6619.3380661933425;6634;6644.368784965421;6689.26418094019;6595.340465953366;6738;6816.352446517573;6843.452523797984;6878.174619045746;6586.901196482152;6588.176477940257;6614.404703576702;6627.801165965029;6654.367835055662 05:51:50 INFO - PID 2614 | |5;yui.html;718.4539749790159;772.7758949904528;815.8531464336417;854.3677678517895;859.4628357276704;16569.254383552754;16738.330466781328;17037;18214.180361883715;19383.127759250834;17958;18226.179821908012;18339.17473713683;18454.630907381845;18599.628007439842;945.031342873555;992.0129471176153;998.6804222648756;1000.0999100809294;1002.04304888831;914.2868562521211;1009.8131845608549;1015.2436434856043;1017;1027.0807627173674;1055.5619417941546;1066.141755886511;1069.3423544520103;1071.201954543862;1071.608862765093;1048;1052.8683914510686;1066.0139371081757;1066.99466502667;1071.1591400750374;667.9713241607918;761.8742907420269;777.747232149548;792.7859477940981;794.4161041634394;14478.058926169871;16728.66542669152;16824.15879206047;17413.12934353277;17690.734638980426;16511.669766604722;16918.323267069303;16989.405370812085;17189.656206875916;17288.56778580533;13630.454781808816;13875.583732488041;14040.157590544497;14130.858691413057;14216.502422415166;3586.372384832644;3615.620359862203;3619.059044648384;3621.257642183346;3631.618680038611;110312;110830;111840.4407977963;113219;113284;13496.797548036788;13592.93203533976;13778.104423212659;13806.447742090404;13836;24494.775261236868;24763.009479620614;25183.496330073296;25445.8549365279;25464.490710186063;6394.616323020634;7976.7208147714555;8018.518888866687;8027.879581806277;8035.517868927883;3841.9231615367535;3876.341022026262;3905.6875449963936;3943.408488726714;3945.467361906106;4215.536291007987;4317.352397140391;4409.867703968886;4468.486124095705;4475.731456112644;926.1942110364026;949.2074118111316;963.5134257200069;968.7723385004518;973;645.9192600924885;658.5094104891887;660.181375094879;674.4638012779753;687.6183718036438;11218.66344009681;11642.301461912313;11952.223105498115;11995.220310679779;12193.817092743617;662.1160750398273;664.3091185167468;671.1074271219267;677.3632785181914;690.326931242045;5396.109641909119;5500.697461639648;5544.251526043932;5635;5680.091185410314;102943.4852825746;104040;104886.47556762167;105602.47198763957;106859.931400685;66309.00536491956;92966.07033929574;94056;95332.52333738287;96215.51892240494;72340.2765972344;84259.57870210732;84813.57593211994;84867.57566212253;85905.69801566812;10415.479226038517;11271.718207044889;11318.434078296217;11363.977242048255;11571.594994175164;35076.29847403089;36121.916342509765;36854.8157259212;37376.439353410264;37451.625483745906;43872.78063609661;45871.770641146584;47336.34322798686;48595;49350.80518155997;13770.586882393543;14057.01600887928;14353.210573418562;14494.420223191377;14531.491397801026;12714.374882347858;15360.308786104875;15694.450694225647;15952.760708589612;15957.680846382775;12396.938015309866;14227.644308891946;14412.783808242675;14518.709625807636;14631.414743410145;14277.500287490304;14312.499062532761;14624.341904614104;14773.03975241649;14850.554483365084;14014.64963375883;14107.224102674041;14160.645983850487;14212;14228.573142805732;9782.9021709782;9831.115199632068;9883.30816842814;9980.900190998287;10362.171026317727;8018.398620103632;11297.548098075986;11408.600698975495;11425.14311426663;11550.653480395602 05:51:50 INFO - PID 2614 | __end_tp_report 05:51:50 INFO - PID 2614 | __start_cc_report 05:51:50 INFO - PID 2614 | _x_x_mozilla_cycle_collect,425 05:51:50 INFO - PID 2614 | __end_cc_report 05:51:50 INFO - PID 2614 | __startTimestamp1493729510228__endTimestamp 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | ------- Summary: start ------- 05:51:50 INFO - PID 2614 | Number of tests: 6 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#0] dojo.html Cycles:165 Average:6214.05 Median:6441.68 stddev:784.18 (12.2%) stddev-sans-first:746.28 05:51:50 INFO - PID 2614 | Values: 3050.4 3613.5 3664.0 3670.8 3698.1 5159.0 6172.4 6298.8 6333.2 6363.9 6243.6 6255.2 6328.8 6329.2 6389.2 4647.0 5350.0 5513.5 5515.5 5545.3 4531.8 5527.1 5611.4 5632.7 5647.5 5381.7 5478.8 5510.8 5587.4 5620.7 5412.3 5435.4 5457.6 5498.2 5569.7 5499.9 5513.6 5543.1 5551.0 5569.2 6110.6 6305.6 6313.2 6333.5 6343.2 6535.1 6753.6 6823.9 6825.1 6841.3 6644.6 6853.7 6955.6 6956.6 6964.4 6407.5 6462.1 6468.1 6472.5 6499.1 7025.1 7078.5 7091.6 7111.2 7112.1 6024.4 6326.7 6393.6 6551.1 6740.4 6045.5 6770.7 6795.3 6805.7 6808.6 6639.8 6684.2 6728.6 6735.5 6746.3 5518.9 6290.1 6374.4 6720.8 6785.8 5375.3 5413.9 5417.7 5420.0 5444.9 4730.7 4823.0 4830.5 4833.4 4869.2 4667.0 6346.3 6368.5 6403.5 6450.7 6883.9 6894.6 6925.4 6951.5 6956.2 6421.5 6422.2 6422.8 6423.4 6426.0 5814.9 5890.6 6021.3 6077.3 6093.0 6063.9 6872.7 7041.3 7093.6 7132.7 6634.3 6753.4 6844.7 6854.9 6877.2 6914.4 6999.5 7047.2 7143.2 7153.2 6190.7 6527.2 6554.8 6821.4 6848.5 6725.9 6838.5 6840.9 6942.9 6948.9 6656.7 6670.5 6691.5 6703.8 6717.4 6662.1 6688.7 6706.7 6712.8 6719.9 6202.0 6349.0 6441.7 6474.9 6514.7 6623.8 6624.4 6634.4 6669.0 6690.8 4995.9 6480.4 6489.5 6499.4 6517.9 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#1] ext.html Cycles:180 Average:43985.42 Median:321144.00 stddev:76402.14 (23.8%) stddev-sans-first:76547.23 05:51:50 INFO - PID 2614 | Values: 664.7 757.2 811.6 1206.1 1252.1 36686.9 37530.2 37564.2 37609.4 37668.4 37612.1 37823.8 37855.0 37893.1 37941.4 7830.4 7998.4 8262.7 8474.9 8502.5 8433.1 8515.5 8529.4 8537.7 8584.5 8490.2 8555.8 8557.6 8574.0 8575.7 8477.1 8507.8 8528.9 8541.0 8545.8 8234.6 8305.4 8305.6 8320.4 8326.2 29354.7 36457.0 36525.1 36650.1 36820.6 3627.3 3679.8 3681.3 3682.4 3686.4 30109.4 30424.7 30516.5 30523.5 30604.5 3155.1 3189.1 3207.5 3227.1 3238.7 243621.0 247568.0 270508.0 271873.6 281725.6 46842.1 47140.8 47178.0 47249.0 47303.8 48798.5 49072.5 49249.0 49301.8 49331.0 11471.5 12784.9 13260.1 14258.9 14296.6 11654.8 11677.6 11678.9 11684.7 11744.1 13003.9 13211.1 13215.9 13243.5 13351.3 5918.7 5920.3 5936.7 5948.0 5961.2 1031.9 1034.0 1042.2 1067.5 1084.5 23377.6 24281.5 24568.5 24662.1 24698.4 992.3 1133.7 1179.2 1185.8 1191.7 12605.4 12622.9 12623.9 12666.1 12722.9 314462.0 318349.0 320859.0 320929.0 321359.0 52973.5 53492.7 53709.0 53780.7 53845.7 1437.3 1501.3 1503.0 1525.1 1572.2 24105.0 24142.0 24264.6 24302.9 24345.3 37781.6 37813.1 37895.8 37927.6 37935.6 287071.0 288255.6 290122.0 290244.0 290440.0 29405.6 29842.1 32648.5 33664.2 33882.8 42735.4 43489.0 44583.8 44763.6 44814.3 29283.9 29572.0 30367.7 30584.1 30809.8 29616.6 29655.9 30384.7 30434.9 30748.2 36267.8 36332.5 36457.6 36537.0 36552.9 25634.4 25779.4 28476.7 30664.0 30937.1 21726.5 23415.5 24072.6 24261.5 24518.1 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#2] jquery.html Cycles:180 Average:34150.42 Median:21886.28 stddev:89963.14 (411.0%) stddev-sans-first:90179.80 05:51:50 INFO - PID 2614 | Values: 395.3 437.0 439.6 446.0 460.3 19271.9 21005.1 21577.0 21798.9 21863.6 21535.7 21909.0 22234.8 22261.1 22271.1 5857.4 6111.8 6119.1 6119.4 6123.8 5698.3 5963.4 5971.6 6046.0 6046.8 5792.8 5938.7 5978.7 6004.7 6006.9 5805.3 5941.3 5952.0 5966.3 5968.3 5113.3 5306.0 5306.3 5317.5 5328.0 25818.0 25833.4 25898.4 25939.5 26157.0 2119.7 2146.3 2164.4 2178.0 2179.5 16802.4 16871.5 16978.6 17157.1 17290.9 1702.8 2096.9 2121.6 2145.8 2147.3 144544.0 145279.3 146014.0 146307.0 156428.2 11846.1 12355.5 12389.4 12460.3 12493.5 13261.0 14158.9 15897.8 15914.4 15924.4 8680.6 8931.3 8957.4 9030.7 9102.9 8577.9 8622.4 8632.6 8724.0 8855.6 6289.9 7712.2 7817.0 7859.7 7887.7 2238.0 2247.6 2254.3 2261.7 2430.8 873.2 983.4 991.4 994.8 1023.9 20067.0 20314.8 20314.9 20456.9 20722.3 1027.6 1030.3 1052.9 1056.7 1059.1 10247.3 10485.5 10492.5 10529.9 10534.5 480032.8 538805.0 542955.0 546755.0 549431.0 96114.0 119625.2 120451.0 121325.2 122874.0 1184.6 1193.1 1196.3 1213.7 1214.1 17635.0 17692.6 17777.6 17802.2 17937.3 56345.7 56350.7 56820.7 56860.7 56925.7 72226.6 72986.9 73996.5 74190.6 75468.6 7091.4 8399.9 8729.6 8764.1 8916.9 13522.2 13566.9 13698.9 13958.9 13968.2 11706.6 11802.4 11928.7 12003.9 12100.4 10163.7 10696.3 10838.3 10967.6 11114.9 11575.4 11937.3 12073.5 12137.9 12139.9 7350.3 8567.9 8763.6 8816.8 8831.4 11651.0 11689.6 12022.3 12025.7 12080.7 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#3] mootools.html Cycles:180 Average:7094.15 Median:4034.73 stddev:4448.29 (110.3%) stddev-sans-first:4438.67 05:51:50 INFO - PID 2614 | Values: 1193.9 1445.5 1460.6 1461.6 1474.4 9397.4 11340.3 11853.7 11895.6 12267.3 11707.5 11796.8 11911.5 11916.7 11932.6 2543.3 2574.7 2578.3 2581.8 2591.4 2481.2 2527.1 2537.6 2537.7 2537.9 2479.7 2503.9 2529.1 2542.6 2551.7 2157.6 2490.3 2521.3 2523.5 2527.9 2431.4 2486.2 2500.3 2505.6 2550.7 11663.2 11668.0 11797.1 11798.4 11804.9 6521.5 6742.1 6787.7 6793.7 6799.3 3904.4 4165.1 4265.9 4269.7 4277.6 1275.9 1283.4 1300.9 1308.5 1320.7 14851.2 15349.2 16453.4 16571.8 16579.2 4446.0 5405.2 5640.0 5671.3 5674.7 10563.9 11098.9 11989.0 11998.8 12004.7 6490.0 6559.8 6566.0 6570.7 6572.6 6057.4 6063.2 6116.8 6180.2 6221.6 3832.4 4284.1 4298.4 4490.3 4506.6 1253.3 1260.7 1278.6 1280.7 1284.0 805.0 809.6 831.7 837.2 863.0 4954.7 6201.1 6315.0 6358.0 6546.6 471.9 571.3 596.5 609.7 613.8 4451.3 4495.0 4513.1 4647.2 4773.8 14877.0 14954.2 15080.2 15183.0 15243.8 12031.7 14406.9 14755.9 15067.8 15094.7 7322.9 8585.1 8674.0 8694.0 8697.4 6236.7 7159.4 7306.8 7356.9 7411.4 13138.0 13194.9 13335.7 13422.2 13702.7 11345.3 13619.8 13646.1 13922.2 14049.5 9195.0 9420.2 9454.3 9495.3 9519.7 10798.2 11078.6 11081.1 11089.7 11098.4 9072.5 9183.4 9291.7 9297.2 9341.2 8988.8 9092.7 9102.8 9114.7 9188.8 8237.4 8378.8 8414.4 8420.0 8425.6 6078.0 6092.2 6177.3 6205.4 6278.9 6128.4 6232.9 6312.7 6361.7 6457.4 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#4] prototype.html Cycles:180 Average:5397.26 Median:6190.85 stddev:1729.66 (27.9%) stddev-sans-first:1693.55 05:51:50 INFO - PID 2614 | Values: 412.0 414.5 415.5 421.4 426.7 5629.5 5857.4 6092.3 6280.6 6443.7 5073.8 5174.0 6062.4 6224.9 6282.5 4326.2 4442.2 4545.4 4569.1 4741.0 4546.8 4558.2 4568.3 4575.8 4583.4 4128.0 4539.5 4539.9 4547.9 4556.8 4047.0 4401.2 4509.8 4512.1 4521.3 3818.9 3836.0 3837.6 3847.7 3849.4 6175.0 6195.0 6197.1 6218.0 6241.7 5348.5 5349.6 5359.6 5414.9 5422.5 5936.7 6250.7 6352.8 6602.4 6629.1 4183.0 4354.8 4372.5 4387.0 4410.6 6964.3 7034.3 7188.4 7197.6 7241.1 3673.0 4387.4 4397.9 4441.1 4468.1 4134.8 4432.3 4517.2 4518.4 4520.6 4562.8 5325.1 5357.2 5382.0 5394.8 6378.6 6761.0 6762.8 6767.2 6770.6 1515.9 1523.3 1527.9 1529.6 1536.2 869.5 978.7 981.4 990.4 1006.1 5226.5 6362.7 6414.9 6439.9 6459.6 5844.5 6170.7 7022.4 7104.5 7114.5 5763.7 5898.9 6414.8 6431.7 6443.7 3608.4 3635.5 3638.3 3679.6 3687.2 6035.4 6811.5 7187.4 7194.3 7209.5 5531.4 7197.6 7204.1 7204.5 7239.6 6038.5 6199.8 7154.9 7235.5 7300.8 5501.0 7005.3 7062.6 7063.6 7181.2 5105.2 6266.5 6509.4 6930.6 6935.6 6513.9 6522.4 6888.8 7086.0 7282.9 4399.9 4415.7 4424.4 4428.2 4439.9 6836.6 6971.3 7028.9 7054.8 7093.3 5983.0 6186.8 6766.4 6790.1 6794.7 6589.0 6697.3 6702.2 6791.2 6796.5 6225.8 6619.3 6634.0 6644.4 6689.3 6595.3 6738.0 6816.4 6843.5 6878.2 6586.9 6588.2 6614.4 6627.8 6654.4 05:51:50 INFO - PID 2614 | 05:51:50 INFO - PID 2614 | [#5] yui.html Cycles:180 Average:20637.50 Median:18220.18 stddev:29189.52 (160.2%) stddev-sans-first:29233.08 05:51:50 INFO - PID 2614 | Values: 718.5 772.8 815.9 854.4 859.5 16569.3 16738.3 17037.0 18214.2 19383.1 17958.0 18226.2 18339.2 18454.6 18599.6 945.0 992.0 998.7 1000.1 1002.0 914.3 1009.8 1015.2 1017.0 1027.1 1055.6 1066.1 1069.3 1071.2 1071.6 1048.0 1052.9 1066.0 1067.0 1071.2 668.0 761.9 777.7 792.8 794.4 14478.1 16728.7 16824.2 17413.1 17690.7 16511.7 16918.3 16989.4 17189.7 17288.6 13630.5 13875.6 14040.2 14130.9 14216.5 3586.4 3615.6 3619.1 3621.3 3631.6 110312.0 110830.0 111840.4 113219.0 113284.0 13496.8 13592.9 13778.1 13806.4 13836.0 24494.8 24763.0 25183.5 25445.9 25464.5 6394.6 7976.7 8018.5 8027.9 8035.5 3841.9 3876.3 3905.7 3943.4 3945.5 4215.5 4317.4 4409.9 4468.5 4475.7 926.2 949.2 963.5 968.8 973.0 645.9 658.5 660.2 674.5 687.6 11218.7 11642.3 11952.2 11995.2 12193.8 662.1 664.3 671.1 677.4 690.3 5396.1 5500.7 5544.3 5635.0 5680.1 102943.5 104040.0 104886.5 105602.5 106859.9 66309.0 92966.1 94056.0 95332.5 96215.5 72340.3 84259.6 84813.6 84867.6 85905.7 10415.5 11271.7 11318.4 11364.0 11571.6 35076.3 36121.9 36854.8 37376.4 37451.6 43872.8 45871.8 47336.3 48595.0 49350.8 13770.6 14057.0 14353.2 14494.4 14531.5 12714.4 15360.3 15694.5 15952.8 15957.7 12396.9 14227.6 14412.8 14518.7 14631.4 14277.5 14312.5 14624.3 14773.0 14850.6 14014.6 14107.2 14160.6 14212.0 14228.6 9782.9 9831.1 9883.3 9980.9 10362.2 8018.4 11297.5 11408.6 11425.1 11550.7 05:51:50 INFO - PID 2614 | -------- Summary: end -------- 05:51:50 INFO - PID 2614 | 05:51:50 INFO - TEST-INFO | 2614: exit 0 05:51:50 INFO - TEST-OK | dromaeo_css | took 1114851ms 05:51:50 INFO - TEST-START | kraken 05:51:50 INFO - operating with platform_type : mac_ 05:51:50 INFO - Initialising browser for kraken test... 05:51:50 INFO - TEST-INFO | started process 2621 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpcNtiFU/profile http://localhost:61110/getInfo.html) 05:51:54 INFO - PID 2621 | 2017-05-02 05:51:54.079 plugin-container[2622:38778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 05:51:54 INFO - PID 2621 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:54 INFO - PID 2621 | 2017-05-02 05:51:54.079 plugin-container[2622:38778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:51:54 INFO - PID 2621 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:54 INFO - PID 2621 | 2017-05-02 05:51:54.079 plugin-container[2622:38778] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:51:54 INFO - PID 2621 | __metrics Screen width/height:1600/1200 05:51:54 INFO - PID 2621 | colorDepth:24 05:51:54 INFO - PID 2621 | Browser inner width/height: 1024/689 05:51:54 INFO - PID 2621 | __metrics 05:51:55 INFO - TEST-INFO | 2621: exit 0 05:51:55 INFO - Browser initialized. 05:51:55 INFO - Running cycle 1/1 for kraken test... 05:51:55 INFO - TEST-INFO | started process 2623 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpcNtiFU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:57 INFO - PID 2623 | 2017-05-02 05:51:57.848 plugin-container[2624:38906] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x974b, name = 'com.apple.tsm.portname' 05:51:57 INFO - PID 2623 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:57 INFO - PID 2623 | 2017-05-02 05:51:57.850 plugin-container[2624:38906] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d17, name = 'com.apple.CFPasteboardClient' 05:51:57 INFO - PID 2623 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:57 INFO - PID 2623 | 2017-05-02 05:51:57.850 plugin-container[2624:38906] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:52:07 INFO - PID 2623 | RSS: Main: 235208704 05:52:07 INFO - PID 2623 | 05:52:10 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61110/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:11 INFO - PID 2623 | RSS: Main: 248676352 05:52:11 INFO - PID 2623 | 05:52:13 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61110/tests/kraken/driver.html?testName=audio-dft) 05:52:14 INFO - PID 2623 | RSS: Main: 256761856 05:52:14 INFO - PID 2623 | 05:52:17 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61110/tests/kraken/driver.html?testName=audio-fft) 05:52:18 INFO - PID 2623 | RSS: Main: 258953216 05:52:18 INFO - PID 2623 | 05:52:20 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61110/tests/kraken/driver.html?testName=audio-oscillator) 05:52:21 INFO - PID 2623 | RSS: Main: 260202496 05:52:21 INFO - PID 2623 | 05:52:23 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:23 INFO - PID 2623 | RSS: Main: 260726784 05:52:23 INFO - PID 2623 | 05:52:26 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61110/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:27 INFO - PID 2623 | RSS: Main: 265854976 05:52:27 INFO - PID 2623 | 05:52:30 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61110/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:30 INFO - PID 2623 | RSS: Main: 267026432 05:52:30 INFO - PID 2623 | 05:52:33 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61110/tests/kraken/driver.html?testName=json-parse-financial) 05:52:34 INFO - PID 2623 | RSS: Main: 266616832 05:52:34 INFO - PID 2623 | 05:52:35 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:36 INFO - PID 2623 | RSS: Main: 266133504 05:52:36 INFO - PID 2623 | 05:52:38 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:38 INFO - PID 2623 | RSS: Main: 267440128 05:52:38 INFO - PID 2623 | 05:52:40 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:41 INFO - PID 2623 | RSS: Main: 267210752 05:52:41 INFO - PID 2623 | 05:52:44 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:45 INFO - PID 2623 | RSS: Main: 267513856 05:52:45 INFO - PID 2623 | 05:52:48 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:48 INFO - PID 2623 | RSS: Main: 267550720 05:52:48 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | Cycle 1(1): loaded http://localhost:61110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61110/tests/kraken/driver.html?testName=ai-astar) 05:52:50 INFO - PID 2623 | RSS: Main: 269127680 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | __start_tp_report 05:52:50 INFO - PID 2623 | _x_x_mozilla_page_load 05:52:50 INFO - PID 2623 | _x_x_mozilla_page_load_details 05:52:50 INFO - PID 2623 | |i|pagename|runs| 05:52:50 INFO - PID 2623 | |0;ai-astar;103;115;114;115;113;115;115;113;118;115 05:52:50 INFO - PID 2623 | |1;audio-beat-detection;141;125;145;185;105;111;111;109;142;135 05:52:50 INFO - PID 2623 | |2;audio-dft;199;204;211;225;262;278;210;197;200;196 05:52:50 INFO - PID 2623 | |3;audio-fft;75;55;62;86;58;58;58;50;87;85 05:52:50 INFO - PID 2623 | |4;audio-oscillator;84;72;84;72;72;72;86;68;70;87 05:52:50 INFO - PID 2623 | |5;imaging-gaussian-blur;91;90;90;87;90;90;93;102;137;90 05:52:50 INFO - PID 2623 | |6;imaging-darkroom;97;97;99;97;96;96;96;97;97;97 05:52:50 INFO - PID 2623 | |7;imaging-desaturate;96;94;90;91;94;91;91;91;93;92 05:52:50 INFO - PID 2623 | |8;json-parse-financial;48;48;49;52;51;52;50;50;51;49 05:52:50 INFO - PID 2623 | |9;json-stringify-tinderbox;57;63;58;64;66;59;58;59;57;58 05:52:50 INFO - PID 2623 | |10;stanford-crypto-aes;83;79;86;83;81;83;83;84;86;85 05:52:50 INFO - PID 2623 | |11;stanford-crypto-ccm;158;156;159;138;145;158;157;140;188;149 05:52:50 INFO - PID 2623 | |12;stanford-crypto-pbkdf2;188;187;185;183;187;180;189;185;182;188 05:52:50 INFO - PID 2623 | |13;stanford-crypto-sha256-iterative;68;71;69;68;65;67;67;67;69;72 05:52:50 INFO - PID 2623 | __end_tp_report 05:52:50 INFO - PID 2623 | __start_cc_report 05:52:50 INFO - PID 2623 | _x_x_mozilla_cycle_collect,981 05:52:50 INFO - PID 2623 | __end_cc_report 05:52:50 INFO - PID 2623 | __startTimestamp1493729570805__endTimestamp 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | ------- Summary: start ------- 05:52:50 INFO - PID 2623 | Number of tests: 14 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.98 (3.5%) stddev-sans-first:1.48 05:52:50 INFO - PID 2623 | Values: 103.0 115.0 114.0 115.0 113.0 115.0 115.0 113.0 118.0 115.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:138.00 stddev:24.37 (17.7%) stddev-sans-first:25.57 05:52:50 INFO - PID 2623 | Values: 141.0 125.0 145.0 185.0 105.0 111.0 111.0 109.0 142.0 135.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#2] audio-dft Cycles:10 Average:218.20 Median:210.50 stddev:28.87 (13.7%) stddev-sans-first:29.78 05:52:50 INFO - PID 2623 | Values: 199.0 204.0 211.0 225.0 262.0 278.0 210.0 197.0 200.0 196.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#3] audio-fft Cycles:10 Average:67.40 Median:68.50 stddev:14.33 (20.9%) stddev-sans-first:14.93 05:52:50 INFO - PID 2623 | Values: 75.0 55.0 62.0 86.0 58.0 58.0 58.0 50.0 87.0 85.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:7.51 (9.6%) stddev-sans-first:7.49 05:52:50 INFO - PID 2623 | Values: 84.0 72.0 84.0 72.0 72.0 72.0 86.0 68.0 70.0 87.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:90.00 stddev:14.95 (16.6%) stddev-sans-first:15.75 05:52:50 INFO - PID 2623 | Values: 91.0 90.0 90.0 87.0 90.0 90.0 93.0 102.0 137.0 90.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 05:52:50 INFO - PID 2623 | Values: 97.0 97.0 99.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:92.50 stddev:1.89 (2.0%) stddev-sans-first:1.45 05:52:50 INFO - PID 2623 | Values: 96.0 94.0 90.0 91.0 94.0 91.0 91.0 91.0 93.0 92.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.50 stddev:1.49 (3.0%) stddev-sans-first:1.39 05:52:50 INFO - PID 2623 | Values: 48.0 48.0 49.0 52.0 51.0 52.0 50.0 50.0 51.0 49.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.00 stddev:3.21 (5.4%) stddev-sans-first:3.23 05:52:50 INFO - PID 2623 | Values: 57.0 63.0 58.0 64.0 66.0 59.0 58.0 59.0 57.0 58.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:2.16 (2.6%) stddev-sans-first:2.29 05:52:50 INFO - PID 2623 | Values: 83.0 79.0 86.0 83.0 81.0 83.0 83.0 84.0 86.0 85.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:157.50 stddev:14.05 (8.9%) stddev-sans-first:14.86 05:52:50 INFO - PID 2623 | Values: 158.0 156.0 159.0 138.0 145.0 158.0 157.0 140.0 188.0 149.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:187.00 stddev:2.95 (1.6%) stddev-sans-first:2.98 05:52:50 INFO - PID 2623 | Values: 188.0 187.0 185.0 183.0 187.0 180.0 189.0 185.0 182.0 188.0 05:52:50 INFO - PID 2623 | 05:52:50 INFO - PID 2623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.06 (3.0%) stddev-sans-first:2.18 05:52:50 INFO - PID 2623 | Values: 68.0 71.0 69.0 68.0 65.0 67.0 67.0 67.0 69.0 72.0 05:52:50 INFO - PID 2623 | -------- Summary: end -------- 05:52:50 INFO - PID 2623 | 05:52:51 INFO - TEST-INFO | 2623: exit 0 05:52:51 INFO - TEST-OK | kraken | took 60962ms 05:52:51 INFO - SUITE-END | took 1175s 05:52:51 INFO - Completed test suite (00:19:35) 05:52:51 INFO - javascript benchmark 05:52:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7815.617167956525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3050.420420120177, 3613.476045973334, 3664.0473476896, 3670.7797532148074, 3698.0569954661555, 5158.974205128974, 6172.413620706037, 6298.779542716006, 6333.20834895638, 6363.936360636392, 6243.56295059346, 6255.249370075586, 6328.810135695937, 6329.1772069631, 6389.169407976968, 4646.977664913714, 5350.0, 5513.476219759116, 5515.503604675579, 5545.251391062216, 4531.841385551506, 5527.060399732035, 5611.3546942101775, 5632.662040277576, 5647.491725744682, 5381.650192737498, 5478.808241711561, 5510.752016159283, 5587.441255874421, 5620.690862002588, 5412.323459567554, 5435.374931882805, 5457.617966742329, 5498.1752737089755, 5569.721513924287, 5499.917501237484, 5513.641613295123, 5543.1408131739645, 5550.972245138789, 5569.164625306196, 6110.63336199825, 6305.621662700207, 6313.210848643919, 6333.46165575922, 6343.238811342622, 6535.117759102508, 6753.561018533779, 6823.897641535381, 6825.1127353444235, 6841.281665425108, 6644.568103073333, 6853.725850965955, 6955.582665040114, 6956.582605043663, 6964.4428445724225, 6407.455366293824, 6462.063000864942, 6468.094466774655, 6472.514561407913, 6499.122618446449, 7025.083887179902, 7078.469114816409, 7091.574505529685, 7111.217766045731, 7112.075430194145, 6024.427679370453, 6326.734653069405, 6393.6163830170335, 6551.148350714377, 6740.4270636995425, 6045.486133678599, 6770.661466926733, 6795.286494918061, 6805.727770889208, 6808.557443766139, 6639.834004149935, 6684.16447944007, 6728.629925354153, 6735.528513004043, 6746.291639377893, 5518.944810551923, 6290.119383286344, 6374.394432528902, 6720.8319792005595, 6785.762498312634, 5375.3280839895015, 5413.945860541423, 5417.729113544386, 5419.972900135474, 5444.945550544444, 4730.739809310521, 4823.0, 4830.492798256132, 4833.4441539222735, 4869.245266983623, 4667.0, 6346.333634968354, 6368.4586810121655, 6403.519736019817, 6450.6774661266745, 6883.862322753617, 6894.551854129466, 6925.376716095576, 6951.5481493703755, 6956.165260168812, 6421.486281097501, 6422.165118534561, 6422.839429014219, 6423.42189202974, 6426.0, 5814.941850581525, 5890.617109887844, 6021.337652858182, 6077.3314935357075, 6093.025115981422, 6063.908496470678, 6872.725090996404, 7041.260667629826, 7093.609851458013, 7132.714691412493, 6634.270230274762, 6753.358430949052, 6844.726210951506, 6854.862902741817, 6877.1747390313485, 6914.412274956685, 6999.545029573062, 7047.154341479055, 7143.178534468602, 7153.248908864494, 6190.7214175363115, 6527.184101987252, 6554.80335589933, 6821.420179284816, 6848.520603557703, 6725.8991115134295, 6838.521303508706, 6840.931590684029, 6942.8611427772175, 6948.930510694829, 6656.73373065072, 6670.533062685759, 6691.498137639794, 6703.765368212089, 6717.429018533479, 6662.100616416722, 6688.7324507019175, 6706.731730730716, 6712.832179195364, 6719.899201512079, 6202.0, 6349.0, 6441.677916104082, 6474.935250647622, 6514.73941042353, 6623.834404139935, 6624.436922861418, 6634.402903738686, 6669.032990216295, 6690.83272918181, 4995.925061124159, 6480.351964803482, 6489.480841532761, 6499.350064993463, 6517.9348206517325], "value": 6161.804552867903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7108507799106, 757.1860250231003, 811.5860910935423, 1206.0592737664613, 1252.067209928602, 36686.89939301822, 37530.24939501212, 37564.248715025715, 37609.435858462144, 37668.43497347542, 37612.05969850755, 37823.81088094556, 37855.0, 37893.052673683174, 37941.43087853684, 7830.412719046066, 7998.360131189491, 8262.669493220264, 8474.915250847474, 8502.489850608952, 8433.072362040171, 8515.489070655749, 8529.360297977646, 8537.658493660247, 8584.527850968194, 8490.150984901522, 8555.828883422328, 8557.614907329154, 8573.95713021434, 8575.742727718178, 8477.10990346011, 8507.829843403128, 8528.914710852874, 8540.999999999969, 8545.829083418297, 8234.629441675139, 8305.37709671771, 8305.584720763938, 8320.417570770049, 8326.167383261685, 29354.70645293541, 36457.0, 36525.08687282839, 36650.083747906516, 36820.63179368199, 3627.3470775260444, 3679.816009199556, 3681.263747250534, 3682.429223470366, 3686.3733165361955, 30109.397812043855, 30424.695753042408, 30516.542251866238, 30523.542146867814, 30604.469776511087, 3155.1165673611426, 3189.1070500259966, 3207.5028370602595, 3227.080282119608, 3238.6923242291946, 243621.0, 247568.0, 270508.0, 271873.64063179557, 281725.5913720439, 46842.06315873664, 47140.7642961783, 47178.0, 47249.0, 47303.763481182374, 48798.51201488011, 49072.509274907505, 49249.0, 49301.75349123303, 49331.013379732205, 11471.483783229774, 12784.872151278369, 13260.07179497426, 14258.928705356408, 14296.57110286693, 11654.825177622342, 11677.591284305008, 11678.941605291919, 11684.70788230301, 11744.060475161967, 13003.869961300456, 13211.14127581704, 13215.933920330337, 13243.536476223479, 13351.265680387673, 5918.733656985446, 5920.31916329619, 5936.673482958478, 5947.970260148758, 5961.165436838846, 1031.896810318962, 1033.9844902326472, 1042.2287507244585, 1067.4876059491332, 1084.5228099636136, 23377.649335259986, 24281.514369712506, 24568.508629827662, 24662.136825211033, 24698.382540436633, 992.3103443106971, 1133.6769020829024, 1179.2334982261427, 1185.7747028064641, 1191.7318603314186, 12605.369731513387, 12622.936885315698, 12623.93688031554, 12666.050046246568, 12722.936385318199, 314462.0, 318349.0, 320859.0, 320929.0, 321359.0, 52973.470265296855, 53492.73253633785, 53709.0, 53780.731096344265, 53845.730771345894, 1437.2813593203398, 1501.2568778454518, 1502.9549113526612, 1525.054466230966, 1572.2138930534732, 24105.0, 24142.0, 24264.63603045991, 24302.87848560746, 24345.26964191077, 37781.622183777814, 37813.05467363338, 37895.81052094722, 37927.62072379241, 37935.62064379431, 287071.0, 288255.55872220505, 290122.0, 290244.0, 290440.0, 29405.55891661584, 29842.104736857927, 32648.51027234546, 33664.15839604029, 33882.8305858479, 42735.3589696161, 43489.0, 44583.77708111569, 44763.55236447594, 44814.3277850826, 29283.85358073196, 29572.0, 30367.696323036485, 30584.08247752571, 30809.845950771, 29616.555751663313, 29655.85172074126, 30384.696153038185, 30434.934777282688, 30748.231294217825, 36267.81866090652, 36332.45501317535, 36457.63542364648, 36537.0, 36552.90341289766, 25634.359141021625, 25779.355516112246, 28476.715232848233, 30664.0, 30937.0718878434, 21726.45683857916, 23415.531689365776, 24072.638910416706, 24261.49257281013, 24518.14186503464], "value": 17347.236957342186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.3318891074085, 436.971596846205, 439.59776804224134, 445.98983302819113, 460.2796623284559, 19271.903640481796, 21005.054772535233, 21577.0, 21798.89100554497, 21863.562728745415, 21535.6769648455, 21909.0, 22234.777652223474, 22261.109555617757, 22271.109155633756, 5857.355690874, 6111.816645500642, 6119.082137679339, 6119.3574674659185, 6123.8162855114415, 5698.344690360599, 5963.373845746178, 5971.581989260753, 6045.969770151165, 6046.818595442144, 5792.82621521355, 5938.673372964486, 5978.671173085479, 6004.699765011754, 6006.879862402771, 5805.303363596353, 5941.346451890288, 5952.0, 5966.3138739045135, 5968.31364393096, 5113.258577506278, 5305.991861546294, 5306.257124002643, 5317.46825317469, 5328.014317351302, 25818.0, 25833.354166145808, 25898.35254118662, 25939.481210375874, 26156.953721851103, 2119.724435823333, 2146.3453646637768, 2164.404788683109, 2178.041661668861, 2179.455136215946, 16802.411915582896, 16871.493855184362, 16978.575535611584, 17157.142142892804, 17290.91354543232, 1702.770126032982, 2096.916123355064, 2121.618108740426, 2145.774693657175, 2147.259195577539, 144544.0, 145279.2736036313, 146014.0, 146307.0, 156428.2178589111, 11846.111541634413, 12355.505779768708, 12389.442475088643, 12460.252384856938, 12493.500259989498, 13261.0, 14158.929205354114, 15897.761533577006, 15914.442994495368, 15924.363025478851, 8680.609372578248, 8931.330150238759, 8957.417767845069, 9030.729078127666, 9102.86345704815, 8577.923213348888, 8622.439541429912, 8632.568371581521, 8724.0, 8855.60149793248, 6289.874202516015, 7712.151663317143, 7817.0, 7859.685612575433, 7887.723929662434, 2237.966430503544, 2247.550489902026, 2254.3011666383472, 2261.7172853393326, 2430.805535557151, 873.2315562305131, 983.409954027592, 991.375433476905, 994.7712026234007, 1023.8617786598862, 20067.0, 20314.796852031584, 20314.882681452367, 20456.897715511328, 20722.274720384714, 1027.6454623155, 1030.340582027503, 1052.921030922684, 1056.746380868586, 1059.0838924330399, 10247.282690211763, 10485.475726213659, 10492.475376231157, 10529.894701053045, 10534.473276336306, 480032.79950800765, 538805.0, 542955.0, 546755.0, 549431.0, 96114.0, 119625.20562191574, 120451.0, 121325.18012229823, 122874.0, 1184.5853951117213, 1193.0634451955173, 1196.3061424373843, 1213.6905089202373, 1214.0833670578656, 17635.0, 17692.646147077245, 17777.555561111076, 17802.198901049742, 17937.282508699507, 56345.71827140838, 56350.718246408505, 56820.71589642025, 56860.715696421255, 56925.71537142288, 72226.55546888927, 72986.85722852303, 73996.52006959938, 74190.62904685442, 75468.62265688636, 7091.432685385053, 8399.916000839914, 8729.563521823757, 8764.123587641185, 8916.86624700617, 13522.18866867991, 13566.86433135656, 13698.931505342409, 13958.930205349314, 13968.161910285415, 11706.590269340531, 11802.403471236314, 11928.701782455508, 12003.879961200277, 12100.394980251129, 10163.7459063524, 10696.304740191863, 10838.349699017768, 10967.616133435291, 11114.888851111386, 11575.363355015555, 11937.28376297425, 12073.464572439534, 12137.939310303393, 12139.939300303442, 7350.338469537767, 8567.914320856711, 8763.649454021768, 8816.779580510538, 8831.425957312755, 11651.0, 11689.649310520697, 12022.27866328023, 12025.654997275447, 12080.697982550506], "value": 10201.864850733768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.9462724177413, 1445.508527100785, 1460.5691321060285, 1461.5980605333532, 1474.3586539855164, 9397.436153830775, 11340.319580825146, 11853.703657408569, 11895.643130706081, 12267.325297108655, 11707.473163707633, 11796.82304765427, 11911.463984120714, 11916.702082447942, 11932.64202073937, 2543.2751665775213, 2574.691037075544, 2578.265194419591, 2581.7547333003336, 2591.3780692633823, 2481.2308184462786, 2527.128140791424, 2537.606670966003, 2537.6701028866223, 2537.860417677027, 2479.710550513732, 2503.8748062596887, 2529.051605647882, 2542.580474221751, 2551.655526503917, 2157.6439887418555, 2490.3027152397267, 2521.3066406738203, 2523.470071285032, 2527.8609676467786, 2431.367844360479, 2486.2168416948784, 2500.3374105861963, 2505.649209110708, 2550.744925507453, 11663.183577149603, 11668.0, 11797.056235501139, 11798.41007949599, 11804.93755561995, 6521.543491955565, 6742.145909874775, 6787.72849086036, 6793.728250869959, 6799.320067993211, 3904.39481880309, 4165.062860856283, 4265.914681706379, 4269.67977401693, 4277.636400905927, 1275.8915492183176, 1283.4096315694792, 1300.8829205371467, 1308.5485507499993, 1320.7094439223356, 14851.183184924825, 15349.155796431192, 16453.42413015551, 16571.768505141503, 16579.17104144788, 4445.977770111129, 5405.162199859028, 5639.984802735465, 5671.319441666944, 5674.744636491368, 10563.94718026405, 11098.892310153171, 11988.98093662031, 11998.820017699742, 12004.699882502833, 6490.0, 6559.8032059038305, 6566.047923051131, 6570.671466426755, 6572.6056436613, 6057.42454466825, 6063.204922365024, 6116.755329786759, 6180.227471566054, 6221.564490485713, 3832.4442955771256, 4284.057507348379, 4298.3552467130185, 4490.3040028795585, 4506.571875671806, 1253.254313683357, 1260.7163388237757, 1278.6419802455327, 1280.692633767889, 1283.9679008024686, 804.9597520123971, 809.6356639512243, 831.7130589946458, 837.1837458477935, 862.9913700863036, 4954.653174277838, 6201.10084037812, 6315.0, 6358.0, 6546.639934803631, 471.9315699223662, 571.2744814086087, 596.4661627843057, 609.6799180430221, 613.8404014956144, 4451.287793952952, 4494.977525112354, 4513.142502924499, 4647.233206520954, 4773.785179666923, 14877.0, 14954.177520236492, 15080.170590617621, 15183.0, 15243.847561524464, 12031.699207519707, 14406.855931440761, 14755.852441475448, 15067.773983390258, 15094.698106037818, 7322.890156647654, 8585.098564650621, 8673.956630216808, 8693.956530217434, 8697.434666746642, 6236.656983865931, 7159.427245820218, 7306.817329566591, 7356.926430735838, 7411.4070874331, 13138.014648901179, 13194.934025329812, 13335.66660833487, 13422.194668319931, 13702.65743356424, 11345.319280843176, 13619.79570306466, 13646.113002654796, 13922.164670119826, 14049.524799896273, 9195.0, 9420.152186303265, 9454.290928180551, 9495.335326527076, 9519.714408567754, 10798.190135739695, 11078.612248571262, 11081.058110060736, 11089.722756931142, 11098.445077746243, 9072.50101244438, 9183.448993060438, 9291.67479138227, 9297.209737172145, 9341.159295663423, 8988.775280617776, 9092.727218183465, 9102.772430689285, 9114.680986165453, 9188.770280743034, 8237.382196335178, 8378.790530236549, 8414.410991230556, 8419.95790021046, 8425.578721064045, 6078.0, 6092.208012958287, 6177.2587289525545, 6205.379462053939, 6278.937210628018, 6128.448439640454, 6232.940400132079, 6312.747490100344, 6361.650109244036, 6457.418832305115], "value": 5334.725926722821, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.9979400103, 414.48092740107506, 415.48894859323053, 421.4373810962365, 426.69278119753784, 5629.465200805922, 5857.3849745776715, 6092.268927728668, 6280.623162610241, 6443.742250309993, 5073.771680274387, 5174.0, 6062.42406971337, 6224.906626400608, 6282.465990390822, 4326.156399502099, 4442.2004039272915, 4545.3637090327775, 4569.126658070192, 4740.952590474103, 4546.772661366935, 4558.247889098295, 4568.314752787075, 4575.839845605405, 4583.449986001685, 4127.979360103211, 4539.45526536816, 4539.931901021488, 4547.909041819162, 4556.794944227501, 4047.028713108862, 4401.163778882018, 4509.7970591323465, 4512.075024619945, 4521.321801729734, 3818.8663396781258, 3835.983464381941, 3837.57786643469, 3847.6537111660086, 3849.441830934527, 6174.969125154345, 6194.955664630661, 6197.101420294032, 6218.0, 6241.7191226394925, 5348.545373643206, 5349.5720342372515, 5359.598030147716, 5414.864628384283, 5422.481705122533, 5936.684692969745, 6250.718717657671, 6352.824727425441, 6602.420954293614, 6629.138212032453, 4182.958170418287, 4354.825806967718, 4372.519022907478, 4386.978065109686, 4410.62509686677, 6964.2589352661835, 7034.261402552761, 7188.424926005907, 7197.640117994079, 7241.131064272268, 3672.9532083356116, 4387.407699960529, 4397.912041759211, 4441.1347234161085, 4468.061707041557, 4134.793260337031, 4432.312991486325, 4517.164324599959, 4518.385291766574, 4520.638348932078, 4562.771861406916, 5325.068113080273, 5357.223202635596, 5382.03123437785, 5394.811181608703, 6378.553501254868, 6761.0, 6762.83092922671, 6767.172863326874, 6770.559913605698, 1515.9393624254906, 1523.2688309611449, 1527.8701310388742, 1529.6023034011237, 1536.216529569905, 869.517417833096, 978.7406337320616, 981.4405788700373, 990.3711143423977, 1006.1196453103535, 5226.477352264819, 6362.727454509117, 6414.871702566016, 6439.871202575922, 6459.61242325462, 5844.486870645578, 6170.691465426711, 7022.40309573692, 7104.538205016657, 7114.50198486101, 5763.682997435181, 5898.941010589925, 6414.775482858077, 6431.742730290736, 6443.74712689632, 3608.386574282378, 3635.473101297461, 3638.3450978824067, 3679.6136405677016, 3687.170386663033, 6035.426634469718, 6811.523193376416, 7187.38907192884, 7194.316539928698, 7209.5127181122425, 5531.446855314436, 7197.568145911262, 7204.135503739585, 7204.495685302083, 7239.601821899741, 6038.516918646497, 6199.845003874939, 7154.892676609855, 7235.529690570096, 7300.817479563053, 5501.0, 7005.334493223136, 7062.576245425291, 7063.611501367474, 7181.245969173162, 5105.1576489880235, 6266.480223731449, 6509.414152726088, 6930.584164950119, 6935.618540980093, 6513.902291465726, 6522.412982831568, 6888.827779305558, 7085.964570177116, 7282.927170728225, 4399.868003959887, 4415.668824838086, 4424.358468022055, 4428.2029234736765, 4439.8890027748275, 6836.555623884432, 6971.337722916315, 7028.929710702828, 7054.788356349318, 7093.32613401726, 5983.0, 6186.752529898934, 6766.391024807791, 6790.117284752951, 6794.694238759169, 6588.978708300221, 6697.292190491394, 6702.162229721285, 6791.2190098139345, 6796.456283497209, 6225.782097626561, 6619.3380661933425, 6634.0, 6644.368784965421, 6689.26418094019, 6595.340465953366, 6738.0, 6816.352446517573, 6843.452523797984, 6878.174619045746, 6586.901196482152, 6588.176477940257, 6614.404703576702, 6627.801165965029, 6654.367835055662], "value": 4855.531979654824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4539749790159, 772.7758949904528, 815.8531464336417, 854.3677678517895, 859.4628357276704, 16569.254383552754, 16738.330466781328, 17037.0, 18214.180361883715, 19383.127759250834, 17958.0, 18226.179821908012, 18339.17473713683, 18454.630907381845, 18599.628007439842, 945.031342873555, 992.0129471176153, 998.6804222648756, 1000.0999100809294, 1002.04304888831, 914.2868562521211, 1009.8131845608549, 1015.2436434856043, 1017.0, 1027.0807627173674, 1055.5619417941546, 1066.141755886511, 1069.3423544520103, 1071.201954543862, 1071.608862765093, 1048.0, 1052.8683914510686, 1066.0139371081757, 1066.99466502667, 1071.1591400750374, 667.9713241607918, 761.8742907420269, 777.747232149548, 792.7859477940981, 794.4161041634394, 14478.058926169871, 16728.66542669152, 16824.15879206047, 17413.12934353277, 17690.734638980426, 16511.669766604722, 16918.323267069303, 16989.405370812085, 17189.656206875916, 17288.56778580533, 13630.454781808816, 13875.583732488041, 14040.157590544497, 14130.858691413057, 14216.502422415166, 3586.372384832644, 3615.620359862203, 3619.059044648384, 3621.257642183346, 3631.618680038611, 110312.0, 110830.0, 111840.4407977963, 113219.0, 113284.0, 13496.797548036788, 13592.93203533976, 13778.104423212659, 13806.447742090404, 13836.0, 24494.775261236868, 24763.009479620614, 25183.496330073296, 25445.8549365279, 25464.490710186063, 6394.616323020634, 7976.7208147714555, 8018.518888866687, 8027.879581806277, 8035.517868927883, 3841.9231615367535, 3876.341022026262, 3905.6875449963936, 3943.408488726714, 3945.467361906106, 4215.536291007987, 4317.352397140391, 4409.867703968886, 4468.486124095705, 4475.731456112644, 926.1942110364026, 949.2074118111316, 963.5134257200069, 968.7723385004518, 973.0, 645.9192600924885, 658.5094104891887, 660.181375094879, 674.4638012779753, 687.6183718036438, 11218.66344009681, 11642.301461912313, 11952.223105498115, 11995.220310679779, 12193.817092743617, 662.1160750398273, 664.3091185167468, 671.1074271219267, 677.3632785181914, 690.326931242045, 5396.109641909119, 5500.697461639648, 5544.251526043932, 5635.0, 5680.091185410314, 102943.4852825746, 104040.0, 104886.47556762167, 105602.47198763957, 106859.931400685, 66309.00536491956, 92966.07033929574, 94056.0, 95332.52333738287, 96215.51892240494, 72340.2765972344, 84259.57870210732, 84813.57593211994, 84867.57566212253, 85905.69801566812, 10415.479226038517, 11271.718207044889, 11318.434078296217, 11363.977242048255, 11571.594994175164, 35076.29847403089, 36121.916342509765, 36854.8157259212, 37376.439353410264, 37451.625483745906, 43872.78063609661, 45871.770641146584, 47336.34322798686, 48595.0, 49350.80518155997, 13770.586882393543, 14057.01600887928, 14353.210573418562, 14494.420223191377, 14531.491397801026, 12714.374882347858, 15360.308786104875, 15694.450694225647, 15952.760708589612, 15957.680846382775, 12396.938015309866, 14227.644308891946, 14412.783808242675, 14518.709625807636, 14631.414743410145, 14277.500287490304, 14312.499062532761, 14624.341904614104, 14773.03975241649, 14850.554483365084, 14014.64963375883, 14107.224102674041, 14160.645983850487, 14212.0, 14228.573142805732, 9782.9021709782, 9831.115199632068, 9883.30816842814, 9980.900190998287, 10362.171026317727, 8018.398620103632, 11297.548098075986, 11408.600698975495, 11425.14311426663, 11550.653480395602], "value": 8068.328807291861, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 114.0, 115.0, 113.0, 115.0, 115.0, 113.0, 118.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 125.0, 145.0, 185.0, 105.0, 111.0, 111.0, 109.0, 142.0, 135.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 204.0, 211.0, 225.0, 262.0, 278.0, 210.0, 197.0, 200.0, 196.0], "value": 218.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 55.0, 62.0, 86.0, 58.0, 58.0, 58.0, 50.0, 87.0, 85.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 84.0, 72.0, 72.0, 72.0, 86.0, 68.0, 70.0, 87.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 90.0, 87.0, 90.0, 90.0, 93.0, 102.0, 137.0, 90.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 99.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 90.0, 91.0, 94.0, 91.0, 91.0, 91.0, 93.0, 92.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 52.0, 51.0, 52.0, 50.0, 50.0, 51.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 58.0, 64.0, 66.0, 59.0, 58.0, 59.0, 57.0, 58.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 86.0, 83.0, 81.0, 83.0, 83.0, 84.0, 86.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 159.0, 138.0, 145.0, 158.0, 157.0, 140.0, 188.0, 149.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 185.0, 183.0, 187.0, 180.0, 189.0, 185.0, 182.0, 188.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 68.0, 65.0, 67.0, 67.0, 67.0, 69.0, 72.0], "value": 68.3, "unit": "score"}]}]} 05:52:52 INFO - Return code: 0 05:52:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:52 ERROR - # TBPL SUCCESS # 05:52:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:52 INFO - 2017-05-02 05:52:52.164 screenresolution[2629:39292] starting screenresolution argv=screenresolution get 05:52:52 INFO - 2017-05-02 05:52:52.166 screenresolution[2629:39292] Display 0: 1600x1200x32@60 05:52:52 INFO - 2017-05-02 05:52:52.173 screenresolution[2630:39297] starting screenresolution argv=screenresolution list 05:52:52 INFO - Available Modes on Display 0 05:52:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:52 INFO - Intel Iris: 05:52:52 INFO - Chipset Model: Intel Iris 05:52:52 INFO - Type: GPU 05:52:52 INFO - Bus: Built-In 05:52:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:52 INFO - Vendor: Intel (0x8086) 05:52:52 INFO - Device ID: 0x0a2e 05:52:52 INFO - Revision ID: 0x0009 05:52:52 INFO - Displays: 05:52:52 INFO - Display: 05:52:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:52 INFO - Display Serial Number: 1600x1200 60 05:52:52 INFO - Main Display: Yes 05:52:52 INFO - Mirror: Off 05:52:52 INFO - Online: Yes 05:52:52 INFO - Rotation: Supported 05:52:52 INFO - Return code: 0 05:52:52 INFO - Running post-action listener: _resource_record_post_action 05:52:52 INFO - [mozharness: 2017-05-02 12:52:52.422288Z] Finished run-tests step (success) 05:52:52 INFO - Running post-run listener: _resource_record_post_run 05:52:52 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 2692608; Write bytes: 511501312; Read time: 20; Write time: 1926 05:52:52 INFO - TinderboxPrint: CPU usage
54.0% 05:52:52 INFO - TinderboxPrint: I/O read bytes / time
2,692,608 / 20 05:52:52 INFO - TinderboxPrint: I/O write bytes / time
511,501,312 / 1,926 05:52:52 INFO - TinderboxPrint: CPU idle
2,201.9 (46.0%) 05:52:52 INFO - TinderboxPrint: CPU system
960.5 (20.1%) 05:52:52 INFO - TinderboxPrint: CPU user
1,623.2 (33.9%) 05:52:52 INFO - TinderboxPrint: Swap in / out
211,226,624 / 0 05:52:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 0; Write bytes: 211208192; Read time: 0; Write time: 453 05:52:52 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1758720; Write bytes: 298916864; Read time: 15; Write time: 1467 05:52:52 INFO - Running post-run listener: _upload_blobber_files 05:52:52 INFO - Blob upload gear active. 05:52:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:54 INFO - (blobuploader) - INFO - Done attempting. 05:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:55 INFO - (blobuploader) - INFO - Done attempting. 05:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:56 INFO - (blobuploader) - INFO - Done attempting. 05:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:59 INFO - (blobuploader) - INFO - Done attempting. 05:52:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:59 INFO - Return code: 0 05:52:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82194fa44a127e7ac74c919f9f3f3946deaaf5a171c057a2d18876d4496ae7979d4f197b152352bcfb84da88592dcd4f4dce071348407c67c55c4580f996a6ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51aabfb8fb88accf6a88cb8e118b32b6c0ac737179bfb7d5fd82aeb1eb66236198a1432f6887e4a0de810809743f8c5ff78b3f34b6aec524d9185eae25cd6e44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd514741458ffb94aa5330cab13f61ea9180da4b90220a5a6aff6cd67ca4c9c61679d23af0833bca1ddf0f5abb5b0d40f127c94d2a41547fd08a888af6b2b826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/493e6d8ae394d072e55264b9a89aea1a5296ea7e3836668e8fc22cab45f584e23e856eda738ad10c40a54f448b541ce3fa55a6bd73e420df21b0a958a38f3474"} 05:52:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:59 INFO - Contents: 05:52:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82194fa44a127e7ac74c919f9f3f3946deaaf5a171c057a2d18876d4496ae7979d4f197b152352bcfb84da88592dcd4f4dce071348407c67c55c4580f996a6ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51aabfb8fb88accf6a88cb8e118b32b6c0ac737179bfb7d5fd82aeb1eb66236198a1432f6887e4a0de810809743f8c5ff78b3f34b6aec524d9185eae25cd6e44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd514741458ffb94aa5330cab13f61ea9180da4b90220a5a6aff6cd67ca4c9c61679d23af0833bca1ddf0f5abb5b0d40f127c94d2a41547fd08a888af6b2b826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/493e6d8ae394d072e55264b9a89aea1a5296ea7e3836668e8fc22cab45f584e23e856eda738ad10c40a54f448b541ce3fa55a6bd73e420df21b0a958a38f3474"} 05:52:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:59 INFO - Copying logs to upload dir... 05:52:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.903256 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-02 05:52:59.412233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:59.421427) ========= 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.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/82194fa44a127e7ac74c919f9f3f3946deaaf5a171c057a2d18876d4496ae7979d4f197b152352bcfb84da88592dcd4f4dce071348407c67c55c4580f996a6ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51aabfb8fb88accf6a88cb8e118b32b6c0ac737179bfb7d5fd82aeb1eb66236198a1432f6887e4a0de810809743f8c5ff78b3f34b6aec524d9185eae25cd6e44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd514741458ffb94aa5330cab13f61ea9180da4b90220a5a6aff6cd67ca4c9c61679d23af0833bca1ddf0f5abb5b0d40f127c94d2a41547fd08a888af6b2b826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/493e6d8ae394d072e55264b9a89aea1a5296ea7e3836668e8fc22cab45f584e23e856eda738ad10c40a54f448b541ce3fa55a6bd73e420df21b0a958a38f3474"} build_url:https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011537 build_url: 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82194fa44a127e7ac74c919f9f3f3946deaaf5a171c057a2d18876d4496ae7979d4f197b152352bcfb84da88592dcd4f4dce071348407c67c55c4580f996a6ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51aabfb8fb88accf6a88cb8e118b32b6c0ac737179bfb7d5fd82aeb1eb66236198a1432f6887e4a0de810809743f8c5ff78b3f34b6aec524d9185eae25cd6e44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd514741458ffb94aa5330cab13f61ea9180da4b90220a5a6aff6cd67ca4c9c61679d23af0833bca1ddf0f5abb5b0d40f127c94d2a41547fd08a888af6b2b826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/493e6d8ae394d072e55264b9a89aea1a5296ea7e3836668e8fc22cab45f584e23e856eda738ad10c40a54f448b541ce3fa55a6bd73e420df21b0a958a38f3474"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:59.457565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:59.457901) ========= 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.OLfVdZAYes/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.mOTUlaEfox/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005574 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:59.515871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 05:52:59.516213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 05:52:59.516545) ========= ========= Total master_lag: 0.24 =========