builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1480629405.82 results: success (0) buildid: 20161201113444 builduid: 0377ee02d38647a194d0c537bf7e9edd revision: eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:45.822928) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:45.823355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:45.823624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:46.012442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:46.012848) ========= 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.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-12-01 13:56:46-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.21M=0.001s 2016-12-01 13:56:46 (8.21 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106353 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:46.159316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:46.159853) ========= 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.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.020487 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:46.258615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 13:56:46.258981) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-12-01 13:56:46,343 truncating revision to first 12 chars 2016-12-01 13:56:46,343 Setting DEBUG logging. 2016-12-01 13:56:46,343 attempt 1/10 2016-12-01 13:56:46,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/eb2dcb26ca17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 13:56:47,554 unpacking tar archive at: larch-eb2dcb26ca17/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464997 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-01 13:56:47.755242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:47.755600) ========= script_repo_revision: eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:47.756033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:47.756296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 13:56:47.784979) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-01 13:56:47.785361) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:56:47 INFO - MultiFileLogger online at 20161201 13:56:47 in /builds/slave/test 13:56:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 13:56:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:56:47 INFO - {'append_to_log': False, 13:56:47 INFO - 'base_work_dir': '/builds/slave/test', 13:56:47 INFO - 'blob_upload_branch': 'Larch', 13:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:56:47 INFO - 'branch': 'Larch', 13:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:47 INFO - 'config_files': ('talos/mac_config.py',), 13:56:47 INFO - 'default_actions': ('clobber', 13:56:47 INFO - 'read-buildbot-config', 13:56:47 INFO - 'download-and-extract', 13:56:47 INFO - 'populate-webroot', 13:56:47 INFO - 'create-virtualenv', 13:56:47 INFO - 'install', 13:56:47 INFO - 'run-tests'), 13:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:47 INFO - 'download_minidump_stackwalk': True, 13:56:47 INFO - 'download_symbols': 'ondemand', 13:56:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:47 INFO - 'installer_path': 'installer.exe', 13:56:47 INFO - 'log_level': 'info', 13:56:47 INFO - 'log_name': 'talos', 13:56:47 INFO - 'log_to_console': True, 13:56:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:56:47 INFO - 'opt_config_files': (), 13:56:47 INFO - 'pip_index': False, 13:56:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:47 INFO - 'cmd': ('bash', 13:56:47 INFO - '-c', 13:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:47 INFO - 'enabled': True, 13:56:47 INFO - 'halt_on_failure': False, 13:56:47 INFO - 'name': 'check_screen_resolution'},), 13:56:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:47 INFO - 'cmd': ('bash', 13:56:47 INFO - '-c', 13:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:47 INFO - 'enabled': True, 13:56:47 INFO - 'halt_on_failure': False, 13:56:47 INFO - 'name': 'check_screen_resolution'},), 13:56:47 INFO - 'run_cmd_checks_enabled': True, 13:56:47 INFO - 'sps_profile': False, 13:56:47 INFO - 'sps_profile_interval': 0, 13:56:47 INFO - 'suite': 'dromaeojs', 13:56:47 INFO - 'system_bits': '32', 13:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:47 INFO - 'title': 't-yosemite-r7-0288', 13:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:47 INFO - 'use_talos_json': True, 13:56:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:47 INFO - 'work_dir': 'build'} 13:56:47 INFO - [mozharness: 2016-12-01 21:56:47.982971Z] Running clobber step. 13:56:47 INFO - Running pre-action listener: _resource_record_pre_action 13:56:47 INFO - Running main action method: clobber 13:56:47 INFO - rmtree: /builds/slave/test/build 13:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:49 INFO - Running post-action listener: _resource_record_post_action 13:56:49 INFO - [mozharness: 2016-12-01 21:56:49.457278Z] Finished clobber step (success) 13:56:49 INFO - [mozharness: 2016-12-01 21:56:49.457416Z] Running read-buildbot-config step. 13:56:49 INFO - Running pre-action listener: _resource_record_pre_action 13:56:49 INFO - Running main action method: read_buildbot_config 13:56:49 INFO - Using buildbot properties: 13:56:49 INFO - { 13:56:49 INFO - "project": "", 13:56:49 INFO - "product": "firefox", 13:56:49 INFO - "script_repo_revision": "production", 13:56:49 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 13:56:49 INFO - "repository": "", 13:56:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 13:56:49 INFO - "buildid": "20161201113444", 13:56:49 INFO - "pgo_build": "False", 13:56:49 INFO - "basedir": "/builds/slave/test", 13:56:49 INFO - "buildnumber": 0, 13:56:49 INFO - "slavename": "t-yosemite-r7-0288", 13:56:49 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:56:49 INFO - "platform": "yosemite_r7", 13:56:49 INFO - "scheduler": "tests-larch-macosx64-talos", 13:56:49 INFO - "branch": "larch", 13:56:49 INFO - "repo_path": "projects/larch", 13:56:49 INFO - "revision": "eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6", 13:56:49 INFO - "stage_platform": "macosx64", 13:56:49 INFO - "builduid": "0377ee02d38647a194d0c537bf7e9edd", 13:56:49 INFO - "slavebuilddir": "test" 13:56:49 INFO - } 13:56:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 13:56:49 INFO - Running post-action listener: _resource_record_post_action 13:56:49 INFO - [mozharness: 2016-12-01 21:56:49.460844Z] Finished read-buildbot-config step (success) 13:56:49 INFO - [mozharness: 2016-12-01 21:56:49.460955Z] Running download-and-extract step. 13:56:49 INFO - Running pre-action listener: _resource_record_pre_action 13:56:49 INFO - Running main action method: download_and_extract 13:56:49 INFO - mkdir: /builds/slave/test/build/tests 13:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:49 INFO - trying https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 13:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 13:56:50 INFO - Downloaded 1199 bytes. 13:56:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:56:50 INFO - Using the following test package requirements: 13:56:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:56:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 13:56:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 13:56:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'jsshell-mac.zip'], 13:56:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 13:56:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:56:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 13:56:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 13:56:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 13:56:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:56:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 13:56:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:56:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:56:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:56:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:56:50 INFO - Http code: 200 13:56:50 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 13:56:50 INFO - x-amz-cf-id: OBdzXFVdurk7sWM_OKU7jTHBYIfqaqgE6UtUH1Ft44I4ERE7I-Gfug== 13:56:50 INFO - x-amz-version-id: kGV7aIDI_DFrRWMErb54hXXtaMeBMFqZ 13:56:51 INFO - Expected file size: 16268102 13:56:51 INFO - Obtained file size: 16268102 13:56:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:56:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:56:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:56:57 INFO - Fetch https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:56:58 INFO - Http code: 200 13:56:58 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 13:56:58 INFO - x-amz-cf-id: oExmtyb8L3aR2XgqfM6eevFJhGUBJj2I6WqUk_cnNAe1DXrJ4_mJuw== 13:56:58 INFO - x-amz-version-id: kGV7aIDI_DFrRWMErb54hXXtaMeBMFqZ 13:56:58 INFO - Expected file size: 16268102 13:56:58 INFO - Obtained file size: 16268102 13:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 13:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 13:57:05 INFO - Http code: 200 13:57:05 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 13:57:05 INFO - x-amz-cf-id: bzQP2Gl4LXij2JxeJdgytU930dUp4kjn67auOh-ceTKI2WInaZKtjg== 13:57:05 INFO - x-amz-version-id: 1Sx2d5b8nAIzkyAax0yUiTGQMgtsnonl 13:57:06 INFO - Expected file size: 14409366 13:57:06 INFO - Obtained file size: 14409366 13:57:06 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')]} 13:57:06 INFO - trying https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:57:06 INFO - Downloading https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 13:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 13:57:12 INFO - Downloaded 111037535 bytes. 13:57:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:57:12 INFO - mkdir: /builds/slave/test/properties 13:57:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:57:12 INFO - Writing to file /builds/slave/test/properties/build_url 13:57:12 INFO - Contents: 13:57:12 INFO - build_url:https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:57:13 INFO - Running post-action listener: _resource_record_post_action 13:57:13 INFO - Running post-action listener: set_extra_try_arguments 13:57:13 INFO - [mozharness: 2016-12-01 21:57:13.240479Z] Finished download-and-extract step (success) 13:57:13 INFO - [mozharness: 2016-12-01 21:57:13.240634Z] Running populate-webroot step. 13:57:13 INFO - Running pre-action listener: _resource_record_pre_action 13:57:13 INFO - Running main action method: populate_webroot 13:57:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:13 INFO - '--tppagecycles', 13:57:13 INFO - '7'], 13:57:13 INFO - 'tests': ['tsvgm']}}, 13:57:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:57:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:57:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:57:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['damp', 'tps']}, 13:57:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'tests': ['damp', 'tps']}, 13:57:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['dromaeo_dom']}, 13:57:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['basic_compositor_video']}, 13:57:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:57:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['a11yr', 13:57:13 INFO - 'ts_paint', 13:57:13 INFO - 'tpaint', 13:57:13 INFO - 'sessionrestore', 13:57:13 INFO - 'sessionrestore_no_auto_restore', 13:57:13 INFO - 'tabpaint']}, 13:57:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['tsvgx', 13:57:13 INFO - 'tsvgr_opacity', 13:57:13 INFO - 'tart', 13:57:13 INFO - 'tscrollx', 13:57:13 INFO - 'cart']}, 13:57:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:57:13 INFO - 'tsvgr_opacity', 13:57:13 INFO - 'tart', 13:57:13 INFO - 'tscrollx', 13:57:13 INFO - 'cart']}, 13:57:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'talos_options': ['--disable-e10s'], 13:57:13 INFO - 'tests': ['tp5o']}, 13:57:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:57:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'talos_options': ['--disable-e10s', 13:57:13 INFO - '--xperf_path', 13:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:13 INFO - 'tests': ['tp5n']}, 13:57:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:57:13 INFO - 'talos_options': ['--xperf_path', 13:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:13 INFO - 'tests': ['tp5n']}}, 13:57:13 INFO - 'talos.zip': {'path': '', 13:57:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:13 INFO - Running post-action listener: _resource_record_post_action 13:57:13 INFO - [mozharness: 2016-12-01 21:57:13.258696Z] Finished populate-webroot step (success) 13:57:13 INFO - [mozharness: 2016-12-01 21:57:13.258819Z] Running create-virtualenv step. 13:57:13 INFO - Running pre-action listener: _resource_record_pre_action 13:57:13 INFO - Running main action method: create_virtualenv 13:57:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:57:13 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 13:57:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:13 INFO - Using real prefix '/tools/python27' 13:57:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:57:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:16 INFO - Installing pip.................done. 13:57:16 INFO - Return code: 0 13:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:57:17 INFO - Reading from file tmpfile_stdout 13:57:17 INFO - Output received: 13:57:17 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) 13:57:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:17 INFO - 'HOME': '/Users/cltbld', 13:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:17 INFO - 'LOGNAME': 'cltbld', 13:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:17 INFO - 'MOZ_NO_REMOTE': '1', 13:57:17 INFO - 'NO_EM_RESTART': '1', 13:57:17 INFO - 'PAGER': '/bin/cat', 13:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:17 INFO - 'PWD': '/builds/slave/test', 13:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:17 INFO - 'SHELL': '/bin/bash', 13:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:17 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:17 INFO - 'USER': 'cltbld', 13:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:17 INFO - 'XPC_FLAGS': '0x0', 13:57:17 INFO - 'XPC_SERVICE_NAME': '0', 13:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:17 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 13:57:17 INFO - Cleaning up... 13:57:17 INFO - Return code: 0 13:57:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:17 INFO - 'HOME': '/Users/cltbld', 13:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:17 INFO - 'LOGNAME': 'cltbld', 13:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:17 INFO - 'MOZ_NO_REMOTE': '1', 13:57:17 INFO - 'NO_EM_RESTART': '1', 13:57:17 INFO - 'PAGER': '/bin/cat', 13:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:17 INFO - 'PWD': '/builds/slave/test', 13:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:17 INFO - 'SHELL': '/bin/bash', 13:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:17 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:17 INFO - 'USER': 'cltbld', 13:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:17 INFO - 'XPC_FLAGS': '0x0', 13:57:17 INFO - 'XPC_SERVICE_NAME': '0', 13:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:17 INFO - Downloading/unpacking psutil>=3.1.1 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:21 INFO - Installing collected packages: psutil 13:57:21 INFO - Running setup.py install for psutil 13:57:21 INFO - building 'psutil._psutil_osx' extension 13:57:21 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 13:57:21 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 13:57:21 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 13:57:21 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 13:57:21 INFO - building 'psutil._psutil_posix' extension 13:57:21 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 13:57:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:57:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:57:21 INFO - ^ 13:57:21 INFO - 1 warning generated. 13:57:21 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 13:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:22 INFO - Successfully installed psutil 13:57:22 INFO - Cleaning up... 13:57:22 INFO - Return code: 0 13:57:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:57:22 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')]} 13:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:22 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')]} 13:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:22 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:22 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 13:57:22 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 13:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:22 INFO - 'HOME': '/Users/cltbld', 13:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:22 INFO - 'LOGNAME': 'cltbld', 13:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:22 INFO - 'MOZ_NO_REMOTE': '1', 13:57:22 INFO - 'NO_EM_RESTART': '1', 13:57:22 INFO - 'PAGER': '/bin/cat', 13:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:22 INFO - 'PWD': '/builds/slave/test', 13:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:22 INFO - 'SHELL': '/bin/bash', 13:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:22 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:22 INFO - 'USER': 'cltbld', 13:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:22 INFO - 'XPC_FLAGS': '0x0', 13:57:22 INFO - 'XPC_SERVICE_NAME': '0', 13:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:22 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 13:57:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:57:25 INFO - Installing collected packages: mozsystemmonitor 13:57:25 INFO - Running setup.py install for mozsystemmonitor 13:57:25 INFO - Successfully installed mozsystemmonitor 13:57:25 INFO - Cleaning up... 13:57:25 INFO - Return code: 0 13:57:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:25 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 13:57:25 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 13:57:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:25 INFO - 'HOME': '/Users/cltbld', 13:57:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:25 INFO - 'LOGNAME': 'cltbld', 13:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:25 INFO - 'MOZ_NO_REMOTE': '1', 13:57:25 INFO - 'NO_EM_RESTART': '1', 13:57:25 INFO - 'PAGER': '/bin/cat', 13:57:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:25 INFO - 'PWD': '/builds/slave/test', 13:57:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:25 INFO - 'SHELL': '/bin/bash', 13:57:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:25 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:25 INFO - 'USER': 'cltbld', 13:57:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:25 INFO - 'XPC_FLAGS': '0x0', 13:57:25 INFO - 'XPC_SERVICE_NAME': '0', 13:57:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:25 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 13:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:57:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:28 INFO - Downloading functools32-3.2.3-2.tar.gz 13:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:57:28 INFO - warning: no files found matching '*.txt' 13:57:28 INFO - no previously-included directories found matching 'build' 13:57:28 INFO - no previously-included directories found matching 'dist' 13:57:28 INFO - no previously-included directories found matching '.git*' 13:57:28 INFO - Installing collected packages: jsonschema, functools32 13:57:28 INFO - Running setup.py install for functools32 13:57:28 INFO - warning: no files found matching '*.txt' 13:57:28 INFO - no previously-included directories found matching 'build' 13:57:28 INFO - no previously-included directories found matching 'dist' 13:57:28 INFO - no previously-included directories found matching '.git*' 13:57:28 INFO - Successfully installed jsonschema functools32 13:57:28 INFO - Cleaning up... 13:57:29 INFO - Return code: 0 13:57:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:57:29 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')]} 13:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:29 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')]} 13:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:29 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:29 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 13:57:29 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 13:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:29 INFO - 'HOME': '/Users/cltbld', 13:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:29 INFO - 'LOGNAME': 'cltbld', 13:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:29 INFO - 'MOZ_NO_REMOTE': '1', 13:57:29 INFO - 'NO_EM_RESTART': '1', 13:57:29 INFO - 'PAGER': '/bin/cat', 13:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:29 INFO - 'PWD': '/builds/slave/test', 13:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:29 INFO - 'SHELL': '/bin/bash', 13:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:29 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:29 INFO - 'USER': 'cltbld', 13:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:29 INFO - 'XPC_FLAGS': '0x0', 13:57:29 INFO - 'XPC_SERVICE_NAME': '0', 13:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:57:29 INFO - Cleaning up... 13:57:29 INFO - Return code: 0 13:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57:29 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')]} 13:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:29 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')]} 13:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:29 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:29 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 13:57:29 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 13:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:29 INFO - 'HOME': '/Users/cltbld', 13:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:29 INFO - 'LOGNAME': 'cltbld', 13:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:29 INFO - 'MOZ_NO_REMOTE': '1', 13:57:29 INFO - 'NO_EM_RESTART': '1', 13:57:29 INFO - 'PAGER': '/bin/cat', 13:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:29 INFO - 'PWD': '/builds/slave/test', 13:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:29 INFO - 'SHELL': '/bin/bash', 13:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:29 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:29 INFO - 'USER': 'cltbld', 13:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:29 INFO - 'XPC_FLAGS': '0x0', 13:57:29 INFO - 'XPC_SERVICE_NAME': '0', 13:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:29 INFO - Downloading/unpacking blobuploader==1.2.4 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:29 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 13:57:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:33 INFO - Downloading docopt-0.6.1.tar.gz 13:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:33 INFO - Running setup.py install for blobuploader 13:57:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:33 INFO - Running setup.py install for requests 13:57:33 INFO - Running setup.py install for docopt 13:57:34 INFO - Successfully installed blobuploader requests docopt 13:57:34 INFO - Cleaning up... 13:57:34 INFO - Return code: 0 13:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:34 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:34 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 13:57:34 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 13:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:34 INFO - 'HOME': '/Users/cltbld', 13:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:34 INFO - 'LOGNAME': 'cltbld', 13:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:34 INFO - 'MOZ_NO_REMOTE': '1', 13:57:34 INFO - 'NO_EM_RESTART': '1', 13:57:34 INFO - 'PAGER': '/bin/cat', 13:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:34 INFO - 'PWD': '/builds/slave/test', 13:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:34 INFO - 'SHELL': '/bin/bash', 13:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:34 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:34 INFO - 'USER': 'cltbld', 13:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:34 INFO - 'XPC_FLAGS': '0x0', 13:57:34 INFO - 'XPC_SERVICE_NAME': '0', 13:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:34 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Ny2BXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:34 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-aWQOHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:34 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3UY9Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:34 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Vc81Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:34 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qcgrED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-W4Exv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-DHEMDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-VY7xLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-fiT1eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-PankNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-WoVGkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-zyzghQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-K8vOy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-4HDWa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-L701IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-q31Am7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-tpgfzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:36 INFO - Running setup.py install for manifestparser 13:57:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:36 INFO - Running setup.py install for mozcrash 13:57:36 INFO - Running setup.py install for mozdebug 13:57:36 INFO - Running setup.py install for mozdevice 13:57:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:36 INFO - Running setup.py install for mozfile 13:57:37 INFO - Running setup.py install for mozhttpd 13:57:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozinfo 13:57:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozInstall 13:57:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozleak 13:57:37 INFO - Running setup.py install for mozlog 13:57:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for moznetwork 13:57:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:57:37 INFO - Running setup.py install for mozprocess 13:57:38 INFO - Running setup.py install for mozprofile 13:57:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Running setup.py install for mozrunner 13:57:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Running setup.py install for mozscreenshot 13:57:38 INFO - Running setup.py install for moztest 13:57:38 INFO - Running setup.py install for mozversion 13:57:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:38 INFO - Cleaning up... 13:57:38 INFO - Return code: 0 13:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:38 INFO - 'HOME': '/Users/cltbld', 13:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:38 INFO - 'LOGNAME': 'cltbld', 13:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:38 INFO - 'MOZ_NO_REMOTE': '1', 13:57:38 INFO - 'NO_EM_RESTART': '1', 13:57:38 INFO - 'PAGER': '/bin/cat', 13:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:38 INFO - 'PWD': '/builds/slave/test', 13:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:38 INFO - 'SHELL': '/bin/bash', 13:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:38 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:38 INFO - 'USER': 'cltbld', 13:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:38 INFO - 'XPC_FLAGS': '0x0', 13:57:38 INFO - 'XPC_SERVICE_NAME': '0', 13:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-HLEvV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-SFW3nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-62ASEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-J1beMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-a8XO8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-PdemAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:39 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)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-xtKr0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qAUU6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:39 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-fvUvUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Exv5HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Jrg03F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-sSTrOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-hds3iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-aWcFF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-b4fqqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5k0m7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:40 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)) 13:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-6K0UtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:57:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:43 INFO - Downloading blessings-1.6.tar.gz 13:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:43 INFO - Installing collected packages: blessings 13:57:43 INFO - Running setup.py install for blessings 13:57:43 INFO - Successfully installed blessings 13:57:43 INFO - Cleaning up... 13:57:43 INFO - Return code: 0 13:57:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:44 INFO - Reading from file tmpfile_stdout 13:57:44 INFO - Current package versions: 13:57:44 INFO - blessings == 1.6 13:57:44 INFO - blobuploader == 1.2.4 13:57:44 INFO - docopt == 0.6.1 13:57:44 INFO - functools32 == 3.2.3-2 13:57:44 INFO - jsonschema == 2.5.1 13:57:44 INFO - manifestparser == 1.1 13:57:44 INFO - mozInstall == 1.12 13:57:44 INFO - mozcrash == 1.0 13:57:44 INFO - mozdebug == 0.1 13:57:44 INFO - mozdevice == 0.48 13:57:44 INFO - mozfile == 1.2 13:57:44 INFO - mozhttpd == 0.7 13:57:44 INFO - mozinfo == 0.9 13:57:44 INFO - mozleak == 0.1 13:57:44 INFO - mozlog == 3.4 13:57:44 INFO - moznetwork == 0.27 13:57:44 INFO - mozprocess == 0.23 13:57:44 INFO - mozprofile == 0.28 13:57:44 INFO - mozrunner == 6.13 13:57:44 INFO - mozscreenshot == 0.1 13:57:44 INFO - mozsystemmonitor == 0.3 13:57:44 INFO - moztest == 0.7 13:57:44 INFO - mozversion == 1.4 13:57:44 INFO - psutil == 3.1.1 13:57:44 INFO - requests == 1.2.3 13:57:44 INFO - wsgiref == 0.1.2 13:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:44 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:44 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 13:57:44 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 13:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:44 INFO - 'HOME': '/Users/cltbld', 13:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:44 INFO - 'LOGNAME': 'cltbld', 13:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:44 INFO - 'MOZ_NO_REMOTE': '1', 13:57:44 INFO - 'NO_EM_RESTART': '1', 13:57:44 INFO - 'PAGER': '/bin/cat', 13:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:44 INFO - 'PWD': '/builds/slave/test', 13:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:44 INFO - 'SHELL': '/bin/bash', 13:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:44 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:44 INFO - 'USER': 'cltbld', 13:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:44 INFO - 'XPC_FLAGS': '0x0', 13:57:44 INFO - 'XPC_SERVICE_NAME': '0', 13:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 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)) 13:57:45 INFO - Cleaning up... 13:57:45 INFO - Return code: 0 13:57:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:45 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')]} 13:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:45 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')]} 13:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:45 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 0x1032263f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe88472cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, '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.lrY2EnibM2/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.2g7w0HnmjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:57:45 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 13:57:45 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 13:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:45 INFO - 'HOME': '/Users/cltbld', 13:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:45 INFO - 'LOGNAME': 'cltbld', 13:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:45 INFO - 'MOZ_NO_REMOTE': '1', 13:57:45 INFO - 'NO_EM_RESTART': '1', 13:57:45 INFO - 'PAGER': '/bin/cat', 13:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:45 INFO - 'PWD': '/builds/slave/test', 13:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:45 INFO - 'SHELL': '/bin/bash', 13:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:57:45 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:45 INFO - 'USER': 'cltbld', 13:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:45 INFO - 'XPC_FLAGS': '0x0', 13:57:45 INFO - 'XPC_SERVICE_NAME': '0', 13:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:45 INFO - Cleaning up... 13:57:45 INFO - Return code: 0 13:57:45 INFO - Running post-action listener: _resource_record_post_action 13:57:45 INFO - Running post-action listener: _start_resource_monitoring 13:57:45 INFO - Starting resource monitoring. 13:57:45 INFO - [mozharness: 2016-12-01 21:57:45.896996Z] Finished create-virtualenv step (success) 13:57:45 INFO - [mozharness: 2016-12-01 21:57:45.898016Z] Running install step. 13:57:45 INFO - Running pre-action listener: _resource_record_pre_action 13:57:45 INFO - Running main action method: install 13:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:46 INFO - Reading from file tmpfile_stdout 13:57:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:46 INFO - Reading from file tmpfile_stdout 13:57:46 INFO - Output received: 13:57:46 INFO - Usage: mozinstall [options] installer 13:57:46 INFO - Options: 13:57:46 INFO - -h, --help show this help message and exit 13:57:46 INFO - -d DEST, --destination=DEST 13:57:46 INFO - Directory to install application into. [default: 13:57:46 INFO - "/builds/slave/test"] 13:57:46 INFO - --app=APP Application being installed. [default: firefox] 13:57:46 INFO - mkdir: /builds/slave/test/build/application 13:57:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:58:20 INFO - Reading from file tmpfile_stdout 13:58:20 INFO - Output received: 13:58:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:58:20 INFO - Running post-action listener: _resource_record_post_action 13:58:20 INFO - [mozharness: 2016-12-01 21:58:20.359401Z] Finished install step (success) 13:58:20 INFO - [mozharness: 2016-12-01 21:58:20.359531Z] Running run-tests step. 13:58:20 INFO - Running pre-action listener: _resource_record_pre_action 13:58:20 INFO - Running main action method: run_tests 13:58:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:58:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:58:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:58:20 INFO - 2016-12-01 13:58:20.374 screenresolution[2174:26032] starting screenresolution argv=screenresolution get 13:58:20 INFO - 2016-12-01 13:58:20.377 screenresolution[2174:26032] Display 0: 1600x1200x32@60 13:58:20 INFO - 2016-12-01 13:58:20.383 screenresolution[2175:26034] starting screenresolution argv=screenresolution list 13:58:20 INFO - Available Modes on Display 0 13:58:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:58:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:58:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:58:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:58:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:58:20 INFO - Intel Iris: 13:58:20 INFO - Chipset Model: Intel Iris 13:58:20 INFO - Type: GPU 13:58:20 INFO - Bus: Built-In 13:58:20 INFO - VRAM (Dynamic, Max): 1536 MB 13:58:20 INFO - Vendor: Intel (0x8086) 13:58:20 INFO - Device ID: 0x0a2e 13:58:20 INFO - Revision ID: 0x0009 13:58:20 INFO - Displays: 13:58:20 INFO - Display: 13:58:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:58:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:58:20 INFO - Display Serial Number: 1600x1200 60 13:58:20 INFO - Main Display: Yes 13:58:20 INFO - Mirror: Off 13:58:20 INFO - Online: Yes 13:58:20 INFO - Rotation: Supported 13:58:20 INFO - Return code: 0 13:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:20 INFO - Python 2.7.3 13:58:20 INFO - Return code: 0 13:58:20 INFO - grabbing minidump binary from tooltool 13:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:20 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 0x10303cd30>, '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 0x102ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103034b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:20 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 13:58:20 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 13:58:20 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 13:58:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:20 INFO - Return code: 0 13:58:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:58:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:58:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lrY2EnibM2/Render', 13:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:20 INFO - 'HOME': '/Users/cltbld', 13:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:20 INFO - 'LOGNAME': 'cltbld', 13:58:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:20 INFO - 'MOZ_NO_REMOTE': '1', 13:58:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:20 INFO - 'NO_EM_RESTART': '1', 13:58:20 INFO - 'PAGER': '/bin/cat', 13:58:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:20 INFO - 'PWD': '/builds/slave/test', 13:58:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:20 INFO - 'SHELL': '/bin/bash', 13:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2g7w0HnmjV/Listeners', 13:58:20 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:20 INFO - 'USER': 'cltbld', 13:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:20 INFO - 'XPC_FLAGS': '0x0', 13:58:20 INFO - 'XPC_SERVICE_NAME': '0', 13:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:58:20 INFO - mozversion application_buildid: 20161201113444 13:58:20 INFO - mozversion application_changeset: eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 13:58:20 INFO - mozversion application_display_name: Nightly 13:58:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:20 INFO - mozversion application_name: Firefox 13:58:20 INFO - mozversion application_remotingname: firefox 13:58:20 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:58:20 INFO - mozversion application_vendor: Mozilla 13:58:20 INFO - mozversion application_version: 53.0a1 13:58:20 INFO - mozversion platform_buildid: 20161201113444 13:58:20 INFO - mozversion platform_changeset: eb2dcb26ca17fb40c02e2ae70730ef45774ac9b6 13:58:20 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:58:20 INFO - mozversion platform_version: 53.0a1 13:58:20 INFO - using testdate: 1480629500 13:58:20 INFO - actual date: 1480629500 13:58:20 INFO - starting webserver on 'localhost:57810' 13:58:20 INFO - SUITE-START | Running 2 tests 13:58:20 INFO - TEST-START | dromaeo_css 13:58:20 INFO - operating with platform_type : mac_ 13:58:20 INFO - Initialising browser for dromaeo_css test... 13:58:20 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp5rr6gM/profile http://localhost:57810/getInfo.html) 13:58:23 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 13:58:23 INFO - PROCESS | 2185 | colorDepth:24 13:58:23 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 13:58:23 INFO - PROCESS | 2185 | __metrics 13:58:23 INFO - PROCESS | 2185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:58:23 INFO - PROCESS | 2185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:24 INFO - TEST-INFO | 2185: exit 0 13:58:24 INFO - Browser initialized. 13:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:58:24 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp5rr6gM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:36 INFO - PROCESS | 2187 | RSS: Main: 232787968 13:58:36 INFO - PROCESS | 2187 | 13:59:28 INFO - PROCESS | 2187 | 1480629568204 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] 14:01:40 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57810/tests/dromaeo/cssquery-ext.html) 14:01:42 INFO - PROCESS | 2187 | RSS: Main: 409882624 14:01:42 INFO - PROCESS | 2187 | 14:04:45 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-ext.html (next: http://localhost:57810/tests/dromaeo/cssquery-jquery.html) 14:04:45 INFO - PROCESS | 2187 | RSS: Main: 377049088 14:04:45 INFO - PROCESS | 2187 | 14:07:48 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57810/tests/dromaeo/cssquery-mootools.html) 14:07:48 INFO - PROCESS | 2187 | RSS: Main: 346136576 14:07:48 INFO - PROCESS | 2187 | 14:10:51 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57810/tests/dromaeo/cssquery-prototype.html) 14:10:51 INFO - PROCESS | 2187 | RSS: Main: 358580224 14:10:51 INFO - PROCESS | 2187 | 14:13:55 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57810/tests/dromaeo/cssquery-yui.html) 14:13:55 INFO - PROCESS | 2187 | RSS: Main: 341168128 14:13:55 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:57810/tests/dromaeo/cssquery-yui.html (next: http://localhost:57810/tests/dromaeo/cssquery-dojo.html) 14:16:59 INFO - PROCESS | 2187 | RSS: Main: 510402560 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | __start_tp_report 14:16:59 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 14:16:59 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 14:16:59 INFO - PROCESS | 2187 | |i|pagename|runs| 14:16:59 INFO - PROCESS | 2187 | |0;dojo.html;3205.9038228853133;3239.5464634951113;3251.4309995750737;3263.118957881372;3276.8689252429904;5329.960657671755;5416.322959630046;5419;5472.972635136824;5506.008918394692;5426.403095659474;5433.565314774818;5448.237246785453;5454.53636440903;5460.672359658413;4949.158643030684;4990.75046247688;4990.975045124769;5037.168867136918;5072.6195535335;5043.24351347299;5047.772850221731;5057.721825299607;5081.364829396325;5141.460146684601;5122.308488354061;5124;5133.3326667533165;5172.198309262051;5188.221766735001;390.38086951413067;5108.208227724708;5110.361204849394;5112.539871411554;5191.325127733408;3208.164081448265;4980.352554167971;4990.90018199634;5043.243513472972;5099.311592934943;4502.4371953505815;5417.106177480711;5429.375621803503;5493.615446918718;5566.582506312043;5998.40015998401;6017.06735456005;6021.307549631804;6022.247219097613;6025.789097381615;5870.823875283706;5885.588008839383;5944.494717948979;5978.1929439525975;6001.549883758736;5529.861753456155;5545.722713864331;5562.165675148679;5569.916451253234;5573.554115670818;6223.315435302113;6227.968860155761;6228.564000520011;6247;6248.5313601480075;5630.6058575900115;5687.573431992617;5688.431156884361;5811.88376232473;5895.292564892155;6039.7282122304605;6054.697265136726;6084.695765211722;6095.542834287447;6102.176206212104;5963;5976.223090998229;5983.760649573968;5993.4905533029305;6009.489193418608;5016.523430274118;5789.189513468118;5880.588358814842;5913.905927403444;6074.51403887688;4756.262779269149;4758.2386818108935;4769.046190761862;4770.308305295782;4777.617790576745;4304.117655880537;4335.544767799399;4341.9131617367475;4347.195768782785;4349.956500435019;5549.250851135045;5630.268065151504;5634.23937768396;5641.407652196543;5652.9152062719095;6025.035994240988;6025.9397406026255;6031.065184896348;6035.39646035393;6045.969770151209;4743.335932969387;5594.748236329375;5611.102223644198;5643.604947653625;5648.576356773258;5070.340855688811;5079.3396858408905;5178.0679477694375;5181.5077567631015;5188.325517682677;6266.68666566679;6279.529035322369;6285.717142728588;6289.213848268966;6296.307406185224;5863.355030946678;5899.321578018411;5913.379095194942;5913.763449461973;5921.792737254175;6190.473809726043;6196.783112591038;6241.531885108726;6245.937540624535;6283.3402492737605;5933.347331793586;5942.702864856827;5951.583389162717;5972.522198224218;5983.55123365758;6044.576879618385;6050.697465126814;6052.122442245762;6062.848428789139;6080.787172448943;5042.445331013659;5611.130274807411;5632.070708333079;5700.372958974593;5704.629199102045;5783.681897495678;5785.566082543742;5785.56608254391;5807.477327040587;5830.008898487183;5650.208970744017;5650.576206784425;5657.12314591239;5664.886702265849;5683.119116536944;5625.381208067028;5721.799737009184;5727.599068065362;5760.366359700346;5767.134929760569;4786.593139583175;5640.520555752642;5691.146328050825;5703.62926409782;5738.368779434342 14:16:59 INFO - PROCESS | 2187 | |1;ext.html;460.9124266389386;462.9421322334708;513.7636687123921;516.202467188194;538.2491424462877;29090.709092909063;30724.771009159635;30750.538741918863;38176;39077.804610976906;39939.800300998526;40393.99015024626;40398;40457.59542404575;40551.59448405515;9163.35856490046;9291.628334866631;9312.208462280714;9326.906730932706;9337.253019758436;9210.125038121401;9332.58003389849;9340.486273254968;9345.345825792198;9356.29827762917;9094.86357704635;9126.771830704252;9160.221381182608;9190.172884440399;9200.953995230015;8556.957215213946;8743.775871378011;9268.814623707522;9330.813383732288;9360.578773955189;9040.005599384063;9087.363884528086;9095.090490950919;9096.681616143404;9103.908960910372;37901.24197516062;38314.61685383166;38355.23289534222;38404.84785456441;38441.61558384437;3251.089694885436;3280.1799550112473;3522.295540891832;3878.45701601776;4021.698372622065;28477.145685629464;29369;29517.557236641467;29603.703962960524;29783.21300721942;3081.403728498523;3103.7206651401257;3220.7745457817964;3234.708876201153;3258.185453636591;466238.6688066572;466605;467274;467667;468929.310706892;53847;54710.72644636752;54734.72632636891;54764;54850.72574637101;56940;56992.43007569954;56997.43002570004;57029.14456283159;57036.71481642648;14889.18109503966;15124.243787810565;15133.54599361999;15145.545633631009;15165.317560709795;11839;11908;11909.464074116686;11917.404129793476;11954.521819127138;14091.577252682437;14723.779143312859;14739.63150921214;14772.55682329532;14952;6509.967450162719;6537.934620653733;6687.732490700318;6697.588868007513;6730.831729206809;845.4673555660017;932.2728271947891;940.586142097475;1035.5961175141701;1041.3855825063097;28386.71613283882;28392.86428542835;28747.425051498853;28962.565561516592;29164.12507624732;876.3952872517942;983.3755565215996;1012.2762225009006;1050.0444595418132;1085.3596378136938;11980.536494073613;14248.287585620677;14613.72472977132;14862.73476308648;14923.104613723212;170056;170131;170303.1484842568;170502;170875;54360.640983974925;54368;54480.45519544754;54529.90940181253;54570.45429545733;1291.225264841088;1330.8003799430162;1347.2522749873717;1347.4744849508895;1348.3999620169127;28231.71768282291;28407.147785566467;28591.285217868888;28884.855575722828;29003.564946525395;45683.54316456793;46145.53854461412;46174.07520360807;46227.075458491316;46395.76802115968;498610;501439;502761;506050;506451;36616.63383366132;36955;37412.812935935144;37643;37783.43324850075;39510.40734388929;40922.1815563693;42966.57033429626;43348;45134.77432612816;35109.297814043064;36192.457113142795;37035.62964370322;37497.62502374942;38130.23739525139;35741.46387804237;35787.46318805272;36985;37387.62612373842;37430.43854342242;29763;35497.46753798747;35827.462588061724;36551.45172822463;36690.63309366979;30527.847360763055;32288.35423291568;32546;33678.83160584181;33994.83002584971;23990;24128.51742965166;24159.879200603886;24634.384140396633;24678.753212467647 14:16:59 INFO - PROCESS | 2187 | |2;jquery.html;348.89707536276796;363.6091201957895;363.6817784438616;375.8459031796964;397.906491974386;14110.647233819147;14690.412383504661;15573.29920153593;17711.46865594034;20019.799802001977;18392.81607183928;18865.96237206953;19406.320778772744;19619;19748.506287342825;5589.74846131924;5970.164177015221;5972.701364931758;5975.611585246967;5983.311919129313;5548.667079975195;5570.415106413829;5795.681237531934;5864.530837533009;5889.793857214999;4951.628627852908;5826.388229235933;5841.678707671076;5843.824685259449;5843.970780146094;5575.2473416088915;5757.4818266355815;5762;5797.884042319172;5828.88342233153;4980.0288943656005;4989.351384320052;5056.570191533724;5064.366954130734;5082.644214904958;20054.298099566444;22766.31701048971;23400.765992340028;23852.057236223063;24534.895929683207;1876.7278744581959;2151.7633060363346;2296.460331822037;2312.1560630369795;2351.6237402015595;9611.711648650551;9668.419894806264;10104.393736375841;10262.948685256526;14374.063342991287;1802.720578310364;1836.5225041489175;1838.8253115953962;1863.3105750872128;1866.2628261836635;109452.90547094507;112924.87075129226;116423;119668.02489813212;120692.79307206991;8157.918420815835;8763.693270735494;8853.601587928559;9565.330426870052;9722.256931081585;11788.115891308185;12189.939050304693;12266.448009839578;12287.078469114853;12307.815382769266;7420.480566360303;7658.846823063507;7698.2686644768655;7772.68909243624;7775.377969762519;7877.527348359117;7880.744398025002;7903.802404939807;8032.15662355456;8042.5121352548795;3776.527934008249;3780.5652349980105;3795.392737162096;3859.1895701902913;3868.0909986153233;1844.1056087797408;1883.5950270691867;1897.9051047447572;1926.0947354743248;1952.8575783167007;804.5373910001772;825.7063270990872;844.3329769482164;850.7787975126512;870.2298465857635;19251.03744812754;19799.901000495192;20166.596668066555;20273.797262027485;20601.690974635392;773.8993930788962;886.8093359927517;896.4038914122166;913.2100732866156;913.5477938420524;8644.956775216084;9701.70894873155;9966.103050725469;10364.948175259075;10671.413072281099;581909;582158;582555;593253;599031;91157.08842911485;129435;140638;140755;143624;940.0881145289059;971.8542218667116;977.1938151025432;991.6479649724243;994.9701508954743;17242.913785430992;18106.366277180234;18128.72806907924;18307;18307.908460457613;40345.59654403418;52969.735151324;53014;53064.73467632637;53978.73010634922;75230;75540.62229688816;75948;79859;81012.3797524058;7743.109542402471;7757.844843102994;7927.128015918129;7973.760787176394;8160.224778646019;10809.513571889127;12512.812307815208;12573.308468034345;12701.872981270439;12782.424790884246;10490;10507.369557826554;10722.73193170177;10942.507587158756;11140.275882067639;10441.425721585385;10447.425391603534;10720.73198170052;10776.353418794584;10938.617148399768;8919.197272245528;10105.141063009432;11143.275687080313;11333.26333788301;11388.715282118013;7632.313091821763;7677;7846.607669616382;7876.566788826441;8160.755177344689;9528.475933823429;10609.257351985287;11047.558097676003;11084;11099.778004439704 14:16:59 INFO - PROCESS | 2187 | |3;mootools.html;1468.5153899213258;1492.8208614966204;1642.6714657068583;1790.6866298397792;1826.853851691864;7934.801629959254;8345.582720863962;8356.164383561641;8379.581020948952;8396.664133434655;7374.668139933702;7625.237476252372;7647.120581133171;7983.32141767949;8105.148959359256;1832.4411054628333;2242.1367773407273;2283.577538155438;2287.90848366066;2289.095807156172;2261.977380226201;2296.8277379196543;2315.235972129193;2318.8840557972117;2322.140807901079;2258.480549473622;2264.3546589222074;2288.1305104060516;2291.0721157931066;2291.4385975436044;1872.3353209610527;2258.4579700871755;2281.2129815213725;2283.7259528856475;2287.4167087392775;2283.2693538067824;2302.7121609798774;2307.3654744945106;2312.213847291912;2312.8496647717843;8279.875801862976;8331.750047498525;8356.373272004563;8376.706815261437;8388.245057944754;4968.503149685002;5137.537621614073;5138;5147.279380886679;5154.144507977126;3211.903642890717;3441.105312618737;3446.5347178130883;3473.548438702978;3490.5636795400574;987.5013118375247;1027.203916964351;1059.6873922192972;1064.297563608015;1070.8447275145138;10338.638147664871;10734.409607471585;10735;10757.139428845674;10760.192985526117;3689.6494832990825;4244.10873716523;4365;4402.537733537996;4411.691181617321;8424.831503369898;8620.827583448421;8622.09468005863;8630.39587228888;8637.870431943526;5028;5028.321176641107;5030.220315851049;5034.546890779848;5034.823781167642;3591.3894637911617;4379.693421460467;4495.730256184639;4661.743604101807;4697.084068606658;3341.732661387132;3385.2213990782257;3436.621971583124;3442.7934323940644;3463.480477928331;1067.6743593204146;1098.873629532598;1109.7225693576606;1109.7891400633853;1112.360392774142;855.6962278391081;868.6004437958484;889.4840992224624;911.6080085563271;925.1303774451993;5129.281900533928;5202.713850738246;5298.947010529922;5593.804216852391;5638.013347664142;886.3751055505853;894.8836651235298;917.495377542349;919.1176470588176;970.8009857979239;3694.8891533254045;3733.9253214935547;3808.27642747877;3857.4985251917633;3867.613238676166;9457.24342052648;9978.950105249573;9980.201583873273;9990;9994.650187243411;9911;9949.452780097019;9952.950235248922;9953.402795832273;9957.153641940371;6626.668666566652;7420.220876807965;7596.696132154762;7633.427492938052;7738.264864837832;4416.823327066882;4726.409198850144;5465.316835395575;5585.385607583082;5642.915356269577;9041.954790226007;9244.583993720164;9260.166585007382;9273.489958052372;9357.20463760588;9129.817403652023;9147.131022552847;9224.40041397307;9398.859017114886;9582.425054496753;7445.441591880739;7631.656575454229;7660.080790304976;7767.184445633127;7783.416243781852;7206.603636800026;7435.7025718970635;7461.515001524884;7587.544747315179;7794.986651735465;6911.17065952089;7010.334018268256;7086.929130708627;7100;7139.714411423485;6886.827829304308;6951.826204344729;6969.407600354027;7020.473464490286;7039.366457018893;6578.407943285128;6601.53789234749;6603.20761508622;6624.105745724266;6691.665416729242;4138.193052354762;4482.65520343889;4621.075784842978;4724.834630787906;4828.227483602606;3983.462232598562;4092.7748973805537;4281.486221653421;4671.322658214608;4934.506549345037 14:16:59 INFO - PROCESS | 2187 | |4;prototype.html;245.91515927005182;265.48363433122574;297.20794083766776;306.3474798678813;313.11544885697907;5100.719460429679;5105;5113.872153196163;5120.2319652052165;5147.040451740246;4708.176069187887;4803.495632958533;4883.6337274704365;4900.191468407708;4967.130752118383;3742.4760533525327;3883.1262965832602;3887.552931412881;3923.1761330120707;3979.5622481527007;3164.335489547198;3915.7650540967634;3916.2754890345236;3931.9803400982955;3935.779908228444;3284;3786.659200671939;3879.35990561557;3927.2145570885937;3941.0935484838506;3262.3475304939107;3338.132085657722;3641.6358364163502;3766.114962983697;3823.655870971626;3233.1917020744813;3406.182516196095;3451.2062225687982;3458.463938089575;3476.443768996948;4069.4506241657296;4096.6313031826985;4915.926261106087;4963.751812409401;4967.279744437073;3757.530308711411;4270.316749320094;4470.530594287586;4492.707973981714;4507.2788353863225;4664.207084795593;5343.305370301875;5354.544863686591;5370.812021579265;5414.5668346532575;3450.9654903450896;3541.8760343388117;3780.7920564368947;3787.0153760022317;3791.317562838688;4746.155613952675;5322.494363035506;5453.890922181574;5596.4123767004285;5634.971825140889;3386.9153271168416;3805.5813860475328;3833.4441505981476;3856.0359910022494;3856.972276762784;3875.399313106473;3881.6700580450415;3889.1638297766117;3899;3902.570717221103;3800.6959443244473;4223.408722778813;4454.621357184676;4473.575010374009;4505.707129036602;5310.362756469249;5316.016536940679;5363.678179309254;5401.487583476633;5438.510534051875;1176.5411489519095;1235.3637876493613;1237.560665963588;1238.1704258147063;1263.7851565233748;817.3747083481142;829.2578142562494;836.8451836410284;837.6146972392768;844.907060223375;4794.5924596408995;4797.688150270221;4804.35141255926;4864.391951006124;4866.391701037371;4737.773246574105;5119.385673719177;5139.537441630271;5172.301739265151;5192.5586325162785;4580.610648094949;4715.3869996900185;4743.45450273223;4806;4841;2243.48399868028;2446.266120163944;2522.994219595426;2600.739926007422;2734.603482495027;4477.224121044973;4882.511748825089;5399.298091248191;5442.401335853053;5495.725213739297;4567.533531892741;5184.5593124584075;5186.783929681371;5321.73391330432;5326.600504962066;4616.838410655611;5259.369595425431;5260.316158899395;5383.5423988961375;5453.727313634303;4591.5435242145295;4689.835855745033;5052.418971818288;5066.08810414129;5073.670211436245;4177.874663760092;4666.2767271073035;4748.691335063209;5038.470960549236;5116.7230582390475;4669.692486103896;4940.752962351796;5049.091163590589;5457.516829842333;5495.230667706604;2950.8819647213872;3445.3109378123972;3542.4686297055646;3614.403623402109;3673.412254039448;3839.080459770115;4150.501939767248;4413.955860441354;4936.370997570722;5217.295665085165;4989.55094041538;5018.673786203885;5033.037115524875;5034.672746271481;5053.8268544524735;4046.4537287465814;4531.235946072827;5000.749962501933;5023.191651005562;5060.797568097235;4047.838086476508;4562.726236425825;4669.719816811003;4867.172580661225;4907.975460122677;4916.06594746997;5008.474110218374;5277.656952298088;5278.947210527999;5284.603654725834;4358;4375.27807911691;5146.871328216825;5169.327987361619;5196.298499702491 14:16:59 INFO - PROCESS | 2187 | |5;yui.html;679.3071067511141;698.0994517072976;743.3012967810258;746.615493021094;776.375018110421;14309.78535321971;14873.702525949475;14895.404183832661;14941.879359048075;14963.775543366844;13303.667408314774;13457.93271033646;13485.46058157675;13493.2578708171;13496.932515337434;640.4140211706283;667.2160211751172;669.2069897171842;801.234820746186;825.3149885594971;797.5732982854145;821.0721884270765;822.9547374894379;835.5070508400042;838.153465000348;870.0777176193224;871.8822958900562;872.6334939325499;874.9300055995537;875.5840975536601;679.341039191983;861.0528418739399;866.2550206822128;866.5797088412115;866.8093019535692;520.8359366799446;615.3323643846433;639.9264084630281;647.757091090841;649.4674367019046;14210.360533776005;14259.643508912257;14310.785338219936;14483.927580362137;14492.927535362362;11952.581659641957;13362.131461455072;13413.329333533382;13451.932740336333;13458.394372253271;12047.939760301142;12158;12198.268103913793;12232.388380581024;12315.93842030793;3824.6557809796973;4281.77139020814;4400.317950717644;4444.666650001231;4529.456465224194;80182;82354;90140.09859901383;91665;91877;8517.659293628309;10816.56733730642;10899.782004359868;10998.34009959405;11446.427678616035;21375.89312053461;21400;21411.25060622902;21444;21472.463188420414;7077.150741911004;7223.494355395072;7612.657430415645;7728.690852365955;7848.568328741974;4155.148194620096;4216.915661686749;4227.513835908849;4246.957530424656;4368.868933931987;3302.2239773653173;3420.6066302375048;3423.9144021399165;3430.0395889151077;3436;569.3651578489954;629.625372903122;633.1831936801475;645.7739791073087;649.3960616626582;503.28784769550674;578.719321129252;586.4340911020886;602.728772052578;608.689568320151;8323.458975166595;8492.830143397097;8501.53241571707;8640.265577425864;8813.647454101892;565.9943400566024;594.7888499582585;604.241676695744;620.3548309757891;630.3759278314436;3938.8818335449982;4079.102597428561;4083.673306135502;4199.811008504625;4275.657947364266;67010;115357;115420;117002;117365;99321;99446.5027674857;100921;101176;103556;80823;90614;92469.53765231131;93492.66268343346;94906.52546737222;7810.921890781019;8085.919140808752;8194.959025204837;8362.331013519026;8395.061728395012;47914.010748656416;54620.72689636526;55087.64800047629;56104.43895560992;56534;63830;65902.67048664918;70779.64610176916;74452.62773686097;77305.22694773205;12565.308908009782;12606.117571770255;12624.55814046504;12932.676683082622;13017.21896686202;13201.471941122632;13335.933320333335;13853;14294.070885392417;14627.853721463074;12887.48450061987;12988.480460781462;13499.932500337436;13574.253416061816;13593.887833978408;13064.477420903057;13162.868371316546;13276;13581.932090339486;13626.386812593655;12813.93593032029;12978.740425191254;13166.539171128965;13492.460301587827;13519.526816561372;11027.889721102687;11155.72110697239;11277.661670149908;11292.096632269562;11379.829302560303;9430.10414010668;9937.602495900082;10698.983596558315;10993.670189894316;11325.830112548154 14:16:59 INFO - PROCESS | 2187 | __end_tp_report 14:16:59 INFO - PROCESS | 2187 | __start_cc_report 14:16:59 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,1760 14:16:59 INFO - PROCESS | 2187 | __end_cc_report 14:16:59 INFO - PROCESS | 2187 | __startTimestamp1480630619456__endTimestamp 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | ------- Summary: start ------- 14:16:59 INFO - PROCESS | 2187 | Number of tests: 6 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#0] dojo.html Cycles:165 Average:5477.87 Median:5650.21 stddev:758.47 (13.4%) stddev-sans-first:739.56 14:16:59 INFO - PROCESS | 2187 | Values: 3205.9 3239.5 3251.4 3263.1 3276.9 5330.0 5416.3 5419.0 5473.0 5506.0 5426.4 5433.6 5448.2 5454.5 5460.7 4949.2 4990.8 4991.0 5037.2 5072.6 5043.2 5047.8 5057.7 5081.4 5141.5 5122.3 5124.0 5133.3 5172.2 5188.2 390.4 5108.2 5110.4 5112.5 5191.3 3208.2 4980.4 4990.9 5043.2 5099.3 4502.4 5417.1 5429.4 5493.6 5566.6 5998.4 6017.1 6021.3 6022.2 6025.8 5870.8 5885.6 5944.5 5978.2 6001.5 5529.9 5545.7 5562.2 5569.9 5573.6 6223.3 6228.0 6228.6 6247.0 6248.5 5630.6 5687.6 5688.4 5811.9 5895.3 6039.7 6054.7 6084.7 6095.5 6102.2 5963.0 5976.2 5983.8 5993.5 6009.5 5016.5 5789.2 5880.6 5913.9 6074.5 4756.3 4758.2 4769.0 4770.3 4777.6 4304.1 4335.5 4341.9 4347.2 4350.0 5549.3 5630.3 5634.2 5641.4 5652.9 6025.0 6025.9 6031.1 6035.4 6046.0 4743.3 5594.7 5611.1 5643.6 5648.6 5070.3 5079.3 5178.1 5181.5 5188.3 6266.7 6279.5 6285.7 6289.2 6296.3 5863.4 5899.3 5913.4 5913.8 5921.8 6190.5 6196.8 6241.5 6245.9 6283.3 5933.3 5942.7 5951.6 5972.5 5983.6 6044.6 6050.7 6052.1 6062.8 6080.8 5042.4 5611.1 5632.1 5700.4 5704.6 5783.7 5785.6 5785.6 5807.5 5830.0 5650.2 5650.6 5657.1 5664.9 5683.1 5625.4 5721.8 5727.6 5760.4 5767.1 4786.6 5640.5 5691.1 5703.6 5738.4 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#1] ext.html Cycles:180 Average:53211.79 Median:38015.74 stddev:109173.59 (287.2%) stddev-sans-first:109408.01 14:16:59 INFO - PROCESS | 2187 | Values: 460.9 462.9 513.8 516.2 538.2 29090.7 30724.8 30750.5 38176.0 39077.8 39939.8 40394.0 40398.0 40457.6 40551.6 9163.4 9291.6 9312.2 9326.9 9337.3 9210.1 9332.6 9340.5 9345.3 9356.3 9094.9 9126.8 9160.2 9190.2 9201.0 8557.0 8743.8 9268.8 9330.8 9360.6 9040.0 9087.4 9095.1 9096.7 9103.9 37901.2 38314.6 38355.2 38404.8 38441.6 3251.1 3280.2 3522.3 3878.5 4021.7 28477.1 29369.0 29517.6 29603.7 29783.2 3081.4 3103.7 3220.8 3234.7 3258.2 466238.7 466605.0 467274.0 467667.0 468929.3 53847.0 54710.7 54734.7 54764.0 54850.7 56940.0 56992.4 56997.4 57029.1 57036.7 14889.2 15124.2 15133.5 15145.5 15165.3 11839.0 11908.0 11909.5 11917.4 11954.5 14091.6 14723.8 14739.6 14772.6 14952.0 6510.0 6537.9 6687.7 6697.6 6730.8 845.5 932.3 940.6 1035.6 1041.4 28386.7 28392.9 28747.4 28962.6 29164.1 876.4 983.4 1012.3 1050.0 1085.4 11980.5 14248.3 14613.7 14862.7 14923.1 170056.0 170131.0 170303.1 170502.0 170875.0 54360.6 54368.0 54480.5 54529.9 54570.5 1291.2 1330.8 1347.3 1347.5 1348.4 28231.7 28407.1 28591.3 28884.9 29003.6 45683.5 46145.5 46174.1 46227.1 46395.8 498610.0 501439.0 502761.0 506050.0 506451.0 36616.6 36955.0 37412.8 37643.0 37783.4 39510.4 40922.2 42966.6 43348.0 45134.8 35109.3 36192.5 37035.6 37497.6 38130.2 35741.5 35787.5 36985.0 37387.6 37430.4 29763.0 35497.5 35827.5 36551.5 36690.6 30527.8 32288.4 32546.0 33678.8 33994.8 23990.0 24128.5 24159.9 24634.4 24678.8 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#2] jquery.html Cycles:180 Average:34071.54 Median:2133.00 stddev:98342.69 (4610.5%) stddev-sans-first:98585.97 14:16:59 INFO - PROCESS | 2187 | Values: 348.9 363.6 363.7 375.8 397.9 14110.6 14690.4 15573.3 17711.5 20019.8 18392.8 18866.0 19406.3 19619.0 19748.5 5589.7 5970.2 5972.7 5975.6 5983.3 5548.7 5570.4 5795.7 5864.5 5889.8 4951.6 5826.4 5841.7 5843.8 5844.0 5575.2 5757.5 5762.0 5797.9 5828.9 4980.0 4989.4 5056.6 5064.4 5082.6 20054.3 22766.3 23400.8 23852.1 24534.9 1876.7 2151.8 2296.5 2312.2 2351.6 9611.7 9668.4 10104.4 10262.9 14374.1 1802.7 1836.5 1838.8 1863.3 1866.3 109452.9 112924.9 116423.0 119668.0 120692.8 8157.9 8763.7 8853.6 9565.3 9722.3 11788.1 12189.9 12266.4 12287.1 12307.8 7420.5 7658.8 7698.3 7772.7 7775.4 7877.5 7880.7 7903.8 8032.2 8042.5 3776.5 3780.6 3795.4 3859.2 3868.1 1844.1 1883.6 1897.9 1926.1 1952.9 804.5 825.7 844.3 850.8 870.2 19251.0 19799.9 20166.6 20273.8 20601.7 773.9 886.8 896.4 913.2 913.5 8645.0 9701.7 9966.1 10364.9 10671.4 581909.0 582158.0 582555.0 593253.0 599031.0 91157.1 129435.0 140638.0 140755.0 143624.0 940.1 971.9 977.2 991.6 995.0 17242.9 18106.4 18128.7 18307.0 18307.9 40345.6 52969.7 53014.0 53064.7 53978.7 75230.0 75540.6 75948.0 79859.0 81012.4 7743.1 7757.8 7927.1 7973.8 8160.2 10809.5 12512.8 12573.3 12701.9 12782.4 10490.0 10507.4 10722.7 10942.5 11140.3 10441.4 10447.4 10720.7 10776.4 10938.6 8919.2 10105.1 11143.3 11333.3 11388.7 7632.3 7677.0 7846.6 7876.6 8160.8 9528.5 10609.3 11047.6 11084.0 11099.8 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#3] mootools.html Cycles:180 Average:5302.44 Median:5150.71 stddev:2935.88 (57.0%) stddev-sans-first:2929.98 14:16:59 INFO - PROCESS | 2187 | Values: 1468.5 1492.8 1642.7 1790.7 1826.9 7934.8 8345.6 8356.2 8379.6 8396.7 7374.7 7625.2 7647.1 7983.3 8105.1 1832.4 2242.1 2283.6 2287.9 2289.1 2262.0 2296.8 2315.2 2318.9 2322.1 2258.5 2264.4 2288.1 2291.1 2291.4 1872.3 2258.5 2281.2 2283.7 2287.4 2283.3 2302.7 2307.4 2312.2 2312.8 8279.9 8331.8 8356.4 8376.7 8388.2 4968.5 5137.5 5138.0 5147.3 5154.1 3211.9 3441.1 3446.5 3473.5 3490.6 987.5 1027.2 1059.7 1064.3 1070.8 10338.6 10734.4 10735.0 10757.1 10760.2 3689.6 4244.1 4365.0 4402.5 4411.7 8424.8 8620.8 8622.1 8630.4 8637.9 5028.0 5028.3 5030.2 5034.5 5034.8 3591.4 4379.7 4495.7 4661.7 4697.1 3341.7 3385.2 3436.6 3442.8 3463.5 1067.7 1098.9 1109.7 1109.8 1112.4 855.7 868.6 889.5 911.6 925.1 5129.3 5202.7 5298.9 5593.8 5638.0 886.4 894.9 917.5 919.1 970.8 3694.9 3733.9 3808.3 3857.5 3867.6 9457.2 9979.0 9980.2 9990.0 9994.7 9911.0 9949.5 9953.0 9953.4 9957.2 6626.7 7420.2 7596.7 7633.4 7738.3 4416.8 4726.4 5465.3 5585.4 5642.9 9042.0 9244.6 9260.2 9273.5 9357.2 9129.8 9147.1 9224.4 9398.9 9582.4 7445.4 7631.7 7660.1 7767.2 7783.4 7206.6 7435.7 7461.5 7587.5 7795.0 6911.2 7010.3 7086.9 7100.0 7139.7 6886.8 6951.8 6969.4 7020.5 7039.4 6578.4 6601.5 6603.2 6624.1 6691.7 4138.2 4482.7 4621.1 4724.8 4828.2 3983.5 4092.8 4281.5 4671.3 4934.5 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#4] prototype.html Cycles:180 Average:4190.27 Median:4679.78 stddev:1258.81 (26.9%) stddev-sans-first:1227.04 14:16:59 INFO - PROCESS | 2187 | Values: 245.9 265.5 297.2 306.3 313.1 5100.7 5105.0 5113.9 5120.2 5147.0 4708.2 4803.5 4883.6 4900.2 4967.1 3742.5 3883.1 3887.6 3923.2 3979.6 3164.3 3915.8 3916.3 3932.0 3935.8 3284.0 3786.7 3879.4 3927.2 3941.1 3262.3 3338.1 3641.6 3766.1 3823.7 3233.2 3406.2 3451.2 3458.5 3476.4 4069.5 4096.6 4915.9 4963.8 4967.3 3757.5 4270.3 4470.5 4492.7 4507.3 4664.2 5343.3 5354.5 5370.8 5414.6 3451.0 3541.9 3780.8 3787.0 3791.3 4746.2 5322.5 5453.9 5596.4 5635.0 3386.9 3805.6 3833.4 3856.0 3857.0 3875.4 3881.7 3889.2 3899.0 3902.6 3800.7 4223.4 4454.6 4473.6 4505.7 5310.4 5316.0 5363.7 5401.5 5438.5 1176.5 1235.4 1237.6 1238.2 1263.8 817.4 829.3 836.8 837.6 844.9 4794.6 4797.7 4804.4 4864.4 4866.4 4737.8 5119.4 5139.5 5172.3 5192.6 4580.6 4715.4 4743.5 4806.0 4841.0 2243.5 2446.3 2523.0 2600.7 2734.6 4477.2 4882.5 5399.3 5442.4 5495.7 4567.5 5184.6 5186.8 5321.7 5326.6 4616.8 5259.4 5260.3 5383.5 5453.7 4591.5 4689.8 5052.4 5066.1 5073.7 4177.9 4666.3 4748.7 5038.5 5116.7 4669.7 4940.8 5049.1 5457.5 5495.2 2950.9 3445.3 3542.5 3614.4 3673.4 3839.1 4150.5 4414.0 4936.4 5217.3 4989.6 5018.7 5033.0 5034.7 5053.8 4046.5 4531.2 5000.7 5023.2 5060.8 4047.8 4562.7 4669.7 4867.2 4908.0 4916.1 5008.5 5277.7 5278.9 5284.6 4358.0 4375.3 5146.9 5169.3 5196.3 14:16:59 INFO - PROCESS | 2187 | 14:16:59 INFO - PROCESS | 2187 | [#5] yui.html Cycles:180 Average:20673.04 Median:4384.59 stddev:30435.07 (694.1%) stddev-sans-first:30483.42 14:16:59 INFO - PROCESS | 2187 | Values: 679.3 698.1 743.3 746.6 776.4 14309.8 14873.7 14895.4 14941.9 14963.8 13303.7 13457.9 13485.5 13493.3 13496.9 640.4 667.2 669.2 801.2 825.3 797.6 821.1 823.0 835.5 838.2 870.1 871.9 872.6 874.9 875.6 679.3 861.1 866.3 866.6 866.8 520.8 615.3 639.9 647.8 649.5 14210.4 14259.6 14310.8 14483.9 14492.9 11952.6 13362.1 13413.3 13451.9 13458.4 12047.9 12158.0 12198.3 12232.4 12315.9 3824.7 4281.8 4400.3 4444.7 4529.5 80182.0 82354.0 90140.1 91665.0 91877.0 8517.7 10816.6 10899.8 10998.3 11446.4 21375.9 21400.0 21411.3 21444.0 21472.5 7077.2 7223.5 7612.7 7728.7 7848.6 4155.1 4216.9 4227.5 4247.0 4368.9 3302.2 3420.6 3423.9 3430.0 3436.0 569.4 629.6 633.2 645.8 649.4 503.3 578.7 586.4 602.7 608.7 8323.5 8492.8 8501.5 8640.3 8813.6 566.0 594.8 604.2 620.4 630.4 3938.9 4079.1 4083.7 4199.8 4275.7 67010.0 115357.0 115420.0 117002.0 117365.0 99321.0 99446.5 100921.0 101176.0 103556.0 80823.0 90614.0 92469.5 93492.7 94906.5 7810.9 8085.9 8195.0 8362.3 8395.1 47914.0 54620.7 55087.6 56104.4 56534.0 63830.0 65902.7 70779.6 74452.6 77305.2 12565.3 12606.1 12624.6 12932.7 13017.2 13201.5 13335.9 13853.0 14294.1 14627.9 12887.5 12988.5 13499.9 13574.3 13593.9 13064.5 13162.9 13276.0 13581.9 13626.4 12813.9 12978.7 13166.5 13492.5 13519.5 11027.9 11155.7 11277.7 11292.1 11379.8 9430.1 9937.6 10699.0 10993.7 11325.8 14:16:59 INFO - PROCESS | 2187 | -------- Summary: end -------- 14:16:59 INFO - PROCESS | 2187 | 14:17:00 INFO - TEST-INFO | 2187: exit 0 14:17:00 INFO - TEST-OK | dromaeo_css | took 1119168ms 14:17:00 INFO - TEST-START | kraken 14:17:00 INFO - operating with platform_type : mac_ 14:17:00 INFO - Initialising browser for kraken test... 14:17:00 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpYupqhe/profile http://localhost:57810/getInfo.html) 14:17:02 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 14:17:02 INFO - PROCESS | 2195 | colorDepth:24 14:17:02 INFO - PROCESS | 2195 | Browser inner width/height: 1024/689 14:17:02 INFO - PROCESS | 2195 | __metrics 14:17:02 INFO - PROCESS | 2195 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:17:02 INFO - PROCESS | 2195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:03 INFO - TEST-INFO | 2195: exit 0 14:17:03 INFO - Browser initialized. 14:17:03 INFO - Running cycle 1/1 for kraken test... 14:17:03 INFO - TEST-INFO | started process 2196 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpYupqhe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:15 INFO - PROCESS | 2196 | RSS: Main: 241471488 14:17:15 INFO - PROCESS | 2196 | 14:17:18 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57810/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:19 INFO - PROCESS | 2196 | RSS: Main: 291532800 14:17:19 INFO - PROCESS | 2196 | 14:17:22 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57810/tests/kraken/driver.html?testName=audio-dft) 14:17:22 INFO - PROCESS | 2196 | RSS: Main: 291741696 14:17:22 INFO - PROCESS | 2196 | 14:17:26 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57810/tests/kraken/driver.html?testName=audio-fft) 14:17:26 INFO - PROCESS | 2196 | RSS: Main: 385388544 14:17:26 INFO - PROCESS | 2196 | 14:17:28 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57810/tests/kraken/driver.html?testName=audio-oscillator) 14:17:29 INFO - PROCESS | 2196 | RSS: Main: 286736384 14:17:29 INFO - PROCESS | 2196 | 14:17:31 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:32 INFO - PROCESS | 2196 | RSS: Main: 291446784 14:17:32 INFO - PROCESS | 2196 | 14:17:35 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57810/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:35 INFO - PROCESS | 2196 | RSS: Main: 332759040 14:17:35 INFO - PROCESS | 2196 | 14:17:38 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57810/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:39 INFO - PROCESS | 2196 | RSS: Main: 335773696 14:17:39 INFO - PROCESS | 2196 | 14:17:42 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57810/tests/kraken/driver.html?testName=json-parse-financial) 14:17:42 INFO - PROCESS | 2196 | RSS: Main: 330534912 14:17:42 INFO - PROCESS | 2196 | 14:17:44 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:44 INFO - PROCESS | 2196 | RSS: Main: 308789248 14:17:44 INFO - PROCESS | 2196 | 14:17:46 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:47 INFO - PROCESS | 2196 | RSS: Main: 310521856 14:17:47 INFO - PROCESS | 2196 | 14:17:49 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:50 INFO - PROCESS | 2196 | RSS: Main: 312807424 14:17:50 INFO - PROCESS | 2196 | 14:17:53 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:54 INFO - PROCESS | 2196 | RSS: Main: 329408512 14:17:54 INFO - PROCESS | 2196 | 14:17:57 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:58 INFO - PROCESS | 2196 | RSS: Main: 323252224 14:17:58 INFO - PROCESS | 2196 | 14:17:59 INFO - PROCESS | 2196 | Cycle 1(1): loaded http://localhost:57810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57810/tests/kraken/driver.html?testName=ai-astar) 14:18:00 INFO - PROCESS | 2196 | RSS: Main: 366018560 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | __start_tp_report 14:18:00 INFO - PROCESS | 2196 | _x_x_mozilla_page_load 14:18:00 INFO - PROCESS | 2196 | _x_x_mozilla_page_load_details 14:18:00 INFO - PROCESS | 2196 | |i|pagename|runs| 14:18:00 INFO - PROCESS | 2196 | |0;ai-astar;114;113;115;113;114;114;113;112;113;114 14:18:00 INFO - PROCESS | 2196 | |1;audio-beat-detection;162;97;126;175;142;142;117;113;142;111 14:18:00 INFO - PROCESS | 2196 | |2;audio-dft;186;183;181;186;185;182;182;178;180;184 14:18:00 INFO - PROCESS | 2196 | |3;audio-fft;84;61;58;88;61;59;62;60;85;65 14:18:00 INFO - PROCESS | 2196 | |4;audio-oscillator;91;69;93;95;99;100;90;68;69;93 14:18:00 INFO - PROCESS | 2196 | |5;imaging-gaussian-blur;89;86;89;86;88;85;90;88;89;85 14:18:00 INFO - PROCESS | 2196 | |6;imaging-darkroom;97;97;102;98;97;97;98;98;97;97 14:18:00 INFO - PROCESS | 2196 | |7;imaging-desaturate;86;86;85;88;85;87;91;129;87;87 14:18:00 INFO - PROCESS | 2196 | |8;json-parse-financial;58;56;55;55;53;54;54;54;55;55 14:18:00 INFO - PROCESS | 2196 | |9;json-stringify-tinderbox;68;71;69;77;73;70;72;72;72;73 14:18:00 INFO - PROCESS | 2196 | |10;stanford-crypto-aes;92;103;109;109;88;87;86;85;89;86 14:18:00 INFO - PROCESS | 2196 | |11;stanford-crypto-ccm;150;145;184;155;153;145;146;149;218;178 14:18:00 INFO - PROCESS | 2196 | |12;stanford-crypto-pbkdf2;176;179;234;196;239;237;176;187;207;173 14:18:00 INFO - PROCESS | 2196 | |13;stanford-crypto-sha256-iterative;68;68;66;67;66;67;67;68;68;66 14:18:00 INFO - PROCESS | 2196 | __end_tp_report 14:18:00 INFO - PROCESS | 2196 | __start_cc_report 14:18:00 INFO - PROCESS | 2196 | _x_x_mozilla_cycle_collect,2185 14:18:00 INFO - PROCESS | 2196 | __end_cc_report 14:18:00 INFO - PROCESS | 2196 | __startTimestamp1480630680147__endTimestamp 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | ------- Summary: start ------- 14:18:00 INFO - PROCESS | 2196 | Number of tests: 14 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 14:18:00 INFO - PROCESS | 2196 | Values: 114.0 113.0 115.0 113.0 114.0 114.0 113.0 112.0 113.0 114.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:142.00 stddev:24.34 (17.1%) stddev-sans-first:23.39 14:18:00 INFO - PROCESS | 2196 | Values: 162.0 97.0 126.0 175.0 142.0 142.0 117.0 113.0 142.0 111.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.50 stddev:2.63 (1.4%) stddev-sans-first:2.50 14:18:00 INFO - PROCESS | 2196 | Values: 186.0 183.0 181.0 186.0 185.0 182.0 182.0 178.0 180.0 184.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#3] audio-fft Cycles:10 Average:68.30 Median:63.50 stddev:12.17 (19.2%) stddev-sans-first:11.50 14:18:00 INFO - PROCESS | 2196 | Values: 84.0 61.0 58.0 88.0 61.0 59.0 62.0 60.0 85.0 65.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:92.00 stddev:12.83 (13.9%) stddev-sans-first:13.52 14:18:00 INFO - PROCESS | 2196 | Values: 91.0 69.0 93.0 95.0 99.0 100.0 90.0 68.0 69.0 93.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.84 (2.1%) stddev-sans-first:1.87 14:18:00 INFO - PROCESS | 2196 | Values: 89.0 86.0 89.0 86.0 88.0 85.0 90.0 88.0 89.0 85.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:97.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 14:18:00 INFO - PROCESS | 2196 | Values: 97.0 97.0 102.0 98.0 97.0 97.0 98.0 98.0 97.0 97.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:87.00 stddev:13.43 (15.4%) stddev-sans-first:14.12 14:18:00 INFO - PROCESS | 2196 | Values: 86.0 86.0 85.0 88.0 85.0 87.0 91.0 129.0 87.0 87.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.37 (2.5%) stddev-sans-first:0.88 14:18:00 INFO - PROCESS | 2196 | Values: 58.0 56.0 55.0 55.0 53.0 54.0 54.0 54.0 55.0 55.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:2.50 (3.5%) stddev-sans-first:2.26 14:18:00 INFO - PROCESS | 2196 | Values: 68.0 71.0 69.0 77.0 73.0 70.0 72.0 72.0 72.0 73.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:86.50 stddev:9.72 (11.2%) stddev-sans-first:10.30 14:18:00 INFO - PROCESS | 2196 | Values: 92.0 103.0 109.0 109.0 88.0 87.0 86.0 85.0 89.0 86.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#11] stanford-crypto-ccm Cycles:10 Average:162.30 Median:154.00 stddev:23.93 (15.5%) stddev-sans-first:24.96 14:18:00 INFO - PROCESS | 2196 | Values: 150.0 145.0 184.0 155.0 153.0 145.0 146.0 149.0 218.0 178.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.40 Median:201.50 stddev:27.08 (13.4%) stddev-sans-first:27.25 14:18:00 INFO - PROCESS | 2196 | Values: 176.0 179.0 234.0 196.0 239.0 237.0 176.0 187.0 207.0 173.0 14:18:00 INFO - PROCESS | 2196 | 14:18:00 INFO - PROCESS | 2196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 14:18:00 INFO - PROCESS | 2196 | Values: 68.0 68.0 66.0 67.0 66.0 67.0 67.0 68.0 68.0 66.0 14:18:00 INFO - PROCESS | 2196 | -------- Summary: end -------- 14:18:00 INFO - PROCESS | 2196 | 14:18:01 INFO - TEST-INFO | 2196: exit 0 14:18:01 INFO - TEST-OK | kraken | took 60926ms 14:18:01 INFO - SUITE-END | took 1180s 14:18:01 INFO - Completed test suite (00:19:40) 14:18:01 INFO - javascript benchmark 14:18:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.9038228853133, 3239.5464634951113, 3251.4309995750737, 3263.118957881372, 3276.8689252429904, 5329.960657671755, 5416.322959630046, 5419.0, 5472.972635136824, 5506.008918394692, 5426.403095659474, 5433.565314774818, 5448.237246785453, 5454.53636440903, 5460.672359658413, 4949.158643030684, 4990.75046247688, 4990.975045124769, 5037.168867136918, 5072.6195535335, 5043.24351347299, 5047.772850221731, 5057.721825299607, 5081.364829396325, 5141.460146684601, 5122.308488354061, 5124.0, 5133.3326667533165, 5172.198309262051, 5188.221766735001, 390.38086951413067, 5108.208227724708, 5110.361204849394, 5112.539871411554, 5191.325127733408, 3208.164081448265, 4980.352554167971, 4990.90018199634, 5043.243513472972, 5099.311592934943, 4502.4371953505815, 5417.106177480711, 5429.375621803503, 5493.615446918718, 5566.582506312043, 5998.40015998401, 6017.06735456005, 6021.307549631804, 6022.247219097613, 6025.789097381615, 5870.823875283706, 5885.588008839383, 5944.494717948979, 5978.1929439525975, 6001.549883758736, 5529.861753456155, 5545.722713864331, 5562.165675148679, 5569.916451253234, 5573.554115670818, 6223.315435302113, 6227.968860155761, 6228.564000520011, 6247.0, 6248.5313601480075, 5630.6058575900115, 5687.573431992617, 5688.431156884361, 5811.88376232473, 5895.292564892155, 6039.7282122304605, 6054.697265136726, 6084.695765211722, 6095.542834287447, 6102.176206212104, 5963.0, 5976.223090998229, 5983.760649573968, 5993.4905533029305, 6009.489193418608, 5016.523430274118, 5789.189513468118, 5880.588358814842, 5913.905927403444, 6074.51403887688, 4756.262779269149, 4758.2386818108935, 4769.046190761862, 4770.308305295782, 4777.617790576745, 4304.117655880537, 4335.544767799399, 4341.9131617367475, 4347.195768782785, 4349.956500435019, 5549.250851135045, 5630.268065151504, 5634.23937768396, 5641.407652196543, 5652.9152062719095, 6025.035994240988, 6025.9397406026255, 6031.065184896348, 6035.39646035393, 6045.969770151209, 4743.335932969387, 5594.748236329375, 5611.102223644198, 5643.604947653625, 5648.576356773258, 5070.340855688811, 5079.3396858408905, 5178.0679477694375, 5181.5077567631015, 5188.325517682677, 6266.68666566679, 6279.529035322369, 6285.717142728588, 6289.213848268966, 6296.307406185224, 5863.355030946678, 5899.321578018411, 5913.379095194942, 5913.763449461973, 5921.792737254175, 6190.473809726043, 6196.783112591038, 6241.531885108726, 6245.937540624535, 6283.3402492737605, 5933.347331793586, 5942.702864856827, 5951.583389162717, 5972.522198224218, 5983.55123365758, 6044.576879618385, 6050.697465126814, 6052.122442245762, 6062.848428789139, 6080.787172448943, 5042.445331013659, 5611.130274807411, 5632.070708333079, 5700.372958974593, 5704.629199102045, 5783.681897495678, 5785.566082543742, 5785.56608254391, 5807.477327040587, 5830.008898487183, 5650.208970744017, 5650.576206784425, 5657.12314591239, 5664.886702265849, 5683.119116536944, 5625.381208067028, 5721.799737009184, 5727.599068065362, 5760.366359700346, 5767.134929760569, 4786.593139583175, 5640.520555752642, 5691.146328050825, 5703.62926409782, 5738.368779434342], "value": 5432.52579606514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.9124266389386, 462.9421322334708, 513.7636687123921, 516.202467188194, 538.2491424462877, 29090.709092909063, 30724.771009159635, 30750.538741918863, 38176.0, 39077.804610976906, 39939.800300998526, 40393.99015024626, 40398.0, 40457.59542404575, 40551.59448405515, 9163.35856490046, 9291.628334866631, 9312.208462280714, 9326.906730932706, 9337.253019758436, 9210.125038121401, 9332.58003389849, 9340.486273254968, 9345.345825792198, 9356.29827762917, 9094.86357704635, 9126.771830704252, 9160.221381182608, 9190.172884440399, 9200.953995230015, 8556.957215213946, 8743.775871378011, 9268.814623707522, 9330.813383732288, 9360.578773955189, 9040.005599384063, 9087.363884528086, 9095.090490950919, 9096.681616143404, 9103.908960910372, 37901.24197516062, 38314.61685383166, 38355.23289534222, 38404.84785456441, 38441.61558384437, 3251.089694885436, 3280.1799550112473, 3522.295540891832, 3878.45701601776, 4021.698372622065, 28477.145685629464, 29369.0, 29517.557236641467, 29603.703962960524, 29783.21300721942, 3081.403728498523, 3103.7206651401257, 3220.7745457817964, 3234.708876201153, 3258.185453636591, 466238.6688066572, 466605.0, 467274.0, 467667.0, 468929.310706892, 53847.0, 54710.72644636752, 54734.72632636891, 54764.0, 54850.72574637101, 56940.0, 56992.43007569954, 56997.43002570004, 57029.14456283159, 57036.71481642648, 14889.18109503966, 15124.243787810565, 15133.54599361999, 15145.545633631009, 15165.317560709795, 11839.0, 11908.0, 11909.464074116686, 11917.404129793476, 11954.521819127138, 14091.577252682437, 14723.779143312859, 14739.63150921214, 14772.55682329532, 14952.0, 6509.967450162719, 6537.934620653733, 6687.732490700318, 6697.588868007513, 6730.831729206809, 845.4673555660017, 932.2728271947891, 940.586142097475, 1035.5961175141701, 1041.3855825063097, 28386.71613283882, 28392.86428542835, 28747.425051498853, 28962.565561516592, 29164.12507624732, 876.3952872517942, 983.3755565215996, 1012.2762225009006, 1050.0444595418132, 1085.3596378136938, 11980.536494073613, 14248.287585620677, 14613.72472977132, 14862.73476308648, 14923.104613723212, 170056.0, 170131.0, 170303.1484842568, 170502.0, 170875.0, 54360.640983974925, 54368.0, 54480.45519544754, 54529.90940181253, 54570.45429545733, 1291.225264841088, 1330.8003799430162, 1347.2522749873717, 1347.4744849508895, 1348.3999620169127, 28231.71768282291, 28407.147785566467, 28591.285217868888, 28884.855575722828, 29003.564946525395, 45683.54316456793, 46145.53854461412, 46174.07520360807, 46227.075458491316, 46395.76802115968, 498610.0, 501439.0, 502761.0, 506050.0, 506451.0, 36616.63383366132, 36955.0, 37412.812935935144, 37643.0, 37783.43324850075, 39510.40734388929, 40922.1815563693, 42966.57033429626, 43348.0, 45134.77432612816, 35109.297814043064, 36192.457113142795, 37035.62964370322, 37497.62502374942, 38130.23739525139, 35741.46387804237, 35787.46318805272, 36985.0, 37387.62612373842, 37430.43854342242, 29763.0, 35497.46753798747, 35827.462588061724, 36551.45172822463, 36690.63309366979, 30527.847360763055, 32288.35423291568, 32546.0, 33678.83160584181, 33994.83002584971, 23990.0, 24128.51742965166, 24159.879200603886, 24634.384140396633, 24678.753212467647], "value": 18283.27911688408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.89707536276796, 363.6091201957895, 363.6817784438616, 375.8459031796964, 397.906491974386, 14110.647233819147, 14690.412383504661, 15573.29920153593, 17711.46865594034, 20019.799802001977, 18392.81607183928, 18865.96237206953, 19406.320778772744, 19619.0, 19748.506287342825, 5589.74846131924, 5970.164177015221, 5972.701364931758, 5975.611585246967, 5983.311919129313, 5548.667079975195, 5570.415106413829, 5795.681237531934, 5864.530837533009, 5889.793857214999, 4951.628627852908, 5826.388229235933, 5841.678707671076, 5843.824685259449, 5843.970780146094, 5575.2473416088915, 5757.4818266355815, 5762.0, 5797.884042319172, 5828.88342233153, 4980.0288943656005, 4989.351384320052, 5056.570191533724, 5064.366954130734, 5082.644214904958, 20054.298099566444, 22766.31701048971, 23400.765992340028, 23852.057236223063, 24534.895929683207, 1876.7278744581959, 2151.7633060363346, 2296.460331822037, 2312.1560630369795, 2351.6237402015595, 9611.711648650551, 9668.419894806264, 10104.393736375841, 10262.948685256526, 14374.063342991287, 1802.720578310364, 1836.5225041489175, 1838.8253115953962, 1863.3105750872128, 1866.2628261836635, 109452.90547094507, 112924.87075129226, 116423.0, 119668.02489813212, 120692.79307206991, 8157.918420815835, 8763.693270735494, 8853.601587928559, 9565.330426870052, 9722.256931081585, 11788.115891308185, 12189.939050304693, 12266.448009839578, 12287.078469114853, 12307.815382769266, 7420.480566360303, 7658.846823063507, 7698.2686644768655, 7772.68909243624, 7775.377969762519, 7877.527348359117, 7880.744398025002, 7903.802404939807, 8032.15662355456, 8042.5121352548795, 3776.527934008249, 3780.5652349980105, 3795.392737162096, 3859.1895701902913, 3868.0909986153233, 1844.1056087797408, 1883.5950270691867, 1897.9051047447572, 1926.0947354743248, 1952.8575783167007, 804.5373910001772, 825.7063270990872, 844.3329769482164, 850.7787975126512, 870.2298465857635, 19251.03744812754, 19799.901000495192, 20166.596668066555, 20273.797262027485, 20601.690974635392, 773.8993930788962, 886.8093359927517, 896.4038914122166, 913.2100732866156, 913.5477938420524, 8644.956775216084, 9701.70894873155, 9966.103050725469, 10364.948175259075, 10671.413072281099, 581909.0, 582158.0, 582555.0, 593253.0, 599031.0, 91157.08842911485, 129435.0, 140638.0, 140755.0, 143624.0, 940.0881145289059, 971.8542218667116, 977.1938151025432, 991.6479649724243, 994.9701508954743, 17242.913785430992, 18106.366277180234, 18128.72806907924, 18307.0, 18307.908460457613, 40345.59654403418, 52969.735151324, 53014.0, 53064.73467632637, 53978.73010634922, 75230.0, 75540.62229688816, 75948.0, 79859.0, 81012.3797524058, 7743.109542402471, 7757.844843102994, 7927.128015918129, 7973.760787176394, 8160.224778646019, 10809.513571889127, 12512.812307815208, 12573.308468034345, 12701.872981270439, 12782.424790884246, 10490.0, 10507.369557826554, 10722.73193170177, 10942.507587158756, 11140.275882067639, 10441.425721585385, 10447.425391603534, 10720.73198170052, 10776.353418794584, 10938.617148399768, 8919.197272245528, 10105.141063009432, 11143.275687080313, 11333.26333788301, 11388.715282118013, 7632.313091821763, 7677.0, 7846.607669616382, 7876.566788826441, 8160.755177344689, 9528.475933823429, 10609.257351985287, 11047.558097676003, 11084.0, 11099.778004439704], "value": 9049.85859051913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.5153899213258, 1492.8208614966204, 1642.6714657068583, 1790.6866298397792, 1826.853851691864, 7934.801629959254, 8345.582720863962, 8356.164383561641, 8379.581020948952, 8396.664133434655, 7374.668139933702, 7625.237476252372, 7647.120581133171, 7983.32141767949, 8105.148959359256, 1832.4411054628333, 2242.1367773407273, 2283.577538155438, 2287.90848366066, 2289.095807156172, 2261.977380226201, 2296.8277379196543, 2315.235972129193, 2318.8840557972117, 2322.140807901079, 2258.480549473622, 2264.3546589222074, 2288.1305104060516, 2291.0721157931066, 2291.4385975436044, 1872.3353209610527, 2258.4579700871755, 2281.2129815213725, 2283.7259528856475, 2287.4167087392775, 2283.2693538067824, 2302.7121609798774, 2307.3654744945106, 2312.213847291912, 2312.8496647717843, 8279.875801862976, 8331.750047498525, 8356.373272004563, 8376.706815261437, 8388.245057944754, 4968.503149685002, 5137.537621614073, 5138.0, 5147.279380886679, 5154.144507977126, 3211.903642890717, 3441.105312618737, 3446.5347178130883, 3473.548438702978, 3490.5636795400574, 987.5013118375247, 1027.203916964351, 1059.6873922192972, 1064.297563608015, 1070.8447275145138, 10338.638147664871, 10734.409607471585, 10735.0, 10757.139428845674, 10760.192985526117, 3689.6494832990825, 4244.10873716523, 4365.0, 4402.537733537996, 4411.691181617321, 8424.831503369898, 8620.827583448421, 8622.09468005863, 8630.39587228888, 8637.870431943526, 5028.0, 5028.321176641107, 5030.220315851049, 5034.546890779848, 5034.823781167642, 3591.3894637911617, 4379.693421460467, 4495.730256184639, 4661.743604101807, 4697.084068606658, 3341.732661387132, 3385.2213990782257, 3436.621971583124, 3442.7934323940644, 3463.480477928331, 1067.6743593204146, 1098.873629532598, 1109.7225693576606, 1109.7891400633853, 1112.360392774142, 855.6962278391081, 868.6004437958484, 889.4840992224624, 911.6080085563271, 925.1303774451993, 5129.281900533928, 5202.713850738246, 5298.947010529922, 5593.804216852391, 5638.013347664142, 886.3751055505853, 894.8836651235298, 917.495377542349, 919.1176470588176, 970.8009857979239, 3694.8891533254045, 3733.9253214935547, 3808.27642747877, 3857.4985251917633, 3867.613238676166, 9457.24342052648, 9978.950105249573, 9980.201583873273, 9990.0, 9994.650187243411, 9911.0, 9949.452780097019, 9952.950235248922, 9953.402795832273, 9957.153641940371, 6626.668666566652, 7420.220876807965, 7596.696132154762, 7633.427492938052, 7738.264864837832, 4416.823327066882, 4726.409198850144, 5465.316835395575, 5585.385607583082, 5642.915356269577, 9041.954790226007, 9244.583993720164, 9260.166585007382, 9273.489958052372, 9357.20463760588, 9129.817403652023, 9147.131022552847, 9224.40041397307, 9398.859017114886, 9582.425054496753, 7445.441591880739, 7631.656575454229, 7660.080790304976, 7767.184445633127, 7783.416243781852, 7206.603636800026, 7435.7025718970635, 7461.515001524884, 7587.544747315179, 7794.986651735465, 6911.17065952089, 7010.334018268256, 7086.929130708627, 7100.0, 7139.714411423485, 6886.827829304308, 6951.826204344729, 6969.407600354027, 7020.473464490286, 7039.366457018893, 6578.407943285128, 6601.53789234749, 6603.20761508622, 6624.105745724266, 6691.665416729242, 4138.193052354762, 4482.65520343889, 4621.075784842978, 4724.834630787906, 4828.227483602606, 3983.462232598562, 4092.7748973805537, 4281.486221653421, 4671.322658214608, 4934.506549345037], "value": 4292.08917717324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [245.91515927005182, 265.48363433122574, 297.20794083766776, 306.3474798678813, 313.11544885697907, 5100.719460429679, 5105.0, 5113.872153196163, 5120.2319652052165, 5147.040451740246, 4708.176069187887, 4803.495632958533, 4883.6337274704365, 4900.191468407708, 4967.130752118383, 3742.4760533525327, 3883.1262965832602, 3887.552931412881, 3923.1761330120707, 3979.5622481527007, 3164.335489547198, 3915.7650540967634, 3916.2754890345236, 3931.9803400982955, 3935.779908228444, 3284.0, 3786.659200671939, 3879.35990561557, 3927.2145570885937, 3941.0935484838506, 3262.3475304939107, 3338.132085657722, 3641.6358364163502, 3766.114962983697, 3823.655870971626, 3233.1917020744813, 3406.182516196095, 3451.2062225687982, 3458.463938089575, 3476.443768996948, 4069.4506241657296, 4096.6313031826985, 4915.926261106087, 4963.751812409401, 4967.279744437073, 3757.530308711411, 4270.316749320094, 4470.530594287586, 4492.707973981714, 4507.2788353863225, 4664.207084795593, 5343.305370301875, 5354.544863686591, 5370.812021579265, 5414.5668346532575, 3450.9654903450896, 3541.8760343388117, 3780.7920564368947, 3787.0153760022317, 3791.317562838688, 4746.155613952675, 5322.494363035506, 5453.890922181574, 5596.4123767004285, 5634.971825140889, 3386.9153271168416, 3805.5813860475328, 3833.4441505981476, 3856.0359910022494, 3856.972276762784, 3875.399313106473, 3881.6700580450415, 3889.1638297766117, 3899.0, 3902.570717221103, 3800.6959443244473, 4223.408722778813, 4454.621357184676, 4473.575010374009, 4505.707129036602, 5310.362756469249, 5316.016536940679, 5363.678179309254, 5401.487583476633, 5438.510534051875, 1176.5411489519095, 1235.3637876493613, 1237.560665963588, 1238.1704258147063, 1263.7851565233748, 817.3747083481142, 829.2578142562494, 836.8451836410284, 837.6146972392768, 844.907060223375, 4794.5924596408995, 4797.688150270221, 4804.35141255926, 4864.391951006124, 4866.391701037371, 4737.773246574105, 5119.385673719177, 5139.537441630271, 5172.301739265151, 5192.5586325162785, 4580.610648094949, 4715.3869996900185, 4743.45450273223, 4806.0, 4841.0, 2243.48399868028, 2446.266120163944, 2522.994219595426, 2600.739926007422, 2734.603482495027, 4477.224121044973, 4882.511748825089, 5399.298091248191, 5442.401335853053, 5495.725213739297, 4567.533531892741, 5184.5593124584075, 5186.783929681371, 5321.73391330432, 5326.600504962066, 4616.838410655611, 5259.369595425431, 5260.316158899395, 5383.5423988961375, 5453.727313634303, 4591.5435242145295, 4689.835855745033, 5052.418971818288, 5066.08810414129, 5073.670211436245, 4177.874663760092, 4666.2767271073035, 4748.691335063209, 5038.470960549236, 5116.7230582390475, 4669.692486103896, 4940.752962351796, 5049.091163590589, 5457.516829842333, 5495.230667706604, 2950.8819647213872, 3445.3109378123972, 3542.4686297055646, 3614.403623402109, 3673.412254039448, 3839.080459770115, 4150.501939767248, 4413.955860441354, 4936.370997570722, 5217.295665085165, 4989.55094041538, 5018.673786203885, 5033.037115524875, 5034.672746271481, 5053.8268544524735, 4046.4537287465814, 4531.235946072827, 5000.749962501933, 5023.191651005562, 5060.797568097235, 4047.838086476508, 4562.726236425825, 4669.719816811003, 4867.172580661225, 4907.975460122677, 4916.06594746997, 5008.474110218374, 5277.656952298088, 5278.947210527999, 5284.603654725834, 4358.0, 4375.27807911691, 5146.871328216825, 5169.327987361619, 5196.298499702491], "value": 3789.1645901206207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.3071067511141, 698.0994517072976, 743.3012967810258, 746.615493021094, 776.375018110421, 14309.78535321971, 14873.702525949475, 14895.404183832661, 14941.879359048075, 14963.775543366844, 13303.667408314774, 13457.93271033646, 13485.46058157675, 13493.2578708171, 13496.932515337434, 640.4140211706283, 667.2160211751172, 669.2069897171842, 801.234820746186, 825.3149885594971, 797.5732982854145, 821.0721884270765, 822.9547374894379, 835.5070508400042, 838.153465000348, 870.0777176193224, 871.8822958900562, 872.6334939325499, 874.9300055995537, 875.5840975536601, 679.341039191983, 861.0528418739399, 866.2550206822128, 866.5797088412115, 866.8093019535692, 520.8359366799446, 615.3323643846433, 639.9264084630281, 647.757091090841, 649.4674367019046, 14210.360533776005, 14259.643508912257, 14310.785338219936, 14483.927580362137, 14492.927535362362, 11952.581659641957, 13362.131461455072, 13413.329333533382, 13451.932740336333, 13458.394372253271, 12047.939760301142, 12158.0, 12198.268103913793, 12232.388380581024, 12315.93842030793, 3824.6557809796973, 4281.77139020814, 4400.317950717644, 4444.666650001231, 4529.456465224194, 80182.0, 82354.0, 90140.09859901383, 91665.0, 91877.0, 8517.659293628309, 10816.56733730642, 10899.782004359868, 10998.34009959405, 11446.427678616035, 21375.89312053461, 21400.0, 21411.25060622902, 21444.0, 21472.463188420414, 7077.150741911004, 7223.494355395072, 7612.657430415645, 7728.690852365955, 7848.568328741974, 4155.148194620096, 4216.915661686749, 4227.513835908849, 4246.957530424656, 4368.868933931987, 3302.2239773653173, 3420.6066302375048, 3423.9144021399165, 3430.0395889151077, 3436.0, 569.3651578489954, 629.625372903122, 633.1831936801475, 645.7739791073087, 649.3960616626582, 503.28784769550674, 578.719321129252, 586.4340911020886, 602.728772052578, 608.689568320151, 8323.458975166595, 8492.830143397097, 8501.53241571707, 8640.265577425864, 8813.647454101892, 565.9943400566024, 594.7888499582585, 604.241676695744, 620.3548309757891, 630.3759278314436, 3938.8818335449982, 4079.102597428561, 4083.673306135502, 4199.811008504625, 4275.657947364266, 67010.0, 115357.0, 115420.0, 117002.0, 117365.0, 99321.0, 99446.5027674857, 100921.0, 101176.0, 103556.0, 80823.0, 90614.0, 92469.53765231131, 93492.66268343346, 94906.52546737222, 7810.921890781019, 8085.919140808752, 8194.959025204837, 8362.331013519026, 8395.061728395012, 47914.010748656416, 54620.72689636526, 55087.64800047629, 56104.43895560992, 56534.0, 63830.0, 65902.67048664918, 70779.64610176916, 74452.62773686097, 77305.22694773205, 12565.308908009782, 12606.117571770255, 12624.55814046504, 12932.676683082622, 13017.21896686202, 13201.471941122632, 13335.933320333335, 13853.0, 14294.070885392417, 14627.853721463074, 12887.48450061987, 12988.480460781462, 13499.932500337436, 13574.253416061816, 13593.887833978408, 13064.477420903057, 13162.868371316546, 13276.0, 13581.932090339486, 13626.386812593655, 12813.93593032029, 12978.740425191254, 13166.539171128965, 13492.460301587827, 13519.526816561372, 11027.889721102687, 11155.72110697239, 11277.661670149908, 11292.096632269562, 11379.829302560303, 9430.10414010668, 9937.602495900082, 10698.983596558315, 10993.670189894316, 11325.830112548154], "value": 7244.897846932666, "unit": "score"}], "name": "dromaeo_css", "value": 6878.574694271475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0, 112.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 97.0, 126.0, 175.0, 142.0, 142.0, 117.0, 113.0, 142.0, 111.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 181.0, 186.0, 185.0, 182.0, 182.0, 178.0, 180.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 58.0, 88.0, 61.0, 59.0, 62.0, 60.0, 85.0, 65.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 93.0, 95.0, 99.0, 100.0, 90.0, 68.0, 69.0, 93.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 85.0, 90.0, 88.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 102.0, 98.0, 97.0, 97.0, 98.0, 98.0, 97.0, 97.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 88.0, 85.0, 87.0, 91.0, 129.0, 87.0, 87.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 55.0, 53.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 77.0, 73.0, 70.0, 72.0, 72.0, 72.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 103.0, 109.0, 109.0, 88.0, 87.0, 86.0, 85.0, 89.0, 86.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 145.0, 184.0, 155.0, 153.0, 145.0, 146.0, 149.0, 218.0, 178.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 234.0, 196.0, 239.0, 237.0, 176.0, 187.0, 207.0, 173.0], "value": 200.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 68.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1510.1, "alertThreshold": 2.0}]} 14:18:01 INFO - Return code: 0 14:18:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:18:01 INFO - # TBPL SUCCESS # 14:18:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:18:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:18:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:18:01 INFO - 2016-12-01 14:18:01.469 screenresolution[2200:28367] starting screenresolution argv=screenresolution get 14:18:01 INFO - 2016-12-01 14:18:01.471 screenresolution[2200:28367] Display 0: 1600x1200x32@60 14:18:01 INFO - 2016-12-01 14:18:01.477 screenresolution[2201:28370] starting screenresolution argv=screenresolution list 14:18:01 INFO - Available Modes on Display 0 14:18:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:18:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:18:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:18:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:18:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:18:01 INFO - Intel Iris: 14:18:01 INFO - Chipset Model: Intel Iris 14:18:01 INFO - Type: GPU 14:18:01 INFO - Bus: Built-In 14:18:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:18:01 INFO - Vendor: Intel (0x8086) 14:18:01 INFO - Device ID: 0x0a2e 14:18:01 INFO - Revision ID: 0x0009 14:18:01 INFO - Displays: 14:18:01 INFO - Display: 14:18:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:18:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:18:01 INFO - Display Serial Number: 1600x1200 60 14:18:01 INFO - Main Display: Yes 14:18:01 INFO - Mirror: Off 14:18:01 INFO - Online: Yes 14:18:01 INFO - Rotation: Supported 14:18:01 INFO - Return code: 0 14:18:01 INFO - Running post-action listener: _resource_record_post_action 14:18:01 INFO - [mozharness: 2016-12-01 22:18:01.715993Z] Finished run-tests step (success) 14:18:01 INFO - Running post-run listener: _resource_record_post_run 14:18:01 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 458752; Write bytes: 702061568; Read time: 8; Write time: 1967 14:18:01 INFO - TinderboxPrint: CPU usage
53.6% 14:18:01 INFO - TinderboxPrint: I/O read bytes / time
458,752 / 8 14:18:01 INFO - TinderboxPrint: I/O write bytes / time
702,061,568 / 1,967 14:18:01 INFO - TinderboxPrint: CPU idle
2,254.9 (46.4%) 14:18:01 INFO - TinderboxPrint: CPU system
974.5 (20.0%) 14:18:01 INFO - TinderboxPrint: CPU user
1,632.4 (33.6%) 14:18:01 INFO - TinderboxPrint: Swap in / out
398,770,176 / 0 14:18:01 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 391715328; Write bytes: 386680832; Read time: 29779; Write time: 800 14:18:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 458752; Write bytes: 298992640; Read time: 8; Write time: 1117 14:18:02 INFO - Running post-run listener: _upload_blobber_files 14:18:02 INFO - Blob upload gear active. 14:18:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:02 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 14:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:18:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:03 INFO - (blobuploader) - INFO - Done attempting. 14:18:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:18:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:05 INFO - (blobuploader) - INFO - Done attempting. 14:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:18:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:07 INFO - (blobuploader) - INFO - Done attempting. 14:18:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:18:07 INFO - Return code: 0 14:18:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:18:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:18:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6e432846850d37d3e5e668b2df5f352a547f769037e0db7e4980338190b23dc111bf89dde3d60ea774b18c6ef45428f32bfb42635b3dd9d9891e3540e4cf73ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/799c18f937d12b78f6cb5123c37d9adc895b538c6fa06c8cf2630f83a5161122189a6032123a8c00044d3711e31dc71656abdc938e3b9c807771c488ee56cbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/848eeba5c802f2bf9f6a3a78d5ab367fd282b082d2e688fbcf68a42ae4ef5264f9f0f8bb4786eef5ca92cbbd5a48b5ff71005a7fe91abd0ab7c64222eead5b1d"} 14:18:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:18:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:18:07 INFO - Contents: 14:18:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6e432846850d37d3e5e668b2df5f352a547f769037e0db7e4980338190b23dc111bf89dde3d60ea774b18c6ef45428f32bfb42635b3dd9d9891e3540e4cf73ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/799c18f937d12b78f6cb5123c37d9adc895b538c6fa06c8cf2630f83a5161122189a6032123a8c00044d3711e31dc71656abdc938e3b9c807771c488ee56cbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/848eeba5c802f2bf9f6a3a78d5ab367fd282b082d2e688fbcf68a42ae4ef5264f9f0f8bb4786eef5ca92cbbd5a48b5ff71005a7fe91abd0ab7c64222eead5b1d"} 14:18:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:18:07 INFO - Copying logs to upload dir... 14:18:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:18:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.827606 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-01 14:18:07.663085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 14:18:07.666722) ========= 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.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6e432846850d37d3e5e668b2df5f352a547f769037e0db7e4980338190b23dc111bf89dde3d60ea774b18c6ef45428f32bfb42635b3dd9d9891e3540e4cf73ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/799c18f937d12b78f6cb5123c37d9adc895b538c6fa06c8cf2630f83a5161122189a6032123a8c00044d3711e31dc71656abdc938e3b9c807771c488ee56cbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/848eeba5c802f2bf9f6a3a78d5ab367fd282b082d2e688fbcf68a42ae4ef5264f9f0f8bb4786eef5ca92cbbd5a48b5ff71005a7fe91abd0ab7c64222eead5b1d"} build_url:https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/SXha54-LQ2Ce71FMpCGq2w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6e432846850d37d3e5e668b2df5f352a547f769037e0db7e4980338190b23dc111bf89dde3d60ea774b18c6ef45428f32bfb42635b3dd9d9891e3540e4cf73ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/799c18f937d12b78f6cb5123c37d9adc895b538c6fa06c8cf2630f83a5161122189a6032123a8c00044d3711e31dc71656abdc938e3b9c807771c488ee56cbec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/848eeba5c802f2bf9f6a3a78d5ab367fd282b082d2e688fbcf68a42ae4ef5264f9f0f8bb4786eef5ca92cbbd5a48b5ff71005a7fe91abd0ab7c64222eead5b1d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 14:18:07.707263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:18:07.707793) ========= 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.lrY2EnibM2/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.2g7w0HnmjV/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.005265 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:18:07.758315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 14:18:07.758831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 14:18:07.759398) ========= ========= Total master_lag: 0.27 =========