builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0162 starttime: 1475821775.63 results: success (0) buildid: 20161006202401 builduid: ee2a3d12a1b746e0b7d546968ad16c8a revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.629025) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.629494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.629778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.659242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.659627) ========= 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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-06 23:29:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-10-06 23:29:35 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103233 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.788198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.788543) ========= 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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.028446 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:35.836998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 23:29:35.837363) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e67f06bcfcc83f4317a968914232bb6c82965ac --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 0e67f06bcfcc83f4317a968914232bb6c82965ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-06 23:29:35,913 truncating revision to first 12 chars 2016-10-06 23:29:35,914 Setting DEBUG logging. 2016-10-06 23:29:35,914 attempt 1/10 2016-10-06 23:29:35,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e67f06bcfcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 23:29:37,541 unpacking tar archive at: fx-team-0e67f06bcfcc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.889338 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 23:29:37.754315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:37.754677) ========= script_repo_revision: 0e67f06bcfcc83f4317a968914232bb6c82965ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:37.755083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:37.755351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 23:29:37.773369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 23:29:37.773793) ========= /tools/buildbot/bin/python 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', '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:29:37 INFO - MultiFileLogger online at 20161006 23:29:37 in /builds/slave/test 23:29:37 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 23:29:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:37 INFO - {'append_to_log': False, 23:29:37 INFO - 'base_work_dir': '/builds/slave/test', 23:29:37 INFO - 'blob_upload_branch': 'Fx-Team', 23:29:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:37 INFO - 'branch': 'Fx-Team', 23:29:37 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:37 INFO - 'config_files': ('talos/mac_config.py',), 23:29:37 INFO - 'default_actions': ('clobber', 23:29:37 INFO - 'read-buildbot-config', 23:29:37 INFO - 'download-and-extract', 23:29:37 INFO - 'populate-webroot', 23:29:37 INFO - 'create-virtualenv', 23:29:37 INFO - 'install', 23:29:37 INFO - 'run-tests'), 23:29:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:37 INFO - 'download_minidump_stackwalk': True, 23:29:37 INFO - 'download_symbols': 'ondemand', 23:29:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:37 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:37 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:37 INFO - 'installer_path': 'installer.exe', 23:29:37 INFO - 'log_level': 'info', 23:29:37 INFO - 'log_name': 'talos', 23:29:37 INFO - 'log_to_console': True, 23:29:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:29:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:29:37 INFO - 'opt_config_files': (), 23:29:37 INFO - 'pip_index': False, 23:29:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:29:37 INFO - 'cmd': ('bash', 23:29:37 INFO - '-c', 23:29:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:29:37 INFO - 'enabled': True, 23:29:37 INFO - 'halt_on_failure': False, 23:29:37 INFO - 'name': 'check_screen_resolution'},), 23:29:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:29:37 INFO - 'cmd': ('bash', 23:29:37 INFO - '-c', 23:29:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:29:37 INFO - 'enabled': True, 23:29:37 INFO - 'halt_on_failure': False, 23:29:37 INFO - 'name': 'check_screen_resolution'},), 23:29:37 INFO - 'run_cmd_checks_enabled': True, 23:29:37 INFO - 'sps_profile': False, 23:29:37 INFO - 'sps_profile_interval': 0, 23:29:37 INFO - 'suite': 'dromaeojs-e10s', 23:29:37 INFO - 'system_bits': '32', 23:29:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:37 INFO - 'title': 't-yosemite-r7-0162', 23:29:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:37 INFO - 'use_talos_json': True, 23:29:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:37 INFO - 'work_dir': 'build'} 23:29:37 INFO - [mozharness: 2016-10-07 06:29:37.978154Z] Running clobber step. 23:29:37 INFO - Running pre-action listener: _resource_record_pre_action 23:29:37 INFO - Running main action method: clobber 23:29:37 INFO - rmtree: /builds/slave/test/build 23:29:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:40 INFO - Running post-action listener: _resource_record_post_action 23:29:40 INFO - [mozharness: 2016-10-07 06:29:40.246049Z] Finished clobber step (success) 23:29:40 INFO - [mozharness: 2016-10-07 06:29:40.246238Z] Running read-buildbot-config step. 23:29:40 INFO - Running pre-action listener: _resource_record_pre_action 23:29:40 INFO - Running main action method: read_buildbot_config 23:29:40 INFO - Using buildbot properties: 23:29:40 INFO - { 23:29:40 INFO - "project": "", 23:29:40 INFO - "product": "firefox", 23:29:40 INFO - "script_repo_revision": "production", 23:29:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:29:40 INFO - "repository": "", 23:29:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:29:40 INFO - "buildid": "20161006202401", 23:29:40 INFO - "pgo_build": "False", 23:29:40 INFO - "basedir": "/builds/slave/test", 23:29:40 INFO - "buildnumber": 40, 23:29:40 INFO - "slavename": "t-yosemite-r7-0162", 23:29:40 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 23:29:40 INFO - "platform": "yosemite_r7", 23:29:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 23:29:40 INFO - "branch": "fx-team", 23:29:40 INFO - "repo_path": "integration/fx-team", 23:29:40 INFO - "revision": "0e67f06bcfcc83f4317a968914232bb6c82965ac", 23:29:40 INFO - "stage_platform": "macosx64", 23:29:40 INFO - "builduid": "ee2a3d12a1b746e0b7d546968ad16c8a", 23:29:40 INFO - "slavebuilddir": "test" 23:29:40 INFO - } 23:29:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 23:29:40 INFO - Running post-action listener: _resource_record_post_action 23:29:40 INFO - [mozharness: 2016-10-07 06:29:40.250266Z] Finished read-buildbot-config step (success) 23:29:40 INFO - [mozharness: 2016-10-07 06:29:40.250429Z] Running download-and-extract step. 23:29:40 INFO - Running pre-action listener: _resource_record_pre_action 23:29:40 INFO - Running main action method: download_and_extract 23:29:40 INFO - mkdir: /builds/slave/test/build/tests 23:29: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')]} 23:29:40 INFO - trying https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 23:29:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/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 23:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/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 23:29:40 INFO - Downloaded 1199 bytes. 23:29:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:29:40 INFO - Using the following test package requirements: 23:29:40 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:29:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 23:29:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 23:29:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'jsshell-mac.zip'], 23:29:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 23:29:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:29:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 23:29:40 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 23:29:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 23:29:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:29:40 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 23:29:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:29:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:29:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:29:40 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:29:41 INFO - Http code: 200 23:29:41 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 23:29:41 INFO - x-amz-cf-id: jtOObvFq8TSJPr_LWOnSZU7SVoyIUQ_kXZGEnyet_zKNRQ13XYQhEg== 23:29:41 INFO - x-amz-version-id: h6ciNXuWd4FeHlhEGrS8vGKOAGrd9qde 23:29:41 INFO - Expected file size: 16482348 23:29:41 INFO - Obtained file size: 16482348 23:29:48 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 23:29:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:29:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:29:48 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:29:48 INFO - Http code: 200 23:29:48 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 23:29:48 INFO - x-amz-cf-id: 0FiLMYraGBBeM8Y8eHZGW-ZaNSVMqr8YZXeyVpP4SUidpIFvbV1d9w== 23:29:48 INFO - x-amz-version-id: h6ciNXuWd4FeHlhEGrS8vGKOAGrd9qde 23:29:49 INFO - Expected file size: 16482348 23:29:49 INFO - Obtained file size: 16482348 23:29:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 23:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:29:55 INFO - Fetch https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 23:29:56 INFO - Http code: 200 23:29:56 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 23:29:56 INFO - x-amz-cf-id: eVE-xz0FjE9DOOHX54Vh_A10R3i8CTerKVhAVVG9X5AXXqpOsl-XFg== 23:29:56 INFO - x-amz-version-id: rylbzKG1NZO5NZK_cF.7qkrrSSXVGrgE 23:29:57 INFO - Expected file size: 14409006 23:29:57 INFO - Obtained file size: 14409006 23:29:57 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')]} 23:29:57 INFO - trying https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:29:57 INFO - Downloading https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 23:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/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 23:30:00 INFO - Downloaded 111722484 bytes. 23:30:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:30:00 INFO - mkdir: /builds/slave/test/properties 23:30:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:30:00 INFO - Writing to file /builds/slave/test/properties/build_url 23:30:00 INFO - Contents: 23:30:00 INFO - build_url:https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 23:30:00 INFO - Running post-action listener: _resource_record_post_action 23:30:00 INFO - Running post-action listener: set_extra_try_arguments 23:30:00 INFO - [mozharness: 2016-10-07 06:30:00.900635Z] Finished download-and-extract step (success) 23:30:00 INFO - [mozharness: 2016-10-07 06:30:00.900786Z] Running populate-webroot step. 23:30:00 INFO - Running pre-action listener: _resource_record_pre_action 23:30:00 INFO - Running main action method: populate_webroot 23:30:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:30:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:30:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:30:00 INFO - '--tppagecycles', 23:30:00 INFO - '7'], 23:30:00 INFO - 'tests': ['tsvgm']}}, 23:30:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:30:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:30:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:30:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:30:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['damp', 'tps']}, 23:30:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'tests': ['damp', 'tps']}, 23:30:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['dromaeo_dom']}, 23:30:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:30:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['basic_compositor_video']}, 23:30:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:30:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'other-e10s': {'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['a11yr', 23:30:00 INFO - 'ts_paint', 23:30:00 INFO - 'tpaint', 23:30:00 INFO - 'sessionrestore', 23:30:00 INFO - 'sessionrestore_no_auto_restore', 23:30:00 INFO - 'tabpaint']}, 23:30:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['tsvgx', 23:30:00 INFO - 'tsvgr_opacity', 23:30:00 INFO - 'tart', 23:30:00 INFO - 'tscrollx', 23:30:00 INFO - 'cart']}, 23:30:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:30:00 INFO - 'tsvgr_opacity', 23:30:00 INFO - 'tart', 23:30:00 INFO - 'tscrollx', 23:30:00 INFO - 'cart']}, 23:30:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'talos_options': ['--disable-e10s'], 23:30:00 INFO - 'tests': ['tp5o']}, 23:30:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'tests': ['tp5o']}, 23:30:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'talos_options': ['--disable-e10s', 23:30:00 INFO - '--xperf_path', 23:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:00 INFO - 'tests': ['tp5n']}, 23:30:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:00 INFO - 'talos_options': ['--xperf_path', 23:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:00 INFO - 'tests': ['tp5n']}}, 23:30:00 INFO - 'talos.zip': {'path': '', 23:30:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:30:00 INFO - Running post-action listener: _resource_record_post_action 23:30:00 INFO - [mozharness: 2016-10-07 06:30:00.919487Z] Finished populate-webroot step (success) 23:30:00 INFO - [mozharness: 2016-10-07 06:30:00.919624Z] Running create-virtualenv step. 23:30:00 INFO - Running pre-action listener: _resource_record_pre_action 23:30:00 INFO - Running main action method: create_virtualenv 23:30:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:30:00 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 23:30:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:30:01 INFO - Using real prefix '/tools/python27' 23:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:30:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:30:04 INFO - Installing pip.................done. 23:30:04 INFO - Return code: 0 23:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:30:04 INFO - Reading from file tmpfile_stdout 23:30:04 INFO - Output received: 23:30:04 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) 23:30:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:30:04 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')]} 23:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:04 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')]} 23:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:04 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:04 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 23:30:04 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 23:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:04 INFO - 'HOME': '/Users/cltbld', 23:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:04 INFO - 'LOGNAME': 'cltbld', 23:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:04 INFO - 'MOZ_NO_REMOTE': '1', 23:30:04 INFO - 'NO_EM_RESTART': '1', 23:30:04 INFO - 'PAGER': '/bin/cat', 23:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:04 INFO - 'PWD': '/builds/slave/test', 23:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:04 INFO - 'SHELL': '/bin/bash', 23:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:04 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:04 INFO - 'USER': 'cltbld', 23:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:04 INFO - 'XPC_FLAGS': '0x0', 23:30:04 INFO - 'XPC_SERVICE_NAME': '0', 23:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:05 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 23:30:05 INFO - Cleaning up... 23:30:05 INFO - Return code: 0 23:30:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:05 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:05 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 23:30:05 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 23:30:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:05 INFO - 'HOME': '/Users/cltbld', 23:30:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:05 INFO - 'LOGNAME': 'cltbld', 23:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:05 INFO - 'MOZ_NO_REMOTE': '1', 23:30:05 INFO - 'NO_EM_RESTART': '1', 23:30:05 INFO - 'PAGER': '/bin/cat', 23:30:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:05 INFO - 'PWD': '/builds/slave/test', 23:30:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:05 INFO - 'SHELL': '/bin/bash', 23:30:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:05 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:05 INFO - 'USER': 'cltbld', 23:30:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:05 INFO - 'XPC_FLAGS': '0x0', 23:30:05 INFO - 'XPC_SERVICE_NAME': '0', 23:30:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:05 INFO - Downloading/unpacking psutil>=3.1.1 23:30:05 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 23:30:05 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 23:30:05 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 23:30:05 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 23:30:05 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 23:30:05 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 23:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:08 INFO - Installing collected packages: psutil 23:30:08 INFO - Running setup.py install for psutil 23:30:08 INFO - building 'psutil._psutil_osx' extension 23:30:08 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 23:30:09 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 23:30:09 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 23:30:09 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 23:30:09 INFO - building 'psutil._psutil_posix' extension 23:30:09 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 23:30:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:30:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:30:09 INFO - ^ 23:30:09 INFO - 1 warning generated. 23:30:09 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 23:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:10 INFO - Successfully installed psutil 23:30:10 INFO - Cleaning up... 23:30:10 INFO - Return code: 0 23:30:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:30:10 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')]} 23:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:10 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')]} 23:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:10 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:10 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 23:30:10 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 23:30:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:10 INFO - 'HOME': '/Users/cltbld', 23:30:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:10 INFO - 'LOGNAME': 'cltbld', 23:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:10 INFO - 'MOZ_NO_REMOTE': '1', 23:30:10 INFO - 'NO_EM_RESTART': '1', 23:30:10 INFO - 'PAGER': '/bin/cat', 23:30:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:10 INFO - 'PWD': '/builds/slave/test', 23:30:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:10 INFO - 'SHELL': '/bin/bash', 23:30:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:10 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:10 INFO - 'USER': 'cltbld', 23:30:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:10 INFO - 'XPC_FLAGS': '0x0', 23:30:10 INFO - 'XPC_SERVICE_NAME': '0', 23:30:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:30:10 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 23:30:10 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 23:30:10 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 23:30:10 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 23:30:10 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 23:30:10 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 23:30:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:30:12 INFO - Installing collected packages: mozsystemmonitor 23:30:12 INFO - Running setup.py install for mozsystemmonitor 23:30:13 INFO - Successfully installed mozsystemmonitor 23:30:13 INFO - Cleaning up... 23:30:13 INFO - Return code: 0 23:30:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:30:13 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')]} 23:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:13 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')]} 23:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:13 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:13 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 23:30:13 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 23:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:13 INFO - 'HOME': '/Users/cltbld', 23:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:13 INFO - 'LOGNAME': 'cltbld', 23:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:13 INFO - 'MOZ_NO_REMOTE': '1', 23:30:13 INFO - 'NO_EM_RESTART': '1', 23:30:13 INFO - 'PAGER': '/bin/cat', 23:30:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:13 INFO - 'PWD': '/builds/slave/test', 23:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:13 INFO - 'SHELL': '/bin/bash', 23:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:13 INFO - 'USER': 'cltbld', 23:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:13 INFO - 'XPC_FLAGS': '0x0', 23:30:13 INFO - 'XPC_SERVICE_NAME': '0', 23:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:13 INFO - Downloading/unpacking jsonschema==2.5.1 23:30:13 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 23:30:13 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 23:30:13 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 23:30:13 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 23:30:13 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 23:30:13 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 23:30:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:30:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:30:15 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 23:30:15 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 23:30:15 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 23:30:15 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 23:30:15 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 23:30:15 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 23:30:16 INFO - Downloading functools32-3.2.3-2.tar.gz 23:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:30:16 INFO - warning: no files found matching '*.txt' 23:30:16 INFO - no previously-included directories found matching 'build' 23:30:16 INFO - no previously-included directories found matching 'dist' 23:30:16 INFO - no previously-included directories found matching '.git*' 23:30:16 INFO - Installing collected packages: jsonschema, functools32 23:30:16 INFO - Running setup.py install for functools32 23:30:16 INFO - warning: no files found matching '*.txt' 23:30:16 INFO - no previously-included directories found matching 'build' 23:30:16 INFO - no previously-included directories found matching 'dist' 23:30:16 INFO - no previously-included directories found matching '.git*' 23:30:16 INFO - Successfully installed jsonschema functools32 23:30:16 INFO - Cleaning up... 23:30:16 INFO - Return code: 0 23:30:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:30:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:16 INFO - 'HOME': '/Users/cltbld', 23:30:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:16 INFO - 'LOGNAME': 'cltbld', 23:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:16 INFO - 'MOZ_NO_REMOTE': '1', 23:30:16 INFO - 'NO_EM_RESTART': '1', 23:30:16 INFO - 'PAGER': '/bin/cat', 23:30:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:16 INFO - 'PWD': '/builds/slave/test', 23:30:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:16 INFO - 'SHELL': '/bin/bash', 23:30:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:16 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:16 INFO - 'USER': 'cltbld', 23:30:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:16 INFO - 'XPC_FLAGS': '0x0', 23:30:16 INFO - 'XPC_SERVICE_NAME': '0', 23:30:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:30:16 INFO - Cleaning up... 23:30:16 INFO - Return code: 0 23:30:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:30:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:16 INFO - 'HOME': '/Users/cltbld', 23:30:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:16 INFO - 'LOGNAME': 'cltbld', 23:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:16 INFO - 'MOZ_NO_REMOTE': '1', 23:30:16 INFO - 'NO_EM_RESTART': '1', 23:30:16 INFO - 'PAGER': '/bin/cat', 23:30:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:16 INFO - 'PWD': '/builds/slave/test', 23:30:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:16 INFO - 'SHELL': '/bin/bash', 23:30:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:16 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:16 INFO - 'USER': 'cltbld', 23:30:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:16 INFO - 'XPC_FLAGS': '0x0', 23:30:16 INFO - 'XPC_SERVICE_NAME': '0', 23:30:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:17 INFO - Downloading/unpacking blobuploader==1.2.4 23:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:19 INFO - Downloading blobuploader-1.2.4.tar.gz 23:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:30:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:30:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:20 INFO - Downloading docopt-0.6.1.tar.gz 23:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:30:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:30:20 INFO - Running setup.py install for blobuploader 23:30:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:30:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:30:20 INFO - Running setup.py install for requests 23:30:21 INFO - Running setup.py install for docopt 23:30:21 INFO - Successfully installed blobuploader requests docopt 23:30:21 INFO - Cleaning up... 23:30:21 INFO - Return code: 0 23:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:21 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:21 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 23:30:21 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 23:30:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:21 INFO - 'HOME': '/Users/cltbld', 23:30:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:21 INFO - 'LOGNAME': 'cltbld', 23:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:21 INFO - 'MOZ_NO_REMOTE': '1', 23:30:21 INFO - 'NO_EM_RESTART': '1', 23:30:21 INFO - 'PAGER': '/bin/cat', 23:30:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:21 INFO - 'PWD': '/builds/slave/test', 23:30:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:21 INFO - 'SHELL': '/bin/bash', 23:30:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:21 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:21 INFO - 'USER': 'cltbld', 23:30:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:21 INFO - 'XPC_FLAGS': '0x0', 23:30:21 INFO - 'XPC_SERVICE_NAME': '0', 23:30:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:21 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-HvJzFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-SUDUqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-u02EJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-5i5QYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-exa3Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-6tBX_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_URtjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GXoMYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GNywoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-wO09lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:22 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MggI96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MkRUNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-oHI35p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7xHNLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lDwyDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-De4iAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-otnWof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:30:23 INFO - Running setup.py install for manifestparser 23:30:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:30:23 INFO - Running setup.py install for mozcrash 23:30:23 INFO - Running setup.py install for mozdebug 23:30:24 INFO - Running setup.py install for mozdevice 23:30:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Running setup.py install for mozfile 23:30:24 INFO - Running setup.py install for mozhttpd 23:30:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Running setup.py install for mozinfo 23:30:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Running setup.py install for mozInstall 23:30:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:30:24 INFO - Running setup.py install for mozleak 23:30:25 INFO - Running setup.py install for mozlog 23:30:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Running setup.py install for moznetwork 23:30:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Running setup.py install for mozprocess 23:30:25 INFO - Running setup.py install for mozprofile 23:30:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Running setup.py install for mozrunner 23:30:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:30:25 INFO - Running setup.py install for mozscreenshot 23:30:25 INFO - Running setup.py install for moztest 23:30:26 INFO - Running setup.py install for mozversion 23:30:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:30:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:30:26 INFO - Cleaning up... 23:30:26 INFO - Return code: 0 23:30:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:26 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:26 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 23:30:26 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 23:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:26 INFO - 'HOME': '/Users/cltbld', 23:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:26 INFO - 'LOGNAME': 'cltbld', 23:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:26 INFO - 'MOZ_NO_REMOTE': '1', 23:30:26 INFO - 'NO_EM_RESTART': '1', 23:30:26 INFO - 'PAGER': '/bin/cat', 23:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:26 INFO - 'PWD': '/builds/slave/test', 23:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:26 INFO - 'SHELL': '/bin/bash', 23:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:26 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:26 INFO - 'USER': 'cltbld', 23:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:26 INFO - 'XPC_FLAGS': '0x0', 23:30:26 INFO - 'XPC_SERVICE_NAME': '0', 23:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:26 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rMC47J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:26 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)) 23:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:26 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-cLJxZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:26 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)) 23:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:26 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aUsQGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:26 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)) 23:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:26 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aF8bsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-__vveV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-y1Rvkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xkQiOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-wLs_x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LPY7Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BIDvEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Z3Psp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-KRZ0BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-egGV36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:27 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)) 23:30:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:27 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-RKd6yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:28 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)) 23:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:28 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3pg28q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:28 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)) 23:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:28 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-jjKRPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:28 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)) 23:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:28 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-fMXrOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:28 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)) 23:30:28 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)) 23:30:28 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)) 23:30:28 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)) 23:30:28 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)) 23:30:28 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)) 23:30:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:30 INFO - Downloading blessings-1.6.tar.gz 23:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:30:30 INFO - Installing collected packages: blessings 23:30:30 INFO - Running setup.py install for blessings 23:30:31 INFO - Successfully installed blessings 23:30:31 INFO - Cleaning up... 23:30:31 INFO - Return code: 0 23:30:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:30:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:31 INFO - Reading from file tmpfile_stdout 23:30:31 INFO - Current package versions: 23:30:31 INFO - blessings == 1.6 23:30:31 INFO - blobuploader == 1.2.4 23:30:31 INFO - docopt == 0.6.1 23:30:31 INFO - functools32 == 3.2.3-2 23:30:31 INFO - jsonschema == 2.5.1 23:30:31 INFO - manifestparser == 1.1 23:30:31 INFO - mozInstall == 1.12 23:30:31 INFO - mozcrash == 0.17 23:30:31 INFO - mozdebug == 0.1 23:30:31 INFO - mozdevice == 0.48 23:30:31 INFO - mozfile == 1.2 23:30:31 INFO - mozhttpd == 0.7 23:30:31 INFO - mozinfo == 0.9 23:30:31 INFO - mozleak == 0.1 23:30:31 INFO - mozlog == 3.4 23:30:31 INFO - moznetwork == 0.27 23:30:31 INFO - mozprocess == 0.23 23:30:31 INFO - mozprofile == 0.28 23:30:31 INFO - mozrunner == 6.12 23:30:31 INFO - mozscreenshot == 0.1 23:30:31 INFO - mozsystemmonitor == 0.3 23:30:31 INFO - moztest == 0.7 23:30:31 INFO - mozversion == 1.4 23:30:31 INFO - psutil == 3.1.1 23:30:31 INFO - requests == 1.2.3 23:30:31 INFO - wsgiref == 0.1.2 23:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30: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')]} 23:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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')]} 23:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:32 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 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30:32 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 23:30:32 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 23:30:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:32 INFO - 'HOME': '/Users/cltbld', 23:30:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:32 INFO - 'LOGNAME': 'cltbld', 23:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:32 INFO - 'MOZ_NO_REMOTE': '1', 23:30:32 INFO - 'NO_EM_RESTART': '1', 23:30:32 INFO - 'PAGER': '/bin/cat', 23:30:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:32 INFO - 'PWD': '/builds/slave/test', 23:30:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:32 INFO - 'SHELL': '/bin/bash', 23:30:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:32 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:32 INFO - 'USER': 'cltbld', 23:30:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:32 INFO - 'XPC_FLAGS': '0x0', 23:30:32 INFO - 'XPC_SERVICE_NAME': '0', 23:30:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 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)) 23:30:32 INFO - Cleaning up... 23:30:32 INFO - Return code: 0 23:30:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:30: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')]} 23:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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')]} 23:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110167490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa070d970c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, '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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 23:30: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', 'jsonschema'] in /builds/slave/test/build 23:30: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 jsonschema 23:30:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:30:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:32 INFO - 'HOME': '/Users/cltbld', 23:30:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:32 INFO - 'LOGNAME': 'cltbld', 23:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:32 INFO - 'MOZ_NO_REMOTE': '1', 23:30:32 INFO - 'NO_EM_RESTART': '1', 23:30:32 INFO - 'PAGER': '/bin/cat', 23:30:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:32 INFO - 'PWD': '/builds/slave/test', 23:30:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:32 INFO - 'SHELL': '/bin/bash', 23:30:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:30:32 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:30:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:32 INFO - 'USER': 'cltbld', 23:30:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:32 INFO - 'XPC_FLAGS': '0x0', 23:30:32 INFO - 'XPC_SERVICE_NAME': '0', 23:30:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:30:33 INFO - Cleaning up... 23:30:33 INFO - Return code: 0 23:30:33 INFO - Running post-action listener: _resource_record_post_action 23:30:33 INFO - Running post-action listener: _start_resource_monitoring 23:30:33 INFO - Starting resource monitoring. 23:30:33 INFO - [mozharness: 2016-10-07 06:30:33.156645Z] Finished create-virtualenv step (success) 23:30:33 INFO - [mozharness: 2016-10-07 06:30:33.157685Z] Running install step. 23:30:33 INFO - Running pre-action listener: _resource_record_pre_action 23:30:33 INFO - Running main action method: install 23:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:33 INFO - Reading from file tmpfile_stdout 23:30:33 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:33 INFO - Reading from file tmpfile_stdout 23:30:33 INFO - Output received: 23:30:33 INFO - Usage: mozinstall [options] installer 23:30:33 INFO - Options: 23:30:33 INFO - -h, --help show this help message and exit 23:30:33 INFO - -d DEST, --destination=DEST 23:30:33 INFO - Directory to install application into. [default: 23:30:33 INFO - "/builds/slave/test"] 23:30:33 INFO - --app=APP Application being installed. [default: firefox] 23:30:33 INFO - mkdir: /builds/slave/test/build/application 23:30:33 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'] 23:30:33 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 23:31:08 INFO - Reading from file tmpfile_stdout 23:31:08 INFO - Output received: 23:31:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:31:08 INFO - Running post-action listener: _resource_record_post_action 23:31:08 INFO - [mozharness: 2016-10-07 06:31:08.290498Z] Finished install step (success) 23:31:08 INFO - [mozharness: 2016-10-07 06:31:08.290632Z] Running run-tests step. 23:31:08 INFO - Running pre-action listener: _resource_record_pre_action 23:31:08 INFO - Running main action method: run_tests 23:31:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:31:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:31:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:31:08 INFO - 2016-10-06 23:31:08.305 screenresolution[1637:7475] starting screenresolution argv=screenresolution get 23:31:08 INFO - 2016-10-06 23:31:08.307 screenresolution[1637:7475] Display 0: 1600x1200x32@60 23:31:08 INFO - 2016-10-06 23:31:08.314 screenresolution[1638:7477] starting screenresolution argv=screenresolution list 23:31:08 INFO - Available Modes on Display 0 23:31:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:31:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:31:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:31:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:31:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:31:08 INFO - Intel Iris: 23:31:08 INFO - Chipset Model: Intel Iris 23:31:08 INFO - Type: GPU 23:31:08 INFO - Bus: Built-In 23:31:08 INFO - VRAM (Dynamic, Max): 1536 MB 23:31:08 INFO - Vendor: Intel (0x8086) 23:31:08 INFO - Device ID: 0x0a2e 23:31:08 INFO - Revision ID: 0x0009 23:31:08 INFO - Displays: 23:31:08 INFO - Display: 23:31:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:31:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:31:08 INFO - Display Serial Number: 1600x1200 60 23:31:08 INFO - Main Display: Yes 23:31:08 INFO - Mirror: Off 23:31:08 INFO - Online: Yes 23:31:08 INFO - Rotation: Supported 23:31:08 INFO - Return code: 0 23:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:31:08 INFO - Python 2.7.3 23:31:08 INFO - Return code: 0 23:31:08 INFO - grabbing minidump binary from tooltool 23:31:08 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')]} 23:31:08 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 0x10ff7bd30>, '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 0x10fda1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:31:08 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 23:31:08 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 23:31:08 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 23:31:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:31:08 INFO - Return code: 0 23:31:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:31:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:31:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:31:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:31:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:31:08 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/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 23:31:08 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/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 23:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAk2qA1XMk/Render', 23:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:31:08 INFO - 'HOME': '/Users/cltbld', 23:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:31:08 INFO - 'LOGNAME': 'cltbld', 23:31:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:31:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:08 INFO - 'MOZ_NO_REMOTE': '1', 23:31:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:31:08 INFO - 'NO_EM_RESTART': '1', 23:31:08 INFO - 'PAGER': '/bin/cat', 23:31:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:08 INFO - 'PWD': '/builds/slave/test', 23:31:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:31:08 INFO - 'SHELL': '/bin/bash', 23:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z4BYhHARBq/Listeners', 23:31:08 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 23:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:31:08 INFO - 'USER': 'cltbld', 23:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:08 INFO - 'XPC_FLAGS': '0x0', 23:31:08 INFO - 'XPC_SERVICE_NAME': '0', 23:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:31:08 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/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 23:31:08 INFO - mozversion application_buildid: 20161006202401 23:31:08 INFO - mozversion application_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 23:31:08 INFO - mozversion application_display_name: Nightly 23:31:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:31:08 INFO - mozversion application_name: Firefox 23:31:08 INFO - mozversion application_remotingname: firefox 23:31:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:31:08 INFO - mozversion application_vendor: Mozilla 23:31:08 INFO - mozversion application_version: 52.0a1 23:31:08 INFO - mozversion platform_buildid: 20161006202401 23:31:08 INFO - mozversion platform_changeset: 0e67f06bcfcc83f4317a968914232bb6c82965ac 23:31:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:31:08 INFO - mozversion platform_version: 52.0a1 23:31:08 INFO - using testdate: 1475821868 23:31:08 INFO - actual date: 1475821868 23:31:08 INFO - starting webserver on 'localhost:49280' 23:31:08 INFO - SUITE-START | Running 2 tests 23:31:08 INFO - TEST-START | dromaeo_css 23:31:08 INFO - operating with platform_type : mac_ 23:31:08 INFO - Initialising browser for dromaeo_css test... 23:31:08 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpVhrTkX/profile http://localhost:49280/getInfo.html) 23:31:11 INFO - PROCESS | 1648 | 2016-10-06 23:31:11.740 plugin-container[1650:7638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904f, name = 'com.apple.tsm.portname' 23:31:11 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:31:11 INFO - PROCESS | 1648 | 2016-10-06 23:31:11.743 plugin-container[1650:7638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 23:31:11 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:31:11 INFO - PROCESS | 1648 | 2016-10-06 23:31:11.743 plugin-container[1650:7638] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:31:11 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 23:31:11 INFO - PROCESS | 1648 | colorDepth:24 23:31:11 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 23:31:11 INFO - PROCESS | 1648 | __metrics 23:31:11 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:31:12 INFO - TEST-INFO | 1648: exit 0 23:31:12 INFO - Browser initialized. 23:31:12 INFO - Running cycle 1/1 for dromaeo_css test... 23:31:12 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpVhrTkX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:14 INFO - PROCESS | 1651 | 2016-10-06 23:31:14.984 plugin-container[1652:7762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 23:31:14 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:31:14 INFO - PROCESS | 1651 | 2016-10-06 23:31:14.986 plugin-container[1652:7762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 23:31:14 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:31:14 INFO - PROCESS | 1651 | 2016-10-06 23:31:14.986 plugin-container[1652:7762] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:31:24 INFO - PROCESS | 1651 | RSS: Main: 240025600 23:31:24 INFO - PROCESS | 1651 | 23:32:14 INFO - PROCESS | 1651 | 1475821934343 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] 23:34:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 23:34:30 INFO - PROCESS | 1651 | RSS: Main: 253739008 23:34:30 INFO - PROCESS | 1651 | 23:37:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 23:37:33 INFO - PROCESS | 1651 | RSS: Main: 265076736 23:37:33 INFO - PROCESS | 1651 | 23:40:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 23:40:35 INFO - PROCESS | 1651 | RSS: Main: 271253504 23:40:35 INFO - PROCESS | 1651 | 23:43:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 23:43:38 INFO - PROCESS | 1651 | RSS: Main: 270991360 23:43:38 INFO - PROCESS | 1651 | 23:46:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 23:46:41 INFO - PROCESS | 1651 | RSS: Main: 276410368 23:46:41 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 23:49:45 INFO - PROCESS | 1651 | RSS: Main: 279121920 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | __start_tp_report 23:49:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 23:49:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 23:49:45 INFO - PROCESS | 1651 | |i|pagename|runs| 23:49:45 INFO - PROCESS | 1651 | |0;dojo.html;3107.782455228134;3374.0215337552113;3417.7265818734504;3433.467812489065;3452.4648679454676;5645.830625081244;5779.248697669303;5792.971035144824;5798.3042034955815;5888.882222355551;5677.006523858329;5803.564732645058;5812.564057695668;5836.533077353812;5851.6196447230905;3726.06848287928;4177.143685544472;4794.849236183309;4862.951370486303;5213.582913366931;4289.785510724467;4398.8020539075815;5322.76047577858;5329.173978033411;5364.517193452608;5335.7865685372535;5343.118385466393;5350.3312085989255;5356.116240820279;5370.785168593252;4302.483701955785;5304.469553044703;5317.6809391436445;5337.919931201035;5346.866328341784;5201.661891977009;5282.603804714662;5282.867928301785;5298.496642818926;5307.840764777063;5788.855278618026;5800.680962547058;5878.941210587925;5887.470127688486;5921.496672782776;5979.252593425822;6148.446639802394;6156.815295541141;6171.444569988677;6197.0704394340755;6128.533679014817;6140.232470941132;6149.477294429978;6173.475254603364;6217.720202590895;4868.853934381974;5977.910331345077;5979.9402005980255;5992.790252341147;6007.579469437185;6333.904991425133;6339.683015849189;6349.809505714836;6360.7137678804565;6362.395572420613;6050.183225264533;6129.908051379233;6136.539759518054;6142.938570614237;6161.137440758297;6109.495762817132;6118.388161183935;6156.107364432132;6182.938170618237;6202.162708034448;6102.847428814226;6152;6158.7228574714245;6178.814635560941;6194.194754681953;6112.017184454359;6125.082842094198;6132.110843927606;6162.137300777895;6181.907271390933;4960.206366981266;4962.950370496249;4987.925181122286;5005.973775376039;5013.774380152902;4455.242608756519;4473.7986790594505;4491.910161796745;4499.212637788374;4515.774211289422;5319.494648008433;5805.071188609802;5837.357890632027;5876.941230587725;5895.94104058954;6220.782272620437;6234.251889773165;6236.781712640036;6244.406781355764;6250.937490625127;5935.821925342247;5942.405759424109;5954.642721436728;5957.3744756799915;5963.075723262901;5369.650972686841;5443.5100840923715;5448.536874365644;5502.669839809624;5549.19536667181;6420.5184611154355;6422.710978006095;6427;6431.5819471734185;6431.678416079271;6238.656873871981;6243.188385509855;6244.46922011616;6264.091706702411;6264.59280146789;6172.6913654318005;6208.534359923115;6236.220472440945;6260.874782504416;6385.808425747235;6130.816075517741;6160.568760186744;6193.318734939063;6200.3799620037635;6202.162708034538;6091;6174.567780255339;6197.504199664107;6233.937660623517;6240.4071613196675;6091.634501929899;6115.909724157069;6159.137720719193;6160;6219.782307619212;6096.677875983316;6116.755329786759;6159.969200153971;6185.381461853779;6192;4989.525995030466;5411.02601531728;6086.878262434638;6087.330393656783;6101.877962440815;4637.536246375335;5107.438181799925;5997.730102145327;6103.246756470893;6135.84660383494;5159.329287192641;6074;6087.817365479043;6112.381899552462;6122.540809439399 23:49:45 INFO - PROCESS | 1651 | |1;ext.html;424.745152908255;489.09761490050846;516.8346129238645;518.028696194635;524.8477941396998;33755.49366759497;34362;36625;40475;42787.57212427875;41519;41809.372859407136;41853.162936741246;42007.15985680292;42069.57930420695;9673.661421850255;9821.754456138618;9841.55712992917;9863;9877.950610246939;8078.798030049237;9744.707658770249;9744.805103897917;9775.951120244388;9819.852702209473;9747.074027967366;9770.511474426286;9814.90185098147;9826.16477599405;9828.21374290055;9747.707568772912;9787.314887957846;9796.90203097967;9805.117539421486;9820.90179098207;9739.610415583367;9743.756406089833;9792.16766574842;9800.166985806214;9835.557399917021;32058.198545036328;39489.802550987064;39575;39680;39769.801150994346;3236.8219747913854;3286.3263031078573;3334.1755470673534;3352.765306428551;3460.3944309745693;28559.71440285612;29685.851570742223;30244.8487757562;30283.697163028308;30528.694713053028;3165.287810242677;3276.4921437177277;3326.4843949187916;3394.694477497037;3398.5242066110764;410892;417114;417624.9118754417;418353.999999997;418703;56579.71710141423;56910.430895691345;57487;57505.424945750005;57512.137317940265;59370.70314648399;59689.70155149196;59726.70136649289;59761.40238597646;60088.892444141864;12055.879441205476;15107.39570417171;15792.21038948048;16226.918865405834;16254.024758514526;12465.439055242536;12502.74994500105;12505.937470312772;12515.56195533152;12520.624381268577;12200.877991219973;16926.74609880853;17897.28410863577;18159.00125493084;18228.45314640563;2731.2216018435047;3136.325689976666;3244.8053116813066;7564.848703025908;7715.884261736079;812.475953010305;859.3726579596929;957.3394357893031;976.5019839881569;1030.2891005206384;24162.87918560396;29146.979855704947;30574.55403567709;31578;32505;947.6067432015636;1027.8201314769885;1029.552144817007;1062.877769056553;1145.2441388683428;14263.716265536152;14847.70304593902;15239.695206095816;15327.927045106735;15663.295151718201;584386;642764;643646;648397;649146;54486.45513544893;55140;55163.724181378835;55234.171487427724;55291.72354138204;1342.1074985134971;1358.660334916271;1372.2315503318173;1390.6731917999261;1403.6701375176622;28978.27554311159;29022.12933611995;29095.12714618565;29679.554806677486;29815.701842981292;48538;48587.27119093146;49142;49167.01665966732;49212;592998;595173.2172052182;596312;596768;599145;39868.800655996536;40417.19165616613;41035.12754107184;41127.794361028005;42929.35605965975;44119.33820992752;44132.779336103114;44853;45291.54708453005;45564.54435455603;31484;32004.5199322015;36974.075648109014;38199.2360152801;39025.804870975466;36882.89351319465;37205.81397092997;37285.25429491341;38315.808420957714;38397.42403864;29516.262093446978;36495;37092.25815483729;37141.442878356305;37267.44098838574;31918.36163276768;33064.33871322608;33873.830630846685;33900.83049584736;34914.65085349114;24458.021679132635;24467.51064978655;24741.62887556652;24981.000759969396;25357.492850142524 23:49:45 INFO - PROCESS | 1651 | |2;jquery.html;312.9499280115182;370.10619354259467;375.566221014728;380.3552977702795;391.0477986103837;16782.74825877613;19770;19942.002899855022;20331;20592.970351482403;19818.702719459183;20001.199952001938;20023.399298021046;20269.290574829884;20311.390658280274;5871.119332100187;5885.264341957255;6174.783882564111;6175.104609831572;6187.4740647045055;5900.704964751767;6095.390460953913;6095.81712548622;6101.35935726749;6112.235970503687;5770.567207459437;6053.878922421549;6059.606125601822;6062;6072.906876762181;6079.939200608003;6113.296970848365;6156.907646385308;6162.383761623847;6163.8150855474405;5878.676672782995;5938.346781853993;5952.434518720715;5978.103284507315;6036.909446358308;13149.276789776559;13346.866531334757;13350.198988060747;22511.77488225113;26944.191674249803;2375.3467796355967;2379.512199998996;2580.9483810323686;3415.9487607685905;3486.8779592714386;16017;17085.231164597622;17449.563760905952;17702;18015.72976405355;2001.1395100106947;2031.177373163871;2044.47865794223;2082.885441300728;2087.7285952826187;133194;134191.32904335513;139492.30253848768;140408;142265;17363.53048789627;19826.413886889015;20421.630430978723;20552.38342849687;21023.369298921058;33849.492257616155;33941;34016;34052.31895362079;34055.14862128417;10221.182305415548;10406.791864162675;10650.254482186172;10657.413842238751;10669.466526673636;6706.692195022021;8675.349348798865;8682.913170868336;8694.608742606599;8819.823603527893;7751.806204844924;8178.583564874901;9082.000979892338;9379.296552758571;9702.54461830731;2996.805207661495;3321.9169520762175;3582.158192824684;3849.4225866119746;3957.6635985941516;839.9160083991552;929.8837645294338;945.2343601682659;960.7934294126796;980.9362391444533;19388.03059847002;19587.34030429661;20815;20839.270625528035;21322.680159797615;925.7916968681992;945.522511131874;946.9100435458621;947.308464820671;947.8720372749729;10766.838497422545;11049.834252486218;11061.72345691348;11062.723431914266;11065.446727663584;588858;592732;601260;603215;605457.945420549;119431;122241.38879305546;126567.3671631636;133642;138288.999999998;431.71506805508216;445.97101188422647;446.51107037793565;447.84773177119934;450.15595757953184;9323.070929460375;10581.36511809294;10916.50875710579;11300.378479183724;11344.092472602337;46588.53411465978;53566.732166338916;53787;54308.45691543034;55019.449805503034;80956;81589.18410815815;81865.77201341865;82607.17392825994;82715.5864220675;7637.5035622684345;7836.70222023303;7982.84677552352;8239.629216685384;8244.876326854983;11091.667249982513;11685.182037257651;12433.37833108359;12475.376231188586;12706.555270565486;10923.726906827074;11079.279846809932;11119.72200694989;11175.10599152082;11237.3257604544;10708.625198118028;10745.623903163352;10873.184511161537;10985.395803230898;11024.5038973248;11151.665450036511;11211.327320360479;11246.943765281121;11302.717432064264;11362.431878405881;7809.882851757115;7838.804029899298;8008.239217274583;8036.955195824506;8143.714969976022;8095.352371810359;10385;10512.053915147673;10716.839247411452;10910.890891090987 23:49:45 INFO - PROCESS | 1651 | |3;mootools.html;1316.8880645145164;1493.5743313155747;1660.1948055193236;1833.1201023508725;1862.5250561106916;8042.879356809653;8323;8489.702860399888;9003.189712925836;9027.142421469965;8473.322134229247;8748.650053997833;8784.95607521963;8886.95556522218;8893.288536917047;2323.500447403808;2355.693759811222;2360.563295790276;2362.2676970139228;2364.267077206063;2307.9192228272013;2343.472718638301;2346.4603141277516;2369.18263199196;2371.3834403055157;2007.7490313710787;2260.0168926516935;2347.600907845662;2358.3750306168877;2359.6460530920413;2309.618912879373;2329.2779238436055;2337.0534933351933;2340.590396680574;2362.9054837806466;1756.306259027677;1853.5551467647801;2336.918207862717;2338.4621537046573;2338.7895089441863;7487.401007919408;8970.013298537157;9001.774955626097;9018.503982280972;9029.277657787361;5188.948110518884;5273.815416460444;5355.6251062425645;5370.650907691027;5379.9731001345135;3482.7736197147105;3541;3589.73077019222;3689.0777305673582;3707.480952666629;1041.7656027393853;1072.6353039966448;1079.1420820447684;1085.6146068145852;1105.060698406356;9193.908060919439;11600.6519804406;11681.182317237712;11738.178327517076;11749.823752643717;3965.167314863911;4530.388397566287;4587.197240482902;4773.809047638056;4805;9890.505474726235;10032.64885728996;10046.14607758334;10048.79902401948;10048.849267260997;4369.847055353048;5253.658512196695;5283.313169288045;5336;5380.3274590676165;4372.431583894074;4529.09418116378;4666.020135771526;4842.080004799077;4881.219004959189;3841.980790096032;3898.4542164096483;3982.1040265939932;3990.7406018609277;4061.7766022868436;1263.9620811375673;1267.9873201268053;1273.4969686973593;1275.3495717184303;1281.4297637551388;841.8063845315489;845.3955421873267;905.8460061789511;914.4696076275744;924.7919218175991;5673.659580425187;5801.361850196475;5993.370696076936;6029.969850150721;6044.818655440344;944.7906679450315;952.2239374909427;965.3290962780941;970.9902900971041;1004.0662184168793;3862.6801317364384;4005.218982298482;4020.6576896951224;4067.08490589615;4094.754314741125;10444.060034596923;10855.077318427864;10869.67390978272;10875.347479151276;10901.890981090246;10091.394516328897;10581.470926453647;10622.097121744739;10755.354678719146;10838.729031774112;6130;8234.752957411287;8240.670373185125;8259.091499935003;8273.379496537664;5184.377874655065;5208.723862653674;5876.941230587639;6017.669028203316;6205.720742566686;8413.789655258422;8726.476411415335;9911.405315681082;10178.625885505659;10204.846927295948;8438.789030274293;8626.353023523387;8992.640294388151;9976.800463990825;10486.475676216007;7022.894656580258;7032.929670703227;7265.782026539001;7461.925380746123;7470.551766894004;8330.50016998982;8557.144285571392;8560.657573696983;8565.528895910784;8579.957100214458;6414.166158399378;7512.774616761506;7589.924100758922;7622.5426474411715;7763.961180194063;7390.1131864174495;7448.292412220831;7478.887816682863;7577.431692623186;7581.886271705818;5920.407959204217;7011.929880701127;7104.11198600175;7126.857462850818;7136.0723105995885;3814.441742118253;4567.223571992703;4602.378678878308;4612.74629895359;4742.691725037862;4956.975215123901;5072.163093089599;5082.3138876252715;5136.332276804141;5158.4583618721 23:49:45 INFO - PROCESS | 1651 | |4;prototype.html;293.7062937062937;298.4493609290858;306.1336417937237;308.54027499026455;311.98596063177166;4526.370506617615;4770.8807279817975;5478.150886612571;5497.697626630534;5586.944130558693;4273.205253793407;4952.752362381884;5212.491195116226;5231.8751468434275;5469.316335458067;4141.792910354493;4181.560936101711;4193.329067349225;4202.222588821062;4213.946513371657;3361.428557145279;3841.9807900960595;4217.725847819897;4218.599233072869;4243.27864263076;3344.3812894614575;4102.594846277582;4122.690798190133;4141.544430112685;4146.730462519941;3381.966180338202;3591.748577599569;4102.835886564534;4102.917941641151;4162.542120366772;3566.4472006838982;3568.4647302904514;3571.3571557119967;3593.3531964246426;3595.442706380515;4305.784710764449;4832.516748325174;5216.765245563959;5400.648957817729;5452.454754524555;4200.789960501963;4706.529347065266;4726.291056341542;4731.810727570893;4734.7689600703725;4253.574642535753;5265.315508983846;5644.74598643062;5733.254676892019;5796.391378905197;3622.4242454532364;3815.9046023849346;3880.9029774255587;3890.3191941410423;3894.5910679378826;6022.879542409171;6074.757009719606;6085.934961381785;6090.299615544225;6118.919567347123;3141.591593092883;3667.669909708139;3940.8079455641023;3942.1918506706056;4015.819288131983;3287.474004159323;3507.5264839246884;3659.7255205859133;3953.584873588289;4022.899427514277;3977.5028121484816;4689.179393606173;4712.764361781898;4722.645801564897;4725.763711814464;5206.8437946860895;5828.6211396259105;5883.676397798076;5885.352611212763;5885.823425297248;1269.8666640002666;1322.6362750243568;1325.4499382756242;1345.3138899161497;1349.1718721132725;752.0899711349219;771.8572064168147;908.5321059654283;916.9317744827334;934.6681927915628;4851;5382.381026182039;5417.26866872975;5439.374471935699;5474.863128421821;4629.745364004944;5402.486763757437;5879.823605291848;5899.528037756969;5944.464998150101;4767.904641907143;4769.618430525549;5301.575873930076;5395.919061214085;5439.673619582838;2360.0441821062495;2427.684401027855;2544.4529426173463;2573.961390579143;2594.702648675662;4250.659947204216;4457;4541.500434952152;5015.774290156952;5111.923321150186;5018.866981532834;5024.748762561857;5046.621503387188;5628.212050312959;6201.503879689614;6231.504438934623;6255.466536052906;6273.686315684289;6285.8742825143245;6306.527010474141;4914.584110406565;6081.847953801191;6110.205673262625;6177.413145751147;6179.474744646755;5286.572625391046;5422.942526207352;5813.6221145625395;5983.7008149591475;5994.850128746816;4758.310045043519;5435.891282174413;5586.994341018656;5640;5659.26429564154;3689.6125906779403;3692.5568931728367;3975.8409663613133;4000.599940005976;4026.134381108076;4419.094085712357;5450.727463626882;5956.910646340221;5996.580239383201;6015.969920150371;5095.337606111182;5214.869628259324;5558.527525160407;5592.636478628876;5734.598578099493;4540.909181816412;5191.0425543606525;5831.591788574759;5873.182431419441;5908.438698323653;5019.0463811875625;5584.720763961867;5695.345035320825;5718.142278658234;5781.335146458043;5815.738291776795;5839.854003649943;5862.208601838868;5878.089620873318;5880.47107751979;4796.544328288807;5439;5738.221151443066;5763.492880596954;5790.565707571865 23:49:45 INFO - PROCESS | 1651 | |5;yui.html;576.668415660995;730.1894896664704;743.5129989856646;764.8852672099184;793.0087390761548;14823.777643335345;15550.688986220268;15745.527634170992;15761.763573546392;15790.36838526459;14582.489612863552;14685.486007989723;14694;14702.63243418915;14750.26248687564;656.737305077969;683.9418649414806;802.8675268580677;831.5925196653657;831.9143517709387;852.5012867472536;858.909814469481;859.2653281444337;860.5482121885997;861.7630151708299;908.0374802709149;908.0737647599444;911.5761171055458;912.8995810460844;913.4519288426924;903.1735961595133;903.3044555692146;904.2991681446898;904.9411788233743;907.0929070929071;670.1455644053822;671.6440286648035;672.0792514255453;673.0509980926919;675.8411773233336;14902;14981.625459363604;15161.317740701696;15189.240537973168;15199.316030778531;14450.349734261983;14466.782998255034;14554.417823287056;14565.053271537316;14610;10850.511726972305;11589.246698964625;11649.47577359021;11684.474198660995;11895.52417903283;2878.971210287912;3788.180875667906;3855.4216867469822;3988.561258261589;3991.042149884036;96549.9999999993;117534.41232793867;119939.21003034488;120969.39515302455;121657.78342216554;10936.56253749841;11003.119750419946;11347.886521134847;11364.829527557093;11498.827517587242;23288.53422931532;23457.77151170636;23473.530529389318;23491.647625285634;23519;7780.844383112306;7892.763217103496;7977.521348719096;8099.959500202462;8101.10887802353;3594.263176048904;4011.6991225657607;4195.538490766014;4377.606015458624;4464.441944756905;2995.9514170040748;3075.8923437680023;3291.440455122635;3353.329334133134;3669.192777588926;546.5354448718637;587.2189987316858;609.996950015256;618.3661746709658;619.553921176752;514.8558403646985;577.9190913272146;581.4098689829826;675.7330854312618;678.3826717686882;8807.515586642796;9165.266778657691;9371.484568348806;9488.383255088396;9692.286159875246;619.7582942652369;626.501930964884;639.4916041746823;661.2098542241974;677.9424098406502;4449.154660614473;4529.139463501924;4536.682432229778;4601.470830854495;4640.396748422683;93704.53147734354;117318.41340793412;128101;163361;167505;133811;135780;136669;138606;143827;77325.22674773181;95173.5241323789;101643.99999999852;109919.90080099256;111057;9508.714738557854;9785.36395134314;9791.314607977372;9947.801043979225;10041.397516149054;56407;56635.716821415626;61371;63282;64395.678021611464;88537;95407.52296238752;96585.5512167304;97586.0482790326;98869;10608.257421980386;11033.786283508647;11497.82753258685;11498.885011149781;11570.132240082195;14509.419623215375;15045.623859403164;15254.847451525786;15264.618384540476;15359.308831102851;12901.817821094512;13326.800097998732;13822.170669759847;14246.287685615885;14273.214973176575;13303.66740831487;13491.932540337628;13648.863511365156;13736.10715303502;14004.509842155476;13180.143290686075;13329.933350333575;13448.394822232827;13496.055276130577;13699.109557878706;10834.67495975122;11130.833037504606;11354.489047993025;11755.118366122746;11767.411629418666;9953.203743700342;10128.987101289813;11099.112071034137;11314.60398886035;11343.886561134283 23:49:45 INFO - PROCESS | 1651 | __end_tp_report 23:49:45 INFO - PROCESS | 1651 | __start_cc_report 23:49:45 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,361 23:49:45 INFO - PROCESS | 1651 | __end_cc_report 23:49:45 INFO - PROCESS | 1651 | __startTimestamp1475822985323__endTimestamp 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | ------- Summary: start ------- 23:49:45 INFO - PROCESS | 1651 | Number of tests: 6 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5719.02 Median:6050.18 stddev:694.76 (11.5%) stddev-sans-first:666.00 23:49:45 INFO - PROCESS | 1651 | Values: 3107.8 3374.0 3417.7 3433.5 3452.5 5645.8 5779.2 5793.0 5798.3 5888.9 5677.0 5803.6 5812.6 5836.5 5851.6 3726.1 4177.1 4794.8 4863.0 5213.6 4289.8 4398.8 5322.8 5329.2 5364.5 5335.8 5343.1 5350.3 5356.1 5370.8 4302.5 5304.5 5317.7 5337.9 5346.9 5201.7 5282.6 5282.9 5298.5 5307.8 5788.9 5800.7 5878.9 5887.5 5921.5 5979.3 6148.4 6156.8 6171.4 6197.1 6128.5 6140.2 6149.5 6173.5 6217.7 4868.9 5977.9 5979.9 5992.8 6007.6 6333.9 6339.7 6349.8 6360.7 6362.4 6050.2 6129.9 6136.5 6142.9 6161.1 6109.5 6118.4 6156.1 6182.9 6202.2 6102.8 6152.0 6158.7 6178.8 6194.2 6112.0 6125.1 6132.1 6162.1 6181.9 4960.2 4963.0 4987.9 5006.0 5013.8 4455.2 4473.8 4491.9 4499.2 4515.8 5319.5 5805.1 5837.4 5876.9 5895.9 6220.8 6234.3 6236.8 6244.4 6250.9 5935.8 5942.4 5954.6 5957.4 5963.1 5369.7 5443.5 5448.5 5502.7 5549.2 6420.5 6422.7 6427.0 6431.6 6431.7 6238.7 6243.2 6244.5 6264.1 6264.6 6172.7 6208.5 6236.2 6260.9 6385.8 6130.8 6160.6 6193.3 6200.4 6202.2 6091.0 6174.6 6197.5 6233.9 6240.4 6091.6 6115.9 6159.1 6160.0 6219.8 6096.7 6116.8 6160.0 6185.4 6192.0 4989.5 5411.0 6086.9 6087.3 6101.9 4637.5 5107.4 5997.7 6103.2 6135.8 5159.3 6074.0 6087.8 6112.4 6122.5 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:68047.97 Median:39819.30 stddev:148985.06 (374.2%) stddev-sans-first:149316.49 23:49:45 INFO - PROCESS | 1651 | Values: 424.7 489.1 516.8 518.0 524.8 33755.5 34362.0 36625.0 40475.0 42787.6 41519.0 41809.4 41853.2 42007.2 42069.6 9673.7 9821.8 9841.6 9863.0 9878.0 8078.8 9744.7 9744.8 9776.0 9819.9 9747.1 9770.5 9814.9 9826.2 9828.2 9747.7 9787.3 9796.9 9805.1 9820.9 9739.6 9743.8 9792.2 9800.2 9835.6 32058.2 39489.8 39575.0 39680.0 39769.8 3236.8 3286.3 3334.2 3352.8 3460.4 28559.7 29685.9 30244.8 30283.7 30528.7 3165.3 3276.5 3326.5 3394.7 3398.5 410892.0 417114.0 417624.9 418354.0 418703.0 56579.7 56910.4 57487.0 57505.4 57512.1 59370.7 59689.7 59726.7 59761.4 60088.9 12055.9 15107.4 15792.2 16226.9 16254.0 12465.4 12502.7 12505.9 12515.6 12520.6 12200.9 16926.7 17897.3 18159.0 18228.5 2731.2 3136.3 3244.8 7564.8 7715.9 812.5 859.4 957.3 976.5 1030.3 24162.9 29147.0 30574.6 31578.0 32505.0 947.6 1027.8 1029.6 1062.9 1145.2 14263.7 14847.7 15239.7 15327.9 15663.3 584386.0 642764.0 643646.0 648397.0 649146.0 54486.5 55140.0 55163.7 55234.2 55291.7 1342.1 1358.7 1372.2 1390.7 1403.7 28978.3 29022.1 29095.1 29679.6 29815.7 48538.0 48587.3 49142.0 49167.0 49212.0 592998.0 595173.2 596312.0 596768.0 599145.0 39868.8 40417.2 41035.1 41127.8 42929.4 44119.3 44132.8 44853.0 45291.5 45564.5 31484.0 32004.5 36974.1 38199.2 39025.8 36882.9 37205.8 37285.3 38315.8 38397.4 29516.3 36495.0 37092.3 37141.4 37267.4 31918.4 33064.3 33873.8 33900.8 34914.7 24458.0 24467.5 24741.6 24981.0 25357.5 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:36383.90 Median:33978.50 stddev:100303.51 (295.2%) stddev-sans-first:100548.33 23:49:45 INFO - PROCESS | 1651 | Values: 312.9 370.1 375.6 380.4 391.0 16782.7 19770.0 19942.0 20331.0 20593.0 19818.7 20001.2 20023.4 20269.3 20311.4 5871.1 5885.3 6174.8 6175.1 6187.5 5900.7 6095.4 6095.8 6101.4 6112.2 5770.6 6053.9 6059.6 6062.0 6072.9 6079.9 6113.3 6156.9 6162.4 6163.8 5878.7 5938.3 5952.4 5978.1 6036.9 13149.3 13346.9 13350.2 22511.8 26944.2 2375.3 2379.5 2580.9 3415.9 3486.9 16017.0 17085.2 17449.6 17702.0 18015.7 2001.1 2031.2 2044.5 2082.9 2087.7 133194.0 134191.3 139492.3 140408.0 142265.0 17363.5 19826.4 20421.6 20552.4 21023.4 33849.5 33941.0 34016.0 34052.3 34055.1 10221.2 10406.8 10650.3 10657.4 10669.5 6706.7 8675.3 8682.9 8694.6 8819.8 7751.8 8178.6 9082.0 9379.3 9702.5 2996.8 3321.9 3582.2 3849.4 3957.7 839.9 929.9 945.2 960.8 980.9 19388.0 19587.3 20815.0 20839.3 21322.7 925.8 945.5 946.9 947.3 947.9 10766.8 11049.8 11061.7 11062.7 11065.4 588858.0 592732.0 601260.0 603215.0 605457.9 119431.0 122241.4 126567.4 133642.0 138289.0 431.7 446.0 446.5 447.8 450.2 9323.1 10581.4 10916.5 11300.4 11344.1 46588.5 53566.7 53787.0 54308.5 55019.4 80956.0 81589.2 81865.8 82607.2 82715.6 7637.5 7836.7 7982.8 8239.6 8244.9 11091.7 11685.2 12433.4 12475.4 12706.6 10923.7 11079.3 11119.7 11175.1 11237.3 10708.6 10745.6 10873.2 10985.4 11024.5 11151.7 11211.3 11246.9 11302.7 11362.4 7809.9 7838.8 8008.2 8037.0 8143.7 8095.4 10385.0 10512.1 10716.8 10910.9 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5620.85 Median:4823.54 stddev:3152.99 (65.4%) stddev-sans-first:3145.25 23:49:45 INFO - PROCESS | 1651 | Values: 1316.9 1493.6 1660.2 1833.1 1862.5 8042.9 8323.0 8489.7 9003.2 9027.1 8473.3 8748.7 8785.0 8887.0 8893.3 2323.5 2355.7 2360.6 2362.3 2364.3 2307.9 2343.5 2346.5 2369.2 2371.4 2007.7 2260.0 2347.6 2358.4 2359.6 2309.6 2329.3 2337.1 2340.6 2362.9 1756.3 1853.6 2336.9 2338.5 2338.8 7487.4 8970.0 9001.8 9018.5 9029.3 5188.9 5273.8 5355.6 5370.7 5380.0 3482.8 3541.0 3589.7 3689.1 3707.5 1041.8 1072.6 1079.1 1085.6 1105.1 9193.9 11600.7 11681.2 11738.2 11749.8 3965.2 4530.4 4587.2 4773.8 4805.0 9890.5 10032.6 10046.1 10048.8 10048.8 4369.8 5253.7 5283.3 5336.0 5380.3 4372.4 4529.1 4666.0 4842.1 4881.2 3842.0 3898.5 3982.1 3990.7 4061.8 1264.0 1268.0 1273.5 1275.3 1281.4 841.8 845.4 905.8 914.5 924.8 5673.7 5801.4 5993.4 6030.0 6044.8 944.8 952.2 965.3 971.0 1004.1 3862.7 4005.2 4020.7 4067.1 4094.8 10444.1 10855.1 10869.7 10875.3 10901.9 10091.4 10581.5 10622.1 10755.4 10838.7 6130.0 8234.8 8240.7 8259.1 8273.4 5184.4 5208.7 5876.9 6017.7 6205.7 8413.8 8726.5 9911.4 10178.6 10204.8 8438.8 8626.4 8992.6 9976.8 10486.5 7022.9 7032.9 7265.8 7461.9 7470.6 8330.5 8557.1 8560.7 8565.5 8580.0 6414.2 7512.8 7589.9 7622.5 7764.0 7390.1 7448.3 7478.9 7577.4 7581.9 5920.4 7011.9 7104.1 7126.9 7136.1 3814.4 4567.2 4602.4 4612.7 4742.7 4957.0 5072.2 5082.3 5136.3 5158.5 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4555.79 Median:5018.96 stddev:1453.33 (29.0%) stddev-sans-first:1421.76 23:49:45 INFO - PROCESS | 1651 | Values: 293.7 298.4 306.1 308.5 312.0 4526.4 4770.9 5478.2 5497.7 5586.9 4273.2 4952.8 5212.5 5231.9 5469.3 4141.8 4181.6 4193.3 4202.2 4213.9 3361.4 3842.0 4217.7 4218.6 4243.3 3344.4 4102.6 4122.7 4141.5 4146.7 3382.0 3591.7 4102.8 4102.9 4162.5 3566.4 3568.5 3571.4 3593.4 3595.4 4305.8 4832.5 5216.8 5400.6 5452.5 4200.8 4706.5 4726.3 4731.8 4734.8 4253.6 5265.3 5644.7 5733.3 5796.4 3622.4 3815.9 3880.9 3890.3 3894.6 6022.9 6074.8 6085.9 6090.3 6118.9 3141.6 3667.7 3940.8 3942.2 4015.8 3287.5 3507.5 3659.7 3953.6 4022.9 3977.5 4689.2 4712.8 4722.6 4725.8 5206.8 5828.6 5883.7 5885.4 5885.8 1269.9 1322.6 1325.4 1345.3 1349.2 752.1 771.9 908.5 916.9 934.7 4851.0 5382.4 5417.3 5439.4 5474.9 4629.7 5402.5 5879.8 5899.5 5944.5 4767.9 4769.6 5301.6 5395.9 5439.7 2360.0 2427.7 2544.5 2574.0 2594.7 4250.7 4457.0 4541.5 5015.8 5111.9 5018.9 5024.7 5046.6 5628.2 6201.5 6231.5 6255.5 6273.7 6285.9 6306.5 4914.6 6081.8 6110.2 6177.4 6179.5 5286.6 5422.9 5813.6 5983.7 5994.9 4758.3 5435.9 5587.0 5640.0 5659.3 3689.6 3692.6 3975.8 4000.6 4026.1 4419.1 5450.7 5956.9 5996.6 6016.0 5095.3 5214.9 5558.5 5592.6 5734.6 4540.9 5191.0 5831.6 5873.2 5908.4 5019.0 5584.7 5695.3 5718.1 5781.3 5815.7 5839.9 5862.2 5878.1 5880.5 4796.5 5439.0 5738.2 5763.5 5790.6 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24628.36 Median:3473.80 stddev:39261.42 (1130.2%) stddev-sans-first:39330.02 23:49:45 INFO - PROCESS | 1651 | Values: 576.7 730.2 743.5 764.9 793.0 14823.8 15550.7 15745.5 15761.8 15790.4 14582.5 14685.5 14694.0 14702.6 14750.3 656.7 683.9 802.9 831.6 831.9 852.5 858.9 859.3 860.5 861.8 908.0 908.1 911.6 912.9 913.5 903.2 903.3 904.3 904.9 907.1 670.1 671.6 672.1 673.1 675.8 14902.0 14981.6 15161.3 15189.2 15199.3 14450.3 14466.8 14554.4 14565.1 14610.0 10850.5 11589.2 11649.5 11684.5 11895.5 2879.0 3788.2 3855.4 3988.6 3991.0 96550.0 117534.4 119939.2 120969.4 121657.8 10936.6 11003.1 11347.9 11364.8 11498.8 23288.5 23457.8 23473.5 23491.6 23519.0 7780.8 7892.8 7977.5 8100.0 8101.1 3594.3 4011.7 4195.5 4377.6 4464.4 2996.0 3075.9 3291.4 3353.3 3669.2 546.5 587.2 610.0 618.4 619.6 514.9 577.9 581.4 675.7 678.4 8807.5 9165.3 9371.5 9488.4 9692.3 619.8 626.5 639.5 661.2 677.9 4449.2 4529.1 4536.7 4601.5 4640.4 93704.5 117318.4 128101.0 163361.0 167505.0 133811.0 135780.0 136669.0 138606.0 143827.0 77325.2 95173.5 101644.0 109919.9 111057.0 9508.7 9785.4 9791.3 9947.8 10041.4 56407.0 56635.7 61371.0 63282.0 64395.7 88537.0 95407.5 96585.6 97586.0 98869.0 10608.3 11033.8 11497.8 11498.9 11570.1 14509.4 15045.6 15254.8 15264.6 15359.3 12901.8 13326.8 13822.2 14246.3 14273.2 13303.7 13491.9 13648.9 13736.1 14004.5 13180.1 13329.9 13448.4 13496.1 13699.1 10834.7 11130.8 11354.5 11755.1 11767.4 9953.2 10129.0 11099.1 11314.6 11343.9 23:49:45 INFO - PROCESS | 1651 | -------- Summary: end -------- 23:49:45 INFO - PROCESS | 1651 | 23:49:45 INFO - TEST-INFO | 1651: exit 0 23:49:45 INFO - TEST-OK | dromaeo_css | took 1117102ms 23:49:45 INFO - TEST-START | kraken 23:49:45 INFO - operating with platform_type : mac_ 23:49:45 INFO - Initialising browser for kraken test... 23:49:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpEb4rBM/profile http://localhost:49280/getInfo.html) 23:49:48 INFO - PROCESS | 1663 | 2016-10-06 23:49:48.480 plugin-container[1664:9912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.tsm.portname' 23:49:48 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:48 INFO - PROCESS | 1663 | 2016-10-06 23:49:48.482 plugin-container[1664:9912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 23:49:48 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:48 INFO - PROCESS | 1663 | 2016-10-06 23:49:48.482 plugin-container[1664:9912] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:49:48 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 23:49:48 INFO - PROCESS | 1663 | colorDepth:24 23:49:48 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 23:49:48 INFO - PROCESS | 1663 | __metrics 23:49:48 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:49:49 INFO - TEST-INFO | 1663: exit 0 23:49:49 INFO - Browser initialized. 23:49:49 INFO - Running cycle 1/1 for kraken test... 23:49:49 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpEb4rBM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:51 INFO - PROCESS | 1665 | 2016-10-06 23:49:51.577 plugin-container[1666:10026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891b, name = 'com.apple.tsm.portname' 23:49:51 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:51 INFO - PROCESS | 1665 | 2016-10-06 23:49:51.581 plugin-container[1666:10026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 23:49:51 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:49:51 INFO - PROCESS | 1665 | 2016-10-06 23:49:51.581 plugin-container[1666:10026] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:50:01 INFO - PROCESS | 1665 | RSS: Main: 239980544 23:50:01 INFO - PROCESS | 1665 | 23:50:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 23:50:05 INFO - PROCESS | 1665 | RSS: Main: 253808640 23:50:05 INFO - PROCESS | 1665 | 23:50:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 23:50:08 INFO - PROCESS | 1665 | RSS: Main: 261398528 23:50:08 INFO - PROCESS | 1665 | 23:50:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 23:50:12 INFO - PROCESS | 1665 | RSS: Main: 262139904 23:50:12 INFO - PROCESS | 1665 | 23:50:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 23:50:15 INFO - PROCESS | 1665 | RSS: Main: 263393280 23:50:15 INFO - PROCESS | 1665 | 23:50:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:50:18 INFO - PROCESS | 1665 | RSS: Main: 263729152 23:50:18 INFO - PROCESS | 1665 | 23:50:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 23:50:21 INFO - PROCESS | 1665 | RSS: Main: 263823360 23:50:21 INFO - PROCESS | 1665 | 23:50:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 23:50:25 INFO - PROCESS | 1665 | RSS: Main: 264065024 23:50:25 INFO - PROCESS | 1665 | 23:50:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 23:50:28 INFO - PROCESS | 1665 | RSS: Main: 264216576 23:50:28 INFO - PROCESS | 1665 | 23:50:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:50:30 INFO - PROCESS | 1665 | RSS: Main: 263974912 23:50:30 INFO - PROCESS | 1665 | 23:50:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:50:33 INFO - PROCESS | 1665 | RSS: Main: 264019968 23:50:33 INFO - PROCESS | 1665 | 23:50:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:50:36 INFO - PROCESS | 1665 | RSS: Main: 264052736 23:50:36 INFO - PROCESS | 1665 | 23:50:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:50:40 INFO - PROCESS | 1665 | RSS: Main: 265613312 23:50:40 INFO - PROCESS | 1665 | 23:50:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:50:43 INFO - PROCESS | 1665 | RSS: Main: 265723904 23:50:43 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 23:50:45 INFO - PROCESS | 1665 | RSS: Main: 267227136 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | __start_tp_report 23:50:45 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 23:50:45 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 23:50:45 INFO - PROCESS | 1665 | |i|pagename|runs| 23:50:45 INFO - PROCESS | 1665 | |0;ai-astar;115;171;104;161;175;175;116;119;118;124 23:50:45 INFO - PROCESS | 1665 | |1;audio-beat-detection;148;117;113;143;148;151;103;98;127;133 23:50:45 INFO - PROCESS | 1665 | |2;audio-dft;207;239;199;199;197;202;194;199;200;200 23:50:45 INFO - PROCESS | 1665 | |3;audio-fft;83;58;60;86;73;72;53;61;92;88 23:50:45 INFO - PROCESS | 1665 | |4;audio-oscillator;83;72;111;107;103;74;90;72;71;85 23:50:45 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;90;88;91;89;91;87;91;89;90;87 23:50:45 INFO - PROCESS | 1665 | |6;imaging-darkroom;124;152;154;97;96;96;96;105;97;103 23:50:45 INFO - PROCESS | 1665 | |7;imaging-desaturate;98;94;90;90;91;109;90;92;88;93 23:50:45 INFO - PROCESS | 1665 | |8;json-parse-financial;57;55;56;57;56;58;65;88;89;56 23:50:45 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;67;83;91;84;76;72;71;71;72;70 23:50:45 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;79;85;87;75;101;108;111;112;89;87 23:50:45 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;147;146;146;156;172;174;145;148;211;173 23:50:45 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;175;241;228;180;176;174;185;174;179;178 23:50:45 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;69;72;74;71;69;73;95;95;95;73 23:50:45 INFO - PROCESS | 1665 | __end_tp_report 23:50:45 INFO - PROCESS | 1665 | __start_cc_report 23:50:45 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,954 23:50:45 INFO - PROCESS | 1665 | __end_cc_report 23:50:45 INFO - PROCESS | 1665 | __startTimestamp1475823045786__endTimestamp 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | ------- Summary: start ------- 23:50:45 INFO - PROCESS | 1665 | Number of tests: 14 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:137.80 Median:142.50 stddev:28.83 (20.2%) stddev-sans-first:29.38 23:50:45 INFO - PROCESS | 1665 | Values: 115.0 171.0 104.0 161.0 175.0 175.0 116.0 119.0 118.0 124.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:145.50 stddev:19.58 (13.5%) stddev-sans-first:19.40 23:50:45 INFO - PROCESS | 1665 | Values: 148.0 117.0 113.0 143.0 148.0 151.0 103.0 98.0 127.0 133.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:203.60 Median:200.00 stddev:12.88 (6.4%) stddev-sans-first:13.60 23:50:45 INFO - PROCESS | 1665 | Values: 207.0 239.0 199.0 199.0 197.0 202.0 194.0 199.0 200.0 200.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:72.60 Median:78.00 stddev:14.11 (18.1%) stddev-sans-first:14.46 23:50:45 INFO - PROCESS | 1665 | Values: 83.0 58.0 60.0 86.0 73.0 72.0 53.0 61.0 92.0 88.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:73.00 stddev:15.40 (21.1%) stddev-sans-first:16.28 23:50:45 INFO - PROCESS | 1665 | Values: 83.0 72.0 111.0 107.0 103.0 74.0 90.0 72.0 71.0 85.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:90.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 23:50:45 INFO - PROCESS | 1665 | Values: 90.0 88.0 91.0 89.0 91.0 87.0 91.0 89.0 90.0 87.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:96.00 stddev:23.23 (24.2%) stddev-sans-first:24.23 23:50:45 INFO - PROCESS | 1665 | Values: 124.0 152.0 154.0 97.0 96.0 96.0 96.0 105.0 97.0 103.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:91.50 stddev:6.11 (6.7%) stddev-sans-first:6.26 23:50:45 INFO - PROCESS | 1665 | Values: 98.0 94.0 90.0 90.0 91.0 109.0 90.0 92.0 88.0 93.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:57.50 stddev:13.37 (23.2%) stddev-sans-first:13.96 23:50:45 INFO - PROCESS | 1665 | Values: 57.0 55.0 56.0 57.0 56.0 58.0 65.0 88.0 89.0 56.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:74.00 stddev:7.72 (10.4%) stddev-sans-first:7.52 23:50:45 INFO - PROCESS | 1665 | Values: 67.0 83.0 91.0 84.0 76.0 72.0 71.0 71.0 72.0 70.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:82.00 stddev:13.52 (16.5%) stddev-sans-first:13.29 23:50:45 INFO - PROCESS | 1665 | Values: 79.0 85.0 87.0 75.0 101.0 108.0 111.0 112.0 89.0 87.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:164.00 stddev:21.14 (12.9%) stddev-sans-first:21.74 23:50:45 INFO - PROCESS | 1665 | Values: 147.0 146.0 146.0 156.0 172.0 174.0 145.0 148.0 211.0 173.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.00 Median:179.50 stddev:24.40 (13.6%) stddev-sans-first:25.35 23:50:45 INFO - PROCESS | 1665 | Values: 175.0 241.0 228.0 180.0 176.0 174.0 185.0 174.0 179.0 178.0 23:50:45 INFO - PROCESS | 1665 | 23:50:45 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:73.50 stddev:11.43 (15.6%) stddev-sans-first:11.59 23:50:45 INFO - PROCESS | 1665 | Values: 69.0 72.0 74.0 71.0 69.0 73.0 95.0 95.0 95.0 73.0 23:50:45 INFO - PROCESS | 1665 | -------- Summary: end -------- 23:50:45 INFO - PROCESS | 1665 | 23:50:46 INFO - TEST-INFO | 1665: exit 0 23:50:46 INFO - TEST-OK | kraken | took 60804ms 23:50:46 INFO - SUITE-END | took 1177s 23:50:46 INFO - Completed test suite (00:19:38) 23:50:46 INFO - javascript benchmark 23:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7371.721830986165, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.782455228134, 3374.0215337552113, 3417.7265818734504, 3433.467812489065, 3452.4648679454676, 5645.830625081244, 5779.248697669303, 5792.971035144824, 5798.3042034955815, 5888.882222355551, 5677.006523858329, 5803.564732645058, 5812.564057695668, 5836.533077353812, 5851.6196447230905, 3726.06848287928, 4177.143685544472, 4794.849236183309, 4862.951370486303, 5213.582913366931, 4289.785510724467, 4398.8020539075815, 5322.76047577858, 5329.173978033411, 5364.517193452608, 5335.7865685372535, 5343.118385466393, 5350.3312085989255, 5356.116240820279, 5370.785168593252, 4302.483701955785, 5304.469553044703, 5317.6809391436445, 5337.919931201035, 5346.866328341784, 5201.661891977009, 5282.603804714662, 5282.867928301785, 5298.496642818926, 5307.840764777063, 5788.855278618026, 5800.680962547058, 5878.941210587925, 5887.470127688486, 5921.496672782776, 5979.252593425822, 6148.446639802394, 6156.815295541141, 6171.444569988677, 6197.0704394340755, 6128.533679014817, 6140.232470941132, 6149.477294429978, 6173.475254603364, 6217.720202590895, 4868.853934381974, 5977.910331345077, 5979.9402005980255, 5992.790252341147, 6007.579469437185, 6333.904991425133, 6339.683015849189, 6349.809505714836, 6360.7137678804565, 6362.395572420613, 6050.183225264533, 6129.908051379233, 6136.539759518054, 6142.938570614237, 6161.137440758297, 6109.495762817132, 6118.388161183935, 6156.107364432132, 6182.938170618237, 6202.162708034448, 6102.847428814226, 6152.0, 6158.7228574714245, 6178.814635560941, 6194.194754681953, 6112.017184454359, 6125.082842094198, 6132.110843927606, 6162.137300777895, 6181.907271390933, 4960.206366981266, 4962.950370496249, 4987.925181122286, 5005.973775376039, 5013.774380152902, 4455.242608756519, 4473.7986790594505, 4491.910161796745, 4499.212637788374, 4515.774211289422, 5319.494648008433, 5805.071188609802, 5837.357890632027, 5876.941230587725, 5895.94104058954, 6220.782272620437, 6234.251889773165, 6236.781712640036, 6244.406781355764, 6250.937490625127, 5935.821925342247, 5942.405759424109, 5954.642721436728, 5957.3744756799915, 5963.075723262901, 5369.650972686841, 5443.5100840923715, 5448.536874365644, 5502.669839809624, 5549.19536667181, 6420.5184611154355, 6422.710978006095, 6427.0, 6431.5819471734185, 6431.678416079271, 6238.656873871981, 6243.188385509855, 6244.46922011616, 6264.091706702411, 6264.59280146789, 6172.6913654318005, 6208.534359923115, 6236.220472440945, 6260.874782504416, 6385.808425747235, 6130.816075517741, 6160.568760186744, 6193.318734939063, 6200.3799620037635, 6202.162708034538, 6091.0, 6174.567780255339, 6197.504199664107, 6233.937660623517, 6240.4071613196675, 6091.634501929899, 6115.909724157069, 6159.137720719193, 6160.0, 6219.782307619212, 6096.677875983316, 6116.755329786759, 6159.969200153971, 6185.381461853779, 6192.0, 4989.525995030466, 5411.02601531728, 6086.878262434638, 6087.330393656783, 6101.877962440815, 4637.536246375335, 5107.438181799925, 5997.730102145327, 6103.246756470893, 6135.84660383494, 5159.329287192641, 6074.0, 6087.817365479043, 6112.381899552462, 6122.540809439399], "value": 5674.7094625568225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.745152908255, 489.09761490050846, 516.8346129238645, 518.028696194635, 524.8477941396998, 33755.49366759497, 34362.0, 36625.0, 40475.0, 42787.57212427875, 41519.0, 41809.372859407136, 41853.162936741246, 42007.15985680292, 42069.57930420695, 9673.661421850255, 9821.754456138618, 9841.55712992917, 9863.0, 9877.950610246939, 8078.798030049237, 9744.707658770249, 9744.805103897917, 9775.951120244388, 9819.852702209473, 9747.074027967366, 9770.511474426286, 9814.90185098147, 9826.16477599405, 9828.21374290055, 9747.707568772912, 9787.314887957846, 9796.90203097967, 9805.117539421486, 9820.90179098207, 9739.610415583367, 9743.756406089833, 9792.16766574842, 9800.166985806214, 9835.557399917021, 32058.198545036328, 39489.802550987064, 39575.0, 39680.0, 39769.801150994346, 3236.8219747913854, 3286.3263031078573, 3334.1755470673534, 3352.765306428551, 3460.3944309745693, 28559.71440285612, 29685.851570742223, 30244.8487757562, 30283.697163028308, 30528.694713053028, 3165.287810242677, 3276.4921437177277, 3326.4843949187916, 3394.694477497037, 3398.5242066110764, 410892.0, 417114.0, 417624.9118754417, 418353.999999997, 418703.0, 56579.71710141423, 56910.430895691345, 57487.0, 57505.424945750005, 57512.137317940265, 59370.70314648399, 59689.70155149196, 59726.70136649289, 59761.40238597646, 60088.892444141864, 12055.879441205476, 15107.39570417171, 15792.21038948048, 16226.918865405834, 16254.024758514526, 12465.439055242536, 12502.74994500105, 12505.937470312772, 12515.56195533152, 12520.624381268577, 12200.877991219973, 16926.74609880853, 17897.28410863577, 18159.00125493084, 18228.45314640563, 2731.2216018435047, 3136.325689976666, 3244.8053116813066, 7564.848703025908, 7715.884261736079, 812.475953010305, 859.3726579596929, 957.3394357893031, 976.5019839881569, 1030.2891005206384, 24162.87918560396, 29146.979855704947, 30574.55403567709, 31578.0, 32505.0, 947.6067432015636, 1027.8201314769885, 1029.552144817007, 1062.877769056553, 1145.2441388683428, 14263.716265536152, 14847.70304593902, 15239.695206095816, 15327.927045106735, 15663.295151718201, 584386.0, 642764.0, 643646.0, 648397.0, 649146.0, 54486.45513544893, 55140.0, 55163.724181378835, 55234.171487427724, 55291.72354138204, 1342.1074985134971, 1358.660334916271, 1372.2315503318173, 1390.6731917999261, 1403.6701375176622, 28978.27554311159, 29022.12933611995, 29095.12714618565, 29679.554806677486, 29815.701842981292, 48538.0, 48587.27119093146, 49142.0, 49167.01665966732, 49212.0, 592998.0, 595173.2172052182, 596312.0, 596768.0, 599145.0, 39868.800655996536, 40417.19165616613, 41035.12754107184, 41127.794361028005, 42929.35605965975, 44119.33820992752, 44132.779336103114, 44853.0, 45291.54708453005, 45564.54435455603, 31484.0, 32004.5199322015, 36974.075648109014, 38199.2360152801, 39025.804870975466, 36882.89351319465, 37205.81397092997, 37285.25429491341, 38315.808420957714, 38397.42403864, 29516.262093446978, 36495.0, 37092.25815483729, 37141.442878356305, 37267.44098838574, 31918.36163276768, 33064.33871322608, 33873.830630846685, 33900.83049584736, 34914.65085349114, 24458.021679132635, 24467.51064978655, 24741.62887556652, 24981.000759969396, 25357.492850142524], "value": 19422.82585885439, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.9499280115182, 370.10619354259467, 375.566221014728, 380.3552977702795, 391.0477986103837, 16782.74825877613, 19770.0, 19942.002899855022, 20331.0, 20592.970351482403, 19818.702719459183, 20001.199952001938, 20023.399298021046, 20269.290574829884, 20311.390658280274, 5871.119332100187, 5885.264341957255, 6174.783882564111, 6175.104609831572, 6187.4740647045055, 5900.704964751767, 6095.390460953913, 6095.81712548622, 6101.35935726749, 6112.235970503687, 5770.567207459437, 6053.878922421549, 6059.606125601822, 6062.0, 6072.906876762181, 6079.939200608003, 6113.296970848365, 6156.907646385308, 6162.383761623847, 6163.8150855474405, 5878.676672782995, 5938.346781853993, 5952.434518720715, 5978.103284507315, 6036.909446358308, 13149.276789776559, 13346.866531334757, 13350.198988060747, 22511.77488225113, 26944.191674249803, 2375.3467796355967, 2379.512199998996, 2580.9483810323686, 3415.9487607685905, 3486.8779592714386, 16017.0, 17085.231164597622, 17449.563760905952, 17702.0, 18015.72976405355, 2001.1395100106947, 2031.177373163871, 2044.47865794223, 2082.885441300728, 2087.7285952826187, 133194.0, 134191.32904335513, 139492.30253848768, 140408.0, 142265.0, 17363.53048789627, 19826.413886889015, 20421.630430978723, 20552.38342849687, 21023.369298921058, 33849.492257616155, 33941.0, 34016.0, 34052.31895362079, 34055.14862128417, 10221.182305415548, 10406.791864162675, 10650.254482186172, 10657.413842238751, 10669.466526673636, 6706.692195022021, 8675.349348798865, 8682.913170868336, 8694.608742606599, 8819.823603527893, 7751.806204844924, 8178.583564874901, 9082.000979892338, 9379.296552758571, 9702.54461830731, 2996.805207661495, 3321.9169520762175, 3582.158192824684, 3849.4225866119746, 3957.6635985941516, 839.9160083991552, 929.8837645294338, 945.2343601682659, 960.7934294126796, 980.9362391444533, 19388.03059847002, 19587.34030429661, 20815.0, 20839.270625528035, 21322.680159797615, 925.7916968681992, 945.522511131874, 946.9100435458621, 947.308464820671, 947.8720372749729, 10766.838497422545, 11049.834252486218, 11061.72345691348, 11062.723431914266, 11065.446727663584, 588858.0, 592732.0, 601260.0, 603215.0, 605457.945420549, 119431.0, 122241.38879305546, 126567.3671631636, 133642.0, 138288.999999998, 431.71506805508216, 445.97101188422647, 446.51107037793565, 447.84773177119934, 450.15595757953184, 9323.070929460375, 10581.36511809294, 10916.50875710579, 11300.378479183724, 11344.092472602337, 46588.53411465978, 53566.732166338916, 53787.0, 54308.45691543034, 55019.449805503034, 80956.0, 81589.18410815815, 81865.77201341865, 82607.17392825994, 82715.5864220675, 7637.5035622684345, 7836.70222023303, 7982.84677552352, 8239.629216685384, 8244.876326854983, 11091.667249982513, 11685.182037257651, 12433.37833108359, 12475.376231188586, 12706.555270565486, 10923.726906827074, 11079.279846809932, 11119.72200694989, 11175.10599152082, 11237.3257604544, 10708.625198118028, 10745.623903163352, 10873.184511161537, 10985.395803230898, 11024.5038973248, 11151.665450036511, 11211.327320360479, 11246.943765281121, 11302.717432064264, 11362.431878405881, 7809.882851757115, 7838.804029899298, 8008.239217274583, 8036.955195824506, 8143.714969976022, 8095.352371810359, 10385.0, 10512.053915147673, 10716.839247411452, 10910.890891090987], "value": 10154.603161864763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.8880645145164, 1493.5743313155747, 1660.1948055193236, 1833.1201023508725, 1862.5250561106916, 8042.879356809653, 8323.0, 8489.702860399888, 9003.189712925836, 9027.142421469965, 8473.322134229247, 8748.650053997833, 8784.95607521963, 8886.95556522218, 8893.288536917047, 2323.500447403808, 2355.693759811222, 2360.563295790276, 2362.2676970139228, 2364.267077206063, 2307.9192228272013, 2343.472718638301, 2346.4603141277516, 2369.18263199196, 2371.3834403055157, 2007.7490313710787, 2260.0168926516935, 2347.600907845662, 2358.3750306168877, 2359.6460530920413, 2309.618912879373, 2329.2779238436055, 2337.0534933351933, 2340.590396680574, 2362.9054837806466, 1756.306259027677, 1853.5551467647801, 2336.918207862717, 2338.4621537046573, 2338.7895089441863, 7487.401007919408, 8970.013298537157, 9001.774955626097, 9018.503982280972, 9029.277657787361, 5188.948110518884, 5273.815416460444, 5355.6251062425645, 5370.650907691027, 5379.9731001345135, 3482.7736197147105, 3541.0, 3589.73077019222, 3689.0777305673582, 3707.480952666629, 1041.7656027393853, 1072.6353039966448, 1079.1420820447684, 1085.6146068145852, 1105.060698406356, 9193.908060919439, 11600.6519804406, 11681.182317237712, 11738.178327517076, 11749.823752643717, 3965.167314863911, 4530.388397566287, 4587.197240482902, 4773.809047638056, 4805.0, 9890.505474726235, 10032.64885728996, 10046.14607758334, 10048.79902401948, 10048.849267260997, 4369.847055353048, 5253.658512196695, 5283.313169288045, 5336.0, 5380.3274590676165, 4372.431583894074, 4529.09418116378, 4666.020135771526, 4842.080004799077, 4881.219004959189, 3841.980790096032, 3898.4542164096483, 3982.1040265939932, 3990.7406018609277, 4061.7766022868436, 1263.9620811375673, 1267.9873201268053, 1273.4969686973593, 1275.3495717184303, 1281.4297637551388, 841.8063845315489, 845.3955421873267, 905.8460061789511, 914.4696076275744, 924.7919218175991, 5673.659580425187, 5801.361850196475, 5993.370696076936, 6029.969850150721, 6044.818655440344, 944.7906679450315, 952.2239374909427, 965.3290962780941, 970.9902900971041, 1004.0662184168793, 3862.6801317364384, 4005.218982298482, 4020.6576896951224, 4067.08490589615, 4094.754314741125, 10444.060034596923, 10855.077318427864, 10869.67390978272, 10875.347479151276, 10901.890981090246, 10091.394516328897, 10581.470926453647, 10622.097121744739, 10755.354678719146, 10838.729031774112, 6130.0, 8234.752957411287, 8240.670373185125, 8259.091499935003, 8273.379496537664, 5184.377874655065, 5208.723862653674, 5876.941230587639, 6017.669028203316, 6205.720742566686, 8413.789655258422, 8726.476411415335, 9911.405315681082, 10178.625885505659, 10204.846927295948, 8438.789030274293, 8626.353023523387, 8992.640294388151, 9976.800463990825, 10486.475676216007, 7022.894656580258, 7032.929670703227, 7265.782026539001, 7461.925380746123, 7470.551766894004, 8330.50016998982, 8557.144285571392, 8560.657573696983, 8565.528895910784, 8579.957100214458, 6414.166158399378, 7512.774616761506, 7589.924100758922, 7622.5426474411715, 7763.961180194063, 7390.1131864174495, 7448.292412220831, 7478.887816682863, 7577.431692623186, 7581.886271705818, 5920.407959204217, 7011.929880701127, 7104.11198600175, 7126.857462850818, 7136.0723105995885, 3814.441742118253, 4567.223571992703, 4602.378678878308, 4612.74629895359, 4742.691725037862, 4956.975215123901, 5072.163093089599, 5082.3138876252715, 5136.332276804141, 5158.4583618721], "value": 4527.0198234735735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7062937062937, 298.4493609290858, 306.1336417937237, 308.54027499026455, 311.98596063177166, 4526.370506617615, 4770.8807279817975, 5478.150886612571, 5497.697626630534, 5586.944130558693, 4273.205253793407, 4952.752362381884, 5212.491195116226, 5231.8751468434275, 5469.316335458067, 4141.792910354493, 4181.560936101711, 4193.329067349225, 4202.222588821062, 4213.946513371657, 3361.428557145279, 3841.9807900960595, 4217.725847819897, 4218.599233072869, 4243.27864263076, 3344.3812894614575, 4102.594846277582, 4122.690798190133, 4141.544430112685, 4146.730462519941, 3381.966180338202, 3591.748577599569, 4102.835886564534, 4102.917941641151, 4162.542120366772, 3566.4472006838982, 3568.4647302904514, 3571.3571557119967, 3593.3531964246426, 3595.442706380515, 4305.784710764449, 4832.516748325174, 5216.765245563959, 5400.648957817729, 5452.454754524555, 4200.789960501963, 4706.529347065266, 4726.291056341542, 4731.810727570893, 4734.7689600703725, 4253.574642535753, 5265.315508983846, 5644.74598643062, 5733.254676892019, 5796.391378905197, 3622.4242454532364, 3815.9046023849346, 3880.9029774255587, 3890.3191941410423, 3894.5910679378826, 6022.879542409171, 6074.757009719606, 6085.934961381785, 6090.299615544225, 6118.919567347123, 3141.591593092883, 3667.669909708139, 3940.8079455641023, 3942.1918506706056, 4015.819288131983, 3287.474004159323, 3507.5264839246884, 3659.7255205859133, 3953.584873588289, 4022.899427514277, 3977.5028121484816, 4689.179393606173, 4712.764361781898, 4722.645801564897, 4725.763711814464, 5206.8437946860895, 5828.6211396259105, 5883.676397798076, 5885.352611212763, 5885.823425297248, 1269.8666640002666, 1322.6362750243568, 1325.4499382756242, 1345.3138899161497, 1349.1718721132725, 752.0899711349219, 771.8572064168147, 908.5321059654283, 916.9317744827334, 934.6681927915628, 4851.0, 5382.381026182039, 5417.26866872975, 5439.374471935699, 5474.863128421821, 4629.745364004944, 5402.486763757437, 5879.823605291848, 5899.528037756969, 5944.464998150101, 4767.904641907143, 4769.618430525549, 5301.575873930076, 5395.919061214085, 5439.673619582838, 2360.0441821062495, 2427.684401027855, 2544.4529426173463, 2573.961390579143, 2594.702648675662, 4250.659947204216, 4457.0, 4541.500434952152, 5015.774290156952, 5111.923321150186, 5018.866981532834, 5024.748762561857, 5046.621503387188, 5628.212050312959, 6201.503879689614, 6231.504438934623, 6255.466536052906, 6273.686315684289, 6285.8742825143245, 6306.527010474141, 4914.584110406565, 6081.847953801191, 6110.205673262625, 6177.413145751147, 6179.474744646755, 5286.572625391046, 5422.942526207352, 5813.6221145625395, 5983.7008149591475, 5994.850128746816, 4758.310045043519, 5435.891282174413, 5586.994341018656, 5640.0, 5659.26429564154, 3689.6125906779403, 3692.5568931728367, 3975.8409663613133, 4000.599940005976, 4026.134381108076, 4419.094085712357, 5450.727463626882, 5956.910646340221, 5996.580239383201, 6015.969920150371, 5095.337606111182, 5214.869628259324, 5558.527525160407, 5592.636478628876, 5734.598578099493, 4540.909181816412, 5191.0425543606525, 5831.591788574759, 5873.182431419441, 5908.438698323653, 5019.0463811875625, 5584.720763961867, 5695.345035320825, 5718.142278658234, 5781.335146458043, 5815.738291776795, 5839.854003649943, 5862.208601838868, 5878.089620873318, 5880.47107751979, 4796.544328288807, 5439.0, 5738.221151443066, 5763.492880596954, 5790.565707571865], "value": 4092.313565279147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.668415660995, 730.1894896664704, 743.5129989856646, 764.8852672099184, 793.0087390761548, 14823.777643335345, 15550.688986220268, 15745.527634170992, 15761.763573546392, 15790.36838526459, 14582.489612863552, 14685.486007989723, 14694.0, 14702.63243418915, 14750.26248687564, 656.737305077969, 683.9418649414806, 802.8675268580677, 831.5925196653657, 831.9143517709387, 852.5012867472536, 858.909814469481, 859.2653281444337, 860.5482121885997, 861.7630151708299, 908.0374802709149, 908.0737647599444, 911.5761171055458, 912.8995810460844, 913.4519288426924, 903.1735961595133, 903.3044555692146, 904.2991681446898, 904.9411788233743, 907.0929070929071, 670.1455644053822, 671.6440286648035, 672.0792514255453, 673.0509980926919, 675.8411773233336, 14902.0, 14981.625459363604, 15161.317740701696, 15189.240537973168, 15199.316030778531, 14450.349734261983, 14466.782998255034, 14554.417823287056, 14565.053271537316, 14610.0, 10850.511726972305, 11589.246698964625, 11649.47577359021, 11684.474198660995, 11895.52417903283, 2878.971210287912, 3788.180875667906, 3855.4216867469822, 3988.561258261589, 3991.042149884036, 96549.9999999993, 117534.41232793867, 119939.21003034488, 120969.39515302455, 121657.78342216554, 10936.56253749841, 11003.119750419946, 11347.886521134847, 11364.829527557093, 11498.827517587242, 23288.53422931532, 23457.77151170636, 23473.530529389318, 23491.647625285634, 23519.0, 7780.844383112306, 7892.763217103496, 7977.521348719096, 8099.959500202462, 8101.10887802353, 3594.263176048904, 4011.6991225657607, 4195.538490766014, 4377.606015458624, 4464.441944756905, 2995.9514170040748, 3075.8923437680023, 3291.440455122635, 3353.329334133134, 3669.192777588926, 546.5354448718637, 587.2189987316858, 609.996950015256, 618.3661746709658, 619.553921176752, 514.8558403646985, 577.9190913272146, 581.4098689829826, 675.7330854312618, 678.3826717686882, 8807.515586642796, 9165.266778657691, 9371.484568348806, 9488.383255088396, 9692.286159875246, 619.7582942652369, 626.501930964884, 639.4916041746823, 661.2098542241974, 677.9424098406502, 4449.154660614473, 4529.139463501924, 4536.682432229778, 4601.470830854495, 4640.396748422683, 93704.53147734354, 117318.41340793412, 128101.0, 163361.0, 167505.0, 133811.0, 135780.0, 136669.0, 138606.0, 143827.0, 77325.22674773181, 95173.5241323789, 101643.99999999852, 109919.90080099256, 111057.0, 9508.714738557854, 9785.36395134314, 9791.314607977372, 9947.801043979225, 10041.397516149054, 56407.0, 56635.716821415626, 61371.0, 63282.0, 64395.678021611464, 88537.0, 95407.52296238752, 96585.5512167304, 97586.0482790326, 98869.0, 10608.257421980386, 11033.786283508647, 11497.82753258685, 11498.885011149781, 11570.132240082195, 14509.419623215375, 15045.623859403164, 15254.847451525786, 15264.618384540476, 15359.308831102851, 12901.817821094512, 13326.800097998732, 13822.170669759847, 14246.287685615885, 14273.214973176575, 13303.66740831487, 13491.932540337628, 13648.863511365156, 13736.10715303502, 14004.509842155476, 13180.143290686075, 13329.933350333575, 13448.394822232827, 13496.055276130577, 13699.109557878706, 10834.67495975122, 11130.833037504606, 11354.489047993025, 11755.118366122746, 11767.411629418666, 9953.203743700342, 10128.987101289813, 11099.112071034137, 11314.60398886035, 11343.886561134283], "value": 7738.68174414837, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 171.0, 104.0, 161.0, 175.0, 175.0, 116.0, 119.0, 118.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 113.0, 143.0, 148.0, 151.0, 103.0, 98.0, 127.0, 133.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 239.0, 199.0, 199.0, 197.0, 202.0, 194.0, 199.0, 200.0, 200.0], "value": 203.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 86.0, 73.0, 72.0, 53.0, 61.0, 92.0, 88.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 72.0, 111.0, 107.0, 103.0, 74.0, 90.0, 72.0, 71.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 89.0, 91.0, 87.0, 91.0, 89.0, 90.0, 87.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 152.0, 154.0, 97.0, 96.0, 96.0, 96.0, 105.0, 97.0, 103.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 90.0, 90.0, 91.0, 109.0, 90.0, 92.0, 88.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 57.0, 56.0, 58.0, 65.0, 88.0, 89.0, 56.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 91.0, 84.0, 76.0, 72.0, 71.0, 71.0, 72.0, 70.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 87.0, 75.0, 101.0, 108.0, 111.0, 112.0, 89.0, 87.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 156.0, 172.0, 174.0, 145.0, 148.0, 211.0, 173.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 241.0, 228.0, 180.0, 176.0, 174.0, 185.0, 174.0, 179.0, 178.0], "value": 189.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 74.0, 71.0, 69.0, 73.0, 95.0, 95.0, 95.0, 73.0], "value": 78.6, "unit": "score"}]}]} 23:50:47 INFO - Return code: 0 23:50:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:50:47 ERROR - # TBPL SUCCESS # 23:50:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:50:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:50:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:50:47 INFO - 2016-10-06 23:50:47.122 screenresolution[1670:10403] starting screenresolution argv=screenresolution get 23:50:47 INFO - 2016-10-06 23:50:47.127 screenresolution[1670:10403] Display 0: 1600x1200x32@60 23:50:47 INFO - 2016-10-06 23:50:47.133 screenresolution[1671:10406] starting screenresolution argv=screenresolution list 23:50:47 INFO - Available Modes on Display 0 23:50:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:50:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:50:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:50:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:50:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:50:47 INFO - Intel Iris: 23:50:47 INFO - Chipset Model: Intel Iris 23:50:47 INFO - Type: GPU 23:50:47 INFO - Bus: Built-In 23:50:47 INFO - VRAM (Dynamic, Max): 1536 MB 23:50:47 INFO - Vendor: Intel (0x8086) 23:50:47 INFO - Device ID: 0x0a2e 23:50:47 INFO - Revision ID: 0x0009 23:50:47 INFO - Displays: 23:50:47 INFO - Display: 23:50:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:50:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:50:47 INFO - Display Serial Number: 1600x1200 60 23:50:47 INFO - Main Display: Yes 23:50:47 INFO - Mirror: Off 23:50:47 INFO - Online: Yes 23:50:47 INFO - Rotation: Supported 23:50:47 INFO - Return code: 0 23:50:47 INFO - Running post-action listener: _resource_record_post_action 23:50:47 INFO - [mozharness: 2016-10-07 06:50:47.375705Z] Finished run-tests step (success) 23:50:47 INFO - Running post-run listener: _resource_record_post_run 23:50:47 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 38394368; Write bytes: 709729280; Read time: 394; Write time: 2086 23:50:47 INFO - TinderboxPrint: CPU usage
54.5% 23:50:47 INFO - TinderboxPrint: I/O read bytes / time
38,394,368 / 394 23:50:47 INFO - TinderboxPrint: I/O write bytes / time
709,729,280 / 2,086 23:50:47 INFO - TinderboxPrint: CPU idle
2,208.3 (45.5%) 23:50:47 INFO - TinderboxPrint: CPU system
983.8 (20.3%) 23:50:47 INFO - TinderboxPrint: CPU user
1,661.6 (34.2%) 23:50:47 INFO - TinderboxPrint: Swap in / out
447,135,744 / 0 23:50:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408859136; Write bytes: 411588096; Read time: 31006; Write time: 802 23:50:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34859520; Write bytes: 296691200; Read time: 361; Write time: 1278 23:50:47 INFO - Running post-run listener: _upload_blobber_files 23:50:47 INFO - Blob upload gear active. 23:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:50:47 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 23:50:47 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'] 23:50:47 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 23:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:50 INFO - (blobuploader) - INFO - Done attempting. 23:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:51 INFO - (blobuploader) - INFO - Done attempting. 23:50:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:50:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:54 INFO - (blobuploader) - INFO - Done attempting. 23:50:54 INFO - (blobuploader) - INFO - Iteration through files over. 23:50:54 INFO - Return code: 0 23:50:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:50:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:50:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89ab70e186cac9809777cc9cf41a145c03d7bc132380a68b11114e642ff773f6de85834627ebcde83a83a7584d746fa0875791341cd30f28d6d9386a23a17422", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16631325dbd3ddba48e5ecae4ca88e68d4761e81b9ed66d0e699318373ba7748e3f09dcad537450f6b74cb1687e7c77373b8e987a87ee9633d09ee694f38c388", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45e21a3085f44dc9cf7829d8b7d3e80858df305cad9288c81b367ac90343ad3dd97aa1a1469515e68f83ca869ed90ad0a625b49703234301117714e9870a928f"} 23:50:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:50:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:50:54 INFO - Contents: 23:50:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89ab70e186cac9809777cc9cf41a145c03d7bc132380a68b11114e642ff773f6de85834627ebcde83a83a7584d746fa0875791341cd30f28d6d9386a23a17422", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16631325dbd3ddba48e5ecae4ca88e68d4761e81b9ed66d0e699318373ba7748e3f09dcad537450f6b74cb1687e7c77373b8e987a87ee9633d09ee694f38c388", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45e21a3085f44dc9cf7829d8b7d3e80858df305cad9288c81b367ac90343ad3dd97aa1a1469515e68f83ca869ed90ad0a625b49703234301117714e9870a928f"} 23:50:54 INFO - Running post-run listener: copy_logs_to_upload_dir 23:50:54 INFO - Copying logs to upload dir... 23:50:54 INFO - mkdir: /builds/slave/test/build/upload/logs 23:50:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.381070 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 23:50:54.210610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 23:50:54.214451) ========= 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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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/89ab70e186cac9809777cc9cf41a145c03d7bc132380a68b11114e642ff773f6de85834627ebcde83a83a7584d746fa0875791341cd30f28d6d9386a23a17422", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16631325dbd3ddba48e5ecae4ca88e68d4761e81b9ed66d0e699318373ba7748e3f09dcad537450f6b74cb1687e7c77373b8e987a87ee9633d09ee694f38c388", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45e21a3085f44dc9cf7829d8b7d3e80858df305cad9288c81b367ac90343ad3dd97aa1a1469515e68f83ca869ed90ad0a625b49703234301117714e9870a928f"} build_url:https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/EOTGJK6mSWmE4251Gj8f2Q/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/89ab70e186cac9809777cc9cf41a145c03d7bc132380a68b11114e642ff773f6de85834627ebcde83a83a7584d746fa0875791341cd30f28d6d9386a23a17422", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16631325dbd3ddba48e5ecae4ca88e68d4761e81b9ed66d0e699318373ba7748e3f09dcad537450f6b74cb1687e7c77373b8e987a87ee9633d09ee694f38c388", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45e21a3085f44dc9cf7829d8b7d3e80858df305cad9288c81b367ac90343ad3dd97aa1a1469515e68f83ca869ed90ad0a625b49703234301117714e9870a928f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 23:50:54.249348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:50:54.249715) ========= 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.tAk2qA1XMk/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.Z4BYhHARBq/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005121 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 23:50:54.301033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 23:50:54.301369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 23:50:54.301734) ========= ========= Total master_lag: 0.20 =========