builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0128 starttime: 1476402783.07 results: success (0) buildid: 20161013133620 builduid: 8854ff9d10eb47f8aa7f74c7d26688fe revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.067135) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.067596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.067883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.095214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.095823) ========= 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.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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-13 16:53:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-10-13 16:53:03 (16.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.303035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.303638) ========= 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.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.028337 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:03.354647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 16:53:03.355122) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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-13 16:53:03,437 truncating revision to first 12 chars 2016-10-13 16:53:03,437 Setting DEBUG logging. 2016-10-13 16:53:03,437 attempt 1/10 2016-10-13 16:53:03,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/183b9d08d264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 16:53:04,584 unpacking tar archive at: fx-team-183b9d08d264/testing/mozharness/ program finished with exit code 0 elapsedTime=1.401379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 16:53:04.781463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:04.782063) ========= script_repo_revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:04.782726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:04.783188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 16:53:04.803687) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-13 16:53:04.804291) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:04 INFO - MultiFileLogger online at 20161013 16:53:04 in /builds/slave/test 16:53:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:53:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:05 INFO - {'append_to_log': False, 16:53:05 INFO - 'base_work_dir': '/builds/slave/test', 16:53:05 INFO - 'blob_upload_branch': 'Fx-Team', 16:53:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:05 INFO - 'branch': 'Fx-Team', 16:53:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:05 INFO - 'config_files': ('talos/mac_config.py',), 16:53:05 INFO - 'default_actions': ('clobber', 16:53:05 INFO - 'read-buildbot-config', 16:53:05 INFO - 'download-and-extract', 16:53:05 INFO - 'populate-webroot', 16:53:05 INFO - 'create-virtualenv', 16:53:05 INFO - 'install', 16:53:05 INFO - 'run-tests'), 16:53:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:05 INFO - 'download_minidump_stackwalk': True, 16:53:05 INFO - 'download_symbols': 'ondemand', 16:53:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:05 INFO - 'installer_path': 'installer.exe', 16:53:05 INFO - 'log_level': 'info', 16:53:05 INFO - 'log_name': 'talos', 16:53:05 INFO - 'log_to_console': True, 16:53:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:05 INFO - 'opt_config_files': (), 16:53:05 INFO - 'pip_index': False, 16:53:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:05 INFO - 'cmd': ('bash', 16:53:05 INFO - '-c', 16:53:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:05 INFO - 'enabled': True, 16:53:05 INFO - 'halt_on_failure': False, 16:53:05 INFO - 'name': 'check_screen_resolution'},), 16:53:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:05 INFO - 'cmd': ('bash', 16:53:05 INFO - '-c', 16:53:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:05 INFO - 'enabled': True, 16:53:05 INFO - 'halt_on_failure': False, 16:53:05 INFO - 'name': 'check_screen_resolution'},), 16:53:05 INFO - 'run_cmd_checks_enabled': True, 16:53:05 INFO - 'sps_profile': False, 16:53:05 INFO - 'sps_profile_interval': 0, 16:53:05 INFO - 'suite': 'dromaeojs-e10s', 16:53:05 INFO - 'system_bits': '32', 16:53:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:05 INFO - 'title': 't-yosemite-r7-0128', 16:53:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:05 INFO - 'use_talos_json': True, 16:53:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:05 INFO - 'work_dir': 'build'} 16:53:05 INFO - [mozharness: 2016-10-13 23:53:05.009658Z] Running clobber step. 16:53:05 INFO - Running pre-action listener: _resource_record_pre_action 16:53:05 INFO - Running main action method: clobber 16:53:05 INFO - rmtree: /builds/slave/test/build 16:53:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:07 INFO - Running post-action listener: _resource_record_post_action 16:53:07 INFO - [mozharness: 2016-10-13 23:53:07.182052Z] Finished clobber step (success) 16:53:07 INFO - [mozharness: 2016-10-13 23:53:07.182206Z] Running read-buildbot-config step. 16:53:07 INFO - Running pre-action listener: _resource_record_pre_action 16:53:07 INFO - Running main action method: read_buildbot_config 16:53:07 INFO - Using buildbot properties: 16:53:07 INFO - { 16:53:07 INFO - "project": "", 16:53:07 INFO - "product": "firefox", 16:53:07 INFO - "script_repo_revision": "production", 16:53:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:53:07 INFO - "repository": "", 16:53:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:53:07 INFO - "buildid": "20161013133620", 16:53:07 INFO - "pgo_build": "False", 16:53:07 INFO - "basedir": "/builds/slave/test", 16:53:07 INFO - "buildnumber": 11, 16:53:07 INFO - "slavename": "t-yosemite-r7-0128", 16:53:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:53:07 INFO - "platform": "yosemite_r7", 16:53:07 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 16:53:07 INFO - "branch": "fx-team", 16:53:07 INFO - "repo_path": "integration/fx-team", 16:53:07 INFO - "revision": "183b9d08d2648d4ed50fa1d354b50bd43c11a891", 16:53:07 INFO - "stage_platform": "macosx64", 16:53:07 INFO - "builduid": "8854ff9d10eb47f8aa7f74c7d26688fe", 16:53:07 INFO - "slavebuilddir": "test" 16:53:07 INFO - } 16:53:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:53:07 INFO - Running post-action listener: _resource_record_post_action 16:53:07 INFO - [mozharness: 2016-10-13 23:53:07.185211Z] Finished read-buildbot-config step (success) 16:53:07 INFO - [mozharness: 2016-10-13 23:53:07.185316Z] Running download-and-extract step. 16:53:07 INFO - Running pre-action listener: _resource_record_pre_action 16:53:07 INFO - Running main action method: download_and_extract 16:53:07 INFO - mkdir: /builds/slave/test/build/tests 16:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:07 INFO - trying https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/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 16:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/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 16:53:08 INFO - Downloaded 1199 bytes. 16:53:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:53:08 INFO - Using the following test package requirements: 16:53:08 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:53:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:53:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:53:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'jsshell-mac.zip'], 16:53:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:53:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:53:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:53:08 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:53:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:53:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:53:08 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:53:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:53:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:53:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:53:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:53:09 INFO - Http code: 200 16:53:09 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 16:53:09 INFO - x-amz-cf-id: MZTctbnyNedBhU86qYtbUv5Bt7m4GMmJXgCDxGWtIF91S-kcYO6-Aw== 16:53:09 INFO - x-amz-version-id: VOJ4gnb4.i_qQVAv1SBW2OH2lD3eXEbj 16:53:09 INFO - Expected file size: 16514321 16:53:09 INFO - Obtained file size: 16514321 16:53:15 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 16:53:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:53:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:53:15 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:53:16 INFO - Http code: 200 16:53:16 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 16:53:16 INFO - x-amz-cf-id: Pm7Y-EmzvAnjn81t789Jy03-4AlRd8d18phtuvUhPbU7MkIyzVcbyQ== 16:53:16 INFO - x-amz-version-id: VOJ4gnb4.i_qQVAv1SBW2OH2lD3eXEbj 16:53:16 INFO - Expected file size: 16514321 16:53:16 INFO - Obtained file size: 16514321 16:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:53:23 INFO - Http code: 200 16:53:23 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 16:53:23 INFO - x-amz-cf-id: Uu-gH85vqJ7G9ocx8YjiZh-0-Y65QWTT31NXmN9CORKLpHUd0sSXuQ== 16:53:23 INFO - x-amz-version-id: 4l_83m7QVAxKmmE.dv7jVKqzLb7gy4I1 16:53:24 INFO - Expected file size: 14409006 16:53:24 INFO - Obtained file size: 14409006 16:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:24 INFO - trying https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/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 16:53:27 INFO - Downloaded 111666536 bytes. 16:53:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:53:27 INFO - mkdir: /builds/slave/test/properties 16:53:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:27 INFO - Contents: 16:53:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:53:27 INFO - Running post-action listener: _resource_record_post_action 16:53:27 INFO - Running post-action listener: set_extra_try_arguments 16:53:27 INFO - [mozharness: 2016-10-13 23:53:27.909128Z] Finished download-and-extract step (success) 16:53:27 INFO - [mozharness: 2016-10-13 23:53:27.909220Z] Running populate-webroot step. 16:53:27 INFO - Running pre-action listener: _resource_record_pre_action 16:53:27 INFO - Running main action method: populate_webroot 16:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:27 INFO - '--tppagecycles', 16:53:27 INFO - '7'], 16:53:27 INFO - 'tests': ['tsvgm']}}, 16:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['damp', 'tps']}, 16:53:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'tests': ['damp', 'tps']}, 16:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['dromaeo_dom']}, 16:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['basic_compositor_video']}, 16:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['a11yr', 16:53:27 INFO - 'ts_paint', 16:53:27 INFO - 'tpaint', 16:53:27 INFO - 'sessionrestore', 16:53:27 INFO - 'sessionrestore_no_auto_restore', 16:53:27 INFO - 'tabpaint']}, 16:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['tsvgx', 16:53:27 INFO - 'tsvgr_opacity', 16:53:27 INFO - 'tart', 16:53:27 INFO - 'tscrollx', 16:53:27 INFO - 'cart']}, 16:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:27 INFO - 'tsvgr_opacity', 16:53:27 INFO - 'tart', 16:53:27 INFO - 'tscrollx', 16:53:27 INFO - 'cart']}, 16:53:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'talos_options': ['--disable-e10s'], 16:53:27 INFO - 'tests': ['tp5o']}, 16:53:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'tests': ['tp5o']}, 16:53:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'talos_options': ['--disable-e10s', 16:53:27 INFO - '--xperf_path', 16:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:27 INFO - 'tests': ['tp5n']}, 16:53:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:27 INFO - 'talos_options': ['--xperf_path', 16:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:27 INFO - 'tests': ['tp5n']}}, 16:53:27 INFO - 'talos.zip': {'path': '', 16:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:27 INFO - Running post-action listener: _resource_record_post_action 16:53:27 INFO - [mozharness: 2016-10-13 23:53:27.928083Z] Finished populate-webroot step (success) 16:53:27 INFO - [mozharness: 2016-10-13 23:53:27.928194Z] Running create-virtualenv step. 16:53:27 INFO - Running pre-action listener: _resource_record_pre_action 16:53:27 INFO - Running main action method: create_virtualenv 16:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:27 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 16:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:28 INFO - Using real prefix '/tools/python27' 16:53:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:31 INFO - Installing pip.................done. 16:53:31 INFO - Return code: 0 16:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:53:31 INFO - Reading from file tmpfile_stdout 16:53:31 INFO - Output received: 16:53:31 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) 16:53:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:31 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:31 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 16:53:31 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 16:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:31 INFO - 'HOME': '/Users/cltbld', 16:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:31 INFO - 'LOGNAME': 'cltbld', 16:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:31 INFO - 'MOZ_NO_REMOTE': '1', 16:53:31 INFO - 'NO_EM_RESTART': '1', 16:53:31 INFO - 'PAGER': '/bin/cat', 16:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:31 INFO - 'PWD': '/builds/slave/test', 16:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:31 INFO - 'SHELL': '/bin/bash', 16:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:31 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:31 INFO - 'USER': 'cltbld', 16:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:31 INFO - 'XPC_FLAGS': '0x0', 16:53:31 INFO - 'XPC_SERVICE_NAME': '0', 16:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:32 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 16:53:32 INFO - Cleaning up... 16:53:32 INFO - Return code: 0 16:53:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:32 INFO - 'HOME': '/Users/cltbld', 16:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:32 INFO - 'LOGNAME': 'cltbld', 16:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:32 INFO - 'MOZ_NO_REMOTE': '1', 16:53:32 INFO - 'NO_EM_RESTART': '1', 16:53:32 INFO - 'PAGER': '/bin/cat', 16:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:32 INFO - 'PWD': '/builds/slave/test', 16:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:32 INFO - 'SHELL': '/bin/bash', 16:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:32 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:32 INFO - 'USER': 'cltbld', 16:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:32 INFO - 'XPC_FLAGS': '0x0', 16:53:32 INFO - 'XPC_SERVICE_NAME': '0', 16:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:32 INFO - Downloading/unpacking psutil>=3.1.1 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53: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 16:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:35 INFO - Installing collected packages: psutil 16:53:35 INFO - Running setup.py install for psutil 16:53:35 INFO - building 'psutil._psutil_osx' extension 16:53:35 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 INFO - building 'psutil._psutil_posix' extension 16:53:36 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 16:53:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:53:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:53:36 INFO - ^ 16:53:36 INFO - 1 warning generated. 16:53:36 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 16:53:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:36 INFO - Successfully installed psutil 16:53:36 INFO - Cleaning up... 16:53:37 INFO - Return code: 0 16:53:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:53:37 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')]} 16:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:37 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')]} 16:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:37 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:37 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 16:53:37 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 16:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:37 INFO - 'HOME': '/Users/cltbld', 16:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:37 INFO - 'LOGNAME': 'cltbld', 16:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:37 INFO - 'MOZ_NO_REMOTE': '1', 16:53:37 INFO - 'NO_EM_RESTART': '1', 16:53:37 INFO - 'PAGER': '/bin/cat', 16:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:37 INFO - 'PWD': '/builds/slave/test', 16:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:37 INFO - 'SHELL': '/bin/bash', 16:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:37 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:37 INFO - 'USER': 'cltbld', 16:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:37 INFO - 'XPC_FLAGS': '0x0', 16:53:37 INFO - 'XPC_SERVICE_NAME': '0', 16:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:53:39 INFO - Installing collected packages: mozsystemmonitor 16:53:39 INFO - Running setup.py install for mozsystemmonitor 16:53:39 INFO - Successfully installed mozsystemmonitor 16:53:39 INFO - Cleaning up... 16:53:40 INFO - Return code: 0 16:53:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:53:40 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')]} 16:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:40 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')]} 16:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:40 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:40 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 16:53:40 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 16:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:40 INFO - 'HOME': '/Users/cltbld', 16:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:40 INFO - 'LOGNAME': 'cltbld', 16:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:40 INFO - 'MOZ_NO_REMOTE': '1', 16:53:40 INFO - 'NO_EM_RESTART': '1', 16:53:40 INFO - 'PAGER': '/bin/cat', 16:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:40 INFO - 'PWD': '/builds/slave/test', 16:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:40 INFO - 'SHELL': '/bin/bash', 16:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:40 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:40 INFO - 'USER': 'cltbld', 16:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:40 INFO - 'XPC_FLAGS': '0x0', 16:53:40 INFO - 'XPC_SERVICE_NAME': '0', 16:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:43 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:43 INFO - warning: no files found matching '*.txt' 16:53:43 INFO - no previously-included directories found matching 'build' 16:53:43 INFO - no previously-included directories found matching 'dist' 16:53:43 INFO - no previously-included directories found matching '.git*' 16:53:43 INFO - Installing collected packages: jsonschema, functools32 16:53:43 INFO - Running setup.py install for functools32 16:53:43 INFO - warning: no files found matching '*.txt' 16:53:43 INFO - no previously-included directories found matching 'build' 16:53:43 INFO - no previously-included directories found matching 'dist' 16:53:43 INFO - no previously-included directories found matching '.git*' 16:53:43 INFO - Successfully installed jsonschema functools32 16:53:43 INFO - Cleaning up... 16:53:43 INFO - Return code: 0 16:53:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:43 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 16:53:43 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 16:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:43 INFO - 'HOME': '/Users/cltbld', 16:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:43 INFO - 'LOGNAME': 'cltbld', 16:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:43 INFO - 'MOZ_NO_REMOTE': '1', 16:53:43 INFO - 'NO_EM_RESTART': '1', 16:53:43 INFO - 'PAGER': '/bin/cat', 16:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:43 INFO - 'PWD': '/builds/slave/test', 16:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:43 INFO - 'SHELL': '/bin/bash', 16:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:43 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:43 INFO - 'USER': 'cltbld', 16:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:43 INFO - 'XPC_FLAGS': '0x0', 16:53:43 INFO - 'XPC_SERVICE_NAME': '0', 16:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:53:43 INFO - Cleaning up... 16:53:43 INFO - Return code: 0 16:53:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:43 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:43 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 16:53:43 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 16:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:43 INFO - 'HOME': '/Users/cltbld', 16:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:43 INFO - 'LOGNAME': 'cltbld', 16:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:43 INFO - 'MOZ_NO_REMOTE': '1', 16:53:43 INFO - 'NO_EM_RESTART': '1', 16:53:43 INFO - 'PAGER': '/bin/cat', 16:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:43 INFO - 'PWD': '/builds/slave/test', 16:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:43 INFO - 'SHELL': '/bin/bash', 16:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:43 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:43 INFO - 'USER': 'cltbld', 16:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:43 INFO - 'XPC_FLAGS': '0x0', 16:53:43 INFO - 'XPC_SERVICE_NAME': '0', 16:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:44 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 16:53:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:46 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 16:53:46 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 16:53:46 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 16:53:46 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 16:53:46 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 16:53:46 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 16:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:47 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 16:53:47 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 16:53:47 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 16:53:47 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 16:53:47 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 16:53:47 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 16:53:47 INFO - Downloading docopt-0.6.1.tar.gz 16:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:48 INFO - Running setup.py install for blobuploader 16:53:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:48 INFO - Running setup.py install for requests 16:53:48 INFO - Running setup.py install for docopt 16:53:48 INFO - Successfully installed blobuploader requests docopt 16:53:48 INFO - Cleaning up... 16:53:48 INFO - Return code: 0 16:53:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:48 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')]} 16:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:48 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')]} 16:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:48 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:48 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 16:53:48 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 16:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:48 INFO - 'HOME': '/Users/cltbld', 16:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:48 INFO - 'LOGNAME': 'cltbld', 16:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:48 INFO - 'MOZ_NO_REMOTE': '1', 16:53:48 INFO - 'NO_EM_RESTART': '1', 16:53:48 INFO - 'PAGER': '/bin/cat', 16:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:48 INFO - 'PWD': '/builds/slave/test', 16:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:48 INFO - 'SHELL': '/bin/bash', 16:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:48 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:48 INFO - 'USER': 'cltbld', 16:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:48 INFO - 'XPC_FLAGS': '0x0', 16:53:48 INFO - 'XPC_SERVICE_NAME': '0', 16:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-YgCobM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-baDYP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-CGaYfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-DMDAJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-dMZauY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-UeEhm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-QTm_A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-mZ1fgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:49 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-eORQ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-4nbFNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-3AXhnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-82UM6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-cqfYBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-xnHCXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-oMu8jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-eha45y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:50 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-xCoIsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:50 INFO - Running setup.py install for manifestparser 16:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:51 INFO - Running setup.py install for mozcrash 16:53:51 INFO - Running setup.py install for mozdebug 16:53:51 INFO - Running setup.py install for mozdevice 16:53:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:53:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:51 INFO - Running setup.py install for mozfile 16:53:51 INFO - Running setup.py install for mozhttpd 16:53:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:51 INFO - Running setup.py install for mozinfo 16:53:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:51 INFO - Running setup.py install for mozInstall 16:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Running setup.py install for mozleak 16:53:52 INFO - Running setup.py install for mozlog 16:53:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Running setup.py install for moznetwork 16:53:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Running setup.py install for mozprocess 16:53:52 INFO - Running setup.py install for mozprofile 16:53:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:52 INFO - Running setup.py install for mozrunner 16:53:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:53 INFO - Running setup.py install for mozscreenshot 16:53:53 INFO - Running setup.py install for moztest 16:53:53 INFO - Running setup.py install for mozversion 16:53:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:53 INFO - Cleaning up... 16:53:53 INFO - Return code: 0 16:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:53 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')]} 16:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:53 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')]} 16:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:53 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:53 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 16:53:53 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 16:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:53 INFO - 'HOME': '/Users/cltbld', 16:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:53 INFO - 'LOGNAME': 'cltbld', 16:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:53 INFO - 'MOZ_NO_REMOTE': '1', 16:53:53 INFO - 'NO_EM_RESTART': '1', 16:53:53 INFO - 'PAGER': '/bin/cat', 16:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:53 INFO - 'PWD': '/builds/slave/test', 16:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:53 INFO - 'SHELL': '/bin/bash', 16:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:53 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:53 INFO - 'USER': 'cltbld', 16:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:53 INFO - 'XPC_FLAGS': '0x0', 16:53:53 INFO - 'XPC_SERVICE_NAME': '0', 16:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:53 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-9M5cyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:53 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)) 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:53 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-UNsBS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:53 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)) 16:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:53 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-J2dyMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-rpjn1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-Kd18Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-XHU825-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-acgMJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-tRwLgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-lOhbP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ZGa7ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-GenpG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:54 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)) 16:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:54 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-k30ItB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:55 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)) 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:55 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-EKyTWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:55 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)) 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:55 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-g8JWfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:55 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)) 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:55 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-RNhjTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:55 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)) 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:55 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-32USQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:55 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)) 16:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:55 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-R0FFeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:55 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)) 16:53:55 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)) 16:53:55 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)) 16:53:55 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)) 16:53:55 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)) 16:53:55 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)) 16:53:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:55 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 16:53:55 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 16:53:55 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 16:53:55 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 16:53:55 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 16:53:55 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 16:53:58 INFO - Downloading blessings-1.6.tar.gz 16:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:58 INFO - Installing collected packages: blessings 16:53:58 INFO - Running setup.py install for blessings 16:53:58 INFO - Successfully installed blessings 16:53:58 INFO - Cleaning up... 16:53:58 INFO - Return code: 0 16:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:58 INFO - Reading from file tmpfile_stdout 16:53:58 INFO - Current package versions: 16:53:58 INFO - blessings == 1.6 16:53:58 INFO - blobuploader == 1.2.4 16:53:58 INFO - docopt == 0.6.1 16:53:58 INFO - functools32 == 3.2.3-2 16:53:58 INFO - jsonschema == 2.5.1 16:53:58 INFO - manifestparser == 1.1 16:53:58 INFO - mozInstall == 1.12 16:53:58 INFO - mozcrash == 0.17 16:53:58 INFO - mozdebug == 0.1 16:53:58 INFO - mozdevice == 0.48 16:53:58 INFO - mozfile == 1.2 16:53:58 INFO - mozhttpd == 0.7 16:53:58 INFO - mozinfo == 0.9 16:53:58 INFO - mozleak == 0.1 16:53:58 INFO - mozlog == 3.4 16:53:58 INFO - moznetwork == 0.27 16:53:58 INFO - mozprocess == 0.23 16:53:58 INFO - mozprofile == 0.28 16:53:58 INFO - mozrunner == 6.12 16:53:58 INFO - mozscreenshot == 0.1 16:53:58 INFO - mozsystemmonitor == 0.3 16:53:58 INFO - moztest == 0.7 16:53:58 INFO - mozversion == 1.4 16:53:58 INFO - psutil == 3.1.1 16:53:58 INFO - requests == 1.2.3 16:53:58 INFO - wsgiref == 0.1.2 16:53:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:58 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:58 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 16:53:58 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 16:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:58 INFO - 'HOME': '/Users/cltbld', 16:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:58 INFO - 'LOGNAME': 'cltbld', 16:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:58 INFO - 'MOZ_NO_REMOTE': '1', 16:53:58 INFO - 'NO_EM_RESTART': '1', 16:53:58 INFO - 'PAGER': '/bin/cat', 16:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:58 INFO - 'PWD': '/builds/slave/test', 16:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:58 INFO - 'SHELL': '/bin/bash', 16:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:58 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:58 INFO - 'USER': 'cltbld', 16:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:58 INFO - 'XPC_FLAGS': '0x0', 16:53:58 INFO - 'XPC_SERVICE_NAME': '0', 16:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 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)) 16:53:58 INFO - Cleaning up... 16:53:59 INFO - Return code: 0 16:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:59 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')]} 16:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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')]} 16:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:59 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 0x10e28e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e204570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9430497c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.Apks2cwvqm/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.i0SPxJX4h5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 16:53:59 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 16:53:59 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 16:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:53:59 INFO - 'HOME': '/Users/cltbld', 16:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PAGER': '/bin/cat', 16:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:53:59 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - 'XPC_FLAGS': '0x0', 16:53:59 INFO - 'XPC_SERVICE_NAME': '0', 16:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:53:59 INFO - Cleaning up... 16:53:59 INFO - Return code: 0 16:53:59 INFO - Running post-action listener: _resource_record_post_action 16:53:59 INFO - Running post-action listener: _start_resource_monitoring 16:53:59 INFO - Starting resource monitoring. 16:53:59 INFO - [mozharness: 2016-10-13 23:53:59.303466Z] Finished create-virtualenv step (success) 16:53:59 INFO - [mozharness: 2016-10-13 23:53:59.304441Z] Running install step. 16:53:59 INFO - Running pre-action listener: _resource_record_pre_action 16:53:59 INFO - Running main action method: install 16:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:59 INFO - Reading from file tmpfile_stdout 16:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:59 INFO - Reading from file tmpfile_stdout 16:53:59 INFO - Output received: 16:53:59 INFO - Usage: mozinstall [options] installer 16:53:59 INFO - Options: 16:53:59 INFO - -h, --help show this help message and exit 16:53:59 INFO - -d DEST, --destination=DEST 16:53:59 INFO - Directory to install application into. [default: 16:53:59 INFO - "/builds/slave/test"] 16:53:59 INFO - --app=APP Application being installed. [default: firefox] 16:53:59 INFO - mkdir: /builds/slave/test/build/application 16:53:59 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'] 16:53:59 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 16:54:34 INFO - Reading from file tmpfile_stdout 16:54:34 INFO - Output received: 16:54:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:54:34 INFO - Running post-action listener: _resource_record_post_action 16:54:34 INFO - [mozharness: 2016-10-13 23:54:34.116796Z] Finished install step (success) 16:54:34 INFO - [mozharness: 2016-10-13 23:54:34.116935Z] Running run-tests step. 16:54:34 INFO - Running pre-action listener: _resource_record_pre_action 16:54:34 INFO - Running main action method: run_tests 16:54:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:54:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:54:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:54:34 INFO - 2016-10-13 16:54:34.131 screenresolution[1636:7388] starting screenresolution argv=screenresolution get 16:54:34 INFO - 2016-10-13 16:54:34.134 screenresolution[1636:7388] Display 0: 1600x1200x32@60 16:54:34 INFO - 2016-10-13 16:54:34.140 screenresolution[1637:7390] starting screenresolution argv=screenresolution list 16:54:34 INFO - Available Modes on Display 0 16:54:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:54:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:54:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:54:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:54:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:54:34 INFO - Intel Iris: 16:54:34 INFO - Chipset Model: Intel Iris 16:54:34 INFO - Type: GPU 16:54:34 INFO - Bus: Built-In 16:54:34 INFO - VRAM (Dynamic, Max): 1536 MB 16:54:34 INFO - Vendor: Intel (0x8086) 16:54:34 INFO - Device ID: 0x0a2e 16:54:34 INFO - Revision ID: 0x0009 16:54:34 INFO - Displays: 16:54:34 INFO - Display: 16:54:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:54:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:54:34 INFO - Display Serial Number: 1600x1200 60 16:54:34 INFO - Main Display: Yes 16:54:34 INFO - Mirror: Off 16:54:34 INFO - Online: Yes 16:54:34 INFO - Rotation: Supported 16:54:34 INFO - Return code: 0 16:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:54:34 INFO - Python 2.7.3 16:54:34 INFO - Return code: 0 16:54:34 INFO - grabbing minidump binary from tooltool 16:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:34 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 0x10e0a2d30>, '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 0x10dec8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:54:34 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 16:54:34 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 16:54:34 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 16:54:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:34 INFO - Return code: 0 16:54:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 16:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 16:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apks2cwvqm/Render', 16:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:34 INFO - 'HOME': '/Users/cltbld', 16:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:34 INFO - 'LOGNAME': 'cltbld', 16:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:34 INFO - 'MOZ_NO_REMOTE': '1', 16:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:54:34 INFO - 'NO_EM_RESTART': '1', 16:54:34 INFO - 'PAGER': '/bin/cat', 16:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:34 INFO - 'PWD': '/builds/slave/test', 16:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:34 INFO - 'SHELL': '/bin/bash', 16:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0SPxJX4h5/Listeners', 16:54:34 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 16:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:34 INFO - 'USER': 'cltbld', 16:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:34 INFO - 'XPC_FLAGS': '0x0', 16:54:34 INFO - 'XPC_SERVICE_NAME': '0', 16:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 16:54:34 INFO - mozversion application_buildid: 20161013133620 16:54:34 INFO - mozversion application_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 16:54:34 INFO - mozversion application_display_name: Nightly 16:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:34 INFO - mozversion application_name: Firefox 16:54:34 INFO - mozversion application_remotingname: firefox 16:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:54:34 INFO - mozversion application_vendor: Mozilla 16:54:34 INFO - mozversion application_version: 52.0a1 16:54:34 INFO - mozversion platform_buildid: 20161013133620 16:54:34 INFO - mozversion platform_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 16:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:54:34 INFO - mozversion platform_version: 52.0a1 16:54:34 INFO - using testdate: 1476402874 16:54:34 INFO - actual date: 1476402874 16:54:34 INFO - starting webserver on 'localhost:49266' 16:54:34 INFO - SUITE-START | Running 2 tests 16:54:34 INFO - TEST-START | dromaeo_css 16:54:34 INFO - operating with platform_type : mac_ 16:54:34 INFO - Initialising browser for dromaeo_css test... 16:54:34 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpcz3CCg/profile http://localhost:49266/getInfo.html) 16:54:37 INFO - PROCESS | 1647 | 2016-10-13 16:54:37.511 plugin-container[1649:7559] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 16:54:37 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:54:37 INFO - PROCESS | 1647 | 2016-10-13 16:54:37.513 plugin-container[1649:7559] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 16:54:37 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:54:37 INFO - PROCESS | 1647 | 2016-10-13 16:54:37.513 plugin-container[1649:7559] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:54:37 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 16:54:37 INFO - PROCESS | 1647 | colorDepth:24 16:54:37 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 16:54:37 INFO - PROCESS | 1647 | __metrics 16:54:37 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:54:38 INFO - TEST-INFO | 1647: exit 0 16:54:38 INFO - Browser initialized. 16:54:38 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:38 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpcz3CCg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:40 INFO - PROCESS | 1650 | 2016-10-13 16:54:40.900 plugin-container[1651:7674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 16:54:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:54:40 INFO - PROCESS | 1650 | 2016-10-13 16:54:40.901 plugin-container[1651:7674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 16:54:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:54:40 INFO - PROCESS | 1650 | 2016-10-13 16:54:40.901 plugin-container[1651:7674] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:54:50 INFO - PROCESS | 1650 | RSS: Main: 239153152 16:54:50 INFO - PROCESS | 1650 | 16:55:40 INFO - PROCESS | 1650 | 1476402940171 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] 16:57:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 16:57:54 INFO - PROCESS | 1650 | RSS: Main: 252256256 16:57:54 INFO - PROCESS | 1650 | 17:00:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 17:00:57 INFO - PROCESS | 1650 | RSS: Main: 265076736 17:00:57 INFO - PROCESS | 1650 | 17:03:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 17:04:00 INFO - PROCESS | 1650 | RSS: Main: 269701120 17:04:00 INFO - PROCESS | 1650 | 17:07:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 17:07:02 INFO - PROCESS | 1650 | RSS: Main: 269266944 17:07:02 INFO - PROCESS | 1650 | 17:10:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 17:10:06 INFO - PROCESS | 1650 | RSS: Main: 274657280 17:10:06 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 17:13:09 INFO - PROCESS | 1650 | RSS: Main: 277340160 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | __start_tp_report 17:13:09 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:13:09 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:13:09 INFO - PROCESS | 1650 | |i|pagename|runs| 17:13:09 INFO - PROCESS | 1650 | |0;dojo.html;3007.774416918731;3331.766776325658;3358.04295775704;3365.242820365418;3409.931801363972;5140.485951404858;5471.699056551888;5525.171224316355;5527.170924361348;5590.440955904418;4613.331066995283;5474.124140137579;5554.777808887649;5652.152177173426;5718.456746609076;5107.770150343244;5131.255967884655;5183.922241166386;5220.269162317279;5234;5035.924461133086;5186.351706036746;5203.4796520348045;5213.7393130343335;5268.341457317835;5007.649464537484;5052.0906236877345;5067.163917953533;5089.46560611136;5160.92258616121;5097.286379906816;5113.335266415379;5122;5129.615278854064;5148.6910785353;5068.797248110108;5084.694918304914;5090.898182036375;5107.770150343244;5120.257562653432;5367.838964831061;5370.7046112463795;5514.779408823642;5545.390007099216;5581.079121944874;6067.029275315928;6081.057436097368;6090.66501342426;6097.634141951497;6127.509799216052;6120.5103591713005;6139.478144357735;6154.8769024619705;6162.84592885177;6164.198654174974;5472.124460086367;5511.779528818883;5512.972435137879;5644.379118296984;5649.519790817785;6148.354422785633;6170.259568851767;6190.257169139642;6206.813795586139;6261.7182226799905;5947.316058653224;5964.761409543657;6028.980291602363;6033.125196846433;6085.482733967574;5941.762329506858;6132.570720049643;6142.14010038586;6169.96915015422;6185.567010309325;5911.76352945886;6004.429579190058;6011.308699499614;6023.849403764853;6089.086637004485;6016.669083200379;6106.4809491192855;6108;6117;6140.109684095781;4811.374521312207;4839.104765618372;4840.15297322967;4841.15279826029;4865.854024379274;4202.348635961431;4251.3622956556765;4267.274563324242;4300.376445415397;4333.241682705514;5538.086215774432;5593.07714227148;5619.297587801525;5645.350784659735;5670.574706896917;6090.512758979271;6095.939040609625;6117.388261173847;6120.60216085953;6128;5430.8913821723345;5491.533219676372;5568.44315568448;5596.300462442195;5605.159226116115;5300;5300.09898317287;5308.840734777963;5341.652792568549;5346.385165705916;6212.751489940351;6227.346128656516;6231.40801623845;6237.906431403442;6239.906401403891;5963.73163207648;5981.132735753378;6016.969915150396;6125.816225513242;6213.9067913980425;6205.100260462117;6212.937870621236;6218.4092511213175;6222.844428889314;6245.18812554365;4628.305754136906;5516.365617953827;5947.613405128653;6054.212952316171;6088.665123418255;4761.452432970114;5222.477752224747;6039.063945088343;6119.632822030692;6156.984097624021;5769.07694768835;5976.581639285208;5985.670788106696;5999.220101386792;6076.756929722762;5747.798827041033;5843.152742852178;5935.643861368331;5939.821805345674;5989.341172471112;4583.702059366131;5572.554195664418;5639.830805075854;5782.710864456676;5818.301803783573;5946.226990491208;5952.404759524013;5965.70171491415;5966.49284810796;5989.490893273946;5613.382527921844;5664.716764161858;5785.3636100028125;5786.07422812348;5819.272590926134 17:13:09 INFO - PROCESS | 1650 | |1;ext.html;441.6930233487727;448.86534039788063;473.5666864818691;534.110705675051;549.0967358694946;36472.817635911815;38396.80801595992;38436.42345364818;40425;40538.59461405385;39707.60292397075;40387.59612403875;40420.59579404205;40569.797151014274;40620.796896015476;9186.770330741734;9442.716718498456;9448.858267126;9454.243660507178;9469.147776700096;9350.485723285217;9384.953075234615;9460.101290377437;9478.289128315404;9492.572834222443;9442.763930901714;9509.714708558755;9511.286653501014;9512.809743805154;9521.857172142389;9428.528573571328;9432.339736218468;9459.668911588062;9493.762655933588;9508.85736713943;8455.450395724258;8847.071057538995;9280.118388753057;9366.157045865904;9400.858987115198;38443.23113537714;38667.61332386668;38738.41892371617;38815.61184388148;38857.61142388568;3103.6120484939383;3221.4362486564755;3222.726068284175;3658.5243918290716;3808.257389808988;29357.559636605467;29599;30097.849510752527;30207.69792302093;30839.229019274473;3183.3792410479964;3210.486322188462;3219.935601287961;3305.7851239669344;3346.5984081910083;403977.9801101005;404778;405529;406293.99999999703;407096;56905;57306.426935730946;57316;57457.42542574604;57534;59018.40981590215;59711.70144149338;59940;60054;60223.39776602265;12914.806277905838;15002.24988750558;15006.174660393783;15006.549803505912;15022.699546009237;11479.655610331703;11523.8271425927;11551.826722599168;11569.132315076404;11571.594994175164;15271.847281527043;16364.018158910503;16388.344466221457;16422.917885410734;16444.6711065778;6047.848803779941;6083.300420451705;6132.816015519452;6171.352008039181;6201.10084037812;834.6661335465741;868.5396739727954;972.3776782858976;983.9754006149903;1019.8878123406568;27855.860720696266;28727.425451490853;29057;29767.553486697718;29775;968.7432830299977;985.7437066362797;1077.7898309829666;1122.6800361896983;1131.12337938097;11472.827907581393;12333.814992775115;13581.777640012446;14609.707805844037;15187.848121518644;513407;552037;557578;559542;564288;54918.901621968136;55149.44850551523;55354.72322638441;55453.445465545636;55583.722081390144;1174.1898090317654;1176.805827038529;1258.5657948008106;1284.5825106840314;1337.237774468563;28527.572086418306;28641.570376443953;28852.855735722027;29272;29278.414431711673;48020.03959920852;48146.51853481561;48549.27176092432;48625.75687121542;48630.513694864014;505197;510657;512787;514037;517749;25537.87231063833;25573.3606659835;25703.228903132935;25859.965601375734;25964.09125680592;40173.39739903962;43445.78277108594;44467.77766111149;45182.77408612936;45709;36041.27917441584;37177.62822371742;37942.620573795015;38497.2300553993;40212.59787402089;33886;36931;38086.666966656034;39691.80154099211;40568.74028226994;37806.43290350702;38623.806880965414;39673.801630991664;39695.2060958785;39810;31754;36400.36198371027;38695.419568705925;39021.80489097536;40256;29160.562591561567;29309.12072637824;29820.50897455162;30323;31048 17:13:09 INFO - PROCESS | 1650 | |2;jquery.html;315.3810029906819;333.9866405343786;372.1533511261879;379.50095624254084;393.19787633228214;19001.334953276637;19542.90228548857;19668.311609093686;20255.291064812736;20399.388018359437;16563.17184140791;17271.136443177853;18958.905205473988;19442.4167274982;19494.122764475596;5617.887642247153;5904.1734157218025;5971.492423144038;5976.133460648203;5989.580729348947;5680;5888.882222355551;5937.6140550864275;5950.256217972754;5968.940310596882;5651.689157096358;5875.236219291486;5876.588638795286;5888.293404791431;5897.911531327033;5812.3025236971835;5915.645061296314;5976.2230909981645;6012.969935150318;6068.96965515174;5674.546036317126;5690.5447564194765;5804.506616937565;5879.118132280149;5880.441358071019;12422.627321180378;12573.245605263714;12598.181118227378;12769;12893.097483176181;2116.8200702940267;2318.7681231876845;2439.316991242455;2613.9869300653563;2778.263760103574;13807.033507654469;14207.573772786833;15487.380504779909;15791.210439478094;16158.83841161585;1695.4489790818034;1866.496046067554;1973.9013049347475;2015.9193632254692;2058.8661736987046;108264;108388;121198;121682;128459.35770321182;18401;18668.439946801616;20347.796522034885;20784.688229676565;20844.957752112332;33432.16419589481;33512.497312540334;33529.83235083858;33530.66469335324;33656.663433365844;9238.676646317346;9350.532473376305;9493;9608.66369677058;9640.529409412606;7594.050743657043;7609.391248700091;7621.809454763565;7713.3443657288635;7766.961165194138;7790.454668173287;9213.76965575866;9243.306751993492;9392.671256506126;9394.248460123174;3021.078571035855;3292.967070329314;3770.5852356240794;3774.75464094833;3780.432935059763;833.4790755777639;898.0109058435596;900.1808354397598;999.6301368493558;1026.6047571684956;18540;20202.59594808125;20253.797462025486;20520.638943475962;20595;885.4112015509614;894.3069121430813;912.9041450647719;920.8987011428737;970.7039352997263;9217.493037882847;9392.436453812656;10921.563137474572;10928;10983.780324393467;509394;509748;510068;510165;510286;87761.56119219364;97674.02325976791;109261;120030;120778.3961080189;848.7878030492377;849.9490030598184;852.754977732505;941.4116177388995;950.1068995144681;15144.54566363011;17978.101094944937;18276.08619569043;18726;19079.141438635572;50270.748646256536;52167.34828561964;52367.47632523626;52497.737511312196;52533.94932101413;55842.44157558535;56424;73378.63310683412;73426.29023952622;74949.6252518734;7743.651535680795;7754.147043825062;7860.621918583706;7942.563159026309;8147.63335649909;7568.697252109854;9854.753631159278;12147.45336459879;12180.45187966526;12631.989440844527;10520.632317798638;10834.187435942178;10849.566017359217;10961.287516311415;11175.764847030463;10332.483375831329;10486.842697359698;10528.157747380037;10926.78146437051;10976.286541374786;10887.564497420331;10900.236983411402;11203.663890083311;11225.887741122811;11347.773044539228;6921.342472465108;7766.301032907066;7975.960120199362;8022.558759268296;8252.381071419788;10411.635592754217;10797.136229101496;11001.779964400826;11012;11143.888561114609 17:13:09 INFO - PROCESS | 1650 | |3;mootools.html;1343.6305016120566;1499.310317254063;1636.8608668263198;1791.8118597547266;1799.622079363333;7737.535747855132;8005.919940800591;8194.672213111477;8766.386352955287;8801.295896328294;8139.593020348989;8429;8454.492730436179;8557.058723540405;8596.398252122353;1924.4900101473086;1950.2199120351831;2332.0322066342446;2335.6846825678485;2355.1756885090253;2284.520250747337;2321.3964369263945;2332.6151185054446;2336.5677349690277;2340.566995105911;2320.8027317678016;2325.2442956039354;2333.9533209335805;2334.2413715542516;2337.824663150262;1921.6156768646188;2297.4830663100834;2303.516261585069;2305.4927915858484;2313.13257528426;2298.276043046435;2298.5058212484396;2301.79283864453;2303.2744685424036;2309.168699268262;8642.913570864273;8710.869336959951;8711.69509067186;8714.08502107276;8721.912780872237;4991.376077990251;5062.063518249136;5117.283580298761;5163.8192663256605;5174.301469301634;3426.1777173478436;3486.477028445728;3614.150674591469;3624.4563315502623;3635.8545658173643;1065.147881694649;1073.7369344510566;1074.7635520185547;1089.0851684584907;1092.2190633696946;11297.717557061056;11315.981561659408;11329.886701133048;11376.431178441127;11396.60111896088;3687.4284485904727;4491.8427855025575;4680.625549955996;4684.976575117171;4701.106789709944;9721.708348749407;9727.124558789743;9779.902200978042;9799.16707079892;9802.75493112678;4500.167469018242;5042.470540593258;5134.512221338967;5160.174372100446;5161.690298582097;4211.241976444269;4219.493660760729;4628.514006029386;4707.29390591414;4735.905281894412;3800.2969450651717;3807.1053302473897;3895.9220815584094;3913.021744563859;3936.035671260502;1266.1896386312767;1270.6950331920273;1272.3129510064646;1277.8274932884128;1282.5062350994933;700.2752151523251;835.436080645574;886.1094599927161;899.2446345070173;940.6848705683536;5527;5583.469570390806;5670.177824215466;5863.237779088691;5940.34656187819;821.4793564913228;890.6214858685033;968.3608818179968;971.2230215827451;1019.4393083804026;3685.244524872395;3792.3173828710546;3826.330392181357;3903.33643280643;3938.369860822255;9377.874655041438;10352.741181470523;10622.787544249071;10647.680569582924;10660.987206215397;9891.802163956681;10383.740406489898;10521.42132182722;10611;10617.256792024638;7447.404207663374;7867.331276841533;8063.798405039804;8077.555734434663;8085.191480851985;5101.260317253903;5192.584593232608;5282.445343239058;5844.12338149281;6026.487748541423;8774.331508053798;9696.175825054666;9730.75673108178;9785.951070244602;9886.159676427584;9672.56473458682;9830;9861;10013.549390277602;10071.244656650928;6590.9670451647435;6813.931860681329;6916.377526022682;7090.822729431806;7203.991441198341;7953.880691789744;8155.592220389076;8182.83634327322;8189.7133600323705;8219.917800822155;6947.5831450113155;7108.3602475777425;7136.892946605909;7181.712731490682;7199.964000180175;6984.231734509099;7009.439244860297;7027.15674119109;7031.050808140835;7089.61007144612;6578.8355291118105;6756.391924726601;6758.222804377559;6809.182898052265;6918.135233095863;4736.502667219892;4783.258594917794;4802.807887684454;4808.2547205183255;4848.10310092634;4814.446338671098;4839.879003024812;4850.684705494132;4901.240307752304;4918.311436398835 17:13:09 INFO - PROCESS | 1650 | |4;prototype.html;294.28048421609174;299.7197620225089;308.05580894558176;308.5911167702794;310.3529141739473;4713.387259656244;4721.308853953248;4747.145513807518;5246.213068039796;5408.2698835657175;4633.768311584424;5322.361316641999;5392.973035134829;5396.406395296514;5404.405515393313;3997.320455522568;4081.1225586498895;4090.1819636072755;4133.090720041601;4135.27632664284;3321.618013928393;3353.864137031871;3889.669378102865;4135.58644135587;4160.791960401983;4043.3126368517273;4091.749537754238;4100.38494225867;4110.97944510277;4120.773357465338;3685.539307586565;3779.9055023624355;3802.0914000789417;3968.4245784361397;4110.671146308288;3423.4693622488303;3599.2441587266703;3608.1778701755447;3618.023133753898;3624.9275014499563;4330.653547716175;4745.762711864393;5036.726128016781;5252.264682944391;5308.389535203424;3511.2436737161206;4063.6342729154517;4092.7517107282265;4278.807453664593;4419.182451246497;5300.708461034642;5559.610097475631;5666.914996275059;5668.858278543028;5707.174948400527;3564.8395822188063;3814.9809250953845;3866.9226615467533;3934.154156856261;3936.212757448493;5193.584513238894;5906.49794767441;5910.408959104098;5925.377835327272;5937.67342796146;3865.9226815463535;3903.375459926455;3909;3909.5308562972054;3938.2714197873483;3842.212346468967;3896.064944413377;3950.486436763202;3963.2271707016853;3988.960110398917;3430.644895266356;3512.627877237829;3897.81722235549;4383.167198232326;4550.270897059163;4922.458529561745;5013.448520662724;5263.447338029452;5322.0952438085615;5742.454466825729;1234.5370486067725;1272.3638180909545;1313.7897936330141;1338.6184937292826;1340.095435580979;780.8209603498758;867.2454964181203;896.7223252937596;902.9277657787493;911.2072496927715;5312.2297266896085;5313.973430132824;5326.680399176062;5332.813351532678;5358.33020872391;5290.92063619046;5796.681182534917;5802.361740208574;5810.709464526757;5817.70911454434;4337.7614231217585;4987.426445958688;5141.331626888481;5259.552938000236;5317.9202311965355;2326.162581470669;2377.181456186019;2392.6052201386924;2472.7156377016513;2593.871665825372;4509.391232183613;4748.4539277982785;5122.846314610568;5155.61332900034;5198.84403467889;4837.822979659168;4983.950160498421;5032.421271553818;5083.517065878736;5435.809746658848;6159.599626024384;6259.248890133122;6286.497080233662;6315.96842015787;6321.494280457552;4947.678400903929;5268.473152684701;5489.478499542537;5962.452340857183;6029.186059881859;5068.467810879804;5494.642848214853;5801.3908539602735;5853.180554722428;5864.621813873821;5157.381114266312;5363.980843639696;6136.23297087864;6160.426952367706;6246.187995560548;3405.216800135933;3419.7093247074276;3750.5499340079364;4079.224947260011;4124.4019617154745;5503.267190216491;5836.920169768607;5848.766049357978;5868.501177399798;5886.264216972879;5042.9243561345875;5471.015217260772;5564.850839821938;5650.519705824887;5710.229119068873;4253.553376895381;5735.541156707537;5745.798897038583;5747.4078700812;5776.508996735324;4569.657275704269;5365.3293338332705;5501.0648189807025;5610.747516361856;5641.746121424464;5730.023142015998;5769.798057067983;5782.710864456844;5795.333536643171;5811.634265947414;4837.129316723023;5592.993261213021;5658.915116273177;5683.829485115453;5708.971455142698 17:13:09 INFO - PROCESS | 1650 | |5;yui.html;628.7139351595022;690.4959379652851;751.4964973467776;755.5164694595458;779.5907148746907;13785;14632;14635.341409636565;14656.560303190909;14659.92670036651;12623.62129136125;12733.808992865092;12735.554255601055;12748.745025099492;12761.80857287139;646.0535315762407;675.4258879952026;805.6656487557657;810.7891948093494;829.5437509369823;817.5176645778989;829.7261903571837;831.2934006094831;833.5998720614109;834.090840983328;834.490960514089;881.3698205782864;883.6200433813458;887.3211992825461;887.6227603268617;848.4315508609216;866.3156106675718;868.6525389844081;868.9348298877546;869.3523325122792;634.2072409488139;643.0932385336699;651.3388910256094;652.2336254900473;653.1313353240179;11484.71288217793;11771.764564708657;12964;13293.401796919163;13358.866411335859;12750.362481875869;13377.799333010013;14217.928910355486;14259.714805703828;14396.496122635657;11229.27009744364;11433;11520.423978801027;11529.030628167237;11717.941410292979;3635.8545658173907;3661.1945372018113;3664.523611930432;3681.7975011374633;3698;108777;110481;110955.9999999992;111317;112828;11050.778984420267;11055;11072.501737421835;11081.667549973514;11154.051905588116;21963.682179069307;21965.780342196693;21972.230971916226;21974.780252197274;22006.779932200472;7542.170361260257;7659.655315510815;7813.882791758128;7897.60511974399;7988.241117093867;4139.79301034947;4227.978860105742;4240.448741663564;4241.278982572909;4302.698811083257;3426.3489936911906;3495.650434956535;3516.841742121611;3544.4151714966742;3547.1486843157973;611.8042226487481;620.3140402059073;626.7774939896362;627.6641996531833;634.010942929023;499.55379177281566;557.3228527339302;568.8151350811003;645.8611398549334;657.0505619380045;8395.62219700115;9046.411983221069;9130.941587877123;9191.63233470667;9298.285029581313;568.2385603291526;647.8736646353916;648.5006544960354;652.2499126005132;652.3965332067818;4138.461999939988;4367.170237654836;4375.146846364992;4417.160739459492;4450.287953927356;72147;114195;125016.37491812483;134718;141302;128885.35557322341;131817;132951.67048329394;133472;136875.31562342125;104235.47882260541;108616.45691771648;109767.45116274367;110702.44648776704;113461;7723.497972631761;8477.152284771473;8492.8959235299;8589.398742087993;8652.23627721943;62531;62797;63056;63739.362606375194;64076;83566.74649880135;93921.06078939396;94507.52746236225;94990;98314;10076.798464030824;10188.439635819805;10728.570857165625;10781;11192.944035279772;14029;14365.497207597684;14626.268686565842;14887.627809304853;15225.923870380577;10838.67483975482;11717.648470545897;13295.601131966056;13657.658558536115;14055.297235137998;11051.72370690739;12862.871371286541;13648.93175534116;13715.794263085862;14293.64265893361;13297.401616927455;13395.330233488481;13515;13569.05016648825;13575.253361065235;10633.415162166155;10677.359358438518;10843.240973131806;10982.945085274523;11098.5560577576;8300.916990830256;8476.444938865283;9339.205298671015;10081.798364032826;10347.172226222036 17:13:09 INFO - PROCESS | 1650 | __end_tp_report 17:13:09 INFO - PROCESS | 1650 | __start_cc_report 17:13:09 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,369 17:13:09 INFO - PROCESS | 1650 | __end_cc_report 17:13:09 INFO - PROCESS | 1650 | __startTimestamp1476403989284__endTimestamp 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:13:09 INFO - PROCESS | 1650 | Number of tests: 6 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5576.97 Median:5670.57 stddev:639.90 (11.3%) stddev-sans-first:609.30 17:13:09 INFO - PROCESS | 1650 | Values: 3007.8 3331.8 3358.0 3365.2 3409.9 5140.5 5471.7 5525.2 5527.2 5590.4 4613.3 5474.1 5554.8 5652.2 5718.5 5107.8 5131.3 5183.9 5220.3 5234.0 5035.9 5186.4 5203.5 5213.7 5268.3 5007.6 5052.1 5067.2 5089.5 5160.9 5097.3 5113.3 5122.0 5129.6 5148.7 5068.8 5084.7 5090.9 5107.8 5120.3 5367.8 5370.7 5514.8 5545.4 5581.1 6067.0 6081.1 6090.7 6097.6 6127.5 6120.5 6139.5 6154.9 6162.8 6164.2 5472.1 5511.8 5513.0 5644.4 5649.5 6148.4 6170.3 6190.3 6206.8 6261.7 5947.3 5964.8 6029.0 6033.1 6085.5 5941.8 6132.6 6142.1 6170.0 6185.6 5911.8 6004.4 6011.3 6023.8 6089.1 6016.7 6106.5 6108.0 6117.0 6140.1 4811.4 4839.1 4840.2 4841.2 4865.9 4202.3 4251.4 4267.3 4300.4 4333.2 5538.1 5593.1 5619.3 5645.4 5670.6 6090.5 6095.9 6117.4 6120.6 6128.0 5430.9 5491.5 5568.4 5596.3 5605.2 5300.0 5300.1 5308.8 5341.7 5346.4 6212.8 6227.3 6231.4 6237.9 6239.9 5963.7 5981.1 6017.0 6125.8 6213.9 6205.1 6212.9 6218.4 6222.8 6245.2 4628.3 5516.4 5947.6 6054.2 6088.7 4761.5 5222.5 6039.1 6119.6 6157.0 5769.1 5976.6 5985.7 5999.2 6076.8 5747.8 5843.2 5935.6 5939.8 5989.3 4583.7 5572.6 5639.8 5782.7 5818.3 5946.2 5952.4 5965.7 5966.5 5989.5 5613.4 5664.7 5785.4 5786.1 5819.3 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:62899.37 Median:40193.00 stddev:131225.99 (326.5%) stddev-sans-first:131510.32 17:13:09 INFO - PROCESS | 1650 | Values: 441.7 448.9 473.6 534.1 549.1 36472.8 38396.8 38436.4 40425.0 40538.6 39707.6 40387.6 40420.6 40569.8 40620.8 9186.8 9442.7 9448.9 9454.2 9469.1 9350.5 9385.0 9460.1 9478.3 9492.6 9442.8 9509.7 9511.3 9512.8 9521.9 9428.5 9432.3 9459.7 9493.8 9508.9 8455.5 8847.1 9280.1 9366.2 9400.9 38443.2 38667.6 38738.4 38815.6 38857.6 3103.6 3221.4 3222.7 3658.5 3808.3 29357.6 29599.0 30097.8 30207.7 30839.2 3183.4 3210.5 3219.9 3305.8 3346.6 403978.0 404778.0 405529.0 406294.0 407096.0 56905.0 57306.4 57316.0 57457.4 57534.0 59018.4 59711.7 59940.0 60054.0 60223.4 12914.8 15002.2 15006.2 15006.5 15022.7 11479.7 11523.8 11551.8 11569.1 11571.6 15271.8 16364.0 16388.3 16422.9 16444.7 6047.8 6083.3 6132.8 6171.4 6201.1 834.7 868.5 972.4 984.0 1019.9 27855.9 28727.4 29057.0 29767.6 29775.0 968.7 985.7 1077.8 1122.7 1131.1 11472.8 12333.8 13581.8 14609.7 15187.8 513407.0 552037.0 557578.0 559542.0 564288.0 54918.9 55149.4 55354.7 55453.4 55583.7 1174.2 1176.8 1258.6 1284.6 1337.2 28527.6 28641.6 28852.9 29272.0 29278.4 48020.0 48146.5 48549.3 48625.8 48630.5 505197.0 510657.0 512787.0 514037.0 517749.0 25537.9 25573.4 25703.2 25860.0 25964.1 40173.4 43445.8 44467.8 45182.8 45709.0 36041.3 37177.6 37942.6 38497.2 40212.6 33886.0 36931.0 38086.7 39691.8 40568.7 37806.4 38623.8 39673.8 39695.2 39810.0 31754.0 36400.4 38695.4 39021.8 40256.0 29160.6 29309.1 29820.5 30323.0 31048.0 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:32147.45 Median:3772.67 stddev:85254.31 (2259.8%) stddev-sans-first:85459.97 17:13:09 INFO - PROCESS | 1650 | Values: 315.4 334.0 372.2 379.5 393.2 19001.3 19542.9 19668.3 20255.3 20399.4 16563.2 17271.1 18958.9 19442.4 19494.1 5617.9 5904.2 5971.5 5976.1 5989.6 5680.0 5888.9 5937.6 5950.3 5968.9 5651.7 5875.2 5876.6 5888.3 5897.9 5812.3 5915.6 5976.2 6013.0 6069.0 5674.5 5690.5 5804.5 5879.1 5880.4 12422.6 12573.2 12598.2 12769.0 12893.1 2116.8 2318.8 2439.3 2614.0 2778.3 13807.0 14207.6 15487.4 15791.2 16158.8 1695.4 1866.5 1973.9 2015.9 2058.9 108264.0 108388.0 121198.0 121682.0 128459.4 18401.0 18668.4 20347.8 20784.7 20845.0 33432.2 33512.5 33529.8 33530.7 33656.7 9238.7 9350.5 9493.0 9608.7 9640.5 7594.1 7609.4 7621.8 7713.3 7767.0 7790.5 9213.8 9243.3 9392.7 9394.2 3021.1 3293.0 3770.6 3774.8 3780.4 833.5 898.0 900.2 999.6 1026.6 18540.0 20202.6 20253.8 20520.6 20595.0 885.4 894.3 912.9 920.9 970.7 9217.5 9392.4 10921.6 10928.0 10983.8 509394.0 509748.0 510068.0 510165.0 510286.0 87761.6 97674.0 109261.0 120030.0 120778.4 848.8 849.9 852.8 941.4 950.1 15144.5 17978.1 18276.1 18726.0 19079.1 50270.7 52167.3 52367.5 52497.7 52533.9 55842.4 56424.0 73378.6 73426.3 74949.6 7743.7 7754.1 7860.6 7942.6 8147.6 7568.7 9854.8 12147.5 12180.5 12632.0 10520.6 10834.2 10849.6 10961.3 11175.8 10332.5 10486.8 10528.2 10926.8 10976.3 10887.6 10900.2 11203.7 11225.9 11347.8 6921.3 7766.3 7976.0 8022.6 8252.4 10411.6 10797.1 11001.8 11012.0 11143.9 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5525.55 Median:4909.78 stddev:3103.34 (63.2%) stddev-sans-first:3096.13 17:13:09 INFO - PROCESS | 1650 | Values: 1343.6 1499.3 1636.9 1791.8 1799.6 7737.5 8005.9 8194.7 8766.4 8801.3 8139.6 8429.0 8454.5 8557.1 8596.4 1924.5 1950.2 2332.0 2335.7 2355.2 2284.5 2321.4 2332.6 2336.6 2340.6 2320.8 2325.2 2334.0 2334.2 2337.8 1921.6 2297.5 2303.5 2305.5 2313.1 2298.3 2298.5 2301.8 2303.3 2309.2 8642.9 8710.9 8711.7 8714.1 8721.9 4991.4 5062.1 5117.3 5163.8 5174.3 3426.2 3486.5 3614.2 3624.5 3635.9 1065.1 1073.7 1074.8 1089.1 1092.2 11297.7 11316.0 11329.9 11376.4 11396.6 3687.4 4491.8 4680.6 4685.0 4701.1 9721.7 9727.1 9779.9 9799.2 9802.8 4500.2 5042.5 5134.5 5160.2 5161.7 4211.2 4219.5 4628.5 4707.3 4735.9 3800.3 3807.1 3895.9 3913.0 3936.0 1266.2 1270.7 1272.3 1277.8 1282.5 700.3 835.4 886.1 899.2 940.7 5527.0 5583.5 5670.2 5863.2 5940.3 821.5 890.6 968.4 971.2 1019.4 3685.2 3792.3 3826.3 3903.3 3938.4 9377.9 10352.7 10622.8 10647.7 10661.0 9891.8 10383.7 10521.4 10611.0 10617.3 7447.4 7867.3 8063.8 8077.6 8085.2 5101.3 5192.6 5282.4 5844.1 6026.5 8774.3 9696.2 9730.8 9786.0 9886.2 9672.6 9830.0 9861.0 10013.5 10071.2 6591.0 6813.9 6916.4 7090.8 7204.0 7953.9 8155.6 8182.8 8189.7 8219.9 6947.6 7108.4 7136.9 7181.7 7200.0 6984.2 7009.4 7027.2 7031.1 7089.6 6578.8 6756.4 6758.2 6809.2 6918.1 4736.5 4783.3 4802.8 4808.3 4848.1 4814.4 4839.9 4850.7 4901.2 4918.3 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4503.53 Median:5055.70 stddev:1431.87 (28.3%) stddev-sans-first:1400.60 17:13:09 INFO - PROCESS | 1650 | Values: 294.3 299.7 308.1 308.6 310.4 4713.4 4721.3 4747.1 5246.2 5408.3 4633.8 5322.4 5393.0 5396.4 5404.4 3997.3 4081.1 4090.2 4133.1 4135.3 3321.6 3353.9 3889.7 4135.6 4160.8 4043.3 4091.7 4100.4 4111.0 4120.8 3685.5 3779.9 3802.1 3968.4 4110.7 3423.5 3599.2 3608.2 3618.0 3624.9 4330.7 4745.8 5036.7 5252.3 5308.4 3511.2 4063.6 4092.8 4278.8 4419.2 5300.7 5559.6 5666.9 5668.9 5707.2 3564.8 3815.0 3866.9 3934.2 3936.2 5193.6 5906.5 5910.4 5925.4 5937.7 3865.9 3903.4 3909.0 3909.5 3938.3 3842.2 3896.1 3950.5 3963.2 3989.0 3430.6 3512.6 3897.8 4383.2 4550.3 4922.5 5013.4 5263.4 5322.1 5742.5 1234.5 1272.4 1313.8 1338.6 1340.1 780.8 867.2 896.7 902.9 911.2 5312.2 5314.0 5326.7 5332.8 5358.3 5290.9 5796.7 5802.4 5810.7 5817.7 4337.8 4987.4 5141.3 5259.6 5317.9 2326.2 2377.2 2392.6 2472.7 2593.9 4509.4 4748.5 5122.8 5155.6 5198.8 4837.8 4984.0 5032.4 5083.5 5435.8 6159.6 6259.2 6286.5 6316.0 6321.5 4947.7 5268.5 5489.5 5962.5 6029.2 5068.5 5494.6 5801.4 5853.2 5864.6 5157.4 5364.0 6136.2 6160.4 6246.2 3405.2 3419.7 3750.5 4079.2 4124.4 5503.3 5836.9 5848.8 5868.5 5886.3 5042.9 5471.0 5564.9 5650.5 5710.2 4253.6 5735.5 5745.8 5747.4 5776.5 4569.7 5365.3 5501.1 5610.7 5641.7 5730.0 5769.8 5782.7 5795.3 5811.6 4837.1 5593.0 5658.9 5683.8 5709.0 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:23807.26 Median:3591.50 stddev:37880.70 (1054.7%) stddev-sans-first:37946.98 17:13:09 INFO - PROCESS | 1650 | Values: 628.7 690.5 751.5 755.5 779.6 13785.0 14632.0 14635.3 14656.6 14659.9 12623.6 12733.8 12735.6 12748.7 12761.8 646.1 675.4 805.7 810.8 829.5 817.5 829.7 831.3 833.6 834.1 834.5 881.4 883.6 887.3 887.6 848.4 866.3 868.7 868.9 869.4 634.2 643.1 651.3 652.2 653.1 11484.7 11771.8 12964.0 13293.4 13358.9 12750.4 13377.8 14217.9 14259.7 14396.5 11229.3 11433.0 11520.4 11529.0 11717.9 3635.9 3661.2 3664.5 3681.8 3698.0 108777.0 110481.0 110956.0 111317.0 112828.0 11050.8 11055.0 11072.5 11081.7 11154.1 21963.7 21965.8 21972.2 21974.8 22006.8 7542.2 7659.7 7813.9 7897.6 7988.2 4139.8 4228.0 4240.4 4241.3 4302.7 3426.3 3495.7 3516.8 3544.4 3547.1 611.8 620.3 626.8 627.7 634.0 499.6 557.3 568.8 645.9 657.1 8395.6 9046.4 9130.9 9191.6 9298.3 568.2 647.9 648.5 652.2 652.4 4138.5 4367.2 4375.1 4417.2 4450.3 72147.0 114195.0 125016.4 134718.0 141302.0 128885.4 131817.0 132951.7 133472.0 136875.3 104235.5 108616.5 109767.5 110702.4 113461.0 7723.5 8477.2 8492.9 8589.4 8652.2 62531.0 62797.0 63056.0 63739.4 64076.0 83566.7 93921.1 94507.5 94990.0 98314.0 10076.8 10188.4 10728.6 10781.0 11192.9 14029.0 14365.5 14626.3 14887.6 15225.9 10838.7 11717.6 13295.6 13657.7 14055.3 11051.7 12862.9 13648.9 13715.8 14293.6 13297.4 13395.3 13515.0 13569.1 13575.3 10633.4 10677.4 10843.2 10982.9 11098.6 8300.9 8476.4 9339.2 10081.8 10347.2 17:13:09 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:13:09 INFO - PROCESS | 1650 | 17:13:09 INFO - TEST-INFO | 1650: exit 0 17:13:09 INFO - TEST-OK | dromaeo_css | took 1115190ms 17:13:09 INFO - TEST-START | kraken 17:13:09 INFO - operating with platform_type : mac_ 17:13:09 INFO - Initialising browser for kraken test... 17:13:09 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpqIZ_Bl/profile http://localhost:49266/getInfo.html) 17:13:12 INFO - PROCESS | 1661 | 2016-10-13 17:13:12.529 plugin-container[1662:9799] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 17:13:12 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:12 INFO - PROCESS | 1661 | 2016-10-13 17:13:12.531 plugin-container[1662:9799] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 17:13:12 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:12 INFO - PROCESS | 1661 | 2016-10-13 17:13:12.531 plugin-container[1662:9799] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:13:12 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 17:13:12 INFO - PROCESS | 1661 | colorDepth:24 17:13:12 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 17:13:12 INFO - PROCESS | 1661 | __metrics 17:13:12 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 17:13:13 INFO - TEST-INFO | 1661: exit 0 17:13:13 INFO - Browser initialized. 17:13:13 INFO - Running cycle 1/1 for kraken test... 17:13:13 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpqIZ_Bl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:15 INFO - PROCESS | 1663 | 2016-10-13 17:13:15.646 plugin-container[1664:9914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 17:13:15 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:15 INFO - PROCESS | 1663 | 2016-10-13 17:13:15.647 plugin-container[1664:9914] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 17:13:15 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:13:15 INFO - PROCESS | 1663 | 2016-10-13 17:13:15.647 plugin-container[1664:9914] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:13:25 INFO - PROCESS | 1663 | RSS: Main: 239423488 17:13:25 INFO - PROCESS | 1663 | 17:13:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:29 INFO - PROCESS | 1663 | RSS: Main: 252731392 17:13:29 INFO - PROCESS | 1663 | 17:13:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 17:13:32 INFO - PROCESS | 1663 | RSS: Main: 260157440 17:13:32 INFO - PROCESS | 1663 | 17:13:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 17:13:37 INFO - PROCESS | 1663 | RSS: Main: 261046272 17:13:37 INFO - PROCESS | 1663 | 17:13:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 17:13:39 INFO - PROCESS | 1663 | RSS: Main: 263307264 17:13:39 INFO - PROCESS | 1663 | 17:13:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:42 INFO - PROCESS | 1663 | RSS: Main: 263901184 17:13:42 INFO - PROCESS | 1663 | 17:13:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:46 INFO - PROCESS | 1663 | RSS: Main: 264368128 17:13:46 INFO - PROCESS | 1663 | 17:13:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:50 INFO - PROCESS | 1663 | RSS: Main: 264671232 17:13:50 INFO - PROCESS | 1663 | 17:13:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 17:13:53 INFO - PROCESS | 1663 | RSS: Main: 264630272 17:13:53 INFO - PROCESS | 1663 | 17:13:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:55 INFO - PROCESS | 1663 | RSS: Main: 264785920 17:13:55 INFO - PROCESS | 1663 | 17:13:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:58 INFO - PROCESS | 1663 | RSS: Main: 264851456 17:13:58 INFO - PROCESS | 1663 | 17:14:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:01 INFO - PROCESS | 1663 | RSS: Main: 264781824 17:14:01 INFO - PROCESS | 1663 | 17:14:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:05 INFO - PROCESS | 1663 | RSS: Main: 265224192 17:14:05 INFO - PROCESS | 1663 | 17:14:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:08 INFO - PROCESS | 1663 | RSS: Main: 262569984 17:14:08 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 17:14:10 INFO - PROCESS | 1663 | RSS: Main: 265367552 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | __start_tp_report 17:14:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 17:14:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 17:14:10 INFO - PROCESS | 1663 | |i|pagename|runs| 17:14:10 INFO - PROCESS | 1663 | |0;ai-astar;135;173;117;118;118;121;115;117;120;149 17:14:10 INFO - PROCESS | 1663 | |1;audio-beat-detection;148;100;127;179;131;132;122;144;178;113 17:14:10 INFO - PROCESS | 1663 | |2;audio-dft;234;228;201;264;281;181;180;257;192;193 17:14:10 INFO - PROCESS | 1663 | |3;audio-fft;94;86;86;109;88;53;65;82;107;82 17:14:10 INFO - PROCESS | 1663 | |4;audio-oscillator;85;71;90;71;72;85;124;98;105;97 17:14:10 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;91;85;136;134;89;87;91;120;96;133 17:14:10 INFO - PROCESS | 1663 | |6;imaging-darkroom;95;96;99;97;135;103;157;134;152;144 17:14:10 INFO - PROCESS | 1663 | |7;imaging-desaturate;90;112;92;93;92;89;92;95;90;116 17:14:10 INFO - PROCESS | 1663 | |8;json-parse-financial;57;58;57;59;67;78;86;50;48;80 17:14:10 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;71;73;69;78;76;70;71;69;72;74 17:14:10 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;88;93;91;89;91;88;108;83;100;114 17:14:10 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;148;148;147;170;174;165;165;152;182;161 17:14:10 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;180;159;219;241;189;200;242;227;242;190 17:14:10 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;72;69;69;70;69;69;71;70;69;70 17:14:10 INFO - PROCESS | 1663 | __end_tp_report 17:14:10 INFO - PROCESS | 1663 | __start_cc_report 17:14:10 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,952 17:14:10 INFO - PROCESS | 1663 | __end_cc_report 17:14:10 INFO - PROCESS | 1663 | __startTimestamp1476404050970__endTimestamp 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | ------- Summary: start ------- 17:14:10 INFO - PROCESS | 1663 | Number of tests: 14 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:128.30 Median:120.50 stddev:18.97 (15.7%) stddev-sans-first:19.96 17:14:10 INFO - PROCESS | 1663 | Values: 135.0 173.0 117.0 118.0 118.0 121.0 115.0 117.0 120.0 149.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:138.00 stddev:25.70 (18.6%) stddev-sans-first:26.97 17:14:10 INFO - PROCESS | 1663 | Values: 148.0 100.0 127.0 179.0 131.0 132.0 122.0 144.0 178.0 113.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:221.10 Median:231.00 stddev:36.92 (16.0%) stddev-sans-first:38.87 17:14:10 INFO - PROCESS | 1663 | Values: 234.0 228.0 201.0 264.0 281.0 181.0 180.0 257.0 192.0 193.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:85.20 Median:84.00 stddev:16.98 (20.2%) stddev-sans-first:17.70 17:14:10 INFO - PROCESS | 1663 | Values: 94.0 86.0 86.0 109.0 88.0 53.0 65.0 82.0 107.0 82.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:85.00 stddev:16.96 (20.0%) stddev-sans-first:17.90 17:14:10 INFO - PROCESS | 1663 | Values: 85.0 71.0 90.0 71.0 72.0 85.0 124.0 98.0 105.0 97.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:88.00 stddev:21.73 (24.7%) stddev-sans-first:22.34 17:14:10 INFO - PROCESS | 1663 | Values: 91.0 85.0 136.0 134.0 89.0 87.0 91.0 120.0 96.0 133.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:121.20 Median:126.00 stddev:25.46 (20.2%) stddev-sans-first:25.18 17:14:10 INFO - PROCESS | 1663 | Values: 95.0 96.0 99.0 97.0 135.0 103.0 157.0 134.0 152.0 144.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:92.00 stddev:9.63 (10.5%) stddev-sans-first:9.96 17:14:10 INFO - PROCESS | 1663 | Values: 90.0 112.0 92.0 93.0 92.0 89.0 92.0 95.0 90.0 116.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.00 stddev:13.15 (20.9%) stddev-sans-first:13.70 17:14:10 INFO - PROCESS | 1663 | Values: 57.0 58.0 57.0 59.0 67.0 78.0 86.0 50.0 48.0 80.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:2.98 (4.1%) stddev-sans-first:3.13 17:14:10 INFO - PROCESS | 1663 | Values: 71.0 73.0 69.0 78.0 76.0 70.0 71.0 69.0 72.0 74.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:88.50 stddev:9.81 (11.1%) stddev-sans-first:10.12 17:14:10 INFO - PROCESS | 1663 | Values: 88.0 93.0 91.0 89.0 91.0 88.0 108.0 83.0 100.0 114.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:161.20 Median:165.00 stddev:12.19 (7.4%) stddev-sans-first:11.96 17:14:10 INFO - PROCESS | 1663 | Values: 148.0 148.0 147.0 170.0 174.0 165.0 165.0 152.0 182.0 161.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.90 Median:223.00 stddev:29.46 (13.2%) stddev-sans-first:29.33 17:14:10 INFO - PROCESS | 1663 | Values: 180.0 159.0 219.0 241.0 189.0 200.0 242.0 227.0 242.0 190.0 17:14:10 INFO - PROCESS | 1663 | 17:14:10 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 17:14:10 INFO - PROCESS | 1663 | Values: 72.0 69.0 69.0 70.0 69.0 69.0 71.0 70.0 69.0 70.0 17:14:10 INFO - PROCESS | 1663 | -------- Summary: end -------- 17:14:10 INFO - PROCESS | 1663 | 17:14:11 INFO - TEST-INFO | 1663: exit 0 17:14:11 INFO - TEST-OK | kraken | took 61905ms 17:14:11 INFO - SUITE-END | took 1177s 17:14:12 INFO - Completed test suite (00:19:37) 17:14:12 INFO - javascript benchmark 17:14:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.878327184378, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.774416918731, 3331.766776325658, 3358.04295775704, 3365.242820365418, 3409.931801363972, 5140.485951404858, 5471.699056551888, 5525.171224316355, 5527.170924361348, 5590.440955904418, 4613.331066995283, 5474.124140137579, 5554.777808887649, 5652.152177173426, 5718.456746609076, 5107.770150343244, 5131.255967884655, 5183.922241166386, 5220.269162317279, 5234.0, 5035.924461133086, 5186.351706036746, 5203.4796520348045, 5213.7393130343335, 5268.341457317835, 5007.649464537484, 5052.0906236877345, 5067.163917953533, 5089.46560611136, 5160.92258616121, 5097.286379906816, 5113.335266415379, 5122.0, 5129.615278854064, 5148.6910785353, 5068.797248110108, 5084.694918304914, 5090.898182036375, 5107.770150343244, 5120.257562653432, 5367.838964831061, 5370.7046112463795, 5514.779408823642, 5545.390007099216, 5581.079121944874, 6067.029275315928, 6081.057436097368, 6090.66501342426, 6097.634141951497, 6127.509799216052, 6120.5103591713005, 6139.478144357735, 6154.8769024619705, 6162.84592885177, 6164.198654174974, 5472.124460086367, 5511.779528818883, 5512.972435137879, 5644.379118296984, 5649.519790817785, 6148.354422785633, 6170.259568851767, 6190.257169139642, 6206.813795586139, 6261.7182226799905, 5947.316058653224, 5964.761409543657, 6028.980291602363, 6033.125196846433, 6085.482733967574, 5941.762329506858, 6132.570720049643, 6142.14010038586, 6169.96915015422, 6185.567010309325, 5911.76352945886, 6004.429579190058, 6011.308699499614, 6023.849403764853, 6089.086637004485, 6016.669083200379, 6106.4809491192855, 6108.0, 6117.0, 6140.109684095781, 4811.374521312207, 4839.104765618372, 4840.15297322967, 4841.15279826029, 4865.854024379274, 4202.348635961431, 4251.3622956556765, 4267.274563324242, 4300.376445415397, 4333.241682705514, 5538.086215774432, 5593.07714227148, 5619.297587801525, 5645.350784659735, 5670.574706896917, 6090.512758979271, 6095.939040609625, 6117.388261173847, 6120.60216085953, 6128.0, 5430.8913821723345, 5491.533219676372, 5568.44315568448, 5596.300462442195, 5605.159226116115, 5300.0, 5300.09898317287, 5308.840734777963, 5341.652792568549, 5346.385165705916, 6212.751489940351, 6227.346128656516, 6231.40801623845, 6237.906431403442, 6239.906401403891, 5963.73163207648, 5981.132735753378, 6016.969915150396, 6125.816225513242, 6213.9067913980425, 6205.100260462117, 6212.937870621236, 6218.4092511213175, 6222.844428889314, 6245.18812554365, 4628.305754136906, 5516.365617953827, 5947.613405128653, 6054.212952316171, 6088.665123418255, 4761.452432970114, 5222.477752224747, 6039.063945088343, 6119.632822030692, 6156.984097624021, 5769.07694768835, 5976.581639285208, 5985.670788106696, 5999.220101386792, 6076.756929722762, 5747.798827041033, 5843.152742852178, 5935.643861368331, 5939.821805345674, 5989.341172471112, 4583.702059366131, 5572.554195664418, 5639.830805075854, 5782.710864456676, 5818.301803783573, 5946.226990491208, 5952.404759524013, 5965.70171491415, 5966.49284810796, 5989.490893273946, 5613.382527921844, 5664.716764161858, 5785.3636100028125, 5786.07422812348, 5819.272590926134], "value": 5537.455630231837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.6930233487727, 448.86534039788063, 473.5666864818691, 534.110705675051, 549.0967358694946, 36472.817635911815, 38396.80801595992, 38436.42345364818, 40425.0, 40538.59461405385, 39707.60292397075, 40387.59612403875, 40420.59579404205, 40569.797151014274, 40620.796896015476, 9186.770330741734, 9442.716718498456, 9448.858267126, 9454.243660507178, 9469.147776700096, 9350.485723285217, 9384.953075234615, 9460.101290377437, 9478.289128315404, 9492.572834222443, 9442.763930901714, 9509.714708558755, 9511.286653501014, 9512.809743805154, 9521.857172142389, 9428.528573571328, 9432.339736218468, 9459.668911588062, 9493.762655933588, 9508.85736713943, 8455.450395724258, 8847.071057538995, 9280.118388753057, 9366.157045865904, 9400.858987115198, 38443.23113537714, 38667.61332386668, 38738.41892371617, 38815.61184388148, 38857.61142388568, 3103.6120484939383, 3221.4362486564755, 3222.726068284175, 3658.5243918290716, 3808.257389808988, 29357.559636605467, 29599.0, 30097.849510752527, 30207.69792302093, 30839.229019274473, 3183.3792410479964, 3210.486322188462, 3219.935601287961, 3305.7851239669344, 3346.5984081910083, 403977.9801101005, 404778.0, 405529.0, 406293.99999999703, 407096.0, 56905.0, 57306.426935730946, 57316.0, 57457.42542574604, 57534.0, 59018.40981590215, 59711.70144149338, 59940.0, 60054.0, 60223.39776602265, 12914.806277905838, 15002.24988750558, 15006.174660393783, 15006.549803505912, 15022.699546009237, 11479.655610331703, 11523.8271425927, 11551.826722599168, 11569.132315076404, 11571.594994175164, 15271.847281527043, 16364.018158910503, 16388.344466221457, 16422.917885410734, 16444.6711065778, 6047.848803779941, 6083.300420451705, 6132.816015519452, 6171.352008039181, 6201.10084037812, 834.6661335465741, 868.5396739727954, 972.3776782858976, 983.9754006149903, 1019.8878123406568, 27855.860720696266, 28727.425451490853, 29057.0, 29767.553486697718, 29775.0, 968.7432830299977, 985.7437066362797, 1077.7898309829666, 1122.6800361896983, 1131.12337938097, 11472.827907581393, 12333.814992775115, 13581.777640012446, 14609.707805844037, 15187.848121518644, 513407.0, 552037.0, 557578.0, 559542.0, 564288.0, 54918.901621968136, 55149.44850551523, 55354.72322638441, 55453.445465545636, 55583.722081390144, 1174.1898090317654, 1176.805827038529, 1258.5657948008106, 1284.5825106840314, 1337.237774468563, 28527.572086418306, 28641.570376443953, 28852.855735722027, 29272.0, 29278.414431711673, 48020.03959920852, 48146.51853481561, 48549.27176092432, 48625.75687121542, 48630.513694864014, 505197.0, 510657.0, 512787.0, 514037.0, 517749.0, 25537.87231063833, 25573.3606659835, 25703.228903132935, 25859.965601375734, 25964.09125680592, 40173.39739903962, 43445.78277108594, 44467.77766111149, 45182.77408612936, 45709.0, 36041.27917441584, 37177.62822371742, 37942.620573795015, 38497.2300553993, 40212.59787402089, 33886.0, 36931.0, 38086.666966656034, 39691.80154099211, 40568.74028226994, 37806.43290350702, 38623.806880965414, 39673.801630991664, 39695.2060958785, 39810.0, 31754.0, 36400.36198371027, 38695.419568705925, 39021.80489097536, 40256.0, 29160.562591561567, 29309.12072637824, 29820.50897455162, 30323.0, 31048.0], "value": 19066.268058761823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.3810029906819, 333.9866405343786, 372.1533511261879, 379.50095624254084, 393.19787633228214, 19001.334953276637, 19542.90228548857, 19668.311609093686, 20255.291064812736, 20399.388018359437, 16563.17184140791, 17271.136443177853, 18958.905205473988, 19442.4167274982, 19494.122764475596, 5617.887642247153, 5904.1734157218025, 5971.492423144038, 5976.133460648203, 5989.580729348947, 5680.0, 5888.882222355551, 5937.6140550864275, 5950.256217972754, 5968.940310596882, 5651.689157096358, 5875.236219291486, 5876.588638795286, 5888.293404791431, 5897.911531327033, 5812.3025236971835, 5915.645061296314, 5976.2230909981645, 6012.969935150318, 6068.96965515174, 5674.546036317126, 5690.5447564194765, 5804.506616937565, 5879.118132280149, 5880.441358071019, 12422.627321180378, 12573.245605263714, 12598.181118227378, 12769.0, 12893.097483176181, 2116.8200702940267, 2318.7681231876845, 2439.316991242455, 2613.9869300653563, 2778.263760103574, 13807.033507654469, 14207.573772786833, 15487.380504779909, 15791.210439478094, 16158.83841161585, 1695.4489790818034, 1866.496046067554, 1973.9013049347475, 2015.9193632254692, 2058.8661736987046, 108264.0, 108388.0, 121198.0, 121682.0, 128459.35770321182, 18401.0, 18668.439946801616, 20347.796522034885, 20784.688229676565, 20844.957752112332, 33432.16419589481, 33512.497312540334, 33529.83235083858, 33530.66469335324, 33656.663433365844, 9238.676646317346, 9350.532473376305, 9493.0, 9608.66369677058, 9640.529409412606, 7594.050743657043, 7609.391248700091, 7621.809454763565, 7713.3443657288635, 7766.961165194138, 7790.454668173287, 9213.76965575866, 9243.306751993492, 9392.671256506126, 9394.248460123174, 3021.078571035855, 3292.967070329314, 3770.5852356240794, 3774.75464094833, 3780.432935059763, 833.4790755777639, 898.0109058435596, 900.1808354397598, 999.6301368493558, 1026.6047571684956, 18540.0, 20202.59594808125, 20253.797462025486, 20520.638943475962, 20595.0, 885.4112015509614, 894.3069121430813, 912.9041450647719, 920.8987011428737, 970.7039352997263, 9217.493037882847, 9392.436453812656, 10921.563137474572, 10928.0, 10983.780324393467, 509394.0, 509748.0, 510068.0, 510165.0, 510286.0, 87761.56119219364, 97674.02325976791, 109261.0, 120030.0, 120778.3961080189, 848.7878030492377, 849.9490030598184, 852.754977732505, 941.4116177388995, 950.1068995144681, 15144.54566363011, 17978.101094944937, 18276.08619569043, 18726.0, 19079.141438635572, 50270.748646256536, 52167.34828561964, 52367.47632523626, 52497.737511312196, 52533.94932101413, 55842.44157558535, 56424.0, 73378.63310683412, 73426.29023952622, 74949.6252518734, 7743.651535680795, 7754.147043825062, 7860.621918583706, 7942.563159026309, 8147.63335649909, 7568.697252109854, 9854.753631159278, 12147.45336459879, 12180.45187966526, 12631.989440844527, 10520.632317798638, 10834.187435942178, 10849.566017359217, 10961.287516311415, 11175.764847030463, 10332.483375831329, 10486.842697359698, 10528.157747380037, 10926.78146437051, 10976.286541374786, 10887.564497420331, 10900.236983411402, 11203.663890083311, 11225.887741122811, 11347.773044539228, 6921.342472465108, 7766.301032907066, 7975.960120199362, 8022.558759268296, 8252.381071419788, 10411.635592754217, 10797.136229101496, 11001.779964400826, 11012.0, 11143.888561114609], "value": 9913.773115511614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.6305016120566, 1499.310317254063, 1636.8608668263198, 1791.8118597547266, 1799.622079363333, 7737.535747855132, 8005.919940800591, 8194.672213111477, 8766.386352955287, 8801.295896328294, 8139.593020348989, 8429.0, 8454.492730436179, 8557.058723540405, 8596.398252122353, 1924.4900101473086, 1950.2199120351831, 2332.0322066342446, 2335.6846825678485, 2355.1756885090253, 2284.520250747337, 2321.3964369263945, 2332.6151185054446, 2336.5677349690277, 2340.566995105911, 2320.8027317678016, 2325.2442956039354, 2333.9533209335805, 2334.2413715542516, 2337.824663150262, 1921.6156768646188, 2297.4830663100834, 2303.516261585069, 2305.4927915858484, 2313.13257528426, 2298.276043046435, 2298.5058212484396, 2301.79283864453, 2303.2744685424036, 2309.168699268262, 8642.913570864273, 8710.869336959951, 8711.69509067186, 8714.08502107276, 8721.912780872237, 4991.376077990251, 5062.063518249136, 5117.283580298761, 5163.8192663256605, 5174.301469301634, 3426.1777173478436, 3486.477028445728, 3614.150674591469, 3624.4563315502623, 3635.8545658173643, 1065.147881694649, 1073.7369344510566, 1074.7635520185547, 1089.0851684584907, 1092.2190633696946, 11297.717557061056, 11315.981561659408, 11329.886701133048, 11376.431178441127, 11396.60111896088, 3687.4284485904727, 4491.8427855025575, 4680.625549955996, 4684.976575117171, 4701.106789709944, 9721.708348749407, 9727.124558789743, 9779.902200978042, 9799.16707079892, 9802.75493112678, 4500.167469018242, 5042.470540593258, 5134.512221338967, 5160.174372100446, 5161.690298582097, 4211.241976444269, 4219.493660760729, 4628.514006029386, 4707.29390591414, 4735.905281894412, 3800.2969450651717, 3807.1053302473897, 3895.9220815584094, 3913.021744563859, 3936.035671260502, 1266.1896386312767, 1270.6950331920273, 1272.3129510064646, 1277.8274932884128, 1282.5062350994933, 700.2752151523251, 835.436080645574, 886.1094599927161, 899.2446345070173, 940.6848705683536, 5527.0, 5583.469570390806, 5670.177824215466, 5863.237779088691, 5940.34656187819, 821.4793564913228, 890.6214858685033, 968.3608818179968, 971.2230215827451, 1019.4393083804026, 3685.244524872395, 3792.3173828710546, 3826.330392181357, 3903.33643280643, 3938.369860822255, 9377.874655041438, 10352.741181470523, 10622.787544249071, 10647.680569582924, 10660.987206215397, 9891.802163956681, 10383.740406489898, 10521.42132182722, 10611.0, 10617.256792024638, 7447.404207663374, 7867.331276841533, 8063.798405039804, 8077.555734434663, 8085.191480851985, 5101.260317253903, 5192.584593232608, 5282.445343239058, 5844.12338149281, 6026.487748541423, 8774.331508053798, 9696.175825054666, 9730.75673108178, 9785.951070244602, 9886.159676427584, 9672.56473458682, 9830.0, 9861.0, 10013.549390277602, 10071.244656650928, 6590.9670451647435, 6813.931860681329, 6916.377526022682, 7090.822729431806, 7203.991441198341, 7953.880691789744, 8155.592220389076, 8182.83634327322, 8189.7133600323705, 8219.917800822155, 6947.5831450113155, 7108.3602475777425, 7136.892946605909, 7181.712731490682, 7199.964000180175, 6984.231734509099, 7009.439244860297, 7027.15674119109, 7031.050808140835, 7089.61007144612, 6578.8355291118105, 6756.391924726601, 6758.222804377559, 6809.182898052265, 6918.135233095863, 4736.502667219892, 4783.258594917794, 4802.807887684454, 4808.2547205183255, 4848.10310092634, 4814.446338671098, 4839.879003024812, 4850.684705494132, 4901.240307752304, 4918.311436398835], "value": 4449.868372534991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.28048421609174, 299.7197620225089, 308.05580894558176, 308.5911167702794, 310.3529141739473, 4713.387259656244, 4721.308853953248, 4747.145513807518, 5246.213068039796, 5408.2698835657175, 4633.768311584424, 5322.361316641999, 5392.973035134829, 5396.406395296514, 5404.405515393313, 3997.320455522568, 4081.1225586498895, 4090.1819636072755, 4133.090720041601, 4135.27632664284, 3321.618013928393, 3353.864137031871, 3889.669378102865, 4135.58644135587, 4160.791960401983, 4043.3126368517273, 4091.749537754238, 4100.38494225867, 4110.97944510277, 4120.773357465338, 3685.539307586565, 3779.9055023624355, 3802.0914000789417, 3968.4245784361397, 4110.671146308288, 3423.4693622488303, 3599.2441587266703, 3608.1778701755447, 3618.023133753898, 3624.9275014499563, 4330.653547716175, 4745.762711864393, 5036.726128016781, 5252.264682944391, 5308.389535203424, 3511.2436737161206, 4063.6342729154517, 4092.7517107282265, 4278.807453664593, 4419.182451246497, 5300.708461034642, 5559.610097475631, 5666.914996275059, 5668.858278543028, 5707.174948400527, 3564.8395822188063, 3814.9809250953845, 3866.9226615467533, 3934.154156856261, 3936.212757448493, 5193.584513238894, 5906.49794767441, 5910.408959104098, 5925.377835327272, 5937.67342796146, 3865.9226815463535, 3903.375459926455, 3909.0, 3909.5308562972054, 3938.2714197873483, 3842.212346468967, 3896.064944413377, 3950.486436763202, 3963.2271707016853, 3988.960110398917, 3430.644895266356, 3512.627877237829, 3897.81722235549, 4383.167198232326, 4550.270897059163, 4922.458529561745, 5013.448520662724, 5263.447338029452, 5322.0952438085615, 5742.454466825729, 1234.5370486067725, 1272.3638180909545, 1313.7897936330141, 1338.6184937292826, 1340.095435580979, 780.8209603498758, 867.2454964181203, 896.7223252937596, 902.9277657787493, 911.2072496927715, 5312.2297266896085, 5313.973430132824, 5326.680399176062, 5332.813351532678, 5358.33020872391, 5290.92063619046, 5796.681182534917, 5802.361740208574, 5810.709464526757, 5817.70911454434, 4337.7614231217585, 4987.426445958688, 5141.331626888481, 5259.552938000236, 5317.9202311965355, 2326.162581470669, 2377.181456186019, 2392.6052201386924, 2472.7156377016513, 2593.871665825372, 4509.391232183613, 4748.4539277982785, 5122.846314610568, 5155.61332900034, 5198.84403467889, 4837.822979659168, 4983.950160498421, 5032.421271553818, 5083.517065878736, 5435.809746658848, 6159.599626024384, 6259.248890133122, 6286.497080233662, 6315.96842015787, 6321.494280457552, 4947.678400903929, 5268.473152684701, 5489.478499542537, 5962.452340857183, 6029.186059881859, 5068.467810879804, 5494.642848214853, 5801.3908539602735, 5853.180554722428, 5864.621813873821, 5157.381114266312, 5363.980843639696, 6136.23297087864, 6160.426952367706, 6246.187995560548, 3405.216800135933, 3419.7093247074276, 3750.5499340079364, 4079.224947260011, 4124.4019617154745, 5503.267190216491, 5836.920169768607, 5848.766049357978, 5868.501177399798, 5886.264216972879, 5042.9243561345875, 5471.015217260772, 5564.850839821938, 5650.519705824887, 5710.229119068873, 4253.553376895381, 5735.541156707537, 5745.798897038583, 5747.4078700812, 5776.508996735324, 4569.657275704269, 5365.3293338332705, 5501.0648189807025, 5610.747516361856, 5641.746121424464, 5730.023142015998, 5769.798057067983, 5782.710864456844, 5795.333536643171, 5811.634265947414, 4837.129316723023, 5592.993261213021, 5658.915116273177, 5683.829485115453, 5708.971455142698], "value": 4047.0709011251424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.7139351595022, 690.4959379652851, 751.4964973467776, 755.5164694595458, 779.5907148746907, 13785.0, 14632.0, 14635.341409636565, 14656.560303190909, 14659.92670036651, 12623.62129136125, 12733.808992865092, 12735.554255601055, 12748.745025099492, 12761.80857287139, 646.0535315762407, 675.4258879952026, 805.6656487557657, 810.7891948093494, 829.5437509369823, 817.5176645778989, 829.7261903571837, 831.2934006094831, 833.5998720614109, 834.090840983328, 834.490960514089, 881.3698205782864, 883.6200433813458, 887.3211992825461, 887.6227603268617, 848.4315508609216, 866.3156106675718, 868.6525389844081, 868.9348298877546, 869.3523325122792, 634.2072409488139, 643.0932385336699, 651.3388910256094, 652.2336254900473, 653.1313353240179, 11484.71288217793, 11771.764564708657, 12964.0, 13293.401796919163, 13358.866411335859, 12750.362481875869, 13377.799333010013, 14217.928910355486, 14259.714805703828, 14396.496122635657, 11229.27009744364, 11433.0, 11520.423978801027, 11529.030628167237, 11717.941410292979, 3635.8545658173907, 3661.1945372018113, 3664.523611930432, 3681.7975011374633, 3698.0, 108777.0, 110481.0, 110955.9999999992, 111317.0, 112828.0, 11050.778984420267, 11055.0, 11072.501737421835, 11081.667549973514, 11154.051905588116, 21963.682179069307, 21965.780342196693, 21972.230971916226, 21974.780252197274, 22006.779932200472, 7542.170361260257, 7659.655315510815, 7813.882791758128, 7897.60511974399, 7988.241117093867, 4139.79301034947, 4227.978860105742, 4240.448741663564, 4241.278982572909, 4302.698811083257, 3426.3489936911906, 3495.650434956535, 3516.841742121611, 3544.4151714966742, 3547.1486843157973, 611.8042226487481, 620.3140402059073, 626.7774939896362, 627.6641996531833, 634.010942929023, 499.55379177281566, 557.3228527339302, 568.8151350811003, 645.8611398549334, 657.0505619380045, 8395.62219700115, 9046.411983221069, 9130.941587877123, 9191.63233470667, 9298.285029581313, 568.2385603291526, 647.8736646353916, 648.5006544960354, 652.2499126005132, 652.3965332067818, 4138.461999939988, 4367.170237654836, 4375.146846364992, 4417.160739459492, 4450.287953927356, 72147.0, 114195.0, 125016.37491812483, 134718.0, 141302.0, 128885.35557322341, 131817.0, 132951.67048329394, 133472.0, 136875.31562342125, 104235.47882260541, 108616.45691771648, 109767.45116274367, 110702.44648776704, 113461.0, 7723.497972631761, 8477.152284771473, 8492.8959235299, 8589.398742087993, 8652.23627721943, 62531.0, 62797.0, 63056.0, 63739.362606375194, 64076.0, 83566.74649880135, 93921.06078939396, 94507.52746236225, 94990.0, 98314.0, 10076.798464030824, 10188.439635819805, 10728.570857165625, 10781.0, 11192.944035279772, 14029.0, 14365.497207597684, 14626.268686565842, 14887.627809304853, 15225.923870380577, 10838.67483975482, 11717.648470545897, 13295.601131966056, 13657.658558536115, 14055.297235137998, 11051.72370690739, 12862.871371286541, 13648.93175534116, 13715.794263085862, 14293.64265893361, 13297.401616927455, 13395.330233488481, 13515.0, 13569.05016648825, 13575.253361065235, 10633.415162166155, 10677.359358438518, 10843.240973131806, 10982.945085274523, 11098.5560577576, 8300.916990830256, 8476.444938865283, 9339.205298671015, 10081.798364032826, 10347.172226222036], "value": 7451.057726354312, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1656.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 173.0, 117.0, 118.0, 118.0, 121.0, 115.0, 117.0, 120.0, 149.0], "value": 128.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 100.0, 127.0, 179.0, 131.0, 132.0, 122.0, 144.0, 178.0, 113.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [234.0, 228.0, 201.0, 264.0, 281.0, 181.0, 180.0, 257.0, 192.0, 193.0], "value": 221.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 86.0, 109.0, 88.0, 53.0, 65.0, 82.0, 107.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 90.0, 71.0, 72.0, 85.0, 124.0, 98.0, 105.0, 97.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 136.0, 134.0, 89.0, 87.0, 91.0, 120.0, 96.0, 133.0], "value": 106.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 97.0, 135.0, 103.0, 157.0, 134.0, 152.0, 144.0], "value": 121.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 112.0, 92.0, 93.0, 92.0, 89.0, 92.0, 95.0, 90.0, 116.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 59.0, 67.0, 78.0, 86.0, 50.0, 48.0, 80.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 69.0, 78.0, 76.0, 70.0, 71.0, 69.0, 72.0, 74.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 91.0, 89.0, 91.0, 88.0, 108.0, 83.0, 100.0, 114.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 170.0, 174.0, 165.0, 165.0, 152.0, 182.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 159.0, 219.0, 241.0, 189.0, 200.0, 242.0, 227.0, 242.0, 190.0], "value": 208.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 70.0, 69.0, 69.0, 71.0, 70.0, 69.0, 70.0], "value": 69.8, "unit": "score"}]}]} 17:14:12 INFO - Return code: 0 17:14:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:12 ERROR - # TBPL SUCCESS # 17:14:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:12 INFO - 2016-10-13 17:14:12.281 screenresolution[1668:10300] starting screenresolution argv=screenresolution get 17:14:12 INFO - 2016-10-13 17:14:12.284 screenresolution[1668:10300] Display 0: 1600x1200x32@60 17:14:12 INFO - 2016-10-13 17:14:12.290 screenresolution[1669:10303] starting screenresolution argv=screenresolution list 17:14:12 INFO - Available Modes on Display 0 17:14:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:12 INFO - Intel Iris: 17:14:12 INFO - Chipset Model: Intel Iris 17:14:12 INFO - Type: GPU 17:14:12 INFO - Bus: Built-In 17:14:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:12 INFO - Vendor: Intel (0x8086) 17:14:12 INFO - Device ID: 0x0a2e 17:14:12 INFO - Revision ID: 0x0009 17:14:12 INFO - Displays: 17:14:12 INFO - Display: 17:14:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:12 INFO - Display Serial Number: 1600x1200 60 17:14:12 INFO - Main Display: Yes 17:14:12 INFO - Mirror: Off 17:14:12 INFO - Online: Yes 17:14:12 INFO - Rotation: Supported 17:14:12 INFO - Return code: 0 17:14:12 INFO - Running post-action listener: _resource_record_post_action 17:14:12 INFO - [mozharness: 2016-10-14 00:14:12.535781Z] Finished run-tests step (success) 17:14:12 INFO - Running post-run listener: _resource_record_post_run 17:14:12 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 37673472; Write bytes: 709734400; Read time: 394; Write time: 2068 17:14:12 INFO - TinderboxPrint: CPU usage
54.5% 17:14:12 INFO - TinderboxPrint: I/O read bytes / time
37,673,472 / 394 17:14:12 INFO - TinderboxPrint: I/O write bytes / time
709,734,400 / 2,068 17:14:12 INFO - TinderboxPrint: CPU idle
2,204.1 (45.4%) 17:14:12 INFO - TinderboxPrint: CPU system
986.4 (20.3%) 17:14:12 INFO - TinderboxPrint: CPU user
1,659.1 (34.2%) 17:14:12 INFO - TinderboxPrint: Swap in / out
444,837,888 / 0 17:14:12 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391205376; Write bytes: 385750528; Read time: 29439; Write time: 674 17:14:12 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 36719104; Write bytes: 299514368; Read time: 379; Write time: 1346 17:14:13 INFO - Running post-run listener: _upload_blobber_files 17:14:13 INFO - Blob upload gear active. 17:14:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:13 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 17:14:13 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:14:13 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:14:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:14:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:14 INFO - (blobuploader) - INFO - Done attempting. 17:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:15 INFO - (blobuploader) - INFO - Done attempting. 17:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:18 INFO - (blobuploader) - INFO - Done attempting. 17:14:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:18 INFO - Return code: 0 17:14:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50fdb60e4a3bd03d9e0ba92202b0ee00224ca63eea3216f1c8cf38b62eb74a7b16a3921f4afdf023a5131b71ee4d7710c9a5f668e2d3e459cf59323a02bae431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6e8603f898ae8b16bff2d5737bd3705c76301ee3ad4aa3480a229bdf241292ae752e1a082f72d7aaaa814104f0a9ce27120ee89d43951a6a4f436ce0651af4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f64be6a5d939528a0f4cb1401986acb7adca5aee8f7dd4a935ec469538f2521221a3b909356785f4f5bee72828b137748066bb603cbf27a501ccacd0ca25af8"} 17:14:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:18 INFO - Contents: 17:14:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50fdb60e4a3bd03d9e0ba92202b0ee00224ca63eea3216f1c8cf38b62eb74a7b16a3921f4afdf023a5131b71ee4d7710c9a5f668e2d3e459cf59323a02bae431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6e8603f898ae8b16bff2d5737bd3705c76301ee3ad4aa3480a229bdf241292ae752e1a082f72d7aaaa814104f0a9ce27120ee89d43951a6a4f436ce0651af4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f64be6a5d939528a0f4cb1401986acb7adca5aee8f7dd4a935ec469538f2521221a3b909356785f4f5bee72828b137748066bb603cbf27a501ccacd0ca25af8"} 17:14:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:18 INFO - Copying logs to upload dir... 17:14:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.317822 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-13 17:14:18.160082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:14:18.163866) ========= 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.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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/Fx-Team/sha512/50fdb60e4a3bd03d9e0ba92202b0ee00224ca63eea3216f1c8cf38b62eb74a7b16a3921f4afdf023a5131b71ee4d7710c9a5f668e2d3e459cf59323a02bae431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6e8603f898ae8b16bff2d5737bd3705c76301ee3ad4aa3480a229bdf241292ae752e1a082f72d7aaaa814104f0a9ce27120ee89d43951a6a4f436ce0651af4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f64be6a5d939528a0f4cb1401986acb7adca5aee8f7dd4a935ec469538f2521221a3b909356785f4f5bee72828b137748066bb603cbf27a501ccacd0ca25af8"} build_url:https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/eHGbZuBVShC_TCRcjh0w4w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50fdb60e4a3bd03d9e0ba92202b0ee00224ca63eea3216f1c8cf38b62eb74a7b16a3921f4afdf023a5131b71ee4d7710c9a5f668e2d3e459cf59323a02bae431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6e8603f898ae8b16bff2d5737bd3705c76301ee3ad4aa3480a229bdf241292ae752e1a082f72d7aaaa814104f0a9ce27120ee89d43951a6a4f436ce0651af4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f64be6a5d939528a0f4cb1401986acb7adca5aee8f7dd4a935ec469538f2521221a3b909356785f4f5bee72828b137748066bb603cbf27a501ccacd0ca25af8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:14:18.200633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:14:18.201132) ========= 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.Apks2cwvqm/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.i0SPxJX4h5/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.005358 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:14:18.251857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 17:14:18.252438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 17:14:18.252926) ========= ========= Total master_lag: 0.18 =========