builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0203 starttime: 1475839420.16 results: success (0) buildid: 20161007013600 builduid: 68cacb6133c94e98b6de80c01f7e5849 revision: f29da9ed45d1584c0f318d84981a60811586fd1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.156770) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.157235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.157531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.181988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.182374) ========= 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.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 --2016-10-07 04:23:40-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-10-07 04:23:40 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.344538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.344866) ========= 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.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.027443 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:40.393416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 04:23:40.393778) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev f29da9ed45d1584c0f318d84981a60811586fd1b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev f29da9ed45d1584c0f318d84981a60811586fd1b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 2016-10-07 04:23:40,469 truncating revision to first 12 chars 2016-10-07 04:23:40,470 Setting DEBUG logging. 2016-10-07 04:23:40,470 attempt 1/10 2016-10-07 04:23:40,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/f29da9ed45d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 04:23:41,867 unpacking tar archive at: larch-f29da9ed45d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 04:23:42.093191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:42.093502) ========= script_repo_revision: f29da9ed45d1584c0f318d84981a60811586fd1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:42.093907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:42.094172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 04:23:42.113099) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-07 04:23:42.113492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:23:42 INFO - MultiFileLogger online at 20161007 04:23:42 in /builds/slave/test 04:23:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 04:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:42 INFO - {'append_to_log': False, 04:23:42 INFO - 'base_work_dir': '/builds/slave/test', 04:23:42 INFO - 'blob_upload_branch': 'Larch', 04:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:42 INFO - 'branch': 'Larch', 04:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:42 INFO - 'config_files': ('talos/mac_config.py',), 04:23:42 INFO - 'default_actions': ('clobber', 04:23:42 INFO - 'read-buildbot-config', 04:23:42 INFO - 'download-and-extract', 04:23:42 INFO - 'populate-webroot', 04:23:42 INFO - 'create-virtualenv', 04:23:42 INFO - 'install', 04:23:42 INFO - 'run-tests'), 04:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:42 INFO - 'download_minidump_stackwalk': True, 04:23:42 INFO - 'download_symbols': 'ondemand', 04:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:42 INFO - 'installer_path': 'installer.exe', 04:23:42 INFO - 'log_level': 'info', 04:23:42 INFO - 'log_name': 'talos', 04:23:42 INFO - 'log_to_console': True, 04:23:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:23:42 INFO - 'opt_config_files': (), 04:23:42 INFO - 'pip_index': False, 04:23:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:42 INFO - 'cmd': ('bash', 04:23:42 INFO - '-c', 04:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:42 INFO - 'enabled': True, 04:23:42 INFO - 'halt_on_failure': False, 04:23:42 INFO - 'name': 'check_screen_resolution'},), 04:23:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:42 INFO - 'cmd': ('bash', 04:23:42 INFO - '-c', 04:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:42 INFO - 'enabled': True, 04:23:42 INFO - 'halt_on_failure': False, 04:23:42 INFO - 'name': 'check_screen_resolution'},), 04:23:42 INFO - 'run_cmd_checks_enabled': True, 04:23:42 INFO - 'sps_profile': False, 04:23:42 INFO - 'sps_profile_interval': 0, 04:23:42 INFO - 'suite': 'dromaeojs-e10s', 04:23:42 INFO - 'system_bits': '32', 04:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:42 INFO - 'title': 't-yosemite-r7-0203', 04:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:42 INFO - 'use_talos_json': True, 04:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:42 INFO - 'work_dir': 'build'} 04:23:42 INFO - [mozharness: 2016-10-07 11:23:42.327050Z] Running clobber step. 04:23:42 INFO - Running pre-action listener: _resource_record_pre_action 04:23:42 INFO - Running main action method: clobber 04:23:42 INFO - rmtree: /builds/slave/test/build 04:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:44 INFO - Running post-action listener: _resource_record_post_action 04:23:44 INFO - [mozharness: 2016-10-07 11:23:44.527453Z] Finished clobber step (success) 04:23:44 INFO - [mozharness: 2016-10-07 11:23:44.527606Z] Running read-buildbot-config step. 04:23:44 INFO - Running pre-action listener: _resource_record_pre_action 04:23:44 INFO - Running main action method: read_buildbot_config 04:23:44 INFO - Using buildbot properties: 04:23:44 INFO - { 04:23:44 INFO - "project": "", 04:23:44 INFO - "product": "firefox", 04:23:44 INFO - "script_repo_revision": "production", 04:23:44 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 04:23:44 INFO - "repository": "", 04:23:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 04:23:44 INFO - "buildid": "20161007013600", 04:23:44 INFO - "pgo_build": "False", 04:23:44 INFO - "basedir": "/builds/slave/test", 04:23:44 INFO - "buildnumber": 2, 04:23:44 INFO - "slavename": "t-yosemite-r7-0203", 04:23:44 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:23:44 INFO - "platform": "yosemite_r7", 04:23:44 INFO - "scheduler": "tests-larch-macosx64-talos", 04:23:44 INFO - "branch": "larch", 04:23:44 INFO - "repo_path": "projects/larch", 04:23:44 INFO - "revision": "f29da9ed45d1584c0f318d84981a60811586fd1b", 04:23:44 INFO - "stage_platform": "macosx64", 04:23:44 INFO - "builduid": "68cacb6133c94e98b6de80c01f7e5849", 04:23:44 INFO - "slavebuilddir": "test" 04:23:44 INFO - } 04:23:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:23:44 INFO - Running post-action listener: _resource_record_post_action 04:23:44 INFO - [mozharness: 2016-10-07 11:23:44.530842Z] Finished read-buildbot-config step (success) 04:23:44 INFO - [mozharness: 2016-10-07 11:23:44.530955Z] Running download-and-extract step. 04:23:44 INFO - Running pre-action listener: _resource_record_pre_action 04:23:44 INFO - Running main action method: download_and_extract 04:23:44 INFO - mkdir: /builds/slave/test/build/tests 04:23: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')]} 04:23:44 INFO - trying https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:23:44 INFO - Downloading https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:23:45 INFO - Downloaded 1199 bytes. 04:23:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:23:45 INFO - Using the following test package requirements: 04:23:45 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:23:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:23:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:23:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'jsshell-mac.zip'], 04:23:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:23:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:23:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:23:45 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:23:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:23:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:23:45 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:23:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:23:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:23:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:23:45 INFO - Fetch https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:23:46 INFO - Http code: 200 04:23:46 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 04:23:46 INFO - x-amz-cf-id: ugeTFJgLclExsF87NL1ZRVijno1ru4FIK8cmsihK3TnOELIjiRXSPA== 04:23:46 INFO - x-amz-version-id: rb.46lZk56TxByJUFhJHwwS1ZeUSbDh_ 04:23:46 INFO - Expected file size: 16476621 04:23:46 INFO - Obtained file size: 16476621 04:23:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:23:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:23:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:23:53 INFO - Fetch https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:23:53 INFO - Http code: 200 04:23:53 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 04:23:53 INFO - x-amz-cf-id: hJ88ZU2vq1pBfZOvQK2cfCNCFUs2VtBdrUgTJSDIDGi8vwvOkJC33A== 04:23:53 INFO - x-amz-version-id: rb.46lZk56TxByJUFhJHwwS1ZeUSbDh_ 04:23:54 INFO - Expected file size: 16476621 04:23:54 INFO - Obtained file size: 16476621 04:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:24:01 INFO - Http code: 200 04:24:01 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 04:24:01 INFO - x-amz-cf-id: QUPQHLy_J90spDYPrJmsmjwEI5IQsmJkGw_LE1hBtOuDdMFkxEVMaA== 04:24:01 INFO - x-amz-version-id: lW2T2wSOENTWdeJzDeHLGXocqny3neHE 04:24:01 INFO - Expected file size: 14408522 04:24:01 INFO - Obtained file size: 14408522 04:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:01 INFO - trying https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:24:01 INFO - Downloading https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:24:04 INFO - Downloaded 111703502 bytes. 04:24:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:24:04 INFO - mkdir: /builds/slave/test/properties 04:24:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:04 INFO - Contents: 04:24:04 INFO - build_url:https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:24:05 INFO - Running post-action listener: _resource_record_post_action 04:24:05 INFO - Running post-action listener: set_extra_try_arguments 04:24:05 INFO - [mozharness: 2016-10-07 11:24:05.160783Z] Finished download-and-extract step (success) 04:24:05 INFO - [mozharness: 2016-10-07 11:24:05.160912Z] Running populate-webroot step. 04:24:05 INFO - Running pre-action listener: _resource_record_pre_action 04:24:05 INFO - Running main action method: populate_webroot 04:24:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:05 INFO - '--tppagecycles', 04:24:05 INFO - '7'], 04:24:05 INFO - 'tests': ['tsvgm']}}, 04:24:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['damp', 'tps']}, 04:24:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'tests': ['damp', 'tps']}, 04:24:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['dromaeo_dom']}, 04:24:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['basic_compositor_video']}, 04:24:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:24:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['a11yr', 04:24:05 INFO - 'ts_paint', 04:24:05 INFO - 'tpaint', 04:24:05 INFO - 'sessionrestore', 04:24:05 INFO - 'sessionrestore_no_auto_restore', 04:24:05 INFO - 'tabpaint']}, 04:24:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['tsvgx', 04:24:05 INFO - 'tsvgr_opacity', 04:24:05 INFO - 'tart', 04:24:05 INFO - 'tscrollx', 04:24:05 INFO - 'cart']}, 04:24:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:05 INFO - 'tsvgr_opacity', 04:24:05 INFO - 'tart', 04:24:05 INFO - 'tscrollx', 04:24:05 INFO - 'cart']}, 04:24:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'talos_options': ['--disable-e10s'], 04:24:05 INFO - 'tests': ['tp5o']}, 04:24:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'tests': ['tp5o']}, 04:24:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'talos_options': ['--disable-e10s', 04:24:05 INFO - '--xperf_path', 04:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:05 INFO - 'tests': ['tp5n']}, 04:24:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:05 INFO - 'talos_options': ['--xperf_path', 04:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:05 INFO - 'tests': ['tp5n']}}, 04:24:05 INFO - 'talos.zip': {'path': '', 04:24:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:05 INFO - Running post-action listener: _resource_record_post_action 04:24:05 INFO - [mozharness: 2016-10-07 11:24:05.179042Z] Finished populate-webroot step (success) 04:24:05 INFO - [mozharness: 2016-10-07 11:24:05.179171Z] Running create-virtualenv step. 04:24:05 INFO - Running pre-action listener: _resource_record_pre_action 04:24:05 INFO - Running main action method: create_virtualenv 04:24:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:24:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:05 INFO - Using real prefix '/tools/python27' 04:24:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:08 INFO - Installing pip.................done. 04:24:08 INFO - Return code: 0 04:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:24:09 INFO - Reading from file tmpfile_stdout 04:24:09 INFO - Output received: 04:24:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:24:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:09 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:09 INFO - 'HOME': '/Users/cltbld', 04:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:09 INFO - 'LOGNAME': 'cltbld', 04:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:09 INFO - 'MOZ_NO_REMOTE': '1', 04:24:09 INFO - 'NO_EM_RESTART': '1', 04:24:09 INFO - 'PAGER': '/bin/cat', 04:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:09 INFO - 'PWD': '/builds/slave/test', 04:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:09 INFO - 'SHELL': '/bin/bash', 04:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:09 INFO - 'USER': 'cltbld', 04:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:09 INFO - 'XPC_FLAGS': '0x0', 04:24:09 INFO - 'XPC_SERVICE_NAME': '0', 04:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:24:09 INFO - Cleaning up... 04:24:09 INFO - Return code: 0 04:24:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:09 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:09 INFO - 'HOME': '/Users/cltbld', 04:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:09 INFO - 'LOGNAME': 'cltbld', 04:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:09 INFO - 'MOZ_NO_REMOTE': '1', 04:24:09 INFO - 'NO_EM_RESTART': '1', 04:24:09 INFO - 'PAGER': '/bin/cat', 04:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:09 INFO - 'PWD': '/builds/slave/test', 04:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:09 INFO - 'SHELL': '/bin/bash', 04:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:09 INFO - 'USER': 'cltbld', 04:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:09 INFO - 'XPC_FLAGS': '0x0', 04:24:09 INFO - 'XPC_SERVICE_NAME': '0', 04:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:09 INFO - Downloading/unpacking psutil>=3.1.1 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:13 INFO - Installing collected packages: psutil 04:24:13 INFO - Running setup.py install for psutil 04:24:13 INFO - building 'psutil._psutil_osx' extension 04:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:24:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:24:13 INFO - building 'psutil._psutil_posix' extension 04:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:24:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:24:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:24:13 INFO - ^ 04:24:13 INFO - 1 warning generated. 04:24:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:14 INFO - Successfully installed psutil 04:24:14 INFO - Cleaning up... 04:24:14 INFO - Return code: 0 04:24:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:14 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:14 INFO - 'HOME': '/Users/cltbld', 04:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:14 INFO - 'LOGNAME': 'cltbld', 04:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:14 INFO - 'MOZ_NO_REMOTE': '1', 04:24:14 INFO - 'NO_EM_RESTART': '1', 04:24:14 INFO - 'PAGER': '/bin/cat', 04:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:14 INFO - 'PWD': '/builds/slave/test', 04:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:14 INFO - 'SHELL': '/bin/bash', 04:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:14 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:14 INFO - 'USER': 'cltbld', 04:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:14 INFO - 'XPC_FLAGS': '0x0', 04:24:14 INFO - 'XPC_SERVICE_NAME': '0', 04:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:24:17 INFO - Installing collected packages: mozsystemmonitor 04:24:17 INFO - Running setup.py install for mozsystemmonitor 04:24:17 INFO - Successfully installed mozsystemmonitor 04:24:17 INFO - Cleaning up... 04:24:17 INFO - Return code: 0 04:24:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:17 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:17 INFO - 'HOME': '/Users/cltbld', 04:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:17 INFO - 'LOGNAME': 'cltbld', 04:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:17 INFO - 'MOZ_NO_REMOTE': '1', 04:24:17 INFO - 'NO_EM_RESTART': '1', 04:24:17 INFO - 'PAGER': '/bin/cat', 04:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:17 INFO - 'PWD': '/builds/slave/test', 04:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:17 INFO - 'SHELL': '/bin/bash', 04:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:17 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:17 INFO - 'USER': 'cltbld', 04:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:17 INFO - 'XPC_FLAGS': '0x0', 04:24:17 INFO - 'XPC_SERVICE_NAME': '0', 04:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:20 INFO - warning: no files found matching '*.txt' 04:24:20 INFO - no previously-included directories found matching 'build' 04:24:20 INFO - no previously-included directories found matching 'dist' 04:24:20 INFO - no previously-included directories found matching '.git*' 04:24:20 INFO - Installing collected packages: jsonschema, functools32 04:24:20 INFO - Running setup.py install for functools32 04:24:20 INFO - warning: no files found matching '*.txt' 04:24:20 INFO - no previously-included directories found matching 'build' 04:24:20 INFO - no previously-included directories found matching 'dist' 04:24:20 INFO - no previously-included directories found matching '.git*' 04:24:20 INFO - Successfully installed jsonschema functools32 04:24:20 INFO - Cleaning up... 04:24:20 INFO - Return code: 0 04:24:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:20 INFO - 'HOME': '/Users/cltbld', 04:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:20 INFO - 'LOGNAME': 'cltbld', 04:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:20 INFO - 'MOZ_NO_REMOTE': '1', 04:24:20 INFO - 'NO_EM_RESTART': '1', 04:24:20 INFO - 'PAGER': '/bin/cat', 04:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:20 INFO - 'PWD': '/builds/slave/test', 04:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:20 INFO - 'SHELL': '/bin/bash', 04:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:20 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:20 INFO - 'USER': 'cltbld', 04:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:20 INFO - 'XPC_FLAGS': '0x0', 04:24:20 INFO - 'XPC_SERVICE_NAME': '0', 04:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:24:20 INFO - Cleaning up... 04:24:20 INFO - Return code: 0 04:24:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:20 INFO - 'HOME': '/Users/cltbld', 04:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:20 INFO - 'LOGNAME': 'cltbld', 04:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:20 INFO - 'MOZ_NO_REMOTE': '1', 04:24:20 INFO - 'NO_EM_RESTART': '1', 04:24:20 INFO - 'PAGER': '/bin/cat', 04:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:20 INFO - 'PWD': '/builds/slave/test', 04:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:20 INFO - 'SHELL': '/bin/bash', 04:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:20 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:20 INFO - 'USER': 'cltbld', 04:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:20 INFO - 'XPC_FLAGS': '0x0', 04:24:20 INFO - 'XPC_SERVICE_NAME': '0', 04:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:24 INFO - Downloading docopt-0.6.1.tar.gz 04:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:24 INFO - Running setup.py install for blobuploader 04:24:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:25 INFO - Running setup.py install for requests 04:24:25 INFO - Running setup.py install for docopt 04:24:25 INFO - Successfully installed blobuploader requests docopt 04:24:25 INFO - Cleaning up... 04:24:25 INFO - Return code: 0 04:24:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:25 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:25 INFO - 'HOME': '/Users/cltbld', 04:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:25 INFO - 'LOGNAME': 'cltbld', 04:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:25 INFO - 'MOZ_NO_REMOTE': '1', 04:24:25 INFO - 'NO_EM_RESTART': '1', 04:24:25 INFO - 'PAGER': '/bin/cat', 04:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:25 INFO - 'PWD': '/builds/slave/test', 04:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:25 INFO - 'SHELL': '/bin/bash', 04:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:25 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:25 INFO - 'USER': 'cltbld', 04:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:25 INFO - 'XPC_FLAGS': '0x0', 04:24:25 INFO - 'XPC_SERVICE_NAME': '0', 04:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-dLcwWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-BSdzBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-sFsPLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-PsYDiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-s_1puk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-XGqqdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ZnIR65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-NMXP8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:26 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-F2PtZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-NP9cwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Gep3Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-g0I9ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-K69KsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-khPdY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tTnWpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-n1aX4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:27 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-QjFVc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:27 INFO - Running setup.py install for manifestparser 04:24:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:28 INFO - Running setup.py install for mozcrash 04:24:28 INFO - Running setup.py install for mozdebug 04:24:28 INFO - Running setup.py install for mozdevice 04:24:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:28 INFO - Running setup.py install for mozfile 04:24:28 INFO - Running setup.py install for mozhttpd 04:24:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:28 INFO - Running setup.py install for mozinfo 04:24:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:28 INFO - Running setup.py install for mozInstall 04:24:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Running setup.py install for mozleak 04:24:29 INFO - Running setup.py install for mozlog 04:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Running setup.py install for moznetwork 04:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Running setup.py install for mozprocess 04:24:29 INFO - Running setup.py install for mozprofile 04:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Running setup.py install for mozrunner 04:24:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:29 INFO - Running setup.py install for mozscreenshot 04:24:30 INFO - Running setup.py install for moztest 04:24:30 INFO - Running setup.py install for mozversion 04:24:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:30 INFO - Cleaning up... 04:24:30 INFO - Return code: 0 04:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:30 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:30 INFO - 'HOME': '/Users/cltbld', 04:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:30 INFO - 'LOGNAME': 'cltbld', 04:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:30 INFO - 'MOZ_NO_REMOTE': '1', 04:24:30 INFO - 'NO_EM_RESTART': '1', 04:24:30 INFO - 'PAGER': '/bin/cat', 04:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:30 INFO - 'PWD': '/builds/slave/test', 04:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:30 INFO - 'SHELL': '/bin/bash', 04:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:30 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:30 INFO - 'USER': 'cltbld', 04:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:30 INFO - 'XPC_FLAGS': '0x0', 04:24:30 INFO - 'XPC_SERVICE_NAME': '0', 04:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:30 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-r0hzSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:30 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-2OkJ7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:30 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-p9eOvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-qpmO_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-6btClf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-witi2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-_02I6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-J4P1sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-BGzOrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-kz2z8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7zLDcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IoTdcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:31 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ABU6pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:32 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ILw0HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:32 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zoW50y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:32 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-yrxbXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:32 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-UeTOAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:34 INFO - Downloading blessings-1.6.tar.gz 04:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:35 INFO - Installing collected packages: blessings 04:24:35 INFO - Running setup.py install for blessings 04:24:35 INFO - Successfully installed blessings 04:24:35 INFO - Cleaning up... 04:24:35 INFO - Return code: 0 04:24:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:35 INFO - Reading from file tmpfile_stdout 04:24:35 INFO - Current package versions: 04:24:35 INFO - blessings == 1.6 04:24:35 INFO - blobuploader == 1.2.4 04:24:35 INFO - docopt == 0.6.1 04:24:35 INFO - functools32 == 3.2.3-2 04:24:35 INFO - jsonschema == 2.5.1 04:24:35 INFO - manifestparser == 1.1 04:24:35 INFO - mozInstall == 1.12 04:24:35 INFO - mozcrash == 0.17 04:24:35 INFO - mozdebug == 0.1 04:24:35 INFO - mozdevice == 0.48 04:24:35 INFO - mozfile == 1.2 04:24:35 INFO - mozhttpd == 0.7 04:24:35 INFO - mozinfo == 0.9 04:24:35 INFO - mozleak == 0.1 04:24:35 INFO - mozlog == 3.4 04:24:35 INFO - moznetwork == 0.27 04:24:35 INFO - mozprocess == 0.23 04:24:35 INFO - mozprofile == 0.28 04:24:35 INFO - mozrunner == 6.12 04:24:35 INFO - mozscreenshot == 0.1 04:24:35 INFO - mozsystemmonitor == 0.3 04:24:35 INFO - moztest == 0.7 04:24:35 INFO - mozversion == 1.4 04:24:35 INFO - psutil == 3.1.1 04:24:35 INFO - requests == 1.2.3 04:24:35 INFO - wsgiref == 0.1.2 04:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:35 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 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:35 INFO - 'HOME': '/Users/cltbld', 04:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:35 INFO - 'LOGNAME': 'cltbld', 04:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:35 INFO - 'MOZ_NO_REMOTE': '1', 04:24:35 INFO - 'NO_EM_RESTART': '1', 04:24:35 INFO - 'PAGER': '/bin/cat', 04:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:35 INFO - 'PWD': '/builds/slave/test', 04:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:35 INFO - 'SHELL': '/bin/bash', 04:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:35 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:35 INFO - 'USER': 'cltbld', 04:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:35 INFO - 'XPC_FLAGS': '0x0', 04:24:35 INFO - 'XPC_SERVICE_NAME': '0', 04:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:35 INFO - Cleaning up... 04:24:35 INFO - Return code: 0 04:24:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102d02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c78570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa052592cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, '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.FThL6dUeet/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.21Q90DhDBJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:35 INFO - 'HOME': '/Users/cltbld', 04:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:35 INFO - 'LOGNAME': 'cltbld', 04:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:35 INFO - 'MOZ_NO_REMOTE': '1', 04:24:35 INFO - 'NO_EM_RESTART': '1', 04:24:35 INFO - 'PAGER': '/bin/cat', 04:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:35 INFO - 'PWD': '/builds/slave/test', 04:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:35 INFO - 'SHELL': '/bin/bash', 04:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:24:35 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:35 INFO - 'USER': 'cltbld', 04:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:35 INFO - 'XPC_FLAGS': '0x0', 04:24:35 INFO - 'XPC_SERVICE_NAME': '0', 04:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:24:36 INFO - Cleaning up... 04:24:36 INFO - Return code: 0 04:24:36 INFO - Running post-action listener: _resource_record_post_action 04:24:36 INFO - Running post-action listener: _start_resource_monitoring 04:24:36 INFO - Starting resource monitoring. 04:24:36 INFO - [mozharness: 2016-10-07 11:24:36.116457Z] Finished create-virtualenv step (success) 04:24:36 INFO - [mozharness: 2016-10-07 11:24:36.117427Z] Running install step. 04:24:36 INFO - Running pre-action listener: _resource_record_pre_action 04:24:36 INFO - Running main action method: install 04:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:36 INFO - Reading from file tmpfile_stdout 04:24:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:36 INFO - Reading from file tmpfile_stdout 04:24:36 INFO - Output received: 04:24:36 INFO - Usage: mozinstall [options] installer 04:24:36 INFO - Options: 04:24:36 INFO - -h, --help show this help message and exit 04:24:36 INFO - -d DEST, --destination=DEST 04:24:36 INFO - Directory to install application into. [default: 04:24:36 INFO - "/builds/slave/test"] 04:24:36 INFO - --app=APP Application being installed. [default: firefox] 04:24:36 INFO - mkdir: /builds/slave/test/build/application 04:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:25:11 INFO - Reading from file tmpfile_stdout 04:25:11 INFO - Output received: 04:25:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:25:11 INFO - Running post-action listener: _resource_record_post_action 04:25:11 INFO - [mozharness: 2016-10-07 11:25:11.910245Z] Finished install step (success) 04:25:11 INFO - [mozharness: 2016-10-07 11:25:11.910389Z] Running run-tests step. 04:25:11 INFO - Running pre-action listener: _resource_record_pre_action 04:25:11 INFO - Running main action method: run_tests 04:25:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:11 INFO - 2016-10-07 04:25:11.924 screenresolution[1647:7590] starting screenresolution argv=screenresolution get 04:25:11 INFO - 2016-10-07 04:25:11.927 screenresolution[1647:7590] Display 0: 1600x1200x32@60 04:25:11 INFO - 2016-10-07 04:25:11.933 screenresolution[1648:7592] starting screenresolution argv=screenresolution list 04:25:11 INFO - Available Modes on Display 0 04:25:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:12 INFO - Intel Iris: 04:25:12 INFO - Chipset Model: Intel Iris 04:25:12 INFO - Type: GPU 04:25:12 INFO - Bus: Built-In 04:25:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:12 INFO - Vendor: Intel (0x8086) 04:25:12 INFO - Device ID: 0x0a2e 04:25:12 INFO - Revision ID: 0x0009 04:25:12 INFO - Displays: 04:25:12 INFO - Display: 04:25:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:12 INFO - Display Serial Number: 1600x1200 60 04:25:12 INFO - Main Display: Yes 04:25:12 INFO - Mirror: Off 04:25:12 INFO - Online: Yes 04:25:12 INFO - Rotation: Supported 04:25:12 INFO - Return code: 0 04:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:12 INFO - Python 2.7.3 04:25:12 INFO - Return code: 0 04:25:12 INFO - grabbing minidump binary from tooltool 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b16d30>, '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 0x10293cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b0eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:25:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:25:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:12 INFO - Return code: 0 04:25:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:25:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:25:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 04:25:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FThL6dUeet/Render', 04:25:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:12 INFO - 'HOME': '/Users/cltbld', 04:25:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:12 INFO - 'LOGNAME': 'cltbld', 04:25:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:12 INFO - 'MOZ_NO_REMOTE': '1', 04:25:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:12 INFO - 'NO_EM_RESTART': '1', 04:25:12 INFO - 'PAGER': '/bin/cat', 04:25:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:12 INFO - 'PWD': '/builds/slave/test', 04:25:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:12 INFO - 'SHELL': '/bin/bash', 04:25:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.21Q90DhDBJ/Listeners', 04:25:12 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 04:25:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:12 INFO - 'USER': 'cltbld', 04:25:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:12 INFO - 'XPC_FLAGS': '0x0', 04:25:12 INFO - 'XPC_SERVICE_NAME': '0', 04:25:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 04:25:12 INFO - mozversion application_buildid: 20161007013600 04:25:12 INFO - mozversion application_changeset: f29da9ed45d1584c0f318d84981a60811586fd1b 04:25:12 INFO - mozversion application_display_name: Nightly 04:25:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:12 INFO - mozversion application_name: Firefox 04:25:12 INFO - mozversion application_remotingname: firefox 04:25:12 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 04:25:12 INFO - mozversion application_vendor: Mozilla 04:25:12 INFO - mozversion application_version: 52.0a1 04:25:12 INFO - mozversion platform_buildid: 20161007013600 04:25:12 INFO - mozversion platform_changeset: f29da9ed45d1584c0f318d84981a60811586fd1b 04:25:12 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 04:25:12 INFO - mozversion platform_version: 52.0a1 04:25:12 INFO - using testdate: 1475839512 04:25:12 INFO - actual date: 1475839512 04:25:12 INFO - starting webserver on 'localhost:49277' 04:25:12 INFO - SUITE-START | Running 2 tests 04:25:12 INFO - TEST-START | dromaeo_css 04:25:12 INFO - operating with platform_type : mac_ 04:25:12 INFO - Initialising browser for dromaeo_css test... 04:25:12 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpprJgOY/profile http://localhost:49277/getInfo.html) 04:25:15 INFO - PROCESS | 1658 | 2016-10-07 04:25:15.355 plugin-container[1660:7761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 04:25:15 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:15 INFO - PROCESS | 1658 | 2016-10-07 04:25:15.358 plugin-container[1660:7761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a1f, name = 'com.apple.CFPasteboardClient' 04:25:15 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:15 INFO - PROCESS | 1658 | 2016-10-07 04:25:15.358 plugin-container[1660:7761] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:15 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 04:25:15 INFO - PROCESS | 1658 | colorDepth:24 04:25:15 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 04:25:15 INFO - PROCESS | 1658 | __metrics 04:25:15 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 04:25:16 INFO - TEST-INFO | 1658: exit 0 04:25:16 INFO - Browser initialized. 04:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:16 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpprJgOY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:18 INFO - PROCESS | 1661 | 2016-10-07 04:25:18.599 plugin-container[1662:7882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 04:25:18 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:18 INFO - PROCESS | 1661 | 2016-10-07 04:25:18.601 plugin-container[1662:7882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 04:25:18 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:18 INFO - PROCESS | 1661 | 2016-10-07 04:25:18.601 plugin-container[1662:7882] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:28 INFO - PROCESS | 1661 | RSS: Main: 246038528 04:25:28 INFO - PROCESS | 1661 | 04:26:17 INFO - PROCESS | 1661 | 1475839577962 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:28:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 04:28:32 INFO - PROCESS | 1661 | RSS: Main: 261189632 04:28:32 INFO - PROCESS | 1661 | 04:31:34 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 04:31:35 INFO - PROCESS | 1661 | RSS: Main: 271732736 04:31:35 INFO - PROCESS | 1661 | 04:34:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 04:34:37 INFO - PROCESS | 1661 | RSS: Main: 274886656 04:34:37 INFO - PROCESS | 1661 | 04:37:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 04:37:40 INFO - PROCESS | 1661 | RSS: Main: 274423808 04:37:40 INFO - PROCESS | 1661 | 04:40:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 04:40:43 INFO - PROCESS | 1661 | RSS: Main: 279805952 04:40:43 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 04:43:46 INFO - PROCESS | 1661 | RSS: Main: 282427392 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | __start_tp_report 04:43:46 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 04:43:46 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 04:43:46 INFO - PROCESS | 1661 | |i|pagename|runs| 04:43:46 INFO - PROCESS | 1661 | |0;dojo.html;3254.5606343143677;3283.40898638245;3320.169957510622;3338.1487720631244;3353.731701463883;5227.843164705056;5496.340439147298;5523.088690366089;5556.916646250299;5624.775008999635;5369.24830523727;5541.0580201365765;5552.139418390156;5587.3015873015875;5595.776168953237;4148.958510414887;4205.306124489455;5059.6458247922665;5070.08738427083;5096.872578185538;5066.493350664922;5119.4880511948695;5142.51146141116;5173.715445650488;5192.766325515342;5137.5633071188995;5146.511081447256;5174.404943431516;5182.481751824825;5209.400918894337;4997.875053123665;5011.173156429185;5044.369453818273;5099.643024988252;5130.358705161855;4971.403431588233;4998.625103117281;5031.270465782441;5031.874203144914;5044.596432285409;4704.529547045302;5483.643563168382;5578.525825304854;5627.774889004435;5708.20085188074;4688.5077066907825;5958.523318134538;6063.787767428119;6073.301570319426;6078.361772013919;5361.410244873061;6026.9095963560585;6058.757649694007;6065.969670151665;6078.1186727924205;5498.615096943176;5676.347220069745;5687.886242275132;5695.202671625976;5697.202391665129;6035.78874739382;6049.122877182784;6081.817545473643;6097.298810636834;6144.784932527429;4889.779959901813;5934.8813023739285;5935.821925342247;5941.881162376728;5964.254468191476;5287.995280896617;6016.759329626853;6033.728482218311;6062.090686397076;6069.544784141207;5904.143899134688;5969.432903874125;5993.0710739835395;6040.546958978094;6067.089936509559;6009.819705408845;6011.789587364421;6035.909461358083;6064.727087280995;6094.75620975156;4803.927941080887;4807.879803004953;4843.346148270009;4867.537583929521;4919.77860996256;4216.64158546527;4242.809073591696;4245.066085461193;4270.295401258758;4291.463567054118;5203.8178663746585;5591.27313449249;5599.300087489064;5602.551795856321;5614.522765564972;5642;5766.308043034863;6061.787837425757;6068;6076.210092687922;5495.780168793203;5522.502974732213;5565.998120338378;5589.273394458694;5604.963081829875;4584.518625544337;4886.827161481219;5313.229581710708;5313.946860531422;5361.222622719683;6116.113163591254;6130.969345153246;6150.231221097363;6156.753729850756;6169.444749972524;5908.675022873783;5959.255093113361;6025.78909738157;6051.818445446644;6092.45167934888;6042.788502402394;6124.106319906441;6125.235451818428;6129.664444256008;6159.4456498915315;5999.610025348338;6002.7298771554515;6004.759809607742;6055.394460553909;6057.939420605914;5979.252593425822;6011.519078473799;6014.9097763534455;6026.306974697965;6124.969375153096;5915.58590898633;5942.851428714143;5959.22530071088;6011.639301641915;6024.608400453956;5822.155787410887;5878.382769809279;5903.498202652822;5910.556708246812;5919.6744179070565;5530.889382212414;5665.631733937281;5723.02708539541;5741.339745929272;5863.912041319469;4504.099180163915;5086.821961231339;5802.622829516068;5902.38025007368;5928.881422371443;5756.366799652119;5759.683217423082;5787.884242315215;5789.1895134680335;5816.04035334182 04:43:46 INFO - PROCESS | 1661 | |1;ext.html;475.20166120916866;493.8888750031243;523.4895976422987;532.575360909567;537.9973100134499;38968.805155974216;41528;41549.99999999996;41562.37656435156;41757.37363939543;41931;42345.364819527735;42352.788236058776;42361.152776944444;42372.78813605928;9652.420854748703;9787.951060244688;9830.213582913386;9862.260330475207;9897.75255618608;9829.459379734148;9906.306558540906;9936.552855121501;9948.60205591779;9951.601935922554;9922.801543969117;9937.751556211117;9941.105300522951;9964.20286377088;9990.700278991606;8925.839640846649;9827.705168844946;9861.359011664219;9916.702498925008;9970.252231082626;9720;9793.853092203623;9818.410895346231;9833.754156146082;9853.655122070693;31067;39709.602903971165;40038.599614003775;40257.79871100655;40524.79737601322;3214.164317277525;3302.4550949093373;3351.916202094967;3407.9659203407896;3751.362268414376;31069.223269418446;31478;31693.049208523782;31766.364672706648;32296.83851580727;3230.628477725068;3276.3774882772436;3279.918002049944;3357.7145942594907;3378.172347774811;405797.97101014305;458831;465935;466822;467961.66019170027;61004;61102;61233.38766612366;61237;61237;63569.36430635634;64065.67967160227;64102;64274.32296639987;64389;14262.643433914027;15764.921175394278;16055.357785688442;16103.19484025794;16360.836391635932;12148.967337776212;12547.24716517012;12567.497300107892;12608.117431779687;12625;16979.15104244783;17699.823001770073;17751.201195946214;17797.555061123574;17798.288068477115;3199.7600179986594;6038.788642397495;6792.252852186256;6976.267491913276;7000.719971201095;831.4678605692362;922.8338898998111;958.5788844996671;987.3088837813559;1053.3206082077018;28775;29343;30223.546646800314;30294.939677111637;31295.687043129732;1005.818952588541;1016.4155610523978;1029.1972261635935;1095.9945200274108;1142.23470274916;15524.844751552566;15974.680506389806;16086.75869861953;16152.529121265316;16195.352185912432;669071.6546417334;673893;679190;681081;682193.5890320616;58344.7082764592;58376;58786.41213587895;58900;58907.410925890195;1337.6187786480807;1373.7389895919744;1392.109050207888;1399.6780740429758;1401.1453013661658;25024.74975250224;30287.848560757055;30352.544711828898;30661.386772263984;30994.0701778947;51913.702157446365;51934.74032629964;52139.95720085501;52430.47569524409;52633.7368313156;615019;616680;618576;619853;620652;26788.19635410941;27024.32439189036;27047.45905081848;27323.590146147428;27344.726552735014;47530.52469475261;48396;48447;48760;48958.75520622374;37305.62694373022;38395.80802095972;39669.60330396659;40528.98677533085;40755.18489630132;34278.65721342755;39615.40576891291;39857.2028559433;40366.59633403629;40758;37568.81215593904;38304.23391532098;38870.80564597272;39175.60824391834;39576.40635390414;28468;28541.42917141604;34252.00193824593;34802.651973479944;34886;23404.76595234094;23666.626775171506;25895;25957.22128336153;26581.803818828586 04:43:46 INFO - PROCESS | 1661 | |2;jquery.html;339.9626041135475;359.67629133779576;375.06234413965086;376.94157405602124;401.8031164729282;13474.461021559138;18829.623407531857;20036.69944950827;20495.692564611523;20753.896230518865;18214.45356639303;18403.723944140816;18584.16371263293;18606;20615.690764638504;5866.76532938683;6168.876622467548;6174.629522228681;6184.56708030438;6191.876162476748;5097.439281679012;5409.6213265071465;5530.668159910419;5663.745131469073;6053.031514957607;5765;5965.105234214859;6032.69836508175;6040.154378387029;6058.515318774487;5913.586048976574;5988;5993.550483713695;5997.220361352996;6081.483073938721;4314.741115533078;4709.764511774431;5133.919648211081;5271.28837606922;5273.472652734734;12943.964482841444;13190.208587484685;13201.14192577489;13233.073684842066;18222.817771822378;2022.342738609943;2023.281734984074;2125.840561957844;2301.5051763870847;2946.749526290268;8700.477971321741;9920.702378928643;10020.49897505129;10370.82873810439;10437.165026797838;1812.0848971269556;1835.5319393554691;1854.5919897622637;1905.3617038292189;1909.7326374307609;100878;127491;127564;129112.35443822815;129668.35165824204;7664;8390.748277551684;9733.659321923698;9771.951140244253;11512.94243528777;12061;12105.15263931534;12149.210301330386;12151.270923744603;12180.695482612828;7978.521288722579;8024.839503209903;8079.111297757242;8154.959225203836;8173.795655108551;7299.270072992658;8388.32893368529;8459.61931713062;8557.914420855835;8593.656253749905;3330.766846320734;3346.748993825473;3767.811609419518;3832.2143960488033;3875.1862108957434;1930.2375561653068;1974.3780709076595;1982.7521559805025;1986.8509861760426;2004.38866145824;816.4407380944073;823.2426167925523;854.8162145138825;855.2943821347288;955.3837774635322;20747.896260518603;21618;21854.672179917314;21957.451063723536;22002.669959950614;764.8202672371988;872.7512658892185;874.1084094223856;901.6618767962015;943.7923656795494;11116.499757510932;11503.654890353302;11514.36670983104;11518.36648984314;11621.593244236412;539199.3040034774;547272;583745;599564;600348;131870;132495;136187.3773627091;137232;138149.3092534531;891.7859713668673;963.2294164668237;978.505854543451;980.789130336981;997.7056768253383;15009.77485337699;15947.840521594635;19268.4219473416;19270;19584.60830783405;54138.64653383697;55389;55528.33414997556;56189.71905140448;56391.71804140953;75313;76714;76756;77381.61309193418;77518.61240693761;7836.529808211526;7882.645280962256;7908.485948413335;8101.432899696964;8118.675252989814;9162.633494660138;9716.708498745049;10474.423906685206;10837.349759014485;11943.641690749291;10231.693049208536;10625.362478251329;10696.251262411557;11105.167112466435;11144.2199046066;8797.780055498664;9081.364304498886;10909.290896091728;11053.944730276296;11085.445727713743;11016.559337626406;11159.888401115884;11265.380404077854;11320.339720165919;11454.94272528632;7843.137254901842;7936.484128531627;8105.946226990689;8280.00639923213;8283.17168283167;10082.798344033225;11065.059469945145;11072.667819965414;11365.54537818511;11446.484908178985 04:43:46 INFO - PROCESS | 1661 | |3;mootools.html;1359.3203398300845;1555.4789145636212;1719.2779032806227;1831.1302131487537;1847.113385574925;7356.7057317707295;8099.757007289776;8382.455140415868;9358.157765801077;9378.671746488866;8619.267362274199;8949.95525022374;8959.776005599862;9076;9085.318601104911;2372.8220383471266;2382.273406610983;2389.307100940725;2400.7719266669637;2406.518696260755;2311.7919387255142;2323.2449453927456;2348.800351970076;2349.765023497645;2360.1621424394352;2345.64815277708;2356.7643235676464;2367.9763202367926;2378.4886249456363;2381.7499162587937;2352.1179557665873;2352.2472808701223;2367.7987371073395;2368.7157541095094;2395.568797616428;2346.577616029114;2370.893309801063;2387.928362149121;2393.964090538643;2411.9517609647883;9233;9255.490947997858;9349.205317548016;9350;9392.248620110375;5341.011912796145;5510.421405752379;5518;5530.723463826793;5538.916916246219;3516.753827232095;3641.217138315275;3710.2950439416422;3713.6472035156617;3727.608601096873;1054.2830875004993;1056.4400867540216;1074.3607553505651;1081.9350838949688;1091.5851976249055;11792.528298868036;11927.045836333073;11954;12008.159428839985;12043.277403355827;4393.472783265965;4434.645228381722;4632.652551058684;4634.976825115853;4649.139909116824;9157.038510956254;9254.12085851843;9349.298802589832;9351.953240233755;9381.812363752822;5200.115980283361;5207.635465517377;5209.140491818884;5247.9737601311745;5284.207368894697;4444.866654000385;4626.768661566908;4627.722336659811;4780.259059845729;4927.063857867065;3236.336551007038;3731.4962480065387;3854.5181852268465;3855.4602355670227;3865.729398942047;1070.347088276151;1174.4186627619383;1187.6140254417348;1192.0582739635763;1196;813.9918600813916;868.431177578687;891.3315013739696;893.7363477774072;957.6025949230991;5950.583459157904;6041.5468839837185;6104.725287362079;6188.81433556994;6430.356964303533;887.401004322093;900.9774755631031;909.5315912305168;929.1683942871092;942.7784470649392;3402.319536092791;3512.5960514541157;3762.5673047599876;4057.188562287495;4069.409935559327;10562.366258024544;10900.781984360268;11295.887041129483;11316.434178291052;11348.375839328915;9340.206082483064;11067.059299959432;11145.387003714874;11223.607173749044;11228.438578071064;8275.337972962148;8324;8354.331653467709;8375.41372103947;8390.496570205807;5556.694381809039;5884.7940322090235;6054.727537260922;6125.754969801336;6157.599756015845;10259.435731034566;10433.165346772088;10548.46836759157;10593.841092383465;10608.416537090534;7655.770326890202;10419.166466682798;10423.583056677648;10615.787684246427;10624.256302058782;6963.6170010647875;7216.3505284524645;7500.887486687595;7690.653920573475;7867.9606601966625;8526.445781024213;8639.95680021596;8645.783855403664;8741.213290803858;8744.344174186834;7633.923660763321;7679.5776232305525;7708.344790692854;7847.176046515034;7870.72452464161;6884.51808373409;7295.416366690758;7459.142198647225;7494.17564067963;7546.509476883985;7063.505554611128;7212.4230061596;7212.711491540489;7214.170370407261;7220.963895180491;5001.624878134227;5134.460881607378;5138.6855478217085;5218.139007063944;5222.817201397933;4655.371524844239;5102.566281866083;5109.616778741535;5209.817656382009;5278.366596008504 04:43:46 INFO - PROCESS | 1661 | |4;prototype.html;295.6437492821151;298.56111516071377;305.71873876034044;308.51255017073026;312.87328631904074;4835.48554751529;5349.421920533442;5573.303337082864;5610.214569960203;5626.943730562693;4833.516648335165;5423.88126827074;5478.972780071369;5518.392976772562;5535.6955367454775;4195.454590903186;4210.368444733299;4210.62104410603;4237.580410562466;4242.575742425748;3872.612738726119;3874.8375487353683;3931.036895960494;4122.958770412288;4232.851850185244;3842.212346468981;3869.419587061949;4087.9182416351655;4108;4137.213929353428;4070.5522392536795;4090.9386359204786;4096.446979657738;4115.52671442782;4151;3268.3790079884748;3546.4857595648746;3568.571771387424;3572.8749493767596;3588.784672919633;4244.872653820359;5113.463086375914;5166.276721259027;5214.739263036871;5294.364676238876;4362.520122786491;4645.536655953398;4706.235011990429;4708.270218116198;4751.904961900777;4735.105957616946;4776.641751868624;5018.397792264952;5048.444671086178;5524.613277070606;2952.099609619065;3098.3028818515877;3488.9358745582585;3618.805794087945;3743.794091324976;5079.1365467870555;5592.7762889484375;5960.642361458283;6108.847278818021;6114.847128821771;3539.02676763892;3941.4431299636485;3943.23973218748;3961.1483531040963;3974.2647610192207;3772.0569857535615;3909.4917660703927;3988.8432354616834;4013.2976729072298;4033.3143365627916;4097.262492751273;4222.78886055696;4326.264535029052;4697.906041879143;4704.482506924235;5854.912176317359;5855.912161317584;5859.501942334864;5862.912056319158;5910.734016969247;1095.7917995580974;1278.4310981613094;1331.1281110872394;1353.7969304604387;1372.0807059270312;828.4449418889359;867.9132086791396;894.1237587164616;925.5973651461636;928.9907100929039;4861.659683822169;5137.486251374908;5409.350877894678;5460.290162278879;5468.972655136698;5748.626339288016;5893.086571581412;5893.3222679391565;5902.881942361215;5936.940630593639;4798.448178459522;5021.774020169101;5334.1732031535175;5363.892722145613;5389.9191512127345;3144.8584813683437;3151.700588444094;3169.7305729012833;3172.4772109387163;3194.7923384980368;4709.835155769531;5737.225474560964;6135.5398345124295;6218.595791273553;6230.719617617127;5124.103281925648;5451.918221226605;5648.774049037993;6108.3280839107665;6148.89480812196;4692.6245900327895;5057.294347524057;5830.3586605473365;6192.832508622127;6302;5119.007174403971;5614.007027505177;5871.418434754711;5909;6067.694276175025;4629.4907560167685;5400.9476398968145;5826.184334193132;5905.675187864708;5937.526546969898;4871.585915197248;6187.81436556904;6202.844928876814;6238;6247;3781.7920014399474;3801.2777572261184;3914.530256369254;4004.9399259010556;4050.4734384529825;5717.285339332583;5990.292766561509;5994;6002.87994240104;6057.969710151598;5643.2472405851295;5730.169125476866;5807.0998995155815;5833.154192642128;5857.238558987305;5810.448007439287;5824.757468374622;5824.912626310524;5828.388019257917;5839.357670656309;5020.171671674133;5154.705512574832;5572.832815015394;5614.438556144353;5660.29246344207;5771.3651498335985;5772.6536407815665;5803.100519419497;5833.533317334518;5835.591508594358;4743.976280118577;4876.512348765095;4965.262158244585;5660.688662123623;5715.570882375057 04:43:46 INFO - PROCESS | 1661 | |5;yui.html;670.8825955457795;727.0040045138159;728.5446595877577;777.9611019449026;824.2746383182798;15018.77471837922;15437.382504699826;15923.999999999985;15982.200889955498;16013.519594412157;14575.562733117997;14663.413463461475;14693.044952078108;14732.705345893075;14995.025323353975;840.0549381945297;859.7334826203866;859.8151397449548;861.4056301152216;861.5692153923038;684.6234570985963;700.4151533469534;827.1232493556819;847.3263755314509;858.5835869603269;828.9709860154895;912.7991841794827;913.5249670171506;914.0767824497273;914.5335878701877;906.8050369170594;907.3920473282916;907.5280853955971;909.0954500272205;909.1635695160435;666.9099671544328;671.9685283090481;674.3492529708855;674.8920172772333;676.2088356622763;14660.633484162874;14690.926545367205;14696.779548306784;14799.482018129422;14808.629784255372;14536.345864436125;14595.562133136023;14831.851681483155;14879.404823807035;14908.925455372653;11691.707707307385;11849.111316651286;11932.70168245792;12115.757684846254;12250.387480625934;3824.579296277407;3868.477755502999;3895.1235971906376;4005.2990726623016;4010.0776821330965;90235;96270;110372.89627103707;113718;116026;10200.846987295197;10760.730981725363;11284.32294062359;11415.657530274106;11906.940465297617;22807.771922280896;23193.956271967803;23254.883725581603;23269.3019209424;23289.417764556023;7972.800679983046;8173.591320433955;8273.544955027532;8343.624536895853;8359.623816928253;4328.264195086843;4445.666575006822;4500.639948804153;4602.1025899949855;4629.699069560468;3520.5951315599036;3622.3660859350034;3664.8350824212976;3672.338978983755;3675.852965881388;554.6976897590823;639.3798015924546;653.1769969838039;667.5794249622803;668.9933100669028;596.6837576084682;604.6523249131767;618.8205420428116;630.4389093706604;677.5426587053719;9389.812203756022;9477.526123693788;9610.135087841987;9639;9911.306208565331;581.8050952930815;663.4327649859397;666.1406785247074;666.5933780393956;679.5752654590881;3739;4334.783260836945;4341.979634785823;4565.3836732040745;4736.313234580966;119788;129522.35238823933;145334;157621.10321313687;161862;127318;129243;130350.34824825815;130377;134253.65746342606;76494;81391;107794.46102769436;111210.88789112006;117199;8965.372423930523;9315;10029.003357237938;10075.798484030132;10301.278910476194;34037.149071272426;51116.23325650044;63474.36525634869;63654.68172659107;66533.33466665466;53359.199612006625;76662;83689;86609.56695216484;86710.1328986702;13048.811374257059;13438.051482535173;13628.386722597705;13702.65743356424;13763.931180344434;13129.868701313248;14881.404743810126;14920.701585968436;14958.476453324081;15211.77182342288;12369.567065152676;14119.223442710749;14153.221572813594;14384;14469.348879300247;13849.376778045214;13979.790303145664;14071.015028947875;14397.568072957829;14595.416183352547;13238.933805330911;13590.796470722918;13766.31168441594;13914.373853176428;14062.226577538333;11151.386673732699;11153.665390038312;11504.884951150381;11512.712182195512;11523.308601483603;8595.44129631572;9813.558389872616;10319.48402579883;11667.824982625438;11685.649430517098 04:43:46 INFO - PROCESS | 1661 | __end_tp_report 04:43:46 INFO - PROCESS | 1661 | __start_cc_report 04:43:46 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,364 04:43:46 INFO - PROCESS | 1661 | __end_cc_report 04:43:46 INFO - PROCESS | 1661 | __startTimestamp1475840626740__endTimestamp 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | ------- Summary: start ------- 04:43:46 INFO - PROCESS | 1661 | Number of tests: 6 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5522.43 Median:5697.20 stddev:638.68 (11.2%) stddev-sans-first:615.36 04:43:46 INFO - PROCESS | 1661 | Values: 3254.6 3283.4 3320.2 3338.1 3353.7 5227.8 5496.3 5523.1 5556.9 5624.8 5369.2 5541.1 5552.1 5587.3 5595.8 4149.0 4205.3 5059.6 5070.1 5096.9 5066.5 5119.5 5142.5 5173.7 5192.8 5137.6 5146.5 5174.4 5182.5 5209.4 4997.9 5011.2 5044.4 5099.6 5130.4 4971.4 4998.6 5031.3 5031.9 5044.6 4704.5 5483.6 5578.5 5627.8 5708.2 4688.5 5958.5 6063.8 6073.3 6078.4 5361.4 6026.9 6058.8 6066.0 6078.1 5498.6 5676.3 5687.9 5695.2 5697.2 6035.8 6049.1 6081.8 6097.3 6144.8 4889.8 5934.9 5935.8 5941.9 5964.3 5288.0 6016.8 6033.7 6062.1 6069.5 5904.1 5969.4 5993.1 6040.5 6067.1 6009.8 6011.8 6035.9 6064.7 6094.8 4803.9 4807.9 4843.3 4867.5 4919.8 4216.6 4242.8 4245.1 4270.3 4291.5 5203.8 5591.3 5599.3 5602.6 5614.5 5642.0 5766.3 6061.8 6068.0 6076.2 5495.8 5522.5 5566.0 5589.3 5605.0 4584.5 4886.8 5313.2 5313.9 5361.2 6116.1 6131.0 6150.2 6156.8 6169.4 5908.7 5959.3 6025.8 6051.8 6092.5 6042.8 6124.1 6125.2 6129.7 6159.4 5999.6 6002.7 6004.8 6055.4 6057.9 5979.3 6011.5 6014.9 6026.3 6125.0 5915.6 5942.9 5959.2 6011.6 6024.6 5822.2 5878.4 5903.5 5910.6 5919.7 5530.9 5665.6 5723.0 5741.3 5863.9 4504.1 5086.8 5802.6 5902.4 5928.9 5756.4 5759.7 5787.9 5789.2 5816.0 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:71517.10 Median:223163.48 stddev:158104.63 (70.8%) stddev-sans-first:158458.18 04:43:46 INFO - PROCESS | 1661 | Values: 475.2 493.9 523.5 532.6 538.0 38968.8 41528.0 41550.0 41562.4 41757.4 41931.0 42345.4 42352.8 42361.2 42372.8 9652.4 9788.0 9830.2 9862.3 9897.8 9829.5 9906.3 9936.6 9948.6 9951.6 9922.8 9937.8 9941.1 9964.2 9990.7 8925.8 9827.7 9861.4 9916.7 9970.3 9720.0 9793.9 9818.4 9833.8 9853.7 31067.0 39709.6 40038.6 40257.8 40524.8 3214.2 3302.5 3351.9 3408.0 3751.4 31069.2 31478.0 31693.0 31766.4 32296.8 3230.6 3276.4 3279.9 3357.7 3378.2 405798.0 458831.0 465935.0 466822.0 467961.7 61004.0 61102.0 61233.4 61237.0 61237.0 63569.4 64065.7 64102.0 64274.3 64389.0 14262.6 15764.9 16055.4 16103.2 16360.8 12149.0 12547.2 12567.5 12608.1 12625.0 16979.2 17699.8 17751.2 17797.6 17798.3 3199.8 6038.8 6792.3 6976.3 7000.7 831.5 922.8 958.6 987.3 1053.3 28775.0 29343.0 30223.5 30294.9 31295.7 1005.8 1016.4 1029.2 1096.0 1142.2 15524.8 15974.7 16086.8 16152.5 16195.4 669071.7 673893.0 679190.0 681081.0 682193.6 58344.7 58376.0 58786.4 58900.0 58907.4 1337.6 1373.7 1392.1 1399.7 1401.1 25024.7 30287.8 30352.5 30661.4 30994.1 51913.7 51934.7 52140.0 52430.5 52633.7 615019.0 616680.0 618576.0 619853.0 620652.0 26788.2 27024.3 27047.5 27323.6 27344.7 47530.5 48396.0 48447.0 48760.0 48958.8 37305.6 38395.8 39669.6 40529.0 40755.2 34278.7 39615.4 39857.2 40366.6 40758.0 37568.8 38304.2 38870.8 39175.6 39576.4 28468.0 28541.4 34252.0 34802.7 34886.0 23404.8 23666.6 25895.0 25957.2 26581.8 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34053.92 Median:2072.38 stddev:96609.19 (4661.8%) stddev-sans-first:96847.04 04:43:46 INFO - PROCESS | 1661 | Values: 340.0 359.7 375.1 376.9 401.8 13474.5 18829.6 20036.7 20495.7 20753.9 18214.5 18403.7 18584.2 18606.0 20615.7 5866.8 6168.9 6174.6 6184.6 6191.9 5097.4 5409.6 5530.7 5663.7 6053.0 5765.0 5965.1 6032.7 6040.2 6058.5 5913.6 5988.0 5993.6 5997.2 6081.5 4314.7 4709.8 5133.9 5271.3 5273.5 12944.0 13190.2 13201.1 13233.1 18222.8 2022.3 2023.3 2125.8 2301.5 2946.7 8700.5 9920.7 10020.5 10370.8 10437.2 1812.1 1835.5 1854.6 1905.4 1909.7 100878.0 127491.0 127564.0 129112.4 129668.4 7664.0 8390.7 9733.7 9772.0 11512.9 12061.0 12105.2 12149.2 12151.3 12180.7 7978.5 8024.8 8079.1 8155.0 8173.8 7299.3 8388.3 8459.6 8557.9 8593.7 3330.8 3346.7 3767.8 3832.2 3875.2 1930.2 1974.4 1982.8 1986.9 2004.4 816.4 823.2 854.8 855.3 955.4 20747.9 21618.0 21854.7 21957.5 22002.7 764.8 872.8 874.1 901.7 943.8 11116.5 11503.7 11514.4 11518.4 11621.6 539199.3 547272.0 583745.0 599564.0 600348.0 131870.0 132495.0 136187.4 137232.0 138149.3 891.8 963.2 978.5 980.8 997.7 15009.8 15947.8 19268.4 19270.0 19584.6 54138.6 55389.0 55528.3 56189.7 56391.7 75313.0 76714.0 76756.0 77381.6 77518.6 7836.5 7882.6 7908.5 8101.4 8118.7 9162.6 9716.7 10474.4 10837.3 11943.6 10231.7 10625.4 10696.3 11105.2 11144.2 8797.8 9081.4 10909.3 11053.9 11085.4 11016.6 11159.9 11265.4 11320.3 11454.9 7843.1 7936.5 8105.9 8280.0 8283.2 10082.8 11065.1 11072.7 11365.5 11446.5 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5777.50 Median:5106.09 stddev:3281.85 (64.3%) stddev-sans-first:3274.26 04:43:46 INFO - PROCESS | 1661 | Values: 1359.3 1555.5 1719.3 1831.1 1847.1 7356.7 8099.8 8382.5 9358.2 9378.7 8619.3 8950.0 8959.8 9076.0 9085.3 2372.8 2382.3 2389.3 2400.8 2406.5 2311.8 2323.2 2348.8 2349.8 2360.2 2345.6 2356.8 2368.0 2378.5 2381.7 2352.1 2352.2 2367.8 2368.7 2395.6 2346.6 2370.9 2387.9 2394.0 2412.0 9233.0 9255.5 9349.2 9350.0 9392.2 5341.0 5510.4 5518.0 5530.7 5538.9 3516.8 3641.2 3710.3 3713.6 3727.6 1054.3 1056.4 1074.4 1081.9 1091.6 11792.5 11927.0 11954.0 12008.2 12043.3 4393.5 4434.6 4632.7 4635.0 4649.1 9157.0 9254.1 9349.3 9352.0 9381.8 5200.1 5207.6 5209.1 5248.0 5284.2 4444.9 4626.8 4627.7 4780.3 4927.1 3236.3 3731.5 3854.5 3855.5 3865.7 1070.3 1174.4 1187.6 1192.1 1196.0 814.0 868.4 891.3 893.7 957.6 5950.6 6041.5 6104.7 6188.8 6430.4 887.4 901.0 909.5 929.2 942.8 3402.3 3512.6 3762.6 4057.2 4069.4 10562.4 10900.8 11295.9 11316.4 11348.4 9340.2 11067.1 11145.4 11223.6 11228.4 8275.3 8324.0 8354.3 8375.4 8390.5 5556.7 5884.8 6054.7 6125.8 6157.6 10259.4 10433.2 10548.5 10593.8 10608.4 7655.8 10419.2 10423.6 10615.8 10624.3 6963.6 7216.4 7500.9 7690.7 7868.0 8526.4 8640.0 8645.8 8741.2 8744.3 7633.9 7679.6 7708.3 7847.2 7870.7 6884.5 7295.4 7459.1 7494.2 7546.5 7063.5 7212.4 7212.7 7214.2 7221.0 5001.6 5134.5 5138.7 5218.1 5222.8 4655.4 5102.6 5109.6 5209.8 5278.4 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4629.74 Median:5116.24 stddev:1446.94 (28.3%) stddev-sans-first:1413.96 04:43:46 INFO - PROCESS | 1661 | Values: 295.6 298.6 305.7 308.5 312.9 4835.5 5349.4 5573.3 5610.2 5626.9 4833.5 5423.9 5479.0 5518.4 5535.7 4195.5 4210.4 4210.6 4237.6 4242.6 3872.6 3874.8 3931.0 4123.0 4232.9 3842.2 3869.4 4087.9 4108.0 4137.2 4070.6 4090.9 4096.4 4115.5 4151.0 3268.4 3546.5 3568.6 3572.9 3588.8 4244.9 5113.5 5166.3 5214.7 5294.4 4362.5 4645.5 4706.2 4708.3 4751.9 4735.1 4776.6 5018.4 5048.4 5524.6 2952.1 3098.3 3488.9 3618.8 3743.8 5079.1 5592.8 5960.6 6108.8 6114.8 3539.0 3941.4 3943.2 3961.1 3974.3 3772.1 3909.5 3988.8 4013.3 4033.3 4097.3 4222.8 4326.3 4697.9 4704.5 5854.9 5855.9 5859.5 5862.9 5910.7 1095.8 1278.4 1331.1 1353.8 1372.1 828.4 867.9 894.1 925.6 929.0 4861.7 5137.5 5409.4 5460.3 5469.0 5748.6 5893.1 5893.3 5902.9 5936.9 4798.4 5021.8 5334.2 5363.9 5389.9 3144.9 3151.7 3169.7 3172.5 3194.8 4709.8 5737.2 6135.5 6218.6 6230.7 5124.1 5451.9 5648.8 6108.3 6148.9 4692.6 5057.3 5830.4 6192.8 6302.0 5119.0 5614.0 5871.4 5909.0 6067.7 4629.5 5400.9 5826.2 5905.7 5937.5 4871.6 6187.8 6202.8 6238.0 6247.0 3781.8 3801.3 3914.5 4004.9 4050.5 5717.3 5990.3 5994.0 6002.9 6058.0 5643.2 5730.2 5807.1 5833.2 5857.2 5810.4 5824.8 5824.9 5828.4 5839.4 5020.2 5154.7 5572.8 5614.4 5660.3 5771.4 5772.7 5803.1 5833.5 5835.6 4744.0 4876.5 4965.3 5660.7 5715.6 04:43:46 INFO - PROCESS | 1661 | 04:43:46 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:23862.08 Median:3668.59 stddev:37757.04 (1029.2%) stddev-sans-first:37822.80 04:43:46 INFO - PROCESS | 1661 | Values: 670.9 727.0 728.5 778.0 824.3 15018.8 15437.4 15924.0 15982.2 16013.5 14575.6 14663.4 14693.0 14732.7 14995.0 840.1 859.7 859.8 861.4 861.6 684.6 700.4 827.1 847.3 858.6 829.0 912.8 913.5 914.1 914.5 906.8 907.4 907.5 909.1 909.2 666.9 672.0 674.3 674.9 676.2 14660.6 14690.9 14696.8 14799.5 14808.6 14536.3 14595.6 14831.9 14879.4 14908.9 11691.7 11849.1 11932.7 12115.8 12250.4 3824.6 3868.5 3895.1 4005.3 4010.1 90235.0 96270.0 110372.9 113718.0 116026.0 10200.8 10760.7 11284.3 11415.7 11906.9 22807.8 23194.0 23254.9 23269.3 23289.4 7972.8 8173.6 8273.5 8343.6 8359.6 4328.3 4445.7 4500.6 4602.1 4629.7 3520.6 3622.4 3664.8 3672.3 3675.9 554.7 639.4 653.2 667.6 669.0 596.7 604.7 618.8 630.4 677.5 9389.8 9477.5 9610.1 9639.0 9911.3 581.8 663.4 666.1 666.6 679.6 3739.0 4334.8 4342.0 4565.4 4736.3 119788.0 129522.4 145334.0 157621.1 161862.0 127318.0 129243.0 130350.3 130377.0 134253.7 76494.0 81391.0 107794.5 111210.9 117199.0 8965.4 9315.0 10029.0 10075.8 10301.3 34037.1 51116.2 63474.4 63654.7 66533.3 53359.2 76662.0 83689.0 86609.6 86710.1 13048.8 13438.1 13628.4 13702.7 13763.9 13129.9 14881.4 14920.7 14958.5 15211.8 12369.6 14119.2 14153.2 14384.0 14469.3 13849.4 13979.8 14071.0 14397.6 14595.4 13238.9 13590.8 13766.3 13914.4 14062.2 11151.4 11153.7 11504.9 11512.7 11523.3 8595.4 9813.6 10319.5 11667.8 11685.6 04:43:46 INFO - PROCESS | 1661 | -------- Summary: end -------- 04:43:46 INFO - PROCESS | 1661 | 04:43:47 INFO - TEST-INFO | 1661: exit 0 04:43:47 INFO - TEST-OK | dromaeo_css | took 1114874ms 04:43:47 INFO - TEST-START | kraken 04:43:47 INFO - operating with platform_type : mac_ 04:43:47 INFO - Initialising browser for kraken test... 04:43:47 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpwEKw0Y/profile http://localhost:49277/getInfo.html) 04:43:50 INFO - PROCESS | 1673 | 2016-10-07 04:43:50.149 plugin-container[1674:10069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1f, name = 'com.apple.tsm.portname' 04:43:50 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:50 INFO - PROCESS | 1673 | 2016-10-07 04:43:50.152 plugin-container[1674:10069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c23, name = 'com.apple.CFPasteboardClient' 04:43:50 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:50 INFO - PROCESS | 1673 | 2016-10-07 04:43:50.152 plugin-container[1674:10069] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:50 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 04:43:50 INFO - PROCESS | 1673 | colorDepth:24 04:43:50 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 04:43:50 INFO - PROCESS | 1673 | __metrics 04:43:50 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 04:43:51 INFO - TEST-INFO | 1673: exit 0 04:43:51 INFO - Browser initialized. 04:43:51 INFO - Running cycle 1/1 for kraken test... 04:43:51 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpwEKw0Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:53 INFO - PROCESS | 1675 | 2016-10-07 04:43:53.366 plugin-container[1676:10191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 04:43:53 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:53 INFO - PROCESS | 1675 | 2016-10-07 04:43:53.368 plugin-container[1676:10191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 04:43:53 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:53 INFO - PROCESS | 1675 | 2016-10-07 04:43:53.368 plugin-container[1676:10191] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:03 INFO - PROCESS | 1675 | RSS: Main: 246333440 04:44:03 INFO - PROCESS | 1675 | 04:44:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:07 INFO - PROCESS | 1675 | RSS: Main: 258076672 04:44:07 INFO - PROCESS | 1675 | 04:44:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 04:44:10 INFO - PROCESS | 1675 | RSS: Main: 266133504 04:44:10 INFO - PROCESS | 1675 | 04:44:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 04:44:14 INFO - PROCESS | 1675 | RSS: Main: 264941568 04:44:14 INFO - PROCESS | 1675 | 04:44:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 04:44:17 INFO - PROCESS | 1675 | RSS: Main: 266874880 04:44:17 INFO - PROCESS | 1675 | 04:44:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:20 INFO - PROCESS | 1675 | RSS: Main: 266682368 04:44:20 INFO - PROCESS | 1675 | 04:44:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:23 INFO - PROCESS | 1675 | RSS: Main: 267333632 04:44:23 INFO - PROCESS | 1675 | 04:44:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:27 INFO - PROCESS | 1675 | RSS: Main: 267935744 04:44:27 INFO - PROCESS | 1675 | 04:44:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 04:44:31 INFO - PROCESS | 1675 | RSS: Main: 267796480 04:44:31 INFO - PROCESS | 1675 | 04:44:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:33 INFO - PROCESS | 1675 | RSS: Main: 267554816 04:44:33 INFO - PROCESS | 1675 | 04:44:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:36 INFO - PROCESS | 1675 | RSS: Main: 267603968 04:44:36 INFO - PROCESS | 1675 | 04:44:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:39 INFO - PROCESS | 1675 | RSS: Main: 267612160 04:44:39 INFO - PROCESS | 1675 | 04:44:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:42 INFO - PROCESS | 1675 | RSS: Main: 268042240 04:44:42 INFO - PROCESS | 1675 | 04:44:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:46 INFO - PROCESS | 1675 | RSS: Main: 268013568 04:44:46 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 04:44:48 INFO - PROCESS | 1675 | RSS: Main: 270729216 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | __start_tp_report 04:44:48 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 04:44:48 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 04:44:48 INFO - PROCESS | 1675 | |i|pagename|runs| 04:44:48 INFO - PROCESS | 1675 | |0;ai-astar;106;117;120;138;117;141;169;110;172;163 04:44:48 INFO - PROCESS | 1675 | |1;audio-beat-detection;146;119;113;149;97;112;133;135;133;124 04:44:48 INFO - PROCESS | 1675 | |2;audio-dft;251;266;273;264;197;194;199;229;232;275 04:44:48 INFO - PROCESS | 1675 | |3;audio-fft;80;58;70;101;80;51;58;74;98;79 04:44:48 INFO - PROCESS | 1675 | |4;audio-oscillator;100;93;71;96;93;95;115;82;71;89 04:44:48 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;92;88;89;87;91;87;91;87;97;85 04:44:48 INFO - PROCESS | 1675 | |6;imaging-darkroom;148;100;117;157;103;155;156;145;118;155 04:44:48 INFO - PROCESS | 1675 | |7;imaging-desaturate;137;97;132;78;138;141;134;91;97;92 04:44:48 INFO - PROCESS | 1675 | |8;json-parse-financial;48;49;82;80;81;66;59;58;58;59 04:44:48 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;68;67;75;78;93;91;92;96;81;72 04:44:48 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;79;75;101;100;102;101;90;90;90;84 04:44:48 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;146;145;145;146;150;165;169;153;241;164 04:44:48 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;180;178;176;173;175;224;237;219;174;175 04:44:48 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;69;71;69;69;74;69;71;70;71;68 04:44:48 INFO - PROCESS | 1675 | __end_tp_report 04:44:48 INFO - PROCESS | 1675 | __start_cc_report 04:44:48 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,970 04:44:48 INFO - PROCESS | 1675 | __end_cc_report 04:44:48 INFO - PROCESS | 1675 | __startTimestamp1475840688495__endTimestamp 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | ------- Summary: start ------- 04:44:48 INFO - PROCESS | 1675 | Number of tests: 14 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:135.30 Median:139.50 stddev:25.15 (18.0%) stddev-sans-first:24.34 04:44:48 INFO - PROCESS | 1675 | Values: 106.0 117.0 120.0 138.0 117.0 141.0 169.0 110.0 172.0 163.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:134.00 stddev:16.22 (12.1%) stddev-sans-first:15.52 04:44:48 INFO - PROCESS | 1675 | Values: 146.0 119.0 113.0 149.0 97.0 112.0 133.0 135.0 133.0 124.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:238.00 Median:257.50 stddev:32.45 (12.6%) stddev-sans-first:34.08 04:44:48 INFO - PROCESS | 1675 | Values: 251.0 266.0 273.0 264.0 197.0 194.0 199.0 229.0 232.0 275.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.90 Median:76.50 stddev:16.50 (21.6%) stddev-sans-first:17.40 04:44:48 INFO - PROCESS | 1675 | Values: 80.0 58.0 70.0 101.0 80.0 51.0 58.0 74.0 98.0 79.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:91.00 stddev:13.29 (14.6%) stddev-sans-first:13.64 04:44:48 INFO - PROCESS | 1675 | Values: 100.0 93.0 71.0 96.0 93.0 95.0 115.0 82.0 71.0 89.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:3.47 (3.9%) stddev-sans-first:3.55 04:44:48 INFO - PROCESS | 1675 | Values: 92.0 88.0 89.0 87.0 91.0 87.0 91.0 87.0 97.0 85.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:135.40 Median:151.50 stddev:23.22 (15.3%) stddev-sans-first:24.18 04:44:48 INFO - PROCESS | 1675 | Values: 148.0 100.0 117.0 157.0 103.0 155.0 156.0 145.0 118.0 155.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:113.70 Median:84.50 stddev:24.59 (29.1%) stddev-sans-first:24.60 04:44:48 INFO - PROCESS | 1675 | Values: 137.0 97.0 132.0 78.0 138.0 141.0 134.0 91.0 97.0 92.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:62.50 stddev:12.81 (20.5%) stddev-sans-first:12.20 04:44:48 INFO - PROCESS | 1675 | Values: 48.0 49.0 82.0 80.0 81.0 66.0 59.0 58.0 58.0 59.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:86.00 stddev:10.95 (12.7%) stddev-sans-first:10.51 04:44:48 INFO - PROCESS | 1675 | Values: 68.0 67.0 75.0 78.0 93.0 91.0 92.0 96.0 81.0 72.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:81.50 stddev:9.74 (11.9%) stddev-sans-first:9.28 04:44:48 INFO - PROCESS | 1675 | Values: 79.0 75.0 101.0 100.0 102.0 101.0 90.0 90.0 90.0 84.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:158.50 stddev:29.09 (18.4%) stddev-sans-first:30.24 04:44:48 INFO - PROCESS | 1675 | Values: 146.0 145.0 145.0 146.0 150.0 165.0 169.0 153.0 241.0 164.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:179.00 stddev:25.01 (14.0%) stddev-sans-first:26.20 04:44:48 INFO - PROCESS | 1675 | Values: 180.0 178.0 176.0 173.0 175.0 224.0 237.0 219.0 174.0 175.0 04:44:48 INFO - PROCESS | 1675 | 04:44:48 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.73 (2.5%) stddev-sans-first:1.79 04:44:48 INFO - PROCESS | 1675 | Values: 69.0 71.0 69.0 69.0 74.0 69.0 71.0 70.0 71.0 68.0 04:44:48 INFO - PROCESS | 1675 | -------- Summary: end -------- 04:44:48 INFO - PROCESS | 1675 | 04:44:49 INFO - TEST-INFO | 1675: exit 0 04:44:49 INFO - TEST-OK | kraken | took 61913ms 04:44:49 INFO - SUITE-END | took 1176s 04:44:49 INFO - Completed test suite (00:19:37) 04:44:49 INFO - javascript benchmark 04:44:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.947536469968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.5606343143677, 3283.40898638245, 3320.169957510622, 3338.1487720631244, 3353.731701463883, 5227.843164705056, 5496.340439147298, 5523.088690366089, 5556.916646250299, 5624.775008999635, 5369.24830523727, 5541.0580201365765, 5552.139418390156, 5587.3015873015875, 5595.776168953237, 4148.958510414887, 4205.306124489455, 5059.6458247922665, 5070.08738427083, 5096.872578185538, 5066.493350664922, 5119.4880511948695, 5142.51146141116, 5173.715445650488, 5192.766325515342, 5137.5633071188995, 5146.511081447256, 5174.404943431516, 5182.481751824825, 5209.400918894337, 4997.875053123665, 5011.173156429185, 5044.369453818273, 5099.643024988252, 5130.358705161855, 4971.403431588233, 4998.625103117281, 5031.270465782441, 5031.874203144914, 5044.596432285409, 4704.529547045302, 5483.643563168382, 5578.525825304854, 5627.774889004435, 5708.20085188074, 4688.5077066907825, 5958.523318134538, 6063.787767428119, 6073.301570319426, 6078.361772013919, 5361.410244873061, 6026.9095963560585, 6058.757649694007, 6065.969670151665, 6078.1186727924205, 5498.615096943176, 5676.347220069745, 5687.886242275132, 5695.202671625976, 5697.202391665129, 6035.78874739382, 6049.122877182784, 6081.817545473643, 6097.298810636834, 6144.784932527429, 4889.779959901813, 5934.8813023739285, 5935.821925342247, 5941.881162376728, 5964.254468191476, 5287.995280896617, 6016.759329626853, 6033.728482218311, 6062.090686397076, 6069.544784141207, 5904.143899134688, 5969.432903874125, 5993.0710739835395, 6040.546958978094, 6067.089936509559, 6009.819705408845, 6011.789587364421, 6035.909461358083, 6064.727087280995, 6094.75620975156, 4803.927941080887, 4807.879803004953, 4843.346148270009, 4867.537583929521, 4919.77860996256, 4216.64158546527, 4242.809073591696, 4245.066085461193, 4270.295401258758, 4291.463567054118, 5203.8178663746585, 5591.27313449249, 5599.300087489064, 5602.551795856321, 5614.522765564972, 5642.0, 5766.308043034863, 6061.787837425757, 6068.0, 6076.210092687922, 5495.780168793203, 5522.502974732213, 5565.998120338378, 5589.273394458694, 5604.963081829875, 4584.518625544337, 4886.827161481219, 5313.229581710708, 5313.946860531422, 5361.222622719683, 6116.113163591254, 6130.969345153246, 6150.231221097363, 6156.753729850756, 6169.444749972524, 5908.675022873783, 5959.255093113361, 6025.78909738157, 6051.818445446644, 6092.45167934888, 6042.788502402394, 6124.106319906441, 6125.235451818428, 6129.664444256008, 6159.4456498915315, 5999.610025348338, 6002.7298771554515, 6004.759809607742, 6055.394460553909, 6057.939420605914, 5979.252593425822, 6011.519078473799, 6014.9097763534455, 6026.306974697965, 6124.969375153096, 5915.58590898633, 5942.851428714143, 5959.22530071088, 6011.639301641915, 6024.608400453956, 5822.155787410887, 5878.382769809279, 5903.498202652822, 5910.556708246812, 5919.6744179070565, 5530.889382212414, 5665.631733937281, 5723.02708539541, 5741.339745929272, 5863.912041319469, 4504.099180163915, 5086.821961231339, 5802.622829516068, 5902.38025007368, 5928.881422371443, 5756.366799652119, 5759.683217423082, 5787.884242315215, 5789.1895134680335, 5816.04035334182], "value": 5484.053137808179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.20166120916866, 493.8888750031243, 523.4895976422987, 532.575360909567, 537.9973100134499, 38968.805155974216, 41528.0, 41549.99999999996, 41562.37656435156, 41757.37363939543, 41931.0, 42345.364819527735, 42352.788236058776, 42361.152776944444, 42372.78813605928, 9652.420854748703, 9787.951060244688, 9830.213582913386, 9862.260330475207, 9897.75255618608, 9829.459379734148, 9906.306558540906, 9936.552855121501, 9948.60205591779, 9951.601935922554, 9922.801543969117, 9937.751556211117, 9941.105300522951, 9964.20286377088, 9990.700278991606, 8925.839640846649, 9827.705168844946, 9861.359011664219, 9916.702498925008, 9970.252231082626, 9720.0, 9793.853092203623, 9818.410895346231, 9833.754156146082, 9853.655122070693, 31067.0, 39709.602903971165, 40038.599614003775, 40257.79871100655, 40524.79737601322, 3214.164317277525, 3302.4550949093373, 3351.916202094967, 3407.9659203407896, 3751.362268414376, 31069.223269418446, 31478.0, 31693.049208523782, 31766.364672706648, 32296.83851580727, 3230.628477725068, 3276.3774882772436, 3279.918002049944, 3357.7145942594907, 3378.172347774811, 405797.97101014305, 458831.0, 465935.0, 466822.0, 467961.66019170027, 61004.0, 61102.0, 61233.38766612366, 61237.0, 61237.0, 63569.36430635634, 64065.67967160227, 64102.0, 64274.32296639987, 64389.0, 14262.643433914027, 15764.921175394278, 16055.357785688442, 16103.19484025794, 16360.836391635932, 12148.967337776212, 12547.24716517012, 12567.497300107892, 12608.117431779687, 12625.0, 16979.15104244783, 17699.823001770073, 17751.201195946214, 17797.555061123574, 17798.288068477115, 3199.7600179986594, 6038.788642397495, 6792.252852186256, 6976.267491913276, 7000.719971201095, 831.4678605692362, 922.8338898998111, 958.5788844996671, 987.3088837813559, 1053.3206082077018, 28775.0, 29343.0, 30223.546646800314, 30294.939677111637, 31295.687043129732, 1005.818952588541, 1016.4155610523978, 1029.1972261635935, 1095.9945200274108, 1142.23470274916, 15524.844751552566, 15974.680506389806, 16086.75869861953, 16152.529121265316, 16195.352185912432, 669071.6546417334, 673893.0, 679190.0, 681081.0, 682193.5890320616, 58344.7082764592, 58376.0, 58786.41213587895, 58900.0, 58907.410925890195, 1337.6187786480807, 1373.7389895919744, 1392.109050207888, 1399.6780740429758, 1401.1453013661658, 25024.74975250224, 30287.848560757055, 30352.544711828898, 30661.386772263984, 30994.0701778947, 51913.702157446365, 51934.74032629964, 52139.95720085501, 52430.47569524409, 52633.7368313156, 615019.0, 616680.0, 618576.0, 619853.0, 620652.0, 26788.19635410941, 27024.32439189036, 27047.45905081848, 27323.590146147428, 27344.726552735014, 47530.52469475261, 48396.0, 48447.0, 48760.0, 48958.75520622374, 37305.62694373022, 38395.80802095972, 39669.60330396659, 40528.98677533085, 40755.18489630132, 34278.65721342755, 39615.40576891291, 39857.2028559433, 40366.59633403629, 40758.0, 37568.81215593904, 38304.23391532098, 38870.80564597272, 39175.60824391834, 39576.40635390414, 28468.0, 28541.42917141604, 34252.00193824593, 34802.651973479944, 34886.0, 23404.76595234094, 23666.626775171506, 25895.0, 25957.22128336153, 26581.803818828586], "value": 19973.23789151182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9626041135475, 359.67629133779576, 375.06234413965086, 376.94157405602124, 401.8031164729282, 13474.461021559138, 18829.623407531857, 20036.69944950827, 20495.692564611523, 20753.896230518865, 18214.45356639303, 18403.723944140816, 18584.16371263293, 18606.0, 20615.690764638504, 5866.76532938683, 6168.876622467548, 6174.629522228681, 6184.56708030438, 6191.876162476748, 5097.439281679012, 5409.6213265071465, 5530.668159910419, 5663.745131469073, 6053.031514957607, 5765.0, 5965.105234214859, 6032.69836508175, 6040.154378387029, 6058.515318774487, 5913.586048976574, 5988.0, 5993.550483713695, 5997.220361352996, 6081.483073938721, 4314.741115533078, 4709.764511774431, 5133.919648211081, 5271.28837606922, 5273.472652734734, 12943.964482841444, 13190.208587484685, 13201.14192577489, 13233.073684842066, 18222.817771822378, 2022.342738609943, 2023.281734984074, 2125.840561957844, 2301.5051763870847, 2946.749526290268, 8700.477971321741, 9920.702378928643, 10020.49897505129, 10370.82873810439, 10437.165026797838, 1812.0848971269556, 1835.5319393554691, 1854.5919897622637, 1905.3617038292189, 1909.7326374307609, 100878.0, 127491.0, 127564.0, 129112.35443822815, 129668.35165824204, 7664.0, 8390.748277551684, 9733.659321923698, 9771.951140244253, 11512.94243528777, 12061.0, 12105.15263931534, 12149.210301330386, 12151.270923744603, 12180.695482612828, 7978.521288722579, 8024.839503209903, 8079.111297757242, 8154.959225203836, 8173.795655108551, 7299.270072992658, 8388.32893368529, 8459.61931713062, 8557.914420855835, 8593.656253749905, 3330.766846320734, 3346.748993825473, 3767.811609419518, 3832.2143960488033, 3875.1862108957434, 1930.2375561653068, 1974.3780709076595, 1982.7521559805025, 1986.8509861760426, 2004.38866145824, 816.4407380944073, 823.2426167925523, 854.8162145138825, 855.2943821347288, 955.3837774635322, 20747.896260518603, 21618.0, 21854.672179917314, 21957.451063723536, 22002.669959950614, 764.8202672371988, 872.7512658892185, 874.1084094223856, 901.6618767962015, 943.7923656795494, 11116.499757510932, 11503.654890353302, 11514.36670983104, 11518.36648984314, 11621.593244236412, 539199.3040034774, 547272.0, 583745.0, 599564.0, 600348.0, 131870.0, 132495.0, 136187.3773627091, 137232.0, 138149.3092534531, 891.7859713668673, 963.2294164668237, 978.505854543451, 980.789130336981, 997.7056768253383, 15009.77485337699, 15947.840521594635, 19268.4219473416, 19270.0, 19584.60830783405, 54138.64653383697, 55389.0, 55528.33414997556, 56189.71905140448, 56391.71804140953, 75313.0, 76714.0, 76756.0, 77381.61309193418, 77518.61240693761, 7836.529808211526, 7882.645280962256, 7908.485948413335, 8101.432899696964, 8118.675252989814, 9162.633494660138, 9716.708498745049, 10474.423906685206, 10837.349759014485, 11943.641690749291, 10231.693049208536, 10625.362478251329, 10696.251262411557, 11105.167112466435, 11144.2199046066, 8797.780055498664, 9081.364304498886, 10909.290896091728, 11053.944730276296, 11085.445727713743, 11016.559337626406, 11159.888401115884, 11265.380404077854, 11320.339720165919, 11454.94272528632, 7843.137254901842, 7936.484128531627, 8105.946226990689, 8280.00639923213, 8283.17168283167, 10082.798344033225, 11065.059469945145, 11072.667819965414, 11365.54537818511, 11446.484908178985], "value": 9076.111184240508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.3203398300845, 1555.4789145636212, 1719.2779032806227, 1831.1302131487537, 1847.113385574925, 7356.7057317707295, 8099.757007289776, 8382.455140415868, 9358.157765801077, 9378.671746488866, 8619.267362274199, 8949.95525022374, 8959.776005599862, 9076.0, 9085.318601104911, 2372.8220383471266, 2382.273406610983, 2389.307100940725, 2400.7719266669637, 2406.518696260755, 2311.7919387255142, 2323.2449453927456, 2348.800351970076, 2349.765023497645, 2360.1621424394352, 2345.64815277708, 2356.7643235676464, 2367.9763202367926, 2378.4886249456363, 2381.7499162587937, 2352.1179557665873, 2352.2472808701223, 2367.7987371073395, 2368.7157541095094, 2395.568797616428, 2346.577616029114, 2370.893309801063, 2387.928362149121, 2393.964090538643, 2411.9517609647883, 9233.0, 9255.490947997858, 9349.205317548016, 9350.0, 9392.248620110375, 5341.011912796145, 5510.421405752379, 5518.0, 5530.723463826793, 5538.916916246219, 3516.753827232095, 3641.217138315275, 3710.2950439416422, 3713.6472035156617, 3727.608601096873, 1054.2830875004993, 1056.4400867540216, 1074.3607553505651, 1081.9350838949688, 1091.5851976249055, 11792.528298868036, 11927.045836333073, 11954.0, 12008.159428839985, 12043.277403355827, 4393.472783265965, 4434.645228381722, 4632.652551058684, 4634.976825115853, 4649.139909116824, 9157.038510956254, 9254.12085851843, 9349.298802589832, 9351.953240233755, 9381.812363752822, 5200.115980283361, 5207.635465517377, 5209.140491818884, 5247.9737601311745, 5284.207368894697, 4444.866654000385, 4626.768661566908, 4627.722336659811, 4780.259059845729, 4927.063857867065, 3236.336551007038, 3731.4962480065387, 3854.5181852268465, 3855.4602355670227, 3865.729398942047, 1070.347088276151, 1174.4186627619383, 1187.6140254417348, 1192.0582739635763, 1196.0, 813.9918600813916, 868.431177578687, 891.3315013739696, 893.7363477774072, 957.6025949230991, 5950.583459157904, 6041.5468839837185, 6104.725287362079, 6188.81433556994, 6430.356964303533, 887.401004322093, 900.9774755631031, 909.5315912305168, 929.1683942871092, 942.7784470649392, 3402.319536092791, 3512.5960514541157, 3762.5673047599876, 4057.188562287495, 4069.409935559327, 10562.366258024544, 10900.781984360268, 11295.887041129483, 11316.434178291052, 11348.375839328915, 9340.206082483064, 11067.059299959432, 11145.387003714874, 11223.607173749044, 11228.438578071064, 8275.337972962148, 8324.0, 8354.331653467709, 8375.41372103947, 8390.496570205807, 5556.694381809039, 5884.7940322090235, 6054.727537260922, 6125.754969801336, 6157.599756015845, 10259.435731034566, 10433.165346772088, 10548.46836759157, 10593.841092383465, 10608.416537090534, 7655.770326890202, 10419.166466682798, 10423.583056677648, 10615.787684246427, 10624.256302058782, 6963.6170010647875, 7216.3505284524645, 7500.887486687595, 7690.653920573475, 7867.9606601966625, 8526.445781024213, 8639.95680021596, 8645.783855403664, 8741.213290803858, 8744.344174186834, 7633.923660763321, 7679.5776232305525, 7708.344790692854, 7847.176046515034, 7870.72452464161, 6884.51808373409, 7295.416366690758, 7459.142198647225, 7494.17564067963, 7546.509476883985, 7063.505554611128, 7212.4230061596, 7212.711491540489, 7214.170370407261, 7220.963895180491, 5001.624878134227, 5134.460881607378, 5138.6855478217085, 5218.139007063944, 5222.817201397933, 4655.371524844239, 5102.566281866083, 5109.616778741535, 5209.817656382009, 5278.366596008504], "value": 4614.247100342935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.6437492821151, 298.56111516071377, 305.71873876034044, 308.51255017073026, 312.87328631904074, 4835.48554751529, 5349.421920533442, 5573.303337082864, 5610.214569960203, 5626.943730562693, 4833.516648335165, 5423.88126827074, 5478.972780071369, 5518.392976772562, 5535.6955367454775, 4195.454590903186, 4210.368444733299, 4210.62104410603, 4237.580410562466, 4242.575742425748, 3872.612738726119, 3874.8375487353683, 3931.036895960494, 4122.958770412288, 4232.851850185244, 3842.212346468981, 3869.419587061949, 4087.9182416351655, 4108.0, 4137.213929353428, 4070.5522392536795, 4090.9386359204786, 4096.446979657738, 4115.52671442782, 4151.0, 3268.3790079884748, 3546.4857595648746, 3568.571771387424, 3572.8749493767596, 3588.784672919633, 4244.872653820359, 5113.463086375914, 5166.276721259027, 5214.739263036871, 5294.364676238876, 4362.520122786491, 4645.536655953398, 4706.235011990429, 4708.270218116198, 4751.904961900777, 4735.105957616946, 4776.641751868624, 5018.397792264952, 5048.444671086178, 5524.613277070606, 2952.099609619065, 3098.3028818515877, 3488.9358745582585, 3618.805794087945, 3743.794091324976, 5079.1365467870555, 5592.7762889484375, 5960.642361458283, 6108.847278818021, 6114.847128821771, 3539.02676763892, 3941.4431299636485, 3943.23973218748, 3961.1483531040963, 3974.2647610192207, 3772.0569857535615, 3909.4917660703927, 3988.8432354616834, 4013.2976729072298, 4033.3143365627916, 4097.262492751273, 4222.78886055696, 4326.264535029052, 4697.906041879143, 4704.482506924235, 5854.912176317359, 5855.912161317584, 5859.501942334864, 5862.912056319158, 5910.734016969247, 1095.7917995580974, 1278.4310981613094, 1331.1281110872394, 1353.7969304604387, 1372.0807059270312, 828.4449418889359, 867.9132086791396, 894.1237587164616, 925.5973651461636, 928.9907100929039, 4861.659683822169, 5137.486251374908, 5409.350877894678, 5460.290162278879, 5468.972655136698, 5748.626339288016, 5893.086571581412, 5893.3222679391565, 5902.881942361215, 5936.940630593639, 4798.448178459522, 5021.774020169101, 5334.1732031535175, 5363.892722145613, 5389.9191512127345, 3144.8584813683437, 3151.700588444094, 3169.7305729012833, 3172.4772109387163, 3194.7923384980368, 4709.835155769531, 5737.225474560964, 6135.5398345124295, 6218.595791273553, 6230.719617617127, 5124.103281925648, 5451.918221226605, 5648.774049037993, 6108.3280839107665, 6148.89480812196, 4692.6245900327895, 5057.294347524057, 5830.3586605473365, 6192.832508622127, 6302.0, 5119.007174403971, 5614.007027505177, 5871.418434754711, 5909.0, 6067.694276175025, 4629.4907560167685, 5400.9476398968145, 5826.184334193132, 5905.675187864708, 5937.526546969898, 4871.585915197248, 6187.81436556904, 6202.844928876814, 6238.0, 6247.0, 3781.7920014399474, 3801.2777572261184, 3914.530256369254, 4004.9399259010556, 4050.4734384529825, 5717.285339332583, 5990.292766561509, 5994.0, 6002.87994240104, 6057.969710151598, 5643.2472405851295, 5730.169125476866, 5807.0998995155815, 5833.154192642128, 5857.238558987305, 5810.448007439287, 5824.757468374622, 5824.912626310524, 5828.388019257917, 5839.357670656309, 5020.171671674133, 5154.705512574832, 5572.832815015394, 5614.438556144353, 5660.29246344207, 5771.3651498335985, 5772.6536407815665, 5803.100519419497, 5833.533317334518, 5835.591508594358, 4743.976280118577, 4876.512348765095, 4965.262158244585, 5660.688662123623, 5715.570882375057], "value": 4164.003364170081, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.8825955457795, 727.0040045138159, 728.5446595877577, 777.9611019449026, 824.2746383182798, 15018.77471837922, 15437.382504699826, 15923.999999999985, 15982.200889955498, 16013.519594412157, 14575.562733117997, 14663.413463461475, 14693.044952078108, 14732.705345893075, 14995.025323353975, 840.0549381945297, 859.7334826203866, 859.8151397449548, 861.4056301152216, 861.5692153923038, 684.6234570985963, 700.4151533469534, 827.1232493556819, 847.3263755314509, 858.5835869603269, 828.9709860154895, 912.7991841794827, 913.5249670171506, 914.0767824497273, 914.5335878701877, 906.8050369170594, 907.3920473282916, 907.5280853955971, 909.0954500272205, 909.1635695160435, 666.9099671544328, 671.9685283090481, 674.3492529708855, 674.8920172772333, 676.2088356622763, 14660.633484162874, 14690.926545367205, 14696.779548306784, 14799.482018129422, 14808.629784255372, 14536.345864436125, 14595.562133136023, 14831.851681483155, 14879.404823807035, 14908.925455372653, 11691.707707307385, 11849.111316651286, 11932.70168245792, 12115.757684846254, 12250.387480625934, 3824.579296277407, 3868.477755502999, 3895.1235971906376, 4005.2990726623016, 4010.0776821330965, 90235.0, 96270.0, 110372.89627103707, 113718.0, 116026.0, 10200.846987295197, 10760.730981725363, 11284.32294062359, 11415.657530274106, 11906.940465297617, 22807.771922280896, 23193.956271967803, 23254.883725581603, 23269.3019209424, 23289.417764556023, 7972.800679983046, 8173.591320433955, 8273.544955027532, 8343.624536895853, 8359.623816928253, 4328.264195086843, 4445.666575006822, 4500.639948804153, 4602.1025899949855, 4629.699069560468, 3520.5951315599036, 3622.3660859350034, 3664.8350824212976, 3672.338978983755, 3675.852965881388, 554.6976897590823, 639.3798015924546, 653.1769969838039, 667.5794249622803, 668.9933100669028, 596.6837576084682, 604.6523249131767, 618.8205420428116, 630.4389093706604, 677.5426587053719, 9389.812203756022, 9477.526123693788, 9610.135087841987, 9639.0, 9911.306208565331, 581.8050952930815, 663.4327649859397, 666.1406785247074, 666.5933780393956, 679.5752654590881, 3739.0, 4334.783260836945, 4341.979634785823, 4565.3836732040745, 4736.313234580966, 119788.0, 129522.35238823933, 145334.0, 157621.10321313687, 161862.0, 127318.0, 129243.0, 130350.34824825815, 130377.0, 134253.65746342606, 76494.0, 81391.0, 107794.46102769436, 111210.88789112006, 117199.0, 8965.372423930523, 9315.0, 10029.003357237938, 10075.798484030132, 10301.278910476194, 34037.149071272426, 51116.23325650044, 63474.36525634869, 63654.68172659107, 66533.33466665466, 53359.199612006625, 76662.0, 83689.0, 86609.56695216484, 86710.1328986702, 13048.811374257059, 13438.051482535173, 13628.386722597705, 13702.65743356424, 13763.931180344434, 13129.868701313248, 14881.404743810126, 14920.701585968436, 14958.476453324081, 15211.77182342288, 12369.567065152676, 14119.223442710749, 14153.221572813594, 14384.0, 14469.348879300247, 13849.376778045214, 13979.790303145664, 14071.015028947875, 14397.568072957829, 14595.416183352547, 13238.933805330911, 13590.796470722918, 13766.31168441594, 13914.373853176428, 14062.226577538333, 11151.386673732699, 11153.665390038312, 11504.884951150381, 11512.712182195512, 11523.308601483603, 8595.44129631572, 9813.558389872616, 10319.48402579883, 11667.824982625438, 11685.649430517098], "value": 7792.2459640810075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1663.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 120.0, 138.0, 117.0, 141.0, 169.0, 110.0, 172.0, 163.0], "value": 135.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 113.0, 149.0, 97.0, 112.0, 133.0, 135.0, 133.0, 124.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [251.0, 266.0, 273.0, 264.0, 197.0, 194.0, 199.0, 229.0, 232.0, 275.0], "value": 238.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 70.0, 101.0, 80.0, 51.0, 58.0, 74.0, 98.0, 79.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 93.0, 71.0, 96.0, 93.0, 95.0, 115.0, 82.0, 71.0, 89.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 89.0, 87.0, 91.0, 87.0, 91.0, 87.0, 97.0, 85.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 100.0, 117.0, 157.0, 103.0, 155.0, 156.0, 145.0, 118.0, 155.0], "value": 135.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 97.0, 132.0, 78.0, 138.0, 141.0, 134.0, 91.0, 97.0, 92.0], "value": 113.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 82.0, 80.0, 81.0, 66.0, 59.0, 58.0, 58.0, 59.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 75.0, 78.0, 93.0, 91.0, 92.0, 96.0, 81.0, 72.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 101.0, 100.0, 102.0, 101.0, 90.0, 90.0, 90.0, 84.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 150.0, 165.0, 169.0, 153.0, 241.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 176.0, 173.0, 175.0, 224.0, 237.0, 219.0, 174.0, 175.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 69.0, 74.0, 69.0, 71.0, 70.0, 71.0, 68.0], "value": 70.1, "unit": "score"}]}]} 04:44:49 INFO - Return code: 0 04:44:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:49 ERROR - # TBPL SUCCESS # 04:44:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:49 INFO - 2016-10-07 04:44:49.815 screenresolution[1680:10577] starting screenresolution argv=screenresolution get 04:44:49 INFO - 2016-10-07 04:44:49.818 screenresolution[1680:10577] Display 0: 1600x1200x32@60 04:44:49 INFO - 2016-10-07 04:44:49.824 screenresolution[1681:10580] starting screenresolution argv=screenresolution list 04:44:49 INFO - Available Modes on Display 0 04:44:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:50 INFO - Intel Iris: 04:44:50 INFO - Chipset Model: Intel Iris 04:44:50 INFO - Type: GPU 04:44:50 INFO - Bus: Built-In 04:44:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:50 INFO - Vendor: Intel (0x8086) 04:44:50 INFO - Device ID: 0x0a2e 04:44:50 INFO - Revision ID: 0x0009 04:44:50 INFO - Displays: 04:44:50 INFO - Display: 04:44:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:50 INFO - Display Serial Number: 1600x1200 60 04:44:50 INFO - Main Display: Yes 04:44:50 INFO - Mirror: Off 04:44:50 INFO - Online: Yes 04:44:50 INFO - Rotation: Supported 04:44:50 INFO - Return code: 0 04:44:50 INFO - Running post-action listener: _resource_record_post_action 04:44:50 INFO - [mozharness: 2016-10-07 11:44:50.060103Z] Finished run-tests step (success) 04:44:50 INFO - Running post-run listener: _resource_record_post_run 04:44:50 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 38083072; Write bytes: 709092352; Read time: 244; Write time: 1963 04:44:50 INFO - TinderboxPrint: CPU usage
54.6% 04:44:50 INFO - TinderboxPrint: I/O read bytes / time
38,083,072 / 244 04:44:50 INFO - TinderboxPrint: I/O write bytes / time
709,092,352 / 1,963 04:44:50 INFO - TinderboxPrint: CPU idle
2,202.8 (45.4%) 04:44:50 INFO - TinderboxPrint: CPU system
984.4 (20.3%) 04:44:50 INFO - TinderboxPrint: CPU user
1,666.5 (34.3%) 04:44:50 INFO - TinderboxPrint: Swap in / out
445,775,872 / 0 04:44:50 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 391385600; Write bytes: 386041856; Read time: 29757; Write time: 757 04:44:50 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37128704; Write bytes: 298589184; Read time: 232; Write time: 1143 04:44:50 INFO - Running post-run listener: _upload_blobber_files 04:44:50 INFO - Blob upload gear active. 04:44:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:50 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 04:44:50 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:50 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:51 INFO - (blobuploader) - INFO - Done attempting. 04:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:52 INFO - (blobuploader) - INFO - Done attempting. 04:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:55 INFO - (blobuploader) - INFO - Done attempting. 04:44:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:55 INFO - Return code: 0 04:44:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a4b7a9b7851501f4958737a94a18d453ab161394af739b94873d2544881cecfa8dfef1dd38a1d4f4719f1517a1ee558a0fbf98ac3323a3f296d21fc143b494d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/437e577854803bf03a0b4f3669e6c398cecd7901868b089bc3cd3e927822387fbdb880e948b84e4d35389c5fa10d6a5ad4e04759d7eb45f8ceb24e6f601b3b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1c0cc13d6414b0e0c107889282448d5e8f3077a2330563e93cf490606019da23b79856b67048f8c422a7d8b58e845dc5bf6c249383492aa87e23c4944d5e2f64"} 04:44:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:55 INFO - Contents: 04:44:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a4b7a9b7851501f4958737a94a18d453ab161394af739b94873d2544881cecfa8dfef1dd38a1d4f4719f1517a1ee558a0fbf98ac3323a3f296d21fc143b494d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/437e577854803bf03a0b4f3669e6c398cecd7901868b089bc3cd3e927822387fbdb880e948b84e4d35389c5fa10d6a5ad4e04759d7eb45f8ceb24e6f601b3b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1c0cc13d6414b0e0c107889282448d5e8f3077a2330563e93cf490606019da23b79856b67048f8c422a7d8b58e845dc5bf6c249383492aa87e23c4944d5e2f64"} 04:44:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:55 INFO - Copying logs to upload dir... 04:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.258457 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-07 04:44:55.409050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 04:44:55.412442) ========= 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.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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/Larch/sha512/a4b7a9b7851501f4958737a94a18d453ab161394af739b94873d2544881cecfa8dfef1dd38a1d4f4719f1517a1ee558a0fbf98ac3323a3f296d21fc143b494d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/437e577854803bf03a0b4f3669e6c398cecd7901868b089bc3cd3e927822387fbdb880e948b84e4d35389c5fa10d6a5ad4e04759d7eb45f8ceb24e6f601b3b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1c0cc13d6414b0e0c107889282448d5e8f3077a2330563e93cf490606019da23b79856b67048f8c422a7d8b58e845dc5bf6c249383492aa87e23c4944d5e2f64"} build_url:https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010993 build_url: 'https://queue.taskcluster.net/v1/task/C73U_ttARUKioOO6pQ6FdA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a4b7a9b7851501f4958737a94a18d453ab161394af739b94873d2544881cecfa8dfef1dd38a1d4f4719f1517a1ee558a0fbf98ac3323a3f296d21fc143b494d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/437e577854803bf03a0b4f3669e6c398cecd7901868b089bc3cd3e927822387fbdb880e948b84e4d35389c5fa10d6a5ad4e04759d7eb45f8ceb24e6f601b3b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1c0cc13d6414b0e0c107889282448d5e8f3077a2330563e93cf490606019da23b79856b67048f8c422a7d8b58e845dc5bf6c249383492aa87e23c4944d5e2f64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 04:44:55.444421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:44:55.444765) ========= 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.FThL6dUeet/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.21Q90DhDBJ/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 04:44:55.493314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 04:44:55.493639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 04:44:55.493978) ========= ========= Total master_lag: 0.17 =========