builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0390 starttime: 1486981247.45 results: success (0) buildid: 20170213004019 builduid: 257721cbdf5241cf91cc31017b6e9dd4 revision: 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.455094) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.455532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.455807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.480481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.480870) ========= 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.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-13 02:20:47-- 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% 8.05M=0.001s 2017-02-13 02:20:47 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.597264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.600628) ========= 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.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.020765 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:47.649151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 02:20:47.649513) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-13 02:20:47,732 truncating revision to first 12 chars 2017-02-13 02:20:47,732 Setting DEBUG logging. 2017-02-13 02:20:47,733 attempt 1/10 2017-02-13 02:20:47,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1acbb1168e11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 02:20:49,575 unpacking tar archive at: mozilla-aurora-1acbb1168e11/testing/mozharness/ program finished with exit code 0 elapsedTime=2.105979 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 02:20:49.781901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:49.782219) ========= script_repo_revision: 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:49.782622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:49.782889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 02:20:49.805777) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-13 02:20:49.806157) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:20:49 INFO - MultiFileLogger online at 20170213 02:20:49 in /builds/slave/test 02:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:49 INFO - {'append_to_log': False, 02:20:49 INFO - 'base_work_dir': '/builds/slave/test', 02:20:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:49 INFO - 'branch': 'Mozilla-Aurora', 02:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:49 INFO - 'config_files': ('talos/mac_config.py',), 02:20:49 INFO - 'default_actions': ('clobber', 02:20:49 INFO - 'read-buildbot-config', 02:20:49 INFO - 'download-and-extract', 02:20:49 INFO - 'populate-webroot', 02:20:49 INFO - 'create-virtualenv', 02:20:49 INFO - 'install', 02:20:49 INFO - 'run-tests'), 02:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:49 INFO - 'download_minidump_stackwalk': True, 02:20:49 INFO - 'download_symbols': 'ondemand', 02:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:49 INFO - 'installer_path': 'installer.exe', 02:20:49 INFO - 'log_level': 'info', 02:20:49 INFO - 'log_name': 'talos', 02:20:49 INFO - 'log_to_console': True, 02:20:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:20:49 INFO - 'opt_config_files': (), 02:20:49 INFO - 'pip_index': False, 02:20:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:50 INFO - 'cmd': ('bash', 02:20:50 INFO - '-c', 02:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:50 INFO - 'enabled': True, 02:20:50 INFO - 'halt_on_failure': False, 02:20:50 INFO - 'name': 'check_screen_resolution'},), 02:20:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:50 INFO - 'cmd': ('bash', 02:20:50 INFO - '-c', 02:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:50 INFO - 'enabled': True, 02:20:50 INFO - 'halt_on_failure': False, 02:20:50 INFO - 'name': 'check_screen_resolution'},), 02:20:50 INFO - 'run_cmd_checks_enabled': True, 02:20:50 INFO - 'sps_profile': False, 02:20:50 INFO - 'sps_profile_interval': 0, 02:20:50 INFO - 'suite': 'dromaeojs-e10s', 02:20:50 INFO - 'system_bits': '32', 02:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:50 INFO - 'title': 't-yosemite-r7-0390', 02:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:50 INFO - 'use_talos_json': True, 02:20:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:50 INFO - 'work_dir': 'build'} 02:20:50 INFO - [mozharness: 2017-02-13 10:20:50.002604Z] Running clobber step. 02:20:50 INFO - Running pre-action listener: _resource_record_pre_action 02:20:50 INFO - Running main action method: clobber 02:20:50 INFO - rmtree: /builds/slave/test/build 02:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:51 INFO - Running post-action listener: _resource_record_post_action 02:20:51 INFO - [mozharness: 2017-02-13 10:20:51.800889Z] Finished clobber step (success) 02:20:51 INFO - [mozharness: 2017-02-13 10:20:51.801198Z] Running read-buildbot-config step. 02:20:51 INFO - Running pre-action listener: _resource_record_pre_action 02:20:51 INFO - Running main action method: read_buildbot_config 02:20:51 INFO - Using buildbot properties: 02:20:51 INFO - { 02:20:51 INFO - "project": "", 02:20:51 INFO - "product": "firefox", 02:20:51 INFO - "script_repo_revision": "production", 02:20:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:20:51 INFO - "repository": "", 02:20:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:20:51 INFO - "buildid": "20170213004019", 02:20:51 INFO - "stage_platform": "macosx64", 02:20:51 INFO - "basedir": "/builds/slave/test", 02:20:51 INFO - "nightly_build": "True", 02:20:51 INFO - "buildnumber": 57, 02:20:51 INFO - "slavename": "t-yosemite-r7-0390", 02:20:51 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:20:51 INFO - "platform": "yosemite_r7", 02:20:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:20:51 INFO - "branch": "mozilla-aurora", 02:20:51 INFO - "repo_path": "releases/mozilla-aurora", 02:20:51 INFO - "revision": "1acbb1168e116fd67dacbd2f740f4c28cffc8a05", 02:20:51 INFO - "pgo_build": "False", 02:20:51 INFO - "builduid": "257721cbdf5241cf91cc31017b6e9dd4", 02:20:51 INFO - "slavebuilddir": "test" 02:20:51 INFO - } 02:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:20:51 INFO - Running post-action listener: _resource_record_post_action 02:20:51 INFO - [mozharness: 2017-02-13 10:20:51.807034Z] Finished read-buildbot-config step (success) 02:20:51 INFO - [mozharness: 2017-02-13 10:20:51.807223Z] Running download-and-extract step. 02:20:51 INFO - Running pre-action listener: _resource_record_pre_action 02:20:51 INFO - Running main action method: download_and_extract 02:20:51 INFO - mkdir: /builds/slave/test/build/tests 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:51 INFO - trying https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:20:53 INFO - Downloaded 1199 bytes. 02:20:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:20:53 INFO - Using the following test package requirements: 02:20:53 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:20:53 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:20:53 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:20:53 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'jsshell-mac.zip'], 02:20:53 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:20:53 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:20:53 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:20:53 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:20:53 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:20:53 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:20:53 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:20:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:20:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:20:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:20:53 INFO - Fetch https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:20:54 INFO - Expected file size: 16358444 02:20:54 INFO - Obtained file size: 16358444 02:21:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:21:01 INFO - Expected file size: 16358444 02:21:01 INFO - Obtained file size: 16358444 02:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:21:09 INFO - Expected file size: 14403485 02:21:09 INFO - Obtained file size: 14403485 02:21:09 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')]} 02:21:09 INFO - trying https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:09 INFO - Downloading https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:21:11 INFO - Downloaded 73997178 bytes. 02:21:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:11 INFO - mkdir: /builds/slave/test/properties 02:21:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:11 INFO - Contents: 02:21:11 INFO - build_url:https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:12 INFO - Running post-action listener: _resource_record_post_action 02:21:12 INFO - Running post-action listener: set_extra_try_arguments 02:21:12 INFO - [mozharness: 2017-02-13 10:21:12.134598Z] Finished download-and-extract step (success) 02:21:12 INFO - [mozharness: 2017-02-13 10:21:12.134754Z] Running populate-webroot step. 02:21:12 INFO - Running pre-action listener: _resource_record_pre_action 02:21:12 INFO - Running main action method: populate_webroot 02:21:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:12 INFO - '--tppagecycles', 02:21:12 INFO - '7'], 02:21:12 INFO - 'tests': ['tsvgm']}}, 02:21:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['damp', 'tps']}, 02:21:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'tests': ['damp', 'tps']}, 02:21:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['dromaeo_dom']}, 02:21:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['basic_compositor_video']}, 02:21:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['a11yr', 02:21:12 INFO - 'ts_paint', 02:21:12 INFO - 'tpaint', 02:21:12 INFO - 'sessionrestore', 02:21:12 INFO - 'sessionrestore_no_auto_restore', 02:21:12 INFO - 'tabpaint']}, 02:21:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['tsvgx', 02:21:12 INFO - 'tsvgr_opacity', 02:21:12 INFO - 'tart', 02:21:12 INFO - 'tscrollx', 02:21:12 INFO - 'cart', 02:21:12 INFO - 'tsvg_static']}, 02:21:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:12 INFO - 'tsvgr_opacity', 02:21:12 INFO - 'tart', 02:21:12 INFO - 'tscrollx', 02:21:12 INFO - 'cart', 02:21:12 INFO - 'tsvg_static']}, 02:21:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'talos_options': ['--disable-e10s'], 02:21:12 INFO - 'tests': ['tp5o']}, 02:21:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:21:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'talos_options': ['--disable-e10s', 02:21:12 INFO - '--xperf_path', 02:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:12 INFO - 'tests': ['tp5n']}, 02:21:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:21:12 INFO - 'talos_options': ['--xperf_path', 02:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:12 INFO - 'tests': ['tp5n']}}, 02:21:12 INFO - 'talos.zip': {'path': '', 02:21:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:12 INFO - Running post-action listener: _resource_record_post_action 02:21:12 INFO - [mozharness: 2017-02-13 10:21:12.153156Z] Finished populate-webroot step (success) 02:21:12 INFO - [mozharness: 2017-02-13 10:21:12.153267Z] Running create-virtualenv step. 02:21:12 INFO - Running pre-action listener: _resource_record_pre_action 02:21:12 INFO - Running main action method: create_virtualenv 02:21:12 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:12 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 02:21:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:12 INFO - Using real prefix '/tools/python27' 02:21:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:12 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:15 INFO - Installing pip.................done. 02:21:15 INFO - Return code: 0 02:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:21:16 INFO - Reading from file tmpfile_stdout 02:21:16 INFO - Output received: 02:21:16 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) 02:21:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:16 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 02:21:16 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 02:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:16 INFO - 'HOME': '/Users/cltbld', 02:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:16 INFO - 'LOGNAME': 'cltbld', 02:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:16 INFO - 'MOZ_NO_REMOTE': '1', 02:21:16 INFO - 'NO_EM_RESTART': '1', 02:21:16 INFO - 'PAGER': '/bin/cat', 02:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:16 INFO - 'PWD': '/builds/slave/test', 02:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:16 INFO - 'SHELL': '/bin/bash', 02:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:16 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:16 INFO - 'USER': 'cltbld', 02:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:16 INFO - 'XPC_FLAGS': '0x0', 02:21:16 INFO - 'XPC_SERVICE_NAME': '0', 02:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:16 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 02:21:16 INFO - Cleaning up... 02:21:16 INFO - Return code: 0 02:21:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:16 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 02:21:16 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 02:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:16 INFO - 'HOME': '/Users/cltbld', 02:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:16 INFO - 'LOGNAME': 'cltbld', 02:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:16 INFO - 'MOZ_NO_REMOTE': '1', 02:21:16 INFO - 'NO_EM_RESTART': '1', 02:21:16 INFO - 'PAGER': '/bin/cat', 02:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:16 INFO - 'PWD': '/builds/slave/test', 02:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:16 INFO - 'SHELL': '/bin/bash', 02:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:16 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:16 INFO - 'USER': 'cltbld', 02:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:16 INFO - 'XPC_FLAGS': '0x0', 02:21:16 INFO - 'XPC_SERVICE_NAME': '0', 02:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:16 INFO - Downloading/unpacking psutil>=3.1.1 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:20 INFO - Installing collected packages: psutil 02:21:20 INFO - Running setup.py install for psutil 02:21:20 INFO - building 'psutil._psutil_osx' extension 02:21:20 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 02:21:20 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 02:21:20 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 02:21:20 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 02:21:20 INFO - building 'psutil._psutil_posix' extension 02:21:20 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 02:21:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:21:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:21:20 INFO - ^ 02:21:20 INFO - 1 warning generated. 02:21:20 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 02:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:21 INFO - Successfully installed psutil 02:21:21 INFO - Cleaning up... 02:21:21 INFO - Return code: 0 02:21:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21:21 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')]} 02:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:21 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')]} 02:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:21 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:21 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 02:21:21 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 02:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:21 INFO - 'HOME': '/Users/cltbld', 02:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:21 INFO - 'LOGNAME': 'cltbld', 02:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:21 INFO - 'MOZ_NO_REMOTE': '1', 02:21:21 INFO - 'NO_EM_RESTART': '1', 02:21:21 INFO - 'PAGER': '/bin/cat', 02:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:21 INFO - 'PWD': '/builds/slave/test', 02:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:21 INFO - 'SHELL': '/bin/bash', 02:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:21 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:21 INFO - 'USER': 'cltbld', 02:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:21 INFO - 'XPC_FLAGS': '0x0', 02:21:21 INFO - 'XPC_SERVICE_NAME': '0', 02:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:24 INFO - Installing collected packages: mozsystemmonitor 02:21:24 INFO - Running setup.py install for mozsystemmonitor 02:21:24 INFO - Successfully installed mozsystemmonitor 02:21:24 INFO - Cleaning up... 02:21:24 INFO - Return code: 0 02:21:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:24 INFO - 'HOME': '/Users/cltbld', 02:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:24 INFO - 'LOGNAME': 'cltbld', 02:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:24 INFO - 'MOZ_NO_REMOTE': '1', 02:21:24 INFO - 'NO_EM_RESTART': '1', 02:21:24 INFO - 'PAGER': '/bin/cat', 02:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:24 INFO - 'PWD': '/builds/slave/test', 02:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:24 INFO - 'SHELL': '/bin/bash', 02:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:24 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:24 INFO - 'USER': 'cltbld', 02:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:24 INFO - 'XPC_FLAGS': '0x0', 02:21:24 INFO - 'XPC_SERVICE_NAME': '0', 02:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:27 INFO - warning: no files found matching '*.txt' 02:21:27 INFO - no previously-included directories found matching 'build' 02:21:27 INFO - no previously-included directories found matching 'dist' 02:21:27 INFO - no previously-included directories found matching '.git*' 02:21:27 INFO - Installing collected packages: jsonschema, functools32 02:21:27 INFO - Running setup.py install for functools32 02:21:27 INFO - warning: no files found matching '*.txt' 02:21:27 INFO - no previously-included directories found matching 'build' 02:21:27 INFO - no previously-included directories found matching 'dist' 02:21:27 INFO - no previously-included directories found matching '.git*' 02:21:27 INFO - Successfully installed jsonschema functools32 02:21:27 INFO - Cleaning up... 02:21:28 INFO - Return code: 0 02:21:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:28 INFO - 'HOME': '/Users/cltbld', 02:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:28 INFO - 'LOGNAME': 'cltbld', 02:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:28 INFO - 'MOZ_NO_REMOTE': '1', 02:21:28 INFO - 'NO_EM_RESTART': '1', 02:21:28 INFO - 'PAGER': '/bin/cat', 02:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:28 INFO - 'PWD': '/builds/slave/test', 02:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:28 INFO - 'SHELL': '/bin/bash', 02:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:28 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:28 INFO - 'USER': 'cltbld', 02:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:28 INFO - 'XPC_FLAGS': '0x0', 02:21:28 INFO - 'XPC_SERVICE_NAME': '0', 02:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:28 INFO - Cleaning up... 02:21:28 INFO - Return code: 0 02:21:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:28 INFO - 'HOME': '/Users/cltbld', 02:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:28 INFO - 'LOGNAME': 'cltbld', 02:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:28 INFO - 'MOZ_NO_REMOTE': '1', 02:21:28 INFO - 'NO_EM_RESTART': '1', 02:21:28 INFO - 'PAGER': '/bin/cat', 02:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:28 INFO - 'PWD': '/builds/slave/test', 02:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:28 INFO - 'SHELL': '/bin/bash', 02:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:28 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:28 INFO - 'USER': 'cltbld', 02:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:28 INFO - 'XPC_FLAGS': '0x0', 02:21:28 INFO - 'XPC_SERVICE_NAME': '0', 02:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:32 INFO - Downloading docopt-0.6.1.tar.gz 02:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:32 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:32 INFO - Running setup.py install for blobuploader 02:21:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:32 INFO - Running setup.py install for requests 02:21:33 INFO - Running setup.py install for docopt 02:21:33 INFO - Successfully installed blobuploader requests docopt 02:21:33 INFO - Cleaning up... 02:21:33 INFO - Return code: 0 02:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:33 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 02:21:33 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 02:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:33 INFO - 'HOME': '/Users/cltbld', 02:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:33 INFO - 'LOGNAME': 'cltbld', 02:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:33 INFO - 'MOZ_NO_REMOTE': '1', 02:21:33 INFO - 'NO_EM_RESTART': '1', 02:21:33 INFO - 'PAGER': '/bin/cat', 02:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:33 INFO - 'PWD': '/builds/slave/test', 02:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:33 INFO - 'SHELL': '/bin/bash', 02:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:33 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:33 INFO - 'USER': 'cltbld', 02:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:33 INFO - 'XPC_FLAGS': '0x0', 02:21:33 INFO - 'XPC_SERVICE_NAME': '0', 02:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:33 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-davRk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:33 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-jEfhaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:33 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-scju_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:33 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-sVWben-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qsoSsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qLXuAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-W6zK4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-JN2f6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-WmRU8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-BgcT_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-okVK9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-8N1ms6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:34 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-EjmLEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:35 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-KTactE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:35 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-wiG1B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:35 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-shKK9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:35 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Jpc47p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:35 INFO - Running setup.py install for manifestparser 02:21:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:35 INFO - Running setup.py install for mozcrash 02:21:35 INFO - Running setup.py install for mozdebug 02:21:35 INFO - Running setup.py install for mozdevice 02:21:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Running setup.py install for mozfile 02:21:36 INFO - Running setup.py install for mozhttpd 02:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Running setup.py install for mozinfo 02:21:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Running setup.py install for mozInstall 02:21:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Running setup.py install for mozleak 02:21:36 INFO - Running setup.py install for mozlog 02:21:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:36 INFO - Running setup.py install for moznetwork 02:21:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:37 INFO - Running setup.py install for mozprocess 02:21:37 INFO - Running setup.py install for mozprofile 02:21:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:37 INFO - Running setup.py install for mozrunner 02:21:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:37 INFO - Running setup.py install for mozscreenshot 02:21:37 INFO - Running setup.py install for moztest 02:21:37 INFO - Running setup.py install for mozversion 02:21:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:38 INFO - Cleaning up... 02:21:38 INFO - Return code: 0 02:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:38 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')]} 02:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:38 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')]} 02:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:38 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:38 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 02:21:38 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 02:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:38 INFO - 'HOME': '/Users/cltbld', 02:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:38 INFO - 'LOGNAME': 'cltbld', 02:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:38 INFO - 'MOZ_NO_REMOTE': '1', 02:21:38 INFO - 'NO_EM_RESTART': '1', 02:21:38 INFO - 'PAGER': '/bin/cat', 02:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:38 INFO - 'PWD': '/builds/slave/test', 02:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:38 INFO - 'SHELL': '/bin/bash', 02:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:38 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:38 INFO - 'USER': 'cltbld', 02:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:38 INFO - 'XPC_FLAGS': '0x0', 02:21:38 INFO - 'XPC_SERVICE_NAME': '0', 02:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-lLFFxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:38 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)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-4KFSrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:38 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)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-uqSpPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:38 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)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-5moNg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-CoT84a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:38 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)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-jZugqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:38 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)) 02:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-wldzcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-UODadB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-jrHt9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-bvbtit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ftM2F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-mUqIzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-bHigRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-71j1SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-f7Lx2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:39 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)) 02:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:39 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-OElOlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:40 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)) 02:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:40 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eTnvBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:40 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)) 02:21:40 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)) 02:21:40 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)) 02:21:40 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)) 02:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:42 INFO - Downloading blessings-1.6.tar.gz 02:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:42 INFO - Installing collected packages: blessings 02:21:42 INFO - Running setup.py install for blessings 02:21:43 INFO - Successfully installed blessings 02:21:43 INFO - Cleaning up... 02:21:43 INFO - Return code: 0 02:21:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:43 INFO - Reading from file tmpfile_stdout 02:21:43 INFO - Current package versions: 02:21:43 INFO - blessings == 1.6 02:21:43 INFO - blobuploader == 1.2.4 02:21:43 INFO - docopt == 0.6.1 02:21:43 INFO - functools32 == 3.2.3-2 02:21:43 INFO - jsonschema == 2.5.1 02:21:43 INFO - manifestparser == 1.1 02:21:43 INFO - mozInstall == 1.12 02:21:43 INFO - mozcrash == 1.0 02:21:43 INFO - mozdebug == 0.1 02:21:43 INFO - mozdevice == 0.49 02:21:43 INFO - mozfile == 1.2 02:21:43 INFO - mozhttpd == 0.7 02:21:43 INFO - mozinfo == 0.9 02:21:43 INFO - mozleak == 0.1 02:21:43 INFO - mozlog == 3.4 02:21:43 INFO - moznetwork == 0.27 02:21:43 INFO - mozprocess == 0.24 02:21:43 INFO - mozprofile == 0.28 02:21:43 INFO - mozrunner == 6.13 02:21:43 INFO - mozscreenshot == 0.1 02:21:43 INFO - mozsystemmonitor == 0.3 02:21:43 INFO - moztest == 0.8 02:21:43 INFO - mozversion == 1.4 02:21:43 INFO - psutil == 3.1.1 02:21:43 INFO - requests == 1.2.3 02:21:43 INFO - wsgiref == 0.1.2 02:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:43 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:43 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 02:21:43 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 02:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:43 INFO - 'HOME': '/Users/cltbld', 02:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:43 INFO - 'LOGNAME': 'cltbld', 02:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:43 INFO - 'MOZ_NO_REMOTE': '1', 02:21:43 INFO - 'NO_EM_RESTART': '1', 02:21:43 INFO - 'PAGER': '/bin/cat', 02:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:43 INFO - 'PWD': '/builds/slave/test', 02:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:43 INFO - 'SHELL': '/bin/bash', 02:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:43 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:43 INFO - 'USER': 'cltbld', 02:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:43 INFO - 'XPC_FLAGS': '0x0', 02:21:43 INFO - 'XPC_SERVICE_NAME': '0', 02:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 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)) 02:21:44 INFO - Cleaning up... 02:21:44 INFO - Return code: 0 02:21:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:44 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 0x10b47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90c85a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, '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.La7XPu1cav/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.cZn7dStOFm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 02:21:44 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 02:21:44 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 02:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:44 INFO - 'HOME': '/Users/cltbld', 02:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:44 INFO - 'LOGNAME': 'cltbld', 02:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:44 INFO - 'MOZ_NO_REMOTE': '1', 02:21:44 INFO - 'NO_EM_RESTART': '1', 02:21:44 INFO - 'PAGER': '/bin/cat', 02:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:44 INFO - 'PWD': '/builds/slave/test', 02:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:44 INFO - 'SHELL': '/bin/bash', 02:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:21:44 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:44 INFO - 'USER': 'cltbld', 02:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:44 INFO - 'XPC_FLAGS': '0x0', 02:21:44 INFO - 'XPC_SERVICE_NAME': '0', 02:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:44 INFO - Cleaning up... 02:21:44 INFO - Return code: 0 02:21:44 INFO - Running post-action listener: _resource_record_post_action 02:21:44 INFO - Running post-action listener: _start_resource_monitoring 02:21:44 INFO - Starting resource monitoring. 02:21:44 INFO - [mozharness: 2017-02-13 10:21:44.936956Z] Finished create-virtualenv step (success) 02:21:44 INFO - [mozharness: 2017-02-13 10:21:44.938017Z] Running install step. 02:21:44 INFO - Running pre-action listener: _resource_record_pre_action 02:21:44 INFO - Running main action method: install 02:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:45 INFO - Reading from file tmpfile_stdout 02:21:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:45 INFO - Reading from file tmpfile_stdout 02:21:45 INFO - Output received: 02:21:45 INFO - Usage: mozinstall [options] installer 02:21:45 INFO - Options: 02:21:45 INFO - -h, --help show this help message and exit 02:21:45 INFO - -d DEST, --destination=DEST 02:21:45 INFO - Directory to install application into. [default: 02:21:45 INFO - "/builds/slave/test"] 02:21:45 INFO - --app=APP Application being installed. [default: firefox] 02:21:45 INFO - mkdir: /builds/slave/test/build/application 02:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:22:05 INFO - Reading from file tmpfile_stdout 02:22:05 INFO - Output received: 02:22:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:22:05 INFO - Running post-action listener: _resource_record_post_action 02:22:05 INFO - [mozharness: 2017-02-13 10:22:05.151885Z] Finished install step (success) 02:22:05 INFO - [mozharness: 2017-02-13 10:22:05.152038Z] Running run-tests step. 02:22:05 INFO - Running pre-action listener: _resource_record_pre_action 02:22:05 INFO - Running main action method: run_tests 02:22:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:05 INFO - 2017-02-13 02:22:05.166 screenresolution[2480:36747] starting screenresolution argv=screenresolution get 02:22:05 INFO - 2017-02-13 02:22:05.169 screenresolution[2480:36747] Display 0: 1600x1200x32@60 02:22:05 INFO - 2017-02-13 02:22:05.175 screenresolution[2481:36750] starting screenresolution argv=screenresolution list 02:22:05 INFO - Available Modes on Display 0 02:22:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:05 INFO - Intel Iris: 02:22:05 INFO - Chipset Model: Intel Iris 02:22:05 INFO - Type: GPU 02:22:05 INFO - Bus: Built-In 02:22:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:05 INFO - Vendor: Intel (0x8086) 02:22:05 INFO - Device ID: 0x0a2e 02:22:05 INFO - Revision ID: 0x0009 02:22:05 INFO - Displays: 02:22:05 INFO - Display: 02:22:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:05 INFO - Display Serial Number: 1600x1200 60 02:22:05 INFO - Main Display: Yes 02:22:05 INFO - Mirror: Off 02:22:05 INFO - Online: Yes 02:22:05 INFO - Rotation: Supported 02:22:05 INFO - Return code: 0 02:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:05 INFO - Python 2.7.3 02:22:05 INFO - Return code: 0 02:22:05 INFO - grabbing minidump binary from tooltool 02:22:05 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')]} 02:22:05 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 0x10b25ad30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b24fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:05 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 02:22:05 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 02:22:05 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 02:22:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:05 INFO - Return code: 0 02:22:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:22:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:22:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 02:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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 02:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.La7XPu1cav/Render', 02:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:05 INFO - 'HOME': '/Users/cltbld', 02:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:05 INFO - 'LOGNAME': 'cltbld', 02:22:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:05 INFO - 'MOZ_NO_REMOTE': '1', 02:22:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:05 INFO - 'NO_EM_RESTART': '1', 02:22:05 INFO - 'PAGER': '/bin/cat', 02:22:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:05 INFO - 'PWD': '/builds/slave/test', 02:22:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:05 INFO - 'SHELL': '/bin/bash', 02:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZn7dStOFm/Listeners', 02:22:05 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 02:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:05 INFO - 'USER': 'cltbld', 02:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:05 INFO - 'XPC_FLAGS': '0x0', 02:22:05 INFO - 'XPC_SERVICE_NAME': '0', 02:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 02:22:05 INFO - mozversion application_buildid: 20170213004019 02:22:05 INFO - mozversion application_changeset: 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 02:22:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:22:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:05 INFO - mozversion application_name: Firefox 02:22:05 INFO - mozversion application_remotingname: firefox-dev 02:22:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:05 INFO - mozversion application_vendor: Mozilla 02:22:05 INFO - mozversion application_version: 53.0a2 02:22:05 INFO - mozversion platform_buildid: 20170213004019 02:22:05 INFO - mozversion platform_changeset: 1acbb1168e116fd67dacbd2f740f4c28cffc8a05 02:22:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:05 INFO - mozversion platform_version: 53.0a2 02:22:05 INFO - using testdate: 1486981325 02:22:05 INFO - actual date: 1486981325 02:22:05 INFO - starting webserver on 'localhost:59156' 02:22:05 INFO - SUITE-START | Running 2 tests 02:22:05 INFO - TEST-START | dromaeo_css 02:22:05 INFO - operating with platform_type : mac_ 02:22:05 INFO - Initialising browser for dromaeo_css test... 02:22:05 INFO - TEST-INFO | started process 2491 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpWqhvGD/profile http://localhost:59156/getInfo.html) 02:22:08 INFO - PROCESS | 2491 | 2017-02-13 02:22:08.813 plugin-container[2494:36912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 02:22:08 INFO - PROCESS | 2491 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:08 INFO - PROCESS | 2491 | 2017-02-13 02:22:08.814 plugin-container[2494:36912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 02:22:08 INFO - PROCESS | 2491 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:08 INFO - PROCESS | 2491 | 2017-02-13 02:22:08.814 plugin-container[2494:36912] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:22:08 INFO - PROCESS | 2491 | __metrics Screen width/height:1600/1200 02:22:08 INFO - PROCESS | 2491 | colorDepth:24 02:22:08 INFO - PROCESS | 2491 | Browser inner width/height: 1024/689 02:22:08 INFO - PROCESS | 2491 | __metrics 02:22:08 ERROR - PROCESS | 2491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:22:09 INFO - TEST-INFO | 2491: exit 0 02:22:09 INFO - Browser initialized. 02:22:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:22:09 INFO - TEST-INFO | started process 2495 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpWqhvGD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:12 INFO - PROCESS | 2495 | 2017-02-13 02:22:12.206 plugin-container[2496:37050] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 02:22:12 INFO - PROCESS | 2495 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:12 INFO - PROCESS | 2495 | 2017-02-13 02:22:12.207 plugin-container[2496:37050] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4523, name = 'com.apple.CFPasteboardClient' 02:22:12 INFO - PROCESS | 2495 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:12 INFO - PROCESS | 2495 | 2017-02-13 02:22:12.207 plugin-container[2496:37050] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:22:21 INFO - PROCESS | 2495 | RSS: Main: 219136000 02:22:21 INFO - PROCESS | 2495 | 02:25:23 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59156/tests/dromaeo/cssquery-ext.html) 02:25:25 INFO - PROCESS | 2495 | RSS: Main: 240222208 02:25:25 INFO - PROCESS | 2495 | 02:27:10 INFO - PROCESS | 2495 | ************************* 02:27:10 INFO - PROCESS | 2495 | A coding exception was thrown and uncaught in a Task. 02:27:10 INFO - PROCESS | 2495 | 02:27:10 ERROR - PROCESS | 2495 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:27:10 INFO - PROCESS | 2495 | Full stack: 02:27:10 INFO - PROCESS | 2495 | ************************* 02:28:27 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-ext.html (next: http://localhost:59156/tests/dromaeo/cssquery-jquery.html) 02:28:28 INFO - PROCESS | 2495 | RSS: Main: 247681024 02:28:28 INFO - PROCESS | 2495 | 02:31:30 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59156/tests/dromaeo/cssquery-mootools.html) 02:31:30 INFO - PROCESS | 2495 | RSS: Main: 253886464 02:31:30 INFO - PROCESS | 2495 | 02:34:32 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59156/tests/dromaeo/cssquery-prototype.html) 02:34:33 INFO - PROCESS | 2495 | RSS: Main: 250306560 02:34:33 INFO - PROCESS | 2495 | 02:37:36 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59156/tests/dromaeo/cssquery-yui.html) 02:37:36 INFO - PROCESS | 2495 | RSS: Main: 254337024 02:37:36 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:59156/tests/dromaeo/cssquery-yui.html (next: http://localhost:59156/tests/dromaeo/cssquery-dojo.html) 02:40:39 INFO - PROCESS | 2495 | RSS: Main: 255655936 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | __start_tp_report 02:40:39 INFO - PROCESS | 2495 | _x_x_mozilla_page_load 02:40:39 INFO - PROCESS | 2495 | _x_x_mozilla_page_load_details 02:40:39 INFO - PROCESS | 2495 | |i|pagename|runs| 02:40:39 INFO - PROCESS | 2495 | |0;dojo.html;2983.4331477019364;3338.332333533294;3373.4771110477886;3394.1514621344663;3408.931821363573;5616.831495055155;5647.6893770842635;5658.688772117537;5714.857128571788;5731.713414329288;5697.6011679182475;5748.338941021784;5767.480926716595;5782.277215348082;5799.478046975772;5160.483951604829;5215.139501982168;5223.451537588537;5234.42421333653;5265.868353291179;5204.089284375238;5272.367315922094;5286.920696189561;5299.019681358942;5320.733963301819;4782.33047373368;5112.463191364927;5186.92219616706;5229.686218826844;5241.030409374278;4186.853460128881;4237.406763053175;5130.9743451282875;5205.609579281569;5231.476852314738;5134.435212126663;5172.379314482248;5179.2749015137915;5186.196139598368;5216.739163041871;4309.4397728295435;5511.503964643161;5631.183478395651;5763.971180144114;5770.682612456313;6076.605020673642;6079.574429789916;6086.9391306087255;6109.694515274263;6123.557162997608;5271.710055946922;5551.472610102034;6165.506759459233;6167.444929956326;6215.378462153793;5618.522425593829;5872.618279811799;5883.323417807007;5891.764329426818;5907.409259074101;6146.078088286703;6167;6177.660228687465;6186.938130618726;6214.098955651496;5202.2196670499725;6071.0286354184;6108.358622344679;6122.663253521099;6136.059583474799;6008.519318454513;6140.570160088841;6147.170132032208;6170.413810687977;6174.783882564088;6041.426064523863;6052.334243233241;6077;6104.572679912452;6107.765388666889;6116.541259405562;6128.387161283925;6139.355367686418;6139.986902161183;6157.107219453154;4926.45808961014;4943.826966056243;4946.505349465025;4949.752512374439;4964.975175124101;4374.912501750011;4410.07388448423;4414.448193975753;4455.933161002587;4480.215962206601;5758.1362795581;5825.854353641193;5853.268341457318;5878.059510478303;5913.497352725067;6136.6011209271255;6140.815775526741;6176.474999624992;6190.7523699052435;6198.101275315144;5614.326280846324;5667.121596152603;5778.104393818965;5821.679807610622;5839.416058394211;4735.408073990751;5485.122380419193;5485.177223416519;5501.284832971688;5522.2544956431175;5412.539934105566;6333.904991425225;6349;6349.619022858736;6401.775937842153;5250.606204534752;6085.482733967662;6117.066276512034;6141.570090093651;6156.846078848064;6287.2140982377205;6362.141110949962;6380.489560835029;6384.265809431975;6384.361563843579;6142.969285153546;6157.938420615916;6174.845628859314;6178.41305076017;6183.3816618337805;6113.9932453606225;6125.264968203844;6129.817282374446;6185.752569897154;6199.473044791243;6074.757009719739;6143.96928015357;6145.446909778141;6147.893379191788;6171.56799024064;4728.763561821826;6084.8783024340155;6150.846228844314;6151.384861513991;6153.169322141453;5731.7420716067045;5839.649621022752;5919.7040147991565;5986.3115741688525;6038.094285856981;5955.67243801595;6010.4891084258325;6011.458968692838;6060.090986352083;6108.645631960618;4459.375687403701;5759.222504961944;6000.039993601003;6000.759969601341;6037.969810151097 02:40:39 INFO - PROCESS | 2495 | |1;ext.html;440.90740944401676;461.5707392125322;461.89146049481263;498.7805365639118;526.3263023330137;36287.63712362875;39284.60715392845;39296.60703392965;39482.407763883566;39693.00767480814;41351.379729304084;41467.58532414675;41790.58209417905;41834.79082604583;41916.161676766445;8463.153684631518;8675.305975521975;9020.954895225515;9279.628814847398;9288.164065234128;11216.439178041106;11455.828162577527;11511;11594.246373985665;11602.071834253282;10373.325733827278;11047.674279086481;11411.201215914889;11412.714682132972;11448.771024579504;11167.218294719332;11284.322940623548;11297.096232301396;11361.091112710963;11373.772524549546;9801.656942006995;11199.216054876162;11223;11228.606998755004;11293.322400655987;39382;39715.60284397148;39734.80132599318;39842.80078599617;39875.601243987476;3856.3058649443087;3917.138229589486;3969.761814291152;4012.1775036117524;4021.939670904939;24500.387490312707;26091.869540652177;27003.86498067497;27036.45927081467;27147.45705085907;3053.114596766935;3110.2224443889027;3214.5660335854595;3237.3848968695875;3273.0344548358294;497064;497518;498053;499699.5015024938;500399;54679.72660136674;56210.43789562134;56314.718426407606;56598;56692.71653641705;57690.711546442835;58209.70895145497;58495.41504584985;58535.12197317043;58558;15820.841791581937;15969.680606387807;15973.520794376187;15987.60030999211;15988.04071755675;11114.277571957797;11382.487788049557;12315.953143982862;12921.483140674456;13164.802527962089;17762;20964.47588810292;21834.344969650618;21863.234786782385;21930.232441864457;7472.32749052577;8625.69810056645;8777.824443511094;8839.955800220958;8860.468371897707;857.7576759847785;864.3301441382979;874.9212570868652;876.8553188723789;882.1266945723816;29557.408851822842;29803;30313.545296820565;30678.53982190269;30694;912.3203213605774;1051.8632577764843;1053.5662619349175;1089.1939964426267;1166.2943918928927;15102.114116390952;15575;15827.366905323888;15912.52262432129;15948.04311741276;643408;644595;646000;647331;648003;44142.77928610337;57505.71247143738;61186.69406652938;61276.77446451046;61333.69333153395;1390.1381143690774;1409.8590140985818;1427.1722401007391;1431.6420894776097;1435.052865109044;28701;29403.705962940097;29646;29676.851615741783;29966.25084372908;39276.41085383664;39368.031598419395;39740.80129599333;39800.80099599483;39897.60102398939;515467.4226628843;520266;526893;527342;527825;25415.491690166462;25985.0905218324;25988.220353389428;27278.318042049108;27376.315592110357;42034.579654203066;42055.7897210512;43090.78454607707;43140.490082848206;43376.56623433725;34715;35030.64969350274;35133.82433087818;35161.648383515836;35464.936051918485;34778.13054673653;34940;35752.82123589365;35767.821160894026;36109;34066.82966585151;34520.136996574285;35021;35102.64897350994;35413;30344.696553034188;31022;31319.530207046457;31354;31381.68618313879;23485.17801876926;23681.460705054116;23898.761012389652;23980.64029039531;24336 02:40:39 INFO - PROCESS | 2495 | |2;jquery.html;388.31462468742694;388.8677849531161;401.5141678568932;402.8831638824742;418.7947905526293;15231.543053708407;17009.31962721491;20283.797162028375;20488;20624.175032998683;17506.824931750678;21478.355649330508;21715.239966601173;22036.779632203674;22434.214802481918;4867.537583929521;5229.398619158788;5577.358603760558;5595.860103497404;5618.887622247553;5059.367579052619;5266.631335806495;5564.554835613141;5661.547076233912;5669.894370597735;4948.430930442991;5558.499735023847;5655.34963479199;5672.574556908227;5674.574406919477;5410.783568657249;5552.112281824199;5644.57665675074;5649.887002259932;5655.0386434306265;5009.7495125243595;5018.824341148079;5020.723860187688;5028.698278103289;5036.043151801146;25563.488730225476;26073.60889586658;26251;26495.867520662465;26533.734662653318;2710.593410988348;2762.06089929425;2771.5704065869822;2778.4026434316515;2787.1220565521794;15678.216089195608;15769.842301577068;16247.593810154722;16353.345866165459;16883.91558042214;1841.9907900460546;1893.2994791927076;1902.9238830446766;1913.6077104193607;1913.7033759767257;129226;133169.33415332958;134268;135288.9375357598;137326.31336843251;11399.772004559862;11489.827652585218;11534.884651153381;11547.076233901267;11671.299722016536;11633.302001879914;13734.931325343508;14618.122912625277;14687.485937992118;14833.480828171178;8630.654773808978;8729.301655867515;8971.416857904216;9003.594838232295;9060.728178154666;7574.545527268381;7797.649105790139;9042.095790420904;9050.456972581665;9092.909070909207;7348.485606007635;7380.667869945865;7483.064616922885;7489.662965166472;7518.548887066793;1930.5366711989302;1951.3950675290705;1958.529952811315;1962.3524237001754;1962.391658585843;1038.984415233772;1049.5987856212043;1066;1077.6928575356142;1091.49245600796;22362;22870.656940145913;23126;23276.883615581814;23850;1084.5661735305782;1103.806589994076;1108.9057430118369;1121.4616983847798;1128.3060917535656;11412;11893.108016898766;11984.760304793856;12125.93937030327;12164.5134194633;764153;781613;789632;802618;806681;132186;134405.32797336148;134784;136330;140050;1021.8109649714827;1040.4641609571077;1044.6343779677204;1044.8537204791487;1053.3206082077018;18984.810151898855;19919.203231871143;19921.900390498533;20010.89940053311;20236;43630.78184609057;47105;55939;58467.53831154255;59317;73628.63185684037;74049;76498.61750691211;77002;77043;8058.959705201437;8224.259816616533;8391.28674062687;8407.201315874981;8448.197421244971;11663.708407289547;12400.875991239973;13251.66870828237;13642.86357136416;13658.180509169482;11016.449177541252;11298.435078246219;11340.262882912584;11377.203595748219;11449.94275028653;11366.659000230007;11379.089672825989;11406.315621062762;11569.942150289195;11802.232854864405;11511.712207194887;11559.76880462403;11692.0061794745;11768.411579421167;11904.821427678418;7459.888101678588;7641.465097443348;7794.532328060334;8254.215849494289;8256.958715206385;8081.272685458337;10872.293300935415;11585.768284634092;11588.826167607662;11660.30038197711 02:40:39 INFO - PROCESS | 2495 | |3;mootools.html;1338.1235290884472;1433.1329545624903;1434.2900264369139;1443.5164219986304;1456.4611093895257;7571.545707257568;7825.882611760828;8197.098319184892;8615.78460538486;8628.525431101294;8092.39307051972;8321.958390208056;8381;8494.91505084949;8496.532690702008;2033.176563491788;2305.5734689082487;2353.411647088228;2354.21133920137;2363.3500787283547;2085.4786303424144;2161.9243326483574;2320.628699408095;2362.456634973957;2369.5616310982437;2276.5105502316997;2356.5404746074523;2362.7755363240462;2368.5973384524673;2371.95256094878;2322.744498105207;2346.4720437901506;2347.5070235250705;2360.527894421114;2366;2306.988465057681;2338.4972230970425;2365.5387199496104;2375.477394973103;2403.291029146406;8567.614457349435;8643.09247529013;8646.870296945552;8660.43707159039;8700;5063.493650634944;5208.036513245024;5211.478852114796;5223.660462069954;5225.921611175835;3292.670732926712;3469.340825243196;3536.0806190390686;3555.0401391624373;3569.250457403948;1203.8194270859353;1213.5267245774155;1261.3251910228075;1264.7027948432112;1267.3219827392302;10595.94702026485;10691.358518488916;10859.83710244347;10876.891231087668;10917.945410272898;4600.079984003212;4671.85984420468;4703.553162449562;4746.288056791509;4758.524147585283;9476.620935162655;9608.711738647851;9611.279154063473;9619.27855410847;9628.037196280316;5271;5273.815416460406;5358.571314294847;5364.383095943938;5387.0841956867425;4618.792154352995;4806.663533552688;4845.563899249085;4854.320395144682;4898.608111351084;3839.251345987506;3942;3950.051987523031;3970.2456533258587;4042.8275800018255;1177.1877404590805;1224.2837939805313;1252.6367353467392;1296.6110166949877;1301.3818436242898;782.8669126248551;841.8358420108143;897.1790811407488;907.9727608171765;913.255696607263;4903.338049363361;5650.689212093374;5808.186853840466;5812.912806307909;5880.94119058804;856.7686724584328;961.4087336288133;975.4439969217619;1021.4177918586483;1024.4826362686795;3598.442241452579;3774.5659249186697;3784.6593806557544;3813.7330386872654;3842.2315536892734;8952.597133128895;9653.938066812645;9809.950950245204;10055.044770746767;10075.193984481224;9502.762430939281;9805.705828825146;9925.454100024424;10034.197264218845;10046.146077583488;6913.446924246048;7846.9215307847335;8001.759947201594;8008.159143289987;8038.517688938682;4635.420572428447;4834.685745426536;5340.968504917217;5440.700761458158;5776.335721392094;8876.911230887608;9154.313426492907;9155.404898681565;9200.447973121367;9395.577199026196;9265.7954465919;9395.483248421402;9397.859032114387;9433.858492122486;9527.952360238432;6983.301669832976;7118.537295075804;7121.893171602534;7130.2156762757095;7157.7136914522835;6748;7831.960840195762;7840.960795195988;7856.921430785619;7971.963644726148;6518.217813862367;7063.364297213276;7182.3894968928225;7194.676239569128;7209.702253594403;6975.6163411012885;7063.081799366049;7080.468964827555;7087.00781890546;7124.180719217149;5625.381208067191;6371.362863713592;6377.139086223486;6442.967785161044;6461.127747753993;4592.311153327028;4696.272077827942;4930.531599498042;4959.3552838132255;5057.898842023213;4130.070734084927;4433.179861725591;4929.975350123226;5078.085944529872;5079.87300317495 02:40:39 INFO - PROCESS | 2495 | |4;prototype.html;270.8618604511699;366;368.33699341185843;375.57747534024224;377.9508663873696;4572.291294849296;5364.275822763935;5480.314960629921;5511.917321240185;5556.638818476797;4506.66200034997;5395.838124856251;5414.3232095987905;5467.200295794424;5467.480589344006;3538.7345949053797;3547.787132772029;4236.237477254093;4239.7668128252935;4245.681573881971;4148.8340466381305;4243.405923170759;4272.615464608185;4276.807543660527;4298.613124818766;3685.299793039327;4161.417401563784;4167.979160104195;4219.303814870543;4273.465816772903;3479.930401391983;3507.7369197310177;3674.5590529136675;4075.409065685459;4192.937105943398;3619.511365965587;3720.8511659533588;3745.700343972476;3747.306748251582;3747.681447077002;4892.828750993698;5337.2527846101575;5337.412884582693;5383.730813459311;5434.565234781208;4869.853904382874;4875.536824001714;4894.461609222983;4896.706197628154;4901.754912254373;5548.278723765925;5649.8587535311535;5833.679147646878;5890.941090589082;5910.911336329958;3477.826108694555;3961.6830653547645;4038.414429907676;4069.247189269965;4081.3265811141127;4685.109829132454;5219;6129.20320358355;6145.477634401082;6150.384961503813;3413.9317213656086;3913.882583522442;4191.434156388909;4192.406885383535;4198.5591512891315;3423.4693622488553;3500.7397336958675;3559.985404159802;3922.9803850981134;3969.622885825842;4123.835046598102;4596.701214421052;4672.925227197696;4689.812407503729;4705.200115980291;5405.5135037846785;5439.537639300704;5817.88364232713;5833.241678581757;5838;1235.0675240193596;1260.6281147061638;1271.173737070893;1299.7855353866505;1302.3785387193004;854.7307598106577;854.9016863060704;864.8400045991511;866.1079088538816;881.4667126388571;4805.519448055236;4944.1100601892;5143.7685304161405;5159.7678104485385;5226.843194704165;5361.383440904346;5383.28553298223;5469.72651367438;5702.486776190163;5722.799702010493;4673.976630116827;4741.928871066937;4767.570918617272;5181.274621552986;5225.425203227642;2445.9143929962365;2492.675952126212;2963.777716671258;2999.3701322722036;3017.7627172859025;4915.353356625499;4998.200287953982;5118.910090427388;5356.92861427716;5872.911906321408;5182.663126896739;5223.973880130575;5650.208970744099;5767;5866.325372582122;4871.853844384674;5282.536256863022;5364.90019546;5811.79658711943;5838.3876737376995;5107.8252002039;5184.637075404686;5236.926430081748;5283.7093959831045;5398.541124004503;4557.384753058294;5533.889322213453;5544.944550554443;5584.106542953108;5596.720163991866;5318.569522657786;5643.372434603586;5785;5883.470487656132;5919.691320384967;3464.7747896386654;3466.913327166841;3732.2162345906577;3754.23038277158;3798.772073675588;4718.7168769873915;4826.3243145958895;4879.414470263591;5160.974195129001;5633.521150702236;5170.5346518813485;5441.395362776347;5459.323322090122;5471.5896307777875;5478;4890.535399137077;5088.313077734459;5440.319960004999;5461.5357694596405;5487.286652735279;4765.189917713928;5434.728263586726;5495.807646732505;5620.690862002629;5633.662080198306;4694.718316900997;5448.591355648263;5694.857628559319;5696.8006119785605;5713.285839270091;5329.241350354451;5561.165825126263;5623.943760562342;5634.32388113429;5634.380218175916 02:40:39 INFO - PROCESS | 2495 | |5;yui.html;688.1638808847252;701.2951983256826;744.4267913706447;821.301893390618;844.9450785698931;14658.63353416165;15421.537353879401;15473.845261547382;15476.845231547695;15665.686686266283;13495.66260843477;14019.299035048258;14188.71622567548;14193.935454840903;14222.857771422283;837.4431003382758;860.3289434241302;861.483110133921;864.1531299326664;865.5845194306737;859.3468963587655;863.6070587882498;864.2092485375905;864.6109250837117;865.7792262972933;903.1510380242551;909.522500687138;909.6361455417853;911.0479548871446;911.4850109688039;883.6200433813458;897.3852910756153;901.8602116671926;905;906.2070688147837;660.6762686283735;668.9096971908779;669.160203944052;670.6210990790237;672.2907332763932;15481.303341349667;15486.5354039379;15512.689746205013;15530.61173470661;15541.222938853125;13800.654983625389;13924.234167120805;14130.364133614012;14143.292835358294;14160.504382346671;9530.904690953072;9954.253430992632;11430.25703329281;11696.824547631792;11748.942595166476;3759.172981943968;3762.811859407046;3773.792441415721;3843.5579908310624;3869.535655721303;62010;100383;103704.85180592767;103828.48085759523;115453.42273288664;9716.708498745049;10138.594456221668;10372.533236004398;10702.143828493701;11304.604338848265;22048.11807527713;22197.22309719152;22311.665325020138;22482.21312254096;22588.887055564617;7455.4408419368765;7790.8052298691855;7865.213478652204;7885.881711774328;7929.405294602928;4116.176764647083;4210.389493523483;4332.978335108367;4352.064306174188;4380.496242932039;3497.405441075023;3606.6934310583893;3617.746757726934;3623.927521449556;3631.5642122945414;549.9395066542677;643.7553729582822;648.1153225846685;658.9110470086573;663.0286630086946;581.2792137749161;618.4186864347499;632.4876849751624;640.4972096903908;643.7135474713707;9186.127317904788;10024.749381265381;10142.239332050125;10387.68836934893;10474.266801323987;578.3002566894105;580.8605934575671;587.7443312159139;642.6529673976;692.4391243093111;4003.679705623543;4206.221848957953;4946.876328091755;4961.305417241589;4967.329410529533;101497.98502014886;102608;111519;114127;115708.84291156981;76999.61500192463;92074.53962730143;93506.53246733722;96864.51567742116;101722;81545;83445.58277208575;83721;83909.16090839135;84250.73623895524;10513.9474302628;11017.779644407226;11148;11225.326480411202;11241.943790280997;40539.1892162161;49451.752741236065;49990.25014624856;50565;51282;67731;68169.59152042477;69738;69851.60296793934;70636.64681676558;12732.87267127317;12875.74152964137;13003.674908127372;13347.66630834237;13677.384517696528;14286.928565357106;14341.426342946166;14839.554813355617;15059.32068883441;15104.924475377553;13495.527656531975;13567.38946747379;13601.863981360455;14224.786628200378;14287.642808929444;11743.76512469763;11774.94112529432;11937.343446110548;12450.501979920702;12713.36433178356;12600;12898.48406063747;12903.612891613267;13366.198028118344;13769.242691652054;10621.628243011457;10853.891461085288;11147.721306967067;11502.539898404304;11782;10596.36193890867;10720.678379648623;10766.569337226423;10783.946080269548;10805.567777288821 02:40:39 INFO - PROCESS | 2495 | __end_tp_report 02:40:39 INFO - PROCESS | 2495 | __start_cc_report 02:40:39 INFO - PROCESS | 2495 | _x_x_mozilla_cycle_collect,375 02:40:39 INFO - PROCESS | 2495 | __end_cc_report 02:40:39 INFO - PROCESS | 2495 | __startTimestamp1486982439656__endTimestamp 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | ------- Summary: start ------- 02:40:39 INFO - PROCESS | 2495 | Number of tests: 6 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#0] dojo.html Cycles:165 Average:5661.06 Median:5891.76 stddev:669.10 (11.4%) stddev-sans-first:637.33 02:40:39 INFO - PROCESS | 2495 | Values: 2983.4 3338.3 3373.5 3394.2 3408.9 5616.8 5647.7 5658.7 5714.9 5731.7 5697.6 5748.3 5767.5 5782.3 5799.5 5160.5 5215.1 5223.5 5234.4 5265.9 5204.1 5272.4 5286.9 5299.0 5320.7 4782.3 5112.5 5186.9 5229.7 5241.0 4186.9 4237.4 5131.0 5205.6 5231.5 5134.4 5172.4 5179.3 5186.2 5216.7 4309.4 5511.5 5631.2 5764.0 5770.7 6076.6 6079.6 6086.9 6109.7 6123.6 5271.7 5551.5 6165.5 6167.4 6215.4 5618.5 5872.6 5883.3 5891.8 5907.4 6146.1 6167.0 6177.7 6186.9 6214.1 5202.2 6071.0 6108.4 6122.7 6136.1 6008.5 6140.6 6147.2 6170.4 6174.8 6041.4 6052.3 6077.0 6104.6 6107.8 6116.5 6128.4 6139.4 6140.0 6157.1 4926.5 4943.8 4946.5 4949.8 4965.0 4374.9 4410.1 4414.4 4455.9 4480.2 5758.1 5825.9 5853.3 5878.1 5913.5 6136.6 6140.8 6176.5 6190.8 6198.1 5614.3 5667.1 5778.1 5821.7 5839.4 4735.4 5485.1 5485.2 5501.3 5522.3 5412.5 6333.9 6349.0 6349.6 6401.8 5250.6 6085.5 6117.1 6141.6 6156.8 6287.2 6362.1 6380.5 6384.3 6384.4 6143.0 6157.9 6174.8 6178.4 6183.4 6114.0 6125.3 6129.8 6185.8 6199.5 6074.8 6144.0 6145.4 6147.9 6171.6 4728.8 6084.9 6150.8 6151.4 6153.2 5731.7 5839.6 5919.7 5986.3 6038.1 5955.7 6010.5 6011.5 6060.1 6108.6 4459.4 5759.2 6000.0 6000.8 6038.0 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#1] ext.html Cycles:180 Average:68132.33 Median:35118.24 stddev:149578.57 (425.9%) stddev-sans-first:149911.83 02:40:39 INFO - PROCESS | 2495 | Values: 440.9 461.6 461.9 498.8 526.3 36287.6 39284.6 39296.6 39482.4 39693.0 41351.4 41467.6 41790.6 41834.8 41916.2 8463.2 8675.3 9021.0 9279.6 9288.2 11216.4 11455.8 11511.0 11594.2 11602.1 10373.3 11047.7 11411.2 11412.7 11448.8 11167.2 11284.3 11297.1 11361.1 11373.8 9801.7 11199.2 11223.0 11228.6 11293.3 39382.0 39715.6 39734.8 39842.8 39875.6 3856.3 3917.1 3969.8 4012.2 4021.9 24500.4 26091.9 27003.9 27036.5 27147.5 3053.1 3110.2 3214.6 3237.4 3273.0 497064.0 497518.0 498053.0 499699.5 500399.0 54679.7 56210.4 56314.7 56598.0 56692.7 57690.7 58209.7 58495.4 58535.1 58558.0 15820.8 15969.7 15973.5 15987.6 15988.0 11114.3 11382.5 12316.0 12921.5 13164.8 17762.0 20964.5 21834.3 21863.2 21930.2 7472.3 8625.7 8777.8 8840.0 8860.5 857.8 864.3 874.9 876.9 882.1 29557.4 29803.0 30313.5 30678.5 30694.0 912.3 1051.9 1053.6 1089.2 1166.3 15102.1 15575.0 15827.4 15912.5 15948.0 643408.0 644595.0 646000.0 647331.0 648003.0 44142.8 57505.7 61186.7 61276.8 61333.7 1390.1 1409.9 1427.2 1431.6 1435.1 28701.0 29403.7 29646.0 29676.9 29966.3 39276.4 39368.0 39740.8 39800.8 39897.6 515467.4 520266.0 526893.0 527342.0 527825.0 25415.5 25985.1 25988.2 27278.3 27376.3 42034.6 42055.8 43090.8 43140.5 43376.6 34715.0 35030.6 35133.8 35161.6 35464.9 34778.1 34940.0 35752.8 35767.8 36109.0 34066.8 34520.1 35021.0 35102.6 35413.0 30344.7 31022.0 31319.5 31354.0 31381.7 23485.2 23681.5 23898.8 23980.6 24336.0 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#2] jquery.html Cycles:180 Average:41267.13 Median:21596.80 stddev:130592.71 (604.7%) stddev-sans-first:130922.98 02:40:39 INFO - PROCESS | 2495 | Values: 388.3 388.9 401.5 402.9 418.8 15231.5 17009.3 20283.8 20488.0 20624.2 17506.8 21478.4 21715.2 22036.8 22434.2 4867.5 5229.4 5577.4 5595.9 5618.9 5059.4 5266.6 5564.6 5661.5 5669.9 4948.4 5558.5 5655.3 5672.6 5674.6 5410.8 5552.1 5644.6 5649.9 5655.0 5009.7 5018.8 5020.7 5028.7 5036.0 25563.5 26073.6 26251.0 26495.9 26533.7 2710.6 2762.1 2771.6 2778.4 2787.1 15678.2 15769.8 16247.6 16353.3 16883.9 1842.0 1893.3 1902.9 1913.6 1913.7 129226.0 133169.3 134268.0 135288.9 137326.3 11399.8 11489.8 11534.9 11547.1 11671.3 11633.3 13734.9 14618.1 14687.5 14833.5 8630.7 8729.3 8971.4 9003.6 9060.7 7574.5 7797.6 9042.1 9050.5 9092.9 7348.5 7380.7 7483.1 7489.7 7518.5 1930.5 1951.4 1958.5 1962.4 1962.4 1039.0 1049.6 1066.0 1077.7 1091.5 22362.0 22870.7 23126.0 23276.9 23850.0 1084.6 1103.8 1108.9 1121.5 1128.3 11412.0 11893.1 11984.8 12125.9 12164.5 764153.0 781613.0 789632.0 802618.0 806681.0 132186.0 134405.3 134784.0 136330.0 140050.0 1021.8 1040.5 1044.6 1044.9 1053.3 18984.8 19919.2 19921.9 20010.9 20236.0 43630.8 47105.0 55939.0 58467.5 59317.0 73628.6 74049.0 76498.6 77002.0 77043.0 8059.0 8224.3 8391.3 8407.2 8448.2 11663.7 12400.9 13251.7 13642.9 13658.2 11016.4 11298.4 11340.3 11377.2 11449.9 11366.7 11379.1 11406.3 11569.9 11802.2 11511.7 11559.8 11692.0 11768.4 11904.8 7459.9 7641.5 7794.5 8254.2 8257.0 8081.3 10872.3 11585.8 11588.8 11660.3 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#3] mootools.html Cycles:180 Average:5430.64 Median:5209.76 stddev:2950.18 (56.6%) stddev-sans-first:2942.42 02:40:39 INFO - PROCESS | 2495 | Values: 1338.1 1433.1 1434.3 1443.5 1456.5 7571.5 7825.9 8197.1 8615.8 8628.5 8092.4 8322.0 8381.0 8494.9 8496.5 2033.2 2305.6 2353.4 2354.2 2363.4 2085.5 2161.9 2320.6 2362.5 2369.6 2276.5 2356.5 2362.8 2368.6 2372.0 2322.7 2346.5 2347.5 2360.5 2366.0 2307.0 2338.5 2365.5 2375.5 2403.3 8567.6 8643.1 8646.9 8660.4 8700.0 5063.5 5208.0 5211.5 5223.7 5225.9 3292.7 3469.3 3536.1 3555.0 3569.3 1203.8 1213.5 1261.3 1264.7 1267.3 10595.9 10691.4 10859.8 10876.9 10917.9 4600.1 4671.9 4703.6 4746.3 4758.5 9476.6 9608.7 9611.3 9619.3 9628.0 5271.0 5273.8 5358.6 5364.4 5387.1 4618.8 4806.7 4845.6 4854.3 4898.6 3839.3 3942.0 3950.1 3970.2 4042.8 1177.2 1224.3 1252.6 1296.6 1301.4 782.9 841.8 897.2 908.0 913.3 4903.3 5650.7 5808.2 5812.9 5880.9 856.8 961.4 975.4 1021.4 1024.5 3598.4 3774.6 3784.7 3813.7 3842.2 8952.6 9653.9 9810.0 10055.0 10075.2 9502.8 9805.7 9925.5 10034.2 10046.1 6913.4 7846.9 8001.8 8008.2 8038.5 4635.4 4834.7 5341.0 5440.7 5776.3 8876.9 9154.3 9155.4 9200.4 9395.6 9265.8 9395.5 9397.9 9433.9 9528.0 6983.3 7118.5 7121.9 7130.2 7157.7 6748.0 7832.0 7841.0 7856.9 7972.0 6518.2 7063.4 7182.4 7194.7 7209.7 6975.6 7063.1 7080.5 7087.0 7124.2 5625.4 6371.4 6377.1 6443.0 6461.1 4592.3 4696.3 4930.5 4959.4 5057.9 4130.1 4433.2 4930.0 5078.1 5079.9 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#4] prototype.html Cycles:180 Average:4523.42 Median:5113.37 stddev:1372.69 (26.8%) stddev-sans-first:1338.92 02:40:39 INFO - PROCESS | 2495 | Values: 270.9 366.0 368.3 375.6 378.0 4572.3 5364.3 5480.3 5511.9 5556.6 4506.7 5395.8 5414.3 5467.2 5467.5 3538.7 3547.8 4236.2 4239.8 4245.7 4148.8 4243.4 4272.6 4276.8 4298.6 3685.3 4161.4 4168.0 4219.3 4273.5 3479.9 3507.7 3674.6 4075.4 4192.9 3619.5 3720.9 3745.7 3747.3 3747.7 4892.8 5337.3 5337.4 5383.7 5434.6 4869.9 4875.5 4894.5 4896.7 4901.8 5548.3 5649.9 5833.7 5890.9 5910.9 3477.8 3961.7 4038.4 4069.2 4081.3 4685.1 5219.0 6129.2 6145.5 6150.4 3413.9 3913.9 4191.4 4192.4 4198.6 3423.5 3500.7 3560.0 3923.0 3969.6 4123.8 4596.7 4672.9 4689.8 4705.2 5405.5 5439.5 5817.9 5833.2 5838.0 1235.1 1260.6 1271.2 1299.8 1302.4 854.7 854.9 864.8 866.1 881.5 4805.5 4944.1 5143.8 5159.8 5226.8 5361.4 5383.3 5469.7 5702.5 5722.8 4674.0 4741.9 4767.6 5181.3 5225.4 2445.9 2492.7 2963.8 2999.4 3017.8 4915.4 4998.2 5118.9 5356.9 5872.9 5182.7 5224.0 5650.2 5767.0 5866.3 4871.9 5282.5 5364.9 5811.8 5838.4 5107.8 5184.6 5236.9 5283.7 5398.5 4557.4 5533.9 5544.9 5584.1 5596.7 5318.6 5643.4 5785.0 5883.5 5919.7 3464.8 3466.9 3732.2 3754.2 3798.8 4718.7 4826.3 4879.4 5161.0 5633.5 5170.5 5441.4 5459.3 5471.6 5478.0 4890.5 5088.3 5440.3 5461.5 5487.3 4765.2 5434.7 5495.8 5620.7 5633.7 4694.7 5448.6 5694.9 5696.8 5713.3 5329.2 5561.2 5623.9 5634.3 5634.4 02:40:39 INFO - PROCESS | 2495 | 02:40:39 INFO - PROCESS | 2495 | [#5] yui.html Cycles:180 Average:20631.52 Median:3695.37 stddev:29962.37 (810.8%) stddev-sans-first:30009.00 02:40:39 INFO - PROCESS | 2495 | Values: 688.2 701.3 744.4 821.3 844.9 14658.6 15421.5 15473.8 15476.8 15665.7 13495.7 14019.3 14188.7 14193.9 14222.9 837.4 860.3 861.5 864.2 865.6 859.3 863.6 864.2 864.6 865.8 903.2 909.5 909.6 911.0 911.5 883.6 897.4 901.9 905.0 906.2 660.7 668.9 669.2 670.6 672.3 15481.3 15486.5 15512.7 15530.6 15541.2 13800.7 13924.2 14130.4 14143.3 14160.5 9530.9 9954.3 11430.3 11696.8 11748.9 3759.2 3762.8 3773.8 3843.6 3869.5 62010.0 100383.0 103704.9 103828.5 115453.4 9716.7 10138.6 10372.5 10702.1 11304.6 22048.1 22197.2 22311.7 22482.2 22588.9 7455.4 7790.8 7865.2 7885.9 7929.4 4116.2 4210.4 4333.0 4352.1 4380.5 3497.4 3606.7 3617.7 3623.9 3631.6 549.9 643.8 648.1 658.9 663.0 581.3 618.4 632.5 640.5 643.7 9186.1 10024.7 10142.2 10387.7 10474.3 578.3 580.9 587.7 642.7 692.4 4003.7 4206.2 4946.9 4961.3 4967.3 101498.0 102608.0 111519.0 114127.0 115708.8 76999.6 92074.5 93506.5 96864.5 101722.0 81545.0 83445.6 83721.0 83909.2 84250.7 10513.9 11017.8 11148.0 11225.3 11241.9 40539.2 49451.8 49990.3 50565.0 51282.0 67731.0 68169.6 69738.0 69851.6 70636.6 12732.9 12875.7 13003.7 13347.7 13677.4 14286.9 14341.4 14839.6 15059.3 15104.9 13495.5 13567.4 13601.9 14224.8 14287.6 11743.8 11774.9 11937.3 12450.5 12713.4 12600.0 12898.5 12903.6 13366.2 13769.2 10621.6 10853.9 11147.7 11502.5 11782.0 10596.4 10720.7 10766.6 10783.9 10805.6 02:40:39 INFO - PROCESS | 2495 | -------- Summary: end -------- 02:40:39 INFO - PROCESS | 2495 | 02:40:40 INFO - TEST-INFO | 2495: exit 0 02:40:40 INFO - TEST-OK | dromaeo_css | took 1114554ms 02:40:40 INFO - TEST-START | kraken 02:40:40 INFO - operating with platform_type : mac_ 02:40:40 INFO - Initialising browser for kraken test... 02:40:40 INFO - TEST-INFO | started process 2500 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpS2Zihq/profile http://localhost:59156/getInfo.html) 02:40:43 INFO - PROCESS | 2500 | 2017-02-13 02:40:43.288 plugin-container[2502:38915] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 02:40:43 INFO - PROCESS | 2500 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:40:43 INFO - PROCESS | 2500 | 2017-02-13 02:40:43.289 plugin-container[2502:38915] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a57, name = 'com.apple.CFPasteboardClient' 02:40:43 INFO - PROCESS | 2500 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:40:43 INFO - PROCESS | 2500 | 2017-02-13 02:40:43.289 plugin-container[2502:38915] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:40:43 INFO - PROCESS | 2500 | __metrics Screen width/height:1600/1200 02:40:43 INFO - PROCESS | 2500 | colorDepth:24 02:40:43 INFO - PROCESS | 2500 | Browser inner width/height: 1024/689 02:40:43 INFO - PROCESS | 2500 | __metrics 02:40:43 ERROR - PROCESS | 2500 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:40:44 INFO - TEST-INFO | 2500: exit 0 02:40:44 INFO - Browser initialized. 02:40:44 INFO - Running cycle 1/1 for kraken test... 02:40:44 INFO - TEST-INFO | started process 2503 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpS2Zihq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:46 INFO - PROCESS | 2503 | 2017-02-13 02:40:46.791 plugin-container[2504:39044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 02:40:46 INFO - PROCESS | 2503 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:40:46 INFO - PROCESS | 2503 | 2017-02-13 02:40:46.791 plugin-container[2504:39044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8927, name = 'com.apple.CFPasteboardClient' 02:40:46 INFO - PROCESS | 2503 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:40:46 INFO - PROCESS | 2503 | 2017-02-13 02:40:46.791 plugin-container[2504:39044] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:40:56 INFO - PROCESS | 2503 | RSS: Main: 219213824 02:40:56 INFO - PROCESS | 2503 | 02:40:59 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59156/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:00 INFO - PROCESS | 2503 | RSS: Main: 234082304 02:41:00 INFO - PROCESS | 2503 | 02:41:02 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59156/tests/kraken/driver.html?testName=audio-dft) 02:41:03 INFO - PROCESS | 2503 | RSS: Main: 241209344 02:41:03 INFO - PROCESS | 2503 | 02:41:06 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59156/tests/kraken/driver.html?testName=audio-fft) 02:41:07 INFO - PROCESS | 2503 | RSS: Main: 245104640 02:41:07 INFO - PROCESS | 2503 | 02:41:09 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59156/tests/kraken/driver.html?testName=audio-oscillator) 02:41:09 INFO - PROCESS | 2503 | RSS: Main: 245407744 02:41:09 INFO - PROCESS | 2503 | 02:41:11 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59156/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:12 INFO - PROCESS | 2503 | RSS: Main: 247279616 02:41:12 INFO - PROCESS | 2503 | 02:41:15 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59156/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:15 INFO - PROCESS | 2503 | RSS: Main: 251691008 02:41:15 INFO - PROCESS | 2503 | 02:41:18 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59156/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:19 INFO - PROCESS | 2503 | RSS: Main: 250982400 02:41:19 INFO - PROCESS | 2503 | 02:41:22 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59156/tests/kraken/driver.html?testName=json-parse-financial) 02:41:23 INFO - PROCESS | 2503 | RSS: Main: 250130432 02:41:23 INFO - PROCESS | 2503 | 02:41:24 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59156/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:25 INFO - PROCESS | 2503 | RSS: Main: 249597952 02:41:25 INFO - PROCESS | 2503 | 02:41:27 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:28 INFO - PROCESS | 2503 | RSS: Main: 249810944 02:41:28 INFO - PROCESS | 2503 | 02:41:30 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:30 INFO - PROCESS | 2503 | RSS: Main: 249597952 02:41:30 INFO - PROCESS | 2503 | 02:41:33 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:34 INFO - PROCESS | 2503 | RSS: Main: 249622528 02:41:34 INFO - PROCESS | 2503 | 02:41:37 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:37 INFO - PROCESS | 2503 | RSS: Main: 249933824 02:41:37 INFO - PROCESS | 2503 | 02:41:39 INFO - PROCESS | 2503 | Cycle 1(1): loaded http://localhost:59156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59156/tests/kraken/driver.html?testName=ai-astar) 02:41:40 INFO - PROCESS | 2503 | RSS: Main: 251510784 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | __start_tp_report 02:41:40 INFO - PROCESS | 2503 | _x_x_mozilla_page_load 02:41:40 INFO - PROCESS | 2503 | _x_x_mozilla_page_load_details 02:41:40 INFO - PROCESS | 2503 | |i|pagename|runs| 02:41:40 INFO - PROCESS | 2503 | |0;ai-astar;113;118;121;118;119;119;119;106;107;157 02:41:40 INFO - PROCESS | 2503 | |1;audio-beat-detection;143;112;112;136;97;130;103;137;167;144 02:41:40 INFO - PROCESS | 2503 | |2;audio-dft;235;277;201;200;200;200;199;198;227;219 02:41:40 INFO - PROCESS | 2503 | |3;audio-fft;80;59;58;85;58;58;58;59;75;62 02:41:40 INFO - PROCESS | 2503 | |4;audio-oscillator;90;70;87;74;70;71;81;70;72;81 02:41:40 INFO - PROCESS | 2503 | |5;imaging-gaussian-blur;89;87;89;86;90;86;90;110;88;87 02:41:40 INFO - PROCESS | 2503 | |6;imaging-darkroom;101;104;169;119;103;100;106;130;103;99 02:41:40 INFO - PROCESS | 2503 | |7;imaging-desaturate;93;99;91;94;94;92;99;142;97;141 02:41:40 INFO - PROCESS | 2503 | |8;json-parse-financial;46;53;88;90;58;62;59;60;60;60 02:41:40 INFO - PROCESS | 2503 | |9;json-stringify-tinderbox;70;77;77;83;76;76;72;75;77;74 02:41:40 INFO - PROCESS | 2503 | |10;stanford-crypto-aes;84;84;87;83;87;84;85;82;84;86 02:41:40 INFO - PROCESS | 2503 | |11;stanford-crypto-ccm;143;152;131;137;135;139;143;142;218;141 02:41:40 INFO - PROCESS | 2503 | |12;stanford-crypto-pbkdf2;166;173;185;228;175;169;170;166;167;169 02:41:40 INFO - PROCESS | 2503 | |13;stanford-crypto-sha256-iterative;67;66;68;85;86;89;81;68;69;69 02:41:40 INFO - PROCESS | 2503 | __end_tp_report 02:41:40 INFO - PROCESS | 2503 | __start_cc_report 02:41:40 INFO - PROCESS | 2503 | _x_x_mozilla_cycle_collect,924 02:41:40 INFO - PROCESS | 2503 | __end_cc_report 02:41:40 INFO - PROCESS | 2503 | __startTimestamp1486982500057__endTimestamp 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | ------- Summary: start ------- 02:41:40 INFO - PROCESS | 2503 | Number of tests: 14 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#0] ai-astar Cycles:10 Average:119.70 Median:119.00 stddev:14.12 (11.9%) stddev-sans-first:14.77 02:41:40 INFO - PROCESS | 2503 | Values: 113.0 118.0 121.0 118.0 119.0 119.0 119.0 106.0 107.0 157.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:140.00 stddev:21.73 (15.5%) stddev-sans-first:22.37 02:41:40 INFO - PROCESS | 2503 | Values: 143.0 112.0 112.0 136.0 97.0 130.0 103.0 137.0 167.0 144.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#2] audio-dft Cycles:10 Average:215.60 Median:210.00 stddev:25.42 (12.1%) stddev-sans-first:25.98 02:41:40 INFO - PROCESS | 2503 | Values: 235.0 277.0 201.0 200.0 200.0 200.0 199.0 198.0 227.0 219.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.50 stddev:10.55 (17.4%) stddev-sans-first:9.74 02:41:40 INFO - PROCESS | 2503 | Values: 80.0 59.0 58.0 85.0 58.0 58.0 58.0 59.0 75.0 62.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.50 stddev:7.57 (9.8%) stddev-sans-first:6.29 02:41:40 INFO - PROCESS | 2503 | Values: 90.0 70.0 87.0 74.0 70.0 71.0 81.0 70.0 72.0 81.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:88.50 stddev:7.11 (8.0%) stddev-sans-first:7.53 02:41:40 INFO - PROCESS | 2503 | Values: 89.0 87.0 89.0 86.0 90.0 86.0 90.0 110.0 88.0 87.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:112.50 stddev:21.85 (19.4%) stddev-sans-first:22.71 02:41:40 INFO - PROCESS | 2503 | Values: 101.0 104.0 169.0 119.0 103.0 100.0 106.0 130.0 103.0 99.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:94.00 stddev:19.85 (21.1%) stddev-sans-first:20.63 02:41:40 INFO - PROCESS | 2503 | Values: 93.0 99.0 91.0 94.0 94.0 92.0 99.0 142.0 97.0 141.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:60.00 stddev:14.18 (23.6%) stddev-sans-first:13.53 02:41:40 INFO - PROCESS | 2503 | Values: 46.0 53.0 88.0 90.0 58.0 62.0 59.0 60.0 60.0 60.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:76.50 stddev:3.47 (4.5%) stddev-sans-first:3.00 02:41:40 INFO - PROCESS | 2503 | Values: 70.0 77.0 77.0 83.0 76.0 76.0 72.0 75.0 77.0 74.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.65 (1.9%) stddev-sans-first:1.73 02:41:40 INFO - PROCESS | 2503 | Values: 84.0 84.0 87.0 83.0 87.0 84.0 85.0 82.0 84.0 86.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:142.50 stddev:25.19 (17.7%) stddev-sans-first:26.65 02:41:40 INFO - PROCESS | 2503 | Values: 143.0 152.0 131.0 137.0 135.0 139.0 143.0 142.0 218.0 141.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:171.50 stddev:18.87 (11.0%) stddev-sans-first:19.60 02:41:40 INFO - PROCESS | 2503 | Values: 166.0 173.0 185.0 228.0 175.0 169.0 170.0 166.0 167.0 169.0 02:41:40 INFO - PROCESS | 2503 | 02:41:40 INFO - PROCESS | 2503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:9.24 (12.3%) stddev-sans-first:9.35 02:41:40 INFO - PROCESS | 2503 | Values: 67.0 66.0 68.0 85.0 86.0 89.0 81.0 68.0 69.0 69.0 02:41:40 INFO - PROCESS | 2503 | -------- Summary: end -------- 02:41:40 INFO - PROCESS | 2503 | 02:41:41 INFO - TEST-INFO | 2503: exit 0 02:41:41 INFO - TEST-OK | kraken | took 60819ms 02:41:41 INFO - SUITE-END | took 1175s 02:41:41 INFO - Completed test suite (00:19:35) 02:41:41 INFO - javascript benchmark 02:41:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.965869090666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.4331477019364, 3338.332333533294, 3373.4771110477886, 3394.1514621344663, 3408.931821363573, 5616.831495055155, 5647.6893770842635, 5658.688772117537, 5714.857128571788, 5731.713414329288, 5697.6011679182475, 5748.338941021784, 5767.480926716595, 5782.277215348082, 5799.478046975772, 5160.483951604829, 5215.139501982168, 5223.451537588537, 5234.42421333653, 5265.868353291179, 5204.089284375238, 5272.367315922094, 5286.920696189561, 5299.019681358942, 5320.733963301819, 4782.33047373368, 5112.463191364927, 5186.92219616706, 5229.686218826844, 5241.030409374278, 4186.853460128881, 4237.406763053175, 5130.9743451282875, 5205.609579281569, 5231.476852314738, 5134.435212126663, 5172.379314482248, 5179.2749015137915, 5186.196139598368, 5216.739163041871, 4309.4397728295435, 5511.503964643161, 5631.183478395651, 5763.971180144114, 5770.682612456313, 6076.605020673642, 6079.574429789916, 6086.9391306087255, 6109.694515274263, 6123.557162997608, 5271.710055946922, 5551.472610102034, 6165.506759459233, 6167.444929956326, 6215.378462153793, 5618.522425593829, 5872.618279811799, 5883.323417807007, 5891.764329426818, 5907.409259074101, 6146.078088286703, 6167.0, 6177.660228687465, 6186.938130618726, 6214.098955651496, 5202.2196670499725, 6071.0286354184, 6108.358622344679, 6122.663253521099, 6136.059583474799, 6008.519318454513, 6140.570160088841, 6147.170132032208, 6170.413810687977, 6174.783882564088, 6041.426064523863, 6052.334243233241, 6077.0, 6104.572679912452, 6107.765388666889, 6116.541259405562, 6128.387161283925, 6139.355367686418, 6139.986902161183, 6157.107219453154, 4926.45808961014, 4943.826966056243, 4946.505349465025, 4949.752512374439, 4964.975175124101, 4374.912501750011, 4410.07388448423, 4414.448193975753, 4455.933161002587, 4480.215962206601, 5758.1362795581, 5825.854353641193, 5853.268341457318, 5878.059510478303, 5913.497352725067, 6136.6011209271255, 6140.815775526741, 6176.474999624992, 6190.7523699052435, 6198.101275315144, 5614.326280846324, 5667.121596152603, 5778.104393818965, 5821.679807610622, 5839.416058394211, 4735.408073990751, 5485.122380419193, 5485.177223416519, 5501.284832971688, 5522.2544956431175, 5412.539934105566, 6333.904991425225, 6349.0, 6349.619022858736, 6401.775937842153, 5250.606204534752, 6085.482733967662, 6117.066276512034, 6141.570090093651, 6156.846078848064, 6287.2140982377205, 6362.141110949962, 6380.489560835029, 6384.265809431975, 6384.361563843579, 6142.969285153546, 6157.938420615916, 6174.845628859314, 6178.41305076017, 6183.3816618337805, 6113.9932453606225, 6125.264968203844, 6129.817282374446, 6185.752569897154, 6199.473044791243, 6074.757009719739, 6143.96928015357, 6145.446909778141, 6147.893379191788, 6171.56799024064, 4728.763561821826, 6084.8783024340155, 6150.846228844314, 6151.384861513991, 6153.169322141453, 5731.7420716067045, 5839.649621022752, 5919.7040147991565, 5986.3115741688525, 6038.094285856981, 5955.67243801595, 6010.4891084258325, 6011.458968692838, 6060.090986352083, 6108.645631960618, 4459.375687403701, 5759.222504961944, 6000.039993601003, 6000.759969601341, 6037.969810151097], "value": 5620.3181467818795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.90740944401676, 461.5707392125322, 461.89146049481263, 498.7805365639118, 526.3263023330137, 36287.63712362875, 39284.60715392845, 39296.60703392965, 39482.407763883566, 39693.00767480814, 41351.379729304084, 41467.58532414675, 41790.58209417905, 41834.79082604583, 41916.161676766445, 8463.153684631518, 8675.305975521975, 9020.954895225515, 9279.628814847398, 9288.164065234128, 11216.439178041106, 11455.828162577527, 11511.0, 11594.246373985665, 11602.071834253282, 10373.325733827278, 11047.674279086481, 11411.201215914889, 11412.714682132972, 11448.771024579504, 11167.218294719332, 11284.322940623548, 11297.096232301396, 11361.091112710963, 11373.772524549546, 9801.656942006995, 11199.216054876162, 11223.0, 11228.606998755004, 11293.322400655987, 39382.0, 39715.60284397148, 39734.80132599318, 39842.80078599617, 39875.601243987476, 3856.3058649443087, 3917.138229589486, 3969.761814291152, 4012.1775036117524, 4021.939670904939, 24500.387490312707, 26091.869540652177, 27003.86498067497, 27036.45927081467, 27147.45705085907, 3053.114596766935, 3110.2224443889027, 3214.5660335854595, 3237.3848968695875, 3273.0344548358294, 497064.0, 497518.0, 498053.0, 499699.5015024938, 500399.0, 54679.72660136674, 56210.43789562134, 56314.718426407606, 56598.0, 56692.71653641705, 57690.711546442835, 58209.70895145497, 58495.41504584985, 58535.12197317043, 58558.0, 15820.841791581937, 15969.680606387807, 15973.520794376187, 15987.60030999211, 15988.04071755675, 11114.277571957797, 11382.487788049557, 12315.953143982862, 12921.483140674456, 13164.802527962089, 17762.0, 20964.47588810292, 21834.344969650618, 21863.234786782385, 21930.232441864457, 7472.32749052577, 8625.69810056645, 8777.824443511094, 8839.955800220958, 8860.468371897707, 857.7576759847785, 864.3301441382979, 874.9212570868652, 876.8553188723789, 882.1266945723816, 29557.408851822842, 29803.0, 30313.545296820565, 30678.53982190269, 30694.0, 912.3203213605774, 1051.8632577764843, 1053.5662619349175, 1089.1939964426267, 1166.2943918928927, 15102.114116390952, 15575.0, 15827.366905323888, 15912.52262432129, 15948.04311741276, 643408.0, 644595.0, 646000.0, 647331.0, 648003.0, 44142.77928610337, 57505.71247143738, 61186.69406652938, 61276.77446451046, 61333.69333153395, 1390.1381143690774, 1409.8590140985818, 1427.1722401007391, 1431.6420894776097, 1435.052865109044, 28701.0, 29403.705962940097, 29646.0, 29676.851615741783, 29966.25084372908, 39276.41085383664, 39368.031598419395, 39740.80129599333, 39800.80099599483, 39897.60102398939, 515467.4226628843, 520266.0, 526893.0, 527342.0, 527825.0, 25415.491690166462, 25985.0905218324, 25988.220353389428, 27278.318042049108, 27376.315592110357, 42034.579654203066, 42055.7897210512, 43090.78454607707, 43140.490082848206, 43376.56623433725, 34715.0, 35030.64969350274, 35133.82433087818, 35161.648383515836, 35464.936051918485, 34778.13054673653, 34940.0, 35752.82123589365, 35767.821160894026, 36109.0, 34066.82966585151, 34520.136996574285, 35021.0, 35102.64897350994, 35413.0, 30344.696553034188, 31022.0, 31319.530207046457, 31354.0, 31381.68618313879, 23485.17801876926, 23681.460705054116, 23898.761012389652, 23980.64029039531, 24336.0], "value": 19716.580959291452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.31462468742694, 388.8677849531161, 401.5141678568932, 402.8831638824742, 418.7947905526293, 15231.543053708407, 17009.31962721491, 20283.797162028375, 20488.0, 20624.175032998683, 17506.824931750678, 21478.355649330508, 21715.239966601173, 22036.779632203674, 22434.214802481918, 4867.537583929521, 5229.398619158788, 5577.358603760558, 5595.860103497404, 5618.887622247553, 5059.367579052619, 5266.631335806495, 5564.554835613141, 5661.547076233912, 5669.894370597735, 4948.430930442991, 5558.499735023847, 5655.34963479199, 5672.574556908227, 5674.574406919477, 5410.783568657249, 5552.112281824199, 5644.57665675074, 5649.887002259932, 5655.0386434306265, 5009.7495125243595, 5018.824341148079, 5020.723860187688, 5028.698278103289, 5036.043151801146, 25563.488730225476, 26073.60889586658, 26251.0, 26495.867520662465, 26533.734662653318, 2710.593410988348, 2762.06089929425, 2771.5704065869822, 2778.4026434316515, 2787.1220565521794, 15678.216089195608, 15769.842301577068, 16247.593810154722, 16353.345866165459, 16883.91558042214, 1841.9907900460546, 1893.2994791927076, 1902.9238830446766, 1913.6077104193607, 1913.7033759767257, 129226.0, 133169.33415332958, 134268.0, 135288.9375357598, 137326.31336843251, 11399.772004559862, 11489.827652585218, 11534.884651153381, 11547.076233901267, 11671.299722016536, 11633.302001879914, 13734.931325343508, 14618.122912625277, 14687.485937992118, 14833.480828171178, 8630.654773808978, 8729.301655867515, 8971.416857904216, 9003.594838232295, 9060.728178154666, 7574.545527268381, 7797.649105790139, 9042.095790420904, 9050.456972581665, 9092.909070909207, 7348.485606007635, 7380.667869945865, 7483.064616922885, 7489.662965166472, 7518.548887066793, 1930.5366711989302, 1951.3950675290705, 1958.529952811315, 1962.3524237001754, 1962.391658585843, 1038.984415233772, 1049.5987856212043, 1066.0, 1077.6928575356142, 1091.49245600796, 22362.0, 22870.656940145913, 23126.0, 23276.883615581814, 23850.0, 1084.5661735305782, 1103.806589994076, 1108.9057430118369, 1121.4616983847798, 1128.3060917535656, 11412.0, 11893.108016898766, 11984.760304793856, 12125.93937030327, 12164.5134194633, 764153.0, 781613.0, 789632.0, 802618.0, 806681.0, 132186.0, 134405.32797336148, 134784.0, 136330.0, 140050.0, 1021.8109649714827, 1040.4641609571077, 1044.6343779677204, 1044.8537204791487, 1053.3206082077018, 18984.810151898855, 19919.203231871143, 19921.900390498533, 20010.89940053311, 20236.0, 43630.78184609057, 47105.0, 55939.0, 58467.53831154255, 59317.0, 73628.63185684037, 74049.0, 76498.61750691211, 77002.0, 77043.0, 8058.959705201437, 8224.259816616533, 8391.28674062687, 8407.201315874981, 8448.197421244971, 11663.708407289547, 12400.875991239973, 13251.66870828237, 13642.86357136416, 13658.180509169482, 11016.449177541252, 11298.435078246219, 11340.262882912584, 11377.203595748219, 11449.94275028653, 11366.659000230007, 11379.089672825989, 11406.315621062762, 11569.942150289195, 11802.232854864405, 11511.712207194887, 11559.76880462403, 11692.0061794745, 11768.411579421167, 11904.821427678418, 7459.888101678588, 7641.465097443348, 7794.532328060334, 8254.215849494289, 8256.958715206385, 8081.272685458337, 10872.293300935415, 11585.768284634092, 11588.826167607662, 11660.30038197711], "value": 10110.118696468548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.1235290884472, 1433.1329545624903, 1434.2900264369139, 1443.5164219986304, 1456.4611093895257, 7571.545707257568, 7825.882611760828, 8197.098319184892, 8615.78460538486, 8628.525431101294, 8092.39307051972, 8321.958390208056, 8381.0, 8494.91505084949, 8496.532690702008, 2033.176563491788, 2305.5734689082487, 2353.411647088228, 2354.21133920137, 2363.3500787283547, 2085.4786303424144, 2161.9243326483574, 2320.628699408095, 2362.456634973957, 2369.5616310982437, 2276.5105502316997, 2356.5404746074523, 2362.7755363240462, 2368.5973384524673, 2371.95256094878, 2322.744498105207, 2346.4720437901506, 2347.5070235250705, 2360.527894421114, 2366.0, 2306.988465057681, 2338.4972230970425, 2365.5387199496104, 2375.477394973103, 2403.291029146406, 8567.614457349435, 8643.09247529013, 8646.870296945552, 8660.43707159039, 8700.0, 5063.493650634944, 5208.036513245024, 5211.478852114796, 5223.660462069954, 5225.921611175835, 3292.670732926712, 3469.340825243196, 3536.0806190390686, 3555.0401391624373, 3569.250457403948, 1203.8194270859353, 1213.5267245774155, 1261.3251910228075, 1264.7027948432112, 1267.3219827392302, 10595.94702026485, 10691.358518488916, 10859.83710244347, 10876.891231087668, 10917.945410272898, 4600.079984003212, 4671.85984420468, 4703.553162449562, 4746.288056791509, 4758.524147585283, 9476.620935162655, 9608.711738647851, 9611.279154063473, 9619.27855410847, 9628.037196280316, 5271.0, 5273.815416460406, 5358.571314294847, 5364.383095943938, 5387.0841956867425, 4618.792154352995, 4806.663533552688, 4845.563899249085, 4854.320395144682, 4898.608111351084, 3839.251345987506, 3942.0, 3950.051987523031, 3970.2456533258587, 4042.8275800018255, 1177.1877404590805, 1224.2837939805313, 1252.6367353467392, 1296.6110166949877, 1301.3818436242898, 782.8669126248551, 841.8358420108143, 897.1790811407488, 907.9727608171765, 913.255696607263, 4903.338049363361, 5650.689212093374, 5808.186853840466, 5812.912806307909, 5880.94119058804, 856.7686724584328, 961.4087336288133, 975.4439969217619, 1021.4177918586483, 1024.4826362686795, 3598.442241452579, 3774.5659249186697, 3784.6593806557544, 3813.7330386872654, 3842.2315536892734, 8952.597133128895, 9653.938066812645, 9809.950950245204, 10055.044770746767, 10075.193984481224, 9502.762430939281, 9805.705828825146, 9925.454100024424, 10034.197264218845, 10046.146077583488, 6913.446924246048, 7846.9215307847335, 8001.759947201594, 8008.159143289987, 8038.517688938682, 4635.420572428447, 4834.685745426536, 5340.968504917217, 5440.700761458158, 5776.335721392094, 8876.911230887608, 9154.313426492907, 9155.404898681565, 9200.447973121367, 9395.577199026196, 9265.7954465919, 9395.483248421402, 9397.859032114387, 9433.858492122486, 9527.952360238432, 6983.301669832976, 7118.537295075804, 7121.893171602534, 7130.2156762757095, 7157.7136914522835, 6748.0, 7831.960840195762, 7840.960795195988, 7856.921430785619, 7971.963644726148, 6518.217813862367, 7063.364297213276, 7182.3894968928225, 7194.676239569128, 7209.702253594403, 6975.6163411012885, 7063.081799366049, 7080.468964827555, 7087.00781890546, 7124.180719217149, 5625.381208067191, 6371.362863713592, 6377.139086223486, 6442.967785161044, 6461.127747753993, 4592.311153327028, 4696.272077827942, 4930.531599498042, 4959.3552838132255, 5057.898842023213, 4130.070734084927, 4433.179861725591, 4929.975350123226, 5078.085944529872, 5079.87300317495], "value": 4424.363445095609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.8618604511699, 366.0, 368.33699341185843, 375.57747534024224, 377.9508663873696, 4572.291294849296, 5364.275822763935, 5480.314960629921, 5511.917321240185, 5556.638818476797, 4506.66200034997, 5395.838124856251, 5414.3232095987905, 5467.200295794424, 5467.480589344006, 3538.7345949053797, 3547.787132772029, 4236.237477254093, 4239.7668128252935, 4245.681573881971, 4148.8340466381305, 4243.405923170759, 4272.615464608185, 4276.807543660527, 4298.613124818766, 3685.299793039327, 4161.417401563784, 4167.979160104195, 4219.303814870543, 4273.465816772903, 3479.930401391983, 3507.7369197310177, 3674.5590529136675, 4075.409065685459, 4192.937105943398, 3619.511365965587, 3720.8511659533588, 3745.700343972476, 3747.306748251582, 3747.681447077002, 4892.828750993698, 5337.2527846101575, 5337.412884582693, 5383.730813459311, 5434.565234781208, 4869.853904382874, 4875.536824001714, 4894.461609222983, 4896.706197628154, 4901.754912254373, 5548.278723765925, 5649.8587535311535, 5833.679147646878, 5890.941090589082, 5910.911336329958, 3477.826108694555, 3961.6830653547645, 4038.414429907676, 4069.247189269965, 4081.3265811141127, 4685.109829132454, 5219.0, 6129.20320358355, 6145.477634401082, 6150.384961503813, 3413.9317213656086, 3913.882583522442, 4191.434156388909, 4192.406885383535, 4198.5591512891315, 3423.4693622488553, 3500.7397336958675, 3559.985404159802, 3922.9803850981134, 3969.622885825842, 4123.835046598102, 4596.701214421052, 4672.925227197696, 4689.812407503729, 4705.200115980291, 5405.5135037846785, 5439.537639300704, 5817.88364232713, 5833.241678581757, 5838.0, 1235.0675240193596, 1260.6281147061638, 1271.173737070893, 1299.7855353866505, 1302.3785387193004, 854.7307598106577, 854.9016863060704, 864.8400045991511, 866.1079088538816, 881.4667126388571, 4805.519448055236, 4944.1100601892, 5143.7685304161405, 5159.7678104485385, 5226.843194704165, 5361.383440904346, 5383.28553298223, 5469.72651367438, 5702.486776190163, 5722.799702010493, 4673.976630116827, 4741.928871066937, 4767.570918617272, 5181.274621552986, 5225.425203227642, 2445.9143929962365, 2492.675952126212, 2963.777716671258, 2999.3701322722036, 3017.7627172859025, 4915.353356625499, 4998.200287953982, 5118.910090427388, 5356.92861427716, 5872.911906321408, 5182.663126896739, 5223.973880130575, 5650.208970744099, 5767.0, 5866.325372582122, 4871.853844384674, 5282.536256863022, 5364.90019546, 5811.79658711943, 5838.3876737376995, 5107.8252002039, 5184.637075404686, 5236.926430081748, 5283.7093959831045, 5398.541124004503, 4557.384753058294, 5533.889322213453, 5544.944550554443, 5584.106542953108, 5596.720163991866, 5318.569522657786, 5643.372434603586, 5785.0, 5883.470487656132, 5919.691320384967, 3464.7747896386654, 3466.913327166841, 3732.2162345906577, 3754.23038277158, 3798.772073675588, 4718.7168769873915, 4826.3243145958895, 4879.414470263591, 5160.974195129001, 5633.521150702236, 5170.5346518813485, 5441.395362776347, 5459.323322090122, 5471.5896307777875, 5478.0, 4890.535399137077, 5088.313077734459, 5440.319960004999, 5461.5357694596405, 5487.286652735279, 4765.189917713928, 5434.728263586726, 5495.807646732505, 5620.690862002629, 5633.662080198306, 4694.718316900997, 5448.591355648263, 5694.857628559319, 5696.8006119785605, 5713.285839270091, 5329.241350354451, 5561.165825126263, 5623.943760562342, 5634.32388113429, 5634.380218175916], "value": 4093.939824887034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.1638808847252, 701.2951983256826, 744.4267913706447, 821.301893390618, 844.9450785698931, 14658.63353416165, 15421.537353879401, 15473.845261547382, 15476.845231547695, 15665.686686266283, 13495.66260843477, 14019.299035048258, 14188.71622567548, 14193.935454840903, 14222.857771422283, 837.4431003382758, 860.3289434241302, 861.483110133921, 864.1531299326664, 865.5845194306737, 859.3468963587655, 863.6070587882498, 864.2092485375905, 864.6109250837117, 865.7792262972933, 903.1510380242551, 909.522500687138, 909.6361455417853, 911.0479548871446, 911.4850109688039, 883.6200433813458, 897.3852910756153, 901.8602116671926, 905.0, 906.2070688147837, 660.6762686283735, 668.9096971908779, 669.160203944052, 670.6210990790237, 672.2907332763932, 15481.303341349667, 15486.5354039379, 15512.689746205013, 15530.61173470661, 15541.222938853125, 13800.654983625389, 13924.234167120805, 14130.364133614012, 14143.292835358294, 14160.504382346671, 9530.904690953072, 9954.253430992632, 11430.25703329281, 11696.824547631792, 11748.942595166476, 3759.172981943968, 3762.811859407046, 3773.792441415721, 3843.5579908310624, 3869.535655721303, 62010.0, 100383.0, 103704.85180592767, 103828.48085759523, 115453.42273288664, 9716.708498745049, 10138.594456221668, 10372.533236004398, 10702.143828493701, 11304.604338848265, 22048.11807527713, 22197.22309719152, 22311.665325020138, 22482.21312254096, 22588.887055564617, 7455.4408419368765, 7790.8052298691855, 7865.213478652204, 7885.881711774328, 7929.405294602928, 4116.176764647083, 4210.389493523483, 4332.978335108367, 4352.064306174188, 4380.496242932039, 3497.405441075023, 3606.6934310583893, 3617.746757726934, 3623.927521449556, 3631.5642122945414, 549.9395066542677, 643.7553729582822, 648.1153225846685, 658.9110470086573, 663.0286630086946, 581.2792137749161, 618.4186864347499, 632.4876849751624, 640.4972096903908, 643.7135474713707, 9186.127317904788, 10024.749381265381, 10142.239332050125, 10387.68836934893, 10474.266801323987, 578.3002566894105, 580.8605934575671, 587.7443312159139, 642.6529673976, 692.4391243093111, 4003.679705623543, 4206.221848957953, 4946.876328091755, 4961.305417241589, 4967.329410529533, 101497.98502014886, 102608.0, 111519.0, 114127.0, 115708.84291156981, 76999.61500192463, 92074.53962730143, 93506.53246733722, 96864.51567742116, 101722.0, 81545.0, 83445.58277208575, 83721.0, 83909.16090839135, 84250.73623895524, 10513.9474302628, 11017.779644407226, 11148.0, 11225.326480411202, 11241.943790280997, 40539.1892162161, 49451.752741236065, 49990.25014624856, 50565.0, 51282.0, 67731.0, 68169.59152042477, 69738.0, 69851.60296793934, 70636.64681676558, 12732.87267127317, 12875.74152964137, 13003.674908127372, 13347.66630834237, 13677.384517696528, 14286.928565357106, 14341.426342946166, 14839.554813355617, 15059.32068883441, 15104.924475377553, 13495.527656531975, 13567.38946747379, 13601.863981360455, 14224.786628200378, 14287.642808929444, 11743.76512469763, 11774.94112529432, 11937.343446110548, 12450.501979920702, 12713.36433178356, 12600.0, 12898.48406063747, 12903.612891613267, 13366.198028118344, 13769.242691652054, 10621.628243011457, 10853.891461085288, 11147.721306967067, 11502.539898404304, 11782.0, 10596.36193890867, 10720.678379648623, 10766.569337226423, 10783.946080269548, 10805.567777288821], "value": 7481.068355217495, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 121.0, 118.0, 119.0, 119.0, 119.0, 106.0, 107.0, 157.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 112.0, 136.0, 97.0, 130.0, 103.0, 137.0, 167.0, 144.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [235.0, 277.0, 201.0, 200.0, 200.0, 200.0, 199.0, 198.0, 227.0, 219.0], "value": 215.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 85.0, 58.0, 58.0, 58.0, 59.0, 75.0, 62.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 74.0, 70.0, 71.0, 81.0, 70.0, 72.0, 81.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 90.0, 86.0, 90.0, 110.0, 88.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 169.0, 119.0, 103.0, 100.0, 106.0, 130.0, 103.0, 99.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 91.0, 94.0, 94.0, 92.0, 99.0, 142.0, 97.0, 141.0], "value": 104.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 53.0, 88.0, 90.0, 58.0, 62.0, 59.0, 60.0, 60.0, 60.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 77.0, 83.0, 76.0, 76.0, 72.0, 75.0, 77.0, 74.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 87.0, 83.0, 87.0, 84.0, 85.0, 82.0, 84.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 152.0, 131.0, 137.0, 135.0, 139.0, 143.0, 142.0, 218.0, 141.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 173.0, 185.0, 228.0, 175.0, 169.0, 170.0, 166.0, 167.0, 169.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 85.0, 86.0, 89.0, 81.0, 68.0, 69.0, 69.0], "value": 74.8, "unit": "score"}]}]} 02:41:41 INFO - Return code: 0 02:41:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:41 ERROR - # TBPL SUCCESS # 02:41:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:41:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:41:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:41:41 INFO - 2017-02-13 02:41:41.359 screenresolution[2508:39422] starting screenresolution argv=screenresolution get 02:41:41 INFO - 2017-02-13 02:41:41.362 screenresolution[2508:39422] Display 0: 1600x1200x32@60 02:41:41 INFO - 2017-02-13 02:41:41.368 screenresolution[2509:39425] starting screenresolution argv=screenresolution list 02:41:41 INFO - Available Modes on Display 0 02:41:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:41:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:41:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:41:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:41:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:41:41 INFO - Intel Iris: 02:41:41 INFO - Chipset Model: Intel Iris 02:41:41 INFO - Type: GPU 02:41:41 INFO - Bus: Built-In 02:41:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:41:41 INFO - Vendor: Intel (0x8086) 02:41:41 INFO - Device ID: 0x0a2e 02:41:41 INFO - Revision ID: 0x0009 02:41:41 INFO - Displays: 02:41:41 INFO - Display: 02:41:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:41:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:41:41 INFO - Display Serial Number: 1600x1200 60 02:41:41 INFO - Main Display: Yes 02:41:41 INFO - Mirror: Off 02:41:41 INFO - Online: Yes 02:41:41 INFO - Rotation: Supported 02:41:41 INFO - Return code: 0 02:41:41 INFO - Running post-action listener: _resource_record_post_action 02:41:41 INFO - [mozharness: 2017-02-13 10:41:41.617329Z] Finished run-tests step (success) 02:41:41 INFO - Running post-run listener: _resource_record_post_run 02:41:41 INFO - Total resource usage - Wall time: 1196s; CPU: 55.0%; Read bytes: 1187840; Write bytes: 510957056; Read time: 8; Write time: 1609 02:41:41 INFO - TinderboxPrint: CPU usage
54.5% 02:41:41 INFO - TinderboxPrint: I/O read bytes / time
1,187,840 / 8 02:41:41 INFO - TinderboxPrint: I/O write bytes / time
510,957,056 / 1,609 02:41:41 INFO - TinderboxPrint: CPU idle
2,175.8 (45.5%) 02:41:41 INFO - TinderboxPrint: CPU system
965.6 (20.2%) 02:41:41 INFO - TinderboxPrint: CPU user
1,644.2 (34.4%) 02:41:41 INFO - TinderboxPrint: Swap in / out
208,523,264 / 0 02:41:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207391232; Write bytes: 199925760; Read time: 15858; Write time: 429 02:41:41 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 1138688; Write bytes: 300992000; Read time: 6; Write time: 1141 02:41:42 INFO - Running post-run listener: _upload_blobber_files 02:41:42 INFO - Blob upload gear active. 02:41:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:42 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 02:41:42 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:42 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:41:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:43 INFO - (blobuploader) - INFO - Done attempting. 02:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:44 INFO - (blobuploader) - INFO - Done attempting. 02:41:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:41:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:45 INFO - (blobuploader) - INFO - Done attempting. 02:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:47 INFO - (blobuploader) - INFO - Done attempting. 02:41:47 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:47 INFO - Return code: 0 02:41:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57f7eb158cc10cd2fb974ebce3a05247e7e899c6d9ff89445f27e4285acdbd75ef18ea224f0bcb7a9f0e48ccfdb2e36eb1b402a9d2a93309fadbcfc2a2240fec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88089f1699df1da726d1f131ebea48766e13e21d5cc02948606bdbd8b651b3b1ebac834d3e64f28438dfa574f15127f371ae71e58971b36c5e5b6d6f27dc60c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de349c343cde3752675ae8b878fc5caa58ce7c27e599359a97718effbc8822eeba5cf971552869eb93d971d8d91a18f197e48533d499bd9a20c57e27987060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa289ef43f8df7d46a4b8fb275f5e9f234ea871169aeb6a9cf563eecd4e11c45208a8782118f66464777ccf1780ed895c9b9bf7f743c2814008be1b7939ae94"} 02:41:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:47 INFO - Contents: 02:41:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57f7eb158cc10cd2fb974ebce3a05247e7e899c6d9ff89445f27e4285acdbd75ef18ea224f0bcb7a9f0e48ccfdb2e36eb1b402a9d2a93309fadbcfc2a2240fec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88089f1699df1da726d1f131ebea48766e13e21d5cc02948606bdbd8b651b3b1ebac834d3e64f28438dfa574f15127f371ae71e58971b36c5e5b6d6f27dc60c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de349c343cde3752675ae8b878fc5caa58ce7c27e599359a97718effbc8822eeba5cf971552869eb93d971d8d91a18f197e48533d499bd9a20c57e27987060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa289ef43f8df7d46a4b8fb275f5e9f234ea871169aeb6a9cf563eecd4e11c45208a8782118f66464777ccf1780ed895c9b9bf7f743c2814008be1b7939ae94"} 02:41:47 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:47 INFO - Copying logs to upload dir... 02:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.454528 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-13 02:41:47.314979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 02:41:47.319768) ========= 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.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/Mozilla-Aurora/sha512/57f7eb158cc10cd2fb974ebce3a05247e7e899c6d9ff89445f27e4285acdbd75ef18ea224f0bcb7a9f0e48ccfdb2e36eb1b402a9d2a93309fadbcfc2a2240fec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88089f1699df1da726d1f131ebea48766e13e21d5cc02948606bdbd8b651b3b1ebac834d3e64f28438dfa574f15127f371ae71e58971b36c5e5b6d6f27dc60c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de349c343cde3752675ae8b878fc5caa58ce7c27e599359a97718effbc8822eeba5cf971552869eb93d971d8d91a18f197e48533d499bd9a20c57e27987060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa289ef43f8df7d46a4b8fb275f5e9f234ea871169aeb6a9cf563eecd4e11c45208a8782118f66464777ccf1780ed895c9b9bf7f743c2814008be1b7939ae94"} build_url:https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/eN1xxrZkRyeu9J9ARJZiYw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57f7eb158cc10cd2fb974ebce3a05247e7e899c6d9ff89445f27e4285acdbd75ef18ea224f0bcb7a9f0e48ccfdb2e36eb1b402a9d2a93309fadbcfc2a2240fec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88089f1699df1da726d1f131ebea48766e13e21d5cc02948606bdbd8b651b3b1ebac834d3e64f28438dfa574f15127f371ae71e58971b36c5e5b6d6f27dc60c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de349c343cde3752675ae8b878fc5caa58ce7c27e599359a97718effbc8822eeba5cf971552869eb93d971d8d91a18f197e48533d499bd9a20c57e27987060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa289ef43f8df7d46a4b8fb275f5e9f234ea871169aeb6a9cf563eecd4e11c45208a8782118f66464777ccf1780ed895c9b9bf7f743c2814008be1b7939ae94"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 02:41:47.357866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:41:47.358241) ========= 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.La7XPu1cav/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.cZn7dStOFm/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005249 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 02:41:47.407150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 02:41:47.410487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 02:41:47.410812) ========= ========= Total master_lag: 0.20 =========