builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1477090318.79 results: success (0) buildid: 20161021141323 builduid: d05bb043d0ba499192aeeb0057f2d028 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.791729) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.792281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.792596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.856351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.856866) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 15:51:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 46.7M=0s 2016-10-21 15:51:58 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073976 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.956197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:58.956563) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019041 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.009283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.009657) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 15:51:59,115 truncating revision to first 12 chars 2016-10-21 15:51:59,115 Setting DEBUG logging. 2016-10-21 15:51:59,115 attempt 1/10 2016-10-21 15:51:59,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 15:51:59,413 unpacking tar archive at: mozilla-central-5639a9f476d0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.647130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.647707) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.648318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.648746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 15:51:59.664348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-21 15:51:59.664664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:59 INFO - MultiFileLogger online at 20161021 15:51:59 in /builds/slave/test 15:51:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:51:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:59 INFO - {'append_to_log': False, 15:51:59 INFO - 'base_work_dir': '/builds/slave/test', 15:51:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:51:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:59 INFO - 'branch': 'Firefox-Non-PGO', 15:51:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:59 INFO - 'config_files': ('talos/linux_config.py',), 15:51:59 INFO - 'default_actions': ('clobber', 15:51:59 INFO - 'read-buildbot-config', 15:51:59 INFO - 'download-and-extract', 15:51:59 INFO - 'populate-webroot', 15:51:59 INFO - 'create-virtualenv', 15:51:59 INFO - 'install', 15:51:59 INFO - 'run-tests'), 15:51:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:59 INFO - 'download_minidump_stackwalk': True, 15:51:59 INFO - 'download_symbols': 'ondemand', 15:51:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:59 INFO - 'installer_path': 'installer.exe', 15:51:59 INFO - 'log_level': 'info', 15:51:59 INFO - 'log_name': 'talos', 15:51:59 INFO - 'log_to_console': True, 15:51:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:59 INFO - 'opt_config_files': (), 15:51:59 INFO - 'pip_index': False, 15:51:59 INFO - 'sps_profile': False, 15:51:59 INFO - 'sps_profile_interval': 0, 15:51:59 INFO - 'suite': 'dromaeojs', 15:51:59 INFO - 'system_bits': '32', 15:51:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:59 INFO - 'title': 'talos-linux64-ix-004', 15:51:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:59 INFO - 'use_talos_json': True, 15:51:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:59 INFO - 'work_dir': 'build'} 15:51:59 INFO - [mozharness: 2016-10-21 22:51:59.866564Z] Running clobber step. 15:51:59 INFO - Running pre-action listener: _resource_record_pre_action 15:51:59 INFO - Running main action method: clobber 15:51:59 INFO - rmtree: /builds/slave/test/build 15:51:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:00 INFO - Running post-action listener: _resource_record_post_action 15:52:00 INFO - [mozharness: 2016-10-21 22:52:00.834955Z] Finished clobber step (success) 15:52:00 INFO - [mozharness: 2016-10-21 22:52:00.835054Z] Running read-buildbot-config step. 15:52:00 INFO - Running pre-action listener: _resource_record_pre_action 15:52:00 INFO - Running main action method: read_buildbot_config 15:52:00 INFO - Using buildbot properties: 15:52:00 INFO - { 15:52:00 INFO - "project": "", 15:52:00 INFO - "product": "firefox", 15:52:00 INFO - "script_repo_revision": "production", 15:52:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:52:00 INFO - "repository": "", 15:52:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:52:00 INFO - "buildid": "20161021141323", 15:52:00 INFO - "pgo_build": "False", 15:52:00 INFO - "basedir": "/builds/slave/test", 15:52:00 INFO - "buildnumber": 263, 15:52:00 INFO - "slavename": "talos-linux64-ix-004", 15:52:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:52:00 INFO - "platform": "ubuntu64_hw", 15:52:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:52:00 INFO - "branch": "mozilla-central", 15:52:00 INFO - "repo_path": "mozilla-central", 15:52:00 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 15:52:00 INFO - "stage_platform": "linux64", 15:52:00 INFO - "builduid": "d05bb043d0ba499192aeeb0057f2d028", 15:52:00 INFO - "slavebuilddir": "test" 15:52:00 INFO - } 15:52:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:52:00 INFO - Running post-action listener: _resource_record_post_action 15:52:00 INFO - [mozharness: 2016-10-21 22:52:00.837494Z] Finished read-buildbot-config step (success) 15:52:00 INFO - [mozharness: 2016-10-21 22:52:00.837582Z] Running download-and-extract step. 15:52:00 INFO - Running pre-action listener: _resource_record_pre_action 15:52:00 INFO - Running main action method: download_and_extract 15:52:00 INFO - mkdir: /builds/slave/test/build/tests 15:52:00 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')]} 15:52:00 INFO - trying https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:52:01 INFO - Downloaded 1361 bytes. 15:52:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:52:01 INFO - Using the following test package requirements: 15:52:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'jsshell-linux-x86_64.zip'], 15:52:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:52:02 INFO - Http code: 200 15:52:02 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 15:52:02 INFO - x-amz-cf-id: 8lBsuWkYgu8jYWD2Rku3TH8NzTWR7XUiFLG5Mf0dKnpHT-F5TNgXnA== 15:52:02 INFO - x-amz-version-id: 0NPtcMRI9T9jzOdNV1_sScH34tga5.jE 15:52:02 INFO - Expected file size: 20463558 15:52:02 INFO - Obtained file size: 20463558 15:52:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:52:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:52:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:52:06 INFO - Http code: 200 15:52:06 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 15:52:06 INFO - x-amz-cf-id: CtZehvOxYuOPtWBT9If6iHvJ3EaKDWJ-61VUNMEHuHydyST2Za75ug== 15:52:06 INFO - x-amz-version-id: 0NPtcMRI9T9jzOdNV1_sScH34tga5.jE 15:52:07 INFO - Expected file size: 20463558 15:52:07 INFO - Obtained file size: 20463558 15:52:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:52:11 INFO - Fetch https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:52:12 INFO - Http code: 200 15:52:12 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:52:12 INFO - x-amz-cf-id: Vo8Zt7tPwXbwF1Nxt9dyC2UydmWp1p-YFzPZ43ONv3FL5QdSnpuaCg== 15:52:12 INFO - x-amz-version-id: t6c2Aav4S2l1xsVtlaIB41vBsLFlgfUu 15:52:12 INFO - Expected file size: 14409028 15:52:12 INFO - Obtained file size: 14409028 15:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:12 INFO - trying https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:52:14 INFO - Downloaded 55546067 bytes. 15:52:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:14 INFO - mkdir: /builds/slave/test/properties 15:52:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:14 INFO - Contents: 15:52:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:52:14 INFO - Running post-action listener: _resource_record_post_action 15:52:14 INFO - Running post-action listener: set_extra_try_arguments 15:52:14 INFO - [mozharness: 2016-10-21 22:52:14.626357Z] Finished download-and-extract step (success) 15:52:14 INFO - [mozharness: 2016-10-21 22:52:14.626582Z] Running populate-webroot step. 15:52:14 INFO - Running pre-action listener: _resource_record_pre_action 15:52:14 INFO - Running main action method: populate_webroot 15:52:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:14 INFO - '--tppagecycles', 15:52:14 INFO - '7'], 15:52:14 INFO - 'tests': ['tsvgm']}}, 15:52:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['damp', 'tps']}, 15:52:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'tests': ['damp', 'tps']}, 15:52:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['dromaeo_dom']}, 15:52:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['basic_compositor_video']}, 15:52:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['a11yr', 15:52:14 INFO - 'ts_paint', 15:52:14 INFO - 'tpaint', 15:52:14 INFO - 'sessionrestore', 15:52:14 INFO - 'sessionrestore_no_auto_restore', 15:52:14 INFO - 'tabpaint']}, 15:52:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['tsvgx', 15:52:14 INFO - 'tsvgr_opacity', 15:52:14 INFO - 'tart', 15:52:14 INFO - 'tscrollx', 15:52:14 INFO - 'cart']}, 15:52:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:14 INFO - 'tsvgr_opacity', 15:52:14 INFO - 'tart', 15:52:14 INFO - 'tscrollx', 15:52:14 INFO - 'cart']}, 15:52:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'talos_options': ['--disable-e10s'], 15:52:14 INFO - 'tests': ['tp5o']}, 15:52:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'tests': ['tp5o']}, 15:52:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'talos_options': ['--disable-e10s', 15:52:14 INFO - '--xperf_path', 15:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:14 INFO - 'tests': ['tp5n']}, 15:52:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:14 INFO - 'talos_options': ['--xperf_path', 15:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:14 INFO - 'tests': ['tp5n']}}, 15:52:14 INFO - 'talos.zip': {'path': '', 15:52:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:14 INFO - Running post-action listener: _resource_record_post_action 15:52:14 INFO - [mozharness: 2016-10-21 22:52:14.645541Z] Finished populate-webroot step (success) 15:52:14 INFO - [mozharness: 2016-10-21 22:52:14.645628Z] Running create-virtualenv step. 15:52:14 INFO - Running pre-action listener: _resource_record_pre_action 15:52:14 INFO - Running main action method: create_virtualenv 15:52:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:14 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 15:52:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:14 INFO - Using real prefix '/usr' 15:52:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:17 INFO - Installing pip.................done. 15:52:17 INFO - Return code: 0 15:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:52:17 INFO - Reading from file tmpfile_stdout 15:52:17 INFO - Output received: 15:52:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:52:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52: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 15:52: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 15:52:17 INFO - Using env: {'DISPLAY': ':0', 15:52:17 INFO - 'HOME': '/home/cltbld', 15:52:17 INFO - 'LANG': 'en_US.UTF-8', 15:52:17 INFO - 'LANGUAGE': 'en_US:en', 15:52:17 INFO - 'LOGNAME': 'cltbld', 15:52:17 INFO - 'MAIL': '/var/mail/cltbld', 15:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:17 INFO - 'MOZ_NO_REMOTE': '1', 15:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:17 INFO - 'NO_EM_RESTART': '1', 15:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:17 INFO - 'PWD': '/builds/slave/test', 15:52:17 INFO - 'SHELL': '/bin/bash', 15:52:17 INFO - 'SHLVL': '1', 15:52:17 INFO - 'TERM': 'linux', 15:52:17 INFO - 'TMOUT': '86400', 15:52:17 INFO - 'USER': 'cltbld', 15:52:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:17 INFO - '_': '/tools/buildbot/bin/python'} 15:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52: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 15:52:17 INFO - Cleaning up... 15:52:17 INFO - Return code: 0 15:52:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52: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 15:52: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 15:52:17 INFO - Using env: {'DISPLAY': ':0', 15:52:17 INFO - 'HOME': '/home/cltbld', 15:52:17 INFO - 'LANG': 'en_US.UTF-8', 15:52:17 INFO - 'LANGUAGE': 'en_US:en', 15:52:17 INFO - 'LOGNAME': 'cltbld', 15:52:17 INFO - 'MAIL': '/var/mail/cltbld', 15:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:17 INFO - 'MOZ_NO_REMOTE': '1', 15:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:17 INFO - 'NO_EM_RESTART': '1', 15:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:17 INFO - 'PWD': '/builds/slave/test', 15:52:17 INFO - 'SHELL': '/bin/bash', 15:52:17 INFO - 'SHLVL': '1', 15:52:17 INFO - 'TERM': 'linux', 15:52:17 INFO - 'TMOUT': '86400', 15:52:17 INFO - 'USER': 'cltbld', 15:52:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:17 INFO - '_': '/tools/buildbot/bin/python'} 15:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:17 INFO - Downloading/unpacking psutil>=3.1.1 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:19 INFO - Installing collected packages: psutil 15:52:19 INFO - Running setup.py install for psutil 15:52:19 INFO - building 'psutil._psutil_linux' extension 15:52:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:52:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:52:20 INFO - building 'psutil._psutil_posix' extension 15:52:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:52:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:20 INFO - Successfully installed psutil 15:52:20 INFO - Cleaning up... 15:52:20 INFO - Return code: 0 15:52:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:52:20 INFO - Using env: {'DISPLAY': ':0', 15:52:20 INFO - 'HOME': '/home/cltbld', 15:52:20 INFO - 'LANG': 'en_US.UTF-8', 15:52:20 INFO - 'LANGUAGE': 'en_US:en', 15:52:20 INFO - 'LOGNAME': 'cltbld', 15:52:20 INFO - 'MAIL': '/var/mail/cltbld', 15:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:20 INFO - 'MOZ_NO_REMOTE': '1', 15:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:20 INFO - 'NO_EM_RESTART': '1', 15:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:20 INFO - 'PWD': '/builds/slave/test', 15:52:20 INFO - 'SHELL': '/bin/bash', 15:52:20 INFO - 'SHLVL': '1', 15:52:20 INFO - 'TERM': 'linux', 15:52:20 INFO - 'TMOUT': '86400', 15:52:20 INFO - 'USER': 'cltbld', 15:52:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:20 INFO - '_': '/tools/buildbot/bin/python'} 15:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:52:22 INFO - Installing collected packages: mozsystemmonitor 15:52:22 INFO - Running setup.py install for mozsystemmonitor 15:52:22 INFO - Successfully installed mozsystemmonitor 15:52:22 INFO - Cleaning up... 15:52:22 INFO - Return code: 0 15:52:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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', '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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:52: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 jsonschema==2.5.1 15:52:22 INFO - Using env: {'DISPLAY': ':0', 15:52:22 INFO - 'HOME': '/home/cltbld', 15:52:22 INFO - 'LANG': 'en_US.UTF-8', 15:52:22 INFO - 'LANGUAGE': 'en_US:en', 15:52:22 INFO - 'LOGNAME': 'cltbld', 15:52:22 INFO - 'MAIL': '/var/mail/cltbld', 15:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:22 INFO - 'MOZ_NO_REMOTE': '1', 15:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:22 INFO - 'NO_EM_RESTART': '1', 15:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:22 INFO - 'PWD': '/builds/slave/test', 15:52:22 INFO - 'SHELL': '/bin/bash', 15:52:22 INFO - 'SHLVL': '1', 15:52:22 INFO - 'TERM': 'linux', 15:52:22 INFO - 'TMOUT': '86400', 15:52:22 INFO - 'USER': 'cltbld', 15:52:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:22 INFO - '_': '/tools/buildbot/bin/python'} 15:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:25 INFO - warning: no files found matching '*.txt' 15:52:25 INFO - no previously-included directories found matching 'build' 15:52:25 INFO - no previously-included directories found matching 'dist' 15:52:25 INFO - no previously-included directories found matching '.git*' 15:52:25 INFO - Installing collected packages: jsonschema, functools32 15:52:25 INFO - Running setup.py install for functools32 15:52:25 INFO - warning: no files found matching '*.txt' 15:52:25 INFO - no previously-included directories found matching 'build' 15:52:25 INFO - no previously-included directories found matching 'dist' 15:52:25 INFO - no previously-included directories found matching '.git*' 15:52:25 INFO - Successfully installed jsonschema functools32 15:52:25 INFO - Cleaning up... 15:52:25 INFO - Return code: 0 15:52:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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', '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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:52: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 functools32==3.2.3-2 15:52:25 INFO - Using env: {'DISPLAY': ':0', 15:52:25 INFO - 'HOME': '/home/cltbld', 15:52:25 INFO - 'LANG': 'en_US.UTF-8', 15:52:25 INFO - 'LANGUAGE': 'en_US:en', 15:52:25 INFO - 'LOGNAME': 'cltbld', 15:52:25 INFO - 'MAIL': '/var/mail/cltbld', 15:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:25 INFO - 'MOZ_NO_REMOTE': '1', 15:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:25 INFO - 'NO_EM_RESTART': '1', 15:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:25 INFO - 'PWD': '/builds/slave/test', 15:52:25 INFO - 'SHELL': '/bin/bash', 15:52:25 INFO - 'SHLVL': '1', 15:52:25 INFO - 'TERM': 'linux', 15:52:25 INFO - 'TMOUT': '86400', 15:52:25 INFO - 'USER': 'cltbld', 15:52:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:25 INFO - '_': '/tools/buildbot/bin/python'} 15:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:52:25 INFO - Cleaning up... 15:52:25 INFO - Return code: 0 15:52:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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', '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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52: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 blobuploader==1.2.4 15:52:25 INFO - Using env: {'DISPLAY': ':0', 15:52:25 INFO - 'HOME': '/home/cltbld', 15:52:25 INFO - 'LANG': 'en_US.UTF-8', 15:52:25 INFO - 'LANGUAGE': 'en_US:en', 15:52:25 INFO - 'LOGNAME': 'cltbld', 15:52:25 INFO - 'MAIL': '/var/mail/cltbld', 15:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:25 INFO - 'MOZ_NO_REMOTE': '1', 15:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:25 INFO - 'NO_EM_RESTART': '1', 15:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:25 INFO - 'PWD': '/builds/slave/test', 15:52:25 INFO - 'SHELL': '/bin/bash', 15:52:25 INFO - 'SHLVL': '1', 15:52:25 INFO - 'TERM': 'linux', 15:52:25 INFO - 'TMOUT': '86400', 15:52:25 INFO - 'USER': 'cltbld', 15:52:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:25 INFO - '_': '/tools/buildbot/bin/python'} 15:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:26 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 15:52:26 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 15:52:26 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 15:52:26 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 15:52:26 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 15:52:26 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 15:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:28 INFO - Downloading docopt-0.6.1.tar.gz 15:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:28 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:28 INFO - Running setup.py install for blobuploader 15:52:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:28 INFO - Running setup.py install for requests 15:52:29 INFO - Running setup.py install for docopt 15:52:29 INFO - Successfully installed blobuploader requests docopt 15:52:29 INFO - Cleaning up... 15:52:29 INFO - Return code: 0 15:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:29 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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:29 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 15:52:29 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 15:52:29 INFO - Using env: {'DISPLAY': ':0', 15:52:29 INFO - 'HOME': '/home/cltbld', 15:52:29 INFO - 'LANG': 'en_US.UTF-8', 15:52:29 INFO - 'LANGUAGE': 'en_US:en', 15:52:29 INFO - 'LOGNAME': 'cltbld', 15:52:29 INFO - 'MAIL': '/var/mail/cltbld', 15:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:29 INFO - 'MOZ_NO_REMOTE': '1', 15:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:29 INFO - 'NO_EM_RESTART': '1', 15:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:29 INFO - 'PWD': '/builds/slave/test', 15:52:29 INFO - 'SHELL': '/bin/bash', 15:52:29 INFO - 'SHLVL': '1', 15:52:29 INFO - 'TERM': 'linux', 15:52:29 INFO - 'TMOUT': '86400', 15:52:29 INFO - 'USER': 'cltbld', 15:52:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:29 INFO - '_': '/tools/buildbot/bin/python'} 15:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:29 INFO - Running setup.py (path:/tmp/pip-eREgd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:29 INFO - Running setup.py (path:/tmp/pip-FUCi2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:29 INFO - Running setup.py (path:/tmp/pip-kQLoPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:29 INFO - Running setup.py (path:/tmp/pip-tklY1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:29 INFO - Running setup.py (path:/tmp/pip-IGLINH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:30 INFO - Running setup.py (path:/tmp/pip-6M0F6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:30 INFO - Running setup.py (path:/tmp/pip-T2qviA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:30 INFO - Running setup.py (path:/tmp/pip-DyPCb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:30 INFO - Running setup.py (path:/tmp/pip-OYMJMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:30 INFO - Running setup.py (path:/tmp/pip-z01Tvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:30 INFO - Running setup.py (path:/tmp/pip-Vz6R2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:30 INFO - Running setup.py (path:/tmp/pip-1DCV7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:30 INFO - Running setup.py (path:/tmp/pip-4wZ812-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:30 INFO - Running setup.py (path:/tmp/pip-luf6Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:30 INFO - Running setup.py (path:/tmp/pip-NKcVx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:30 INFO - Running setup.py (path:/tmp/pip-LnzoCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:30 INFO - Running setup.py (path:/tmp/pip-19QCAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:30 INFO - Running setup.py install for manifestparser 15:52:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:30 INFO - Running setup.py install for mozcrash 15:52:31 INFO - Running setup.py install for mozdebug 15:52:31 INFO - Running setup.py install for mozdevice 15:52:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Running setup.py install for mozfile 15:52:31 INFO - Running setup.py install for mozhttpd 15:52:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Running setup.py install for mozinfo 15:52:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Running setup.py install for mozInstall 15:52:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Running setup.py install for mozleak 15:52:31 INFO - Running setup.py install for mozlog 15:52:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:31 INFO - Running setup.py install for moznetwork 15:52:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Running setup.py install for mozprocess 15:52:32 INFO - Running setup.py install for mozprofile 15:52:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Running setup.py install for mozrunner 15:52:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Running setup.py install for mozscreenshot 15:52:32 INFO - Running setup.py install for moztest 15:52:32 INFO - Running setup.py install for mozversion 15:52:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:32 INFO - Cleaning up... 15:52:32 INFO - Return code: 0 15:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:32 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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:32 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 15:52:32 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 15:52:32 INFO - Using env: {'DISPLAY': ':0', 15:52:32 INFO - 'HOME': '/home/cltbld', 15:52:32 INFO - 'LANG': 'en_US.UTF-8', 15:52:32 INFO - 'LANGUAGE': 'en_US:en', 15:52:32 INFO - 'LOGNAME': 'cltbld', 15:52:32 INFO - 'MAIL': '/var/mail/cltbld', 15:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:32 INFO - 'MOZ_NO_REMOTE': '1', 15:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:32 INFO - 'NO_EM_RESTART': '1', 15:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:32 INFO - 'PWD': '/builds/slave/test', 15:52:32 INFO - 'SHELL': '/bin/bash', 15:52:32 INFO - 'SHLVL': '1', 15:52:32 INFO - 'TERM': 'linux', 15:52:32 INFO - 'TMOUT': '86400', 15:52:32 INFO - 'USER': 'cltbld', 15:52:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:32 INFO - '_': '/tools/buildbot/bin/python'} 15:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:32 INFO - Running setup.py (path:/tmp/pip-YjH_0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:32 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)) 15:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:32 INFO - Running setup.py (path:/tmp/pip-6C_cK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:33 INFO - Running setup.py (path:/tmp/pip-TpGMPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:33 INFO - Running setup.py (path:/tmp/pip-zvuKiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:33 INFO - Running setup.py (path:/tmp/pip-K18XAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:33 INFO - Running setup.py (path:/tmp/pip-pRK4Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:33 INFO - Running setup.py (path:/tmp/pip-rr0Y57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:33 INFO - Running setup.py (path:/tmp/pip-aI0cgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:33 INFO - Running setup.py (path:/tmp/pip-dd8umK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:33 INFO - Running setup.py (path:/tmp/pip-2I5n8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:33 INFO - Running setup.py (path:/tmp/pip-1FCyym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:33 INFO - Running setup.py (path:/tmp/pip-9wlx89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:33 INFO - Running setup.py (path:/tmp/pip-gXQLf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:33 INFO - Running setup.py (path:/tmp/pip-pivliO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:33 INFO - Running setup.py (path:/tmp/pip-oGbqYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:33 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)) 15:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:34 INFO - Running setup.py (path:/tmp/pip-JkadKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:34 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)) 15:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:34 INFO - Running setup.py (path:/tmp/pip-zh0Wlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:34 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)) 15:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:34 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)) 15:52:34 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)) 15:52:34 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)) 15:52:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:36 INFO - Downloading blessings-1.6.tar.gz 15:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:36 INFO - Installing collected packages: blessings 15:52:36 INFO - Running setup.py install for blessings 15:52:36 INFO - Successfully installed blessings 15:52:36 INFO - Cleaning up... 15:52:36 INFO - Return code: 0 15:52:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:36 INFO - Reading from file tmpfile_stdout 15:52:36 INFO - Current package versions: 15:52:36 INFO - argparse == 1.2.1 15:52:36 INFO - blessings == 1.6 15:52:36 INFO - blobuploader == 1.2.4 15:52:36 INFO - docopt == 0.6.1 15:52:36 INFO - functools32 == 3.2.3-2 15:52:36 INFO - jsonschema == 2.5.1 15:52:36 INFO - manifestparser == 1.1 15:52:36 INFO - mozInstall == 1.12 15:52:36 INFO - mozcrash == 0.17 15:52:36 INFO - mozdebug == 0.1 15:52:36 INFO - mozdevice == 0.48 15:52:36 INFO - mozfile == 1.2 15:52:36 INFO - mozhttpd == 0.7 15:52:36 INFO - mozinfo == 0.9 15:52:36 INFO - mozleak == 0.1 15:52:36 INFO - mozlog == 3.4 15:52:36 INFO - moznetwork == 0.27 15:52:36 INFO - mozprocess == 0.23 15:52:36 INFO - mozprofile == 0.28 15:52:36 INFO - mozrunner == 6.12 15:52:36 INFO - mozscreenshot == 0.1 15:52:36 INFO - mozsystemmonitor == 0.3 15:52:36 INFO - moztest == 0.7 15:52:36 INFO - mozversion == 1.4 15:52:36 INFO - psutil == 3.1.1 15:52:36 INFO - requests == 1.2.3 15:52:36 INFO - wsgiref == 0.1.2 15:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:36 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')]} 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:36 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')]} 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:36 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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:36 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 15:52:36 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 15:52:36 INFO - Using env: {'DISPLAY': ':0', 15:52:36 INFO - 'HOME': '/home/cltbld', 15:52:36 INFO - 'LANG': 'en_US.UTF-8', 15:52:36 INFO - 'LANGUAGE': 'en_US:en', 15:52:36 INFO - 'LOGNAME': 'cltbld', 15:52:36 INFO - 'MAIL': '/var/mail/cltbld', 15:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:36 INFO - 'MOZ_NO_REMOTE': '1', 15:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:36 INFO - 'NO_EM_RESTART': '1', 15:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:36 INFO - 'PWD': '/builds/slave/test', 15:52:36 INFO - 'SHELL': '/bin/bash', 15:52:36 INFO - 'SHLVL': '1', 15:52:36 INFO - 'TERM': 'linux', 15:52:36 INFO - 'TMOUT': '86400', 15:52:36 INFO - 'USER': 'cltbld', 15:52:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:36 INFO - '_': '/tools/buildbot/bin/python'} 15:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 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)) 15:52:36 INFO - Cleaning up... 15:52:36 INFO - Return code: 0 15:52:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:36 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')]} 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:36 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')]} 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:36 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 0x7f21a1b1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:36 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 15:52:36 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 15:52:36 INFO - Using env: {'DISPLAY': ':0', 15:52:36 INFO - 'HOME': '/home/cltbld', 15:52:36 INFO - 'LANG': 'en_US.UTF-8', 15:52:36 INFO - 'LANGUAGE': 'en_US:en', 15:52:36 INFO - 'LOGNAME': 'cltbld', 15:52:36 INFO - 'MAIL': '/var/mail/cltbld', 15:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:36 INFO - 'MOZ_NO_REMOTE': '1', 15:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:36 INFO - 'NO_EM_RESTART': '1', 15:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:36 INFO - 'PWD': '/builds/slave/test', 15:52:36 INFO - 'SHELL': '/bin/bash', 15:52:36 INFO - 'SHLVL': '1', 15:52:36 INFO - 'TERM': 'linux', 15:52:36 INFO - 'TMOUT': '86400', 15:52:36 INFO - 'USER': 'cltbld', 15:52:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:36 INFO - '_': '/tools/buildbot/bin/python'} 15:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:52:37 INFO - Cleaning up... 15:52:37 INFO - Return code: 0 15:52:37 INFO - Running post-action listener: _resource_record_post_action 15:52:37 INFO - Running post-action listener: _start_resource_monitoring 15:52:37 INFO - Starting resource monitoring. 15:52:37 INFO - [mozharness: 2016-10-21 22:52:37.074592Z] Finished create-virtualenv step (success) 15:52:37 INFO - [mozharness: 2016-10-21 22:52:37.075047Z] Running install step. 15:52:37 INFO - Running pre-action listener: _resource_record_pre_action 15:52:37 INFO - Running main action method: install 15:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:37 INFO - Reading from file tmpfile_stdout 15:52:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:37 INFO - Reading from file tmpfile_stdout 15:52:37 INFO - Output received: 15:52:37 INFO - Usage: mozinstall [options] installer 15:52:37 INFO - Options: 15:52:37 INFO - -h, --help show this help message and exit 15:52:37 INFO - -d DEST, --destination=DEST 15:52:37 INFO - Directory to install application into. [default: 15:52:37 INFO - "/builds/slave/test"] 15:52:37 INFO - --app=APP Application being installed. [default: firefox] 15:52:37 INFO - mkdir: /builds/slave/test/build/application 15:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:52:53 INFO - Reading from file tmpfile_stdout 15:52:53 INFO - Output received: 15:52:53 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:53 INFO - Running post-action listener: _resource_record_post_action 15:52:53 INFO - [mozharness: 2016-10-21 22:52:53.424054Z] Finished install step (success) 15:52:53 INFO - [mozharness: 2016-10-21 22:52:53.424299Z] Running run-tests step. 15:52:53 INFO - Running pre-action listener: _resource_record_pre_action 15:52:53 INFO - Running main action method: run_tests 15:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:53 INFO - Python 2.7.3 15:52:53 INFO - Return code: 0 15:52:53 INFO - grabbing minidump binary from tooltool 15:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:53 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/linux64/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 0x2c8af60>, '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 0x2c8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:53 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:52:53 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/linux64/releng.manifest -o -c /builds/tooltool_cache 15:52:53 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:52:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:53 INFO - Return code: 0 15:52:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 15:52:53 INFO - Using env: {'DISPLAY': ':0', 15:52:53 INFO - 'HOME': '/home/cltbld', 15:52:53 INFO - 'LANG': 'en_US.UTF-8', 15:52:53 INFO - 'LANGUAGE': 'en_US:en', 15:52:53 INFO - 'LOGNAME': 'cltbld', 15:52:53 INFO - 'MAIL': '/var/mail/cltbld', 15:52:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:53 INFO - 'MOZ_NO_REMOTE': '1', 15:52:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:53 INFO - 'NO_EM_RESTART': '1', 15:52:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:53 INFO - 'PWD': '/builds/slave/test', 15:52:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:53 INFO - 'SHELL': '/bin/bash', 15:52:53 INFO - 'SHLVL': '1', 15:52:53 INFO - 'TERM': 'linux', 15:52:53 INFO - 'TMOUT': '86400', 15:52:53 INFO - 'USER': 'cltbld', 15:52:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226', 15:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:53 INFO - '_': '/tools/buildbot/bin/python'} 15:52:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:52:53 INFO - mozversion application_buildid: 20161021141323 15:52:53 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 15:52:53 INFO - mozversion application_display_name: Nightly 15:52:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:53 INFO - mozversion application_name: Firefox 15:52:53 INFO - mozversion application_remotingname: firefox 15:52:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:52:53 INFO - mozversion application_vendor: Mozilla 15:52:53 INFO - mozversion application_version: 52.0a1 15:52:53 INFO - mozversion platform_buildid: 20161021141323 15:52:53 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 15:52:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:52:53 INFO - mozversion platform_version: 52.0a1 15:52:53 INFO - using testdate: 1477090373 15:52:53 INFO - actual date: 1477090373 15:52:53 INFO - starting webserver on 'localhost:55716' 15:52:53 INFO - SUITE-START | Running 2 tests 15:52:53 INFO - TEST-START | dromaeo_css 15:52:53 INFO - operating with platform_type : linux_ 15:52:53 INFO - Initialising browser for dromaeo_css test... 15:52:53 INFO - TEST-INFO | started process 20331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3IWsGo/profile http://localhost:55716/getInfo.html) 15:52:57 INFO - PROCESS | 20331 | __metrics Screen width/height:1600/1200 15:52:57 INFO - PROCESS | 20331 | colorDepth:24 15:52:57 INFO - PROCESS | 20331 | Browser inner width/height: 1024/697 15:52:57 INFO - PROCESS | 20331 | __metrics 15:52:58 INFO - PROCESS | 20331 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:52:58 INFO - PROCESS | 20331 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:59 INFO - PROCESS | 20331 | console.error: PushService: 15:52:59 INFO - PROCESS | 20331 | stateChangeProcessEnqueue: Error transitioning state 15:52:59 INFO - PROCESS | 20331 | UnknownError 15:52:59 INFO - TEST-INFO | 20331: exit 0 15:52:59 INFO - Browser initialized. 15:52:59 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:59 INFO - TEST-INFO | started process 20412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3IWsGo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:12 INFO - PROCESS | 20412 | RSS: Main: 173608960 15:53:12 INFO - PROCESS | 20412 | 15:54:03 INFO - PROCESS | 20412 | 1477090443167 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] 15:56:17 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55716/tests/dromaeo/cssquery-ext.html) 15:56:19 INFO - PROCESS | 20412 | RSS: Main: 339865600 15:56:19 INFO - PROCESS | 20412 | 15:59:22 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-ext.html (next: http://localhost:55716/tests/dromaeo/cssquery-jquery.html) 15:59:23 INFO - PROCESS | 20412 | RSS: Main: 272338944 15:59:23 INFO - PROCESS | 20412 | 16:02:25 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55716/tests/dromaeo/cssquery-mootools.html) 16:02:25 INFO - PROCESS | 20412 | RSS: Main: 272306176 16:02:25 INFO - PROCESS | 20412 | 16:05:28 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55716/tests/dromaeo/cssquery-prototype.html) 16:05:28 INFO - PROCESS | 20412 | RSS: Main: 213430272 16:05:28 INFO - PROCESS | 20412 | 16:08:31 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55716/tests/dromaeo/cssquery-yui.html) 16:08:32 INFO - PROCESS | 20412 | RSS: Main: 217419776 16:08:32 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | Cycle 1(1): loaded http://localhost:55716/tests/dromaeo/cssquery-yui.html (next: http://localhost:55716/tests/dromaeo/cssquery-dojo.html) 16:11:35 INFO - PROCESS | 20412 | RSS: Main: 298811392 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | __start_tp_report 16:11:35 INFO - PROCESS | 20412 | _x_x_mozilla_page_load 16:11:35 INFO - PROCESS | 20412 | _x_x_mozilla_page_load_details 16:11:35 INFO - PROCESS | 20412 | |i|pagename|runs| 16:11:35 INFO - PROCESS | 20412 | |0;dojo.html;2623.488419758147;2640.907568235112;2667.0931883159724;2680.5309070912585;2692.744189302017;4557.954420455794;4636.559526844952;4739.810407583697;4796.6162706983405;4813.951860481398;4663.766811659412;4761.738104404257;4777.641676874231;4831.951680483203;4880.243562247849;4312;4333.349997500369;4377.627901628365;4382.978085109586;4385.495667998189;4310.59049390309;4472.195004899117;4481.2381895077915;4505.053938672866;4557.316402539613;4229.746215227096;4444.488883778342;4451.5103338632725;4481.708688935225;4577.015941572561;4254.574542545752;4317.41714868495;4332.155229730204;4379.912401751947;4391.9780401098105;4317.352397140423;4331.177076355482;4331.6534677225745;4390.714603550759;4396.318570621559;4702;4713.175194340976;4732.763361831929;4737.692050016738;4756.690815097042;4863.732494712789;4937.432195297515;4937.975310123462;5060.139776238048;5068.72122033288;5046.016026874761;5076.695398276078;5089.592832573422;5167.819126330598;5195.948040519622;4721.3390125382475;4725.527447255247;4752.239641657318;4756.6432517561325;4776.355192049029;5171.379434467888;5172.120739474299;5180.067587834226;5180.171172612364;5249.396319423316;4796.592289655418;4856.1987272099705;4860.73265970368;4938.580220681282;4956.603471722254;4972.627052971042;4982.302477653131;4989.5758860496535;5032.043911656773;5106.872328191825;4953.554180123806;4978.327925730053;4984.825531106394;4996.275540046673;5001.424836143818;4795.568398844121;4842.612590992712;4844.563989240985;4967.503249675004;4981.6014718823135;4229.851955181553;4260.808263628144;4264.275073237557;4301.78491075445;4318.330658747836;3720.4419337099653;3727.962720372816;3733.6079711629886;3743.8502459901842;3766.8681596144;4218.557051509609;4261.808218630169;4365.607095361433;4366.519682834885;4413.183561041217;4997.750112494361;5066.569341606005;5075.111855425286;5086.287919691172;5181.922271165936;4334.19817333788;4340.327249276367;4341.913161736811;4357.085012147421;4399.758013309235;4574.222382195035;4595.0809838031855;4597.057603191338;4603.401557797465;4638.768061596907;4668.78990445424;4715.622750180046;4720.150372932905;4770.499097594703;4808.711477311373;5065.898682026413;5124.308218390619;5126.077306084941;5174.301469301747;5189.532942035235;4798.640101992434;4804.471508134172;4804.8798780030775;4811.206150985048;4865.026994601165;4846.781894814671;4900.558949694545;4966.354373931365;5039.294498770102;5098.719570423662;5092.668976516515;5106.540411362995;5119.232115182753;5184.274201611702;5190.766415511235;4919.286703427912;4935.136351138608;4960.131976903956;4990.6506544541535;5052.1663925451885;4797.976010120066;4851.223804191453;4941.9868926869185;4944.851654450372;5017.749112544431;4836.46798852133;4845.1520983828395;4845.49122342149;4848.781804818862;4850.733209673502;4953.578945789648;4968.602511798975;4989.675671081368;5013.172826483589;5080.46655101209;4643.86068417948;4676.041411510564;4681.063787242633;4856.150173719656;4922.261660750916 16:11:35 INFO - PROCESS | 20412 | |1;ext.html;518.6423096870859;585.3385674188166;587.5358466811219;594.1029046140327;594.5422025040722;27459.313517162056;38602;39827;39958;39974.60025399745;39262.21475570494;39751.801240993824;39878;40163.598364016354;40236.59763402365;7626.4280178986655;7774.727884524043;7775.6500957456765;7777.883331750028;7782;7654.158042615336;7757.8836317455;7757.922420775776;7760.223977602251;7762.961185194066;7732.922670773305;7750.534967901944;7756.922430775677;7781.805454863617;7785.065792104955;7710.267524585155;7738;7749.883751743729;7756.844863102763;7758.069031716173;7388.3719883809945;7456.962715186443;7460.104787425544;7461.179270280265;7461.8507629847645;37840;38016.42975355372;38035.80982095099;38164.9468042556;38333.42499862504;2882.2506148401358;3031.1209749172713;3105.813651180914;3211.7109460148463;3345.414552453335;27758.44483110347;28050.2987425316;28059.564215482915;28081.29796755077;28081.29796755077;3246.788958717676;3338;3503.8248087595516;3509.508668786372;3524.1894364296354;222808;223428;224269.99999999837;225198;228125;31174.609205112898;52441.21338179854;52795.47204527982;52953.38082739658;53036.73481632644;31311.21721956969;33330.333393331995;33333.499997500054;33337.16657083544;33339.33231350676;12697;12756.107072504836;12767.744645107046;12779.105462617528;12786.552470663482;10601.41692206936;10634.042936135786;10646.414447205323;10674.359538427563;10713.732156695989;7693.538387696756;7720.266574675396;7800.297973182441;7814.921850781533;7819.843603127905;3050.8627111780024;3073.877044918223;3077.07687693691;3102.3329984053535;3113.470709979309;795.4988357334842;903.7740564858785;915.4004127296631;954.8472244440995;956.6077908057663;27129.864350678516;27630.861845690644;27758.722412775613;27864.080093875695;28086.43827123446;935.2144198872979;945.7682867697458;955.7849483866074;963.6097380560884;987.274353350287;14000.859991400159;14910.478133265284;15205.467808626867;15289.636280018378;15297.770533442008;354103;354592;355213;355604;356742;49382.50617493779;49908.750456247486;49910;49976;50006.49993500091;1068.7969285835666;1115.0856297835696;1163.2380790582183;1164.2374244869625;1171.8652354979286;25708.357291067874;28762.42475150527;29277;29445.558316625695;29690.703092968793;41645.58354416417;42323;42399.788001059795;42437.78781106075;42454;278034.82947755395;278953;280927;281623;283958;21822.672659909796;22593.2092376766;23773;24854.875725621256;24985.750142498342;39360.80319598383;40205.597944021356;40256.59743402529;40657.59342406538;40836.59163408328;34675.47986780251;34836.65163348334;35074.649253508156;35189.64810351864;35471.82264088663;34443;34984.825075874454;34993.300133996665;35113.824430877685;35500;33919;34005.48991765175;34941.47587786236;35001;35109.648903510635;29935.70064299329;32142;32168;32317.838410808738;32509.34981300408;24043.398915027265;24213.941814945927;24404.87797561001;24674.753252467963;25190.49619007573 16:11:35 INFO - PROCESS | 20412 | |2;jquery.html;349.37287568813974;350.68963966889294;352.3094734320731;355.7794167616078;357.99105022374454;13094.999999999976;13698.452061917511;15899.523014309574;16089.75865362019;17209.225584848682;13540.593782186526;15892.443764468246;16079.91960040201;16195.352185912549;17019.48941531753;4928.137575924199;4943.6539442239055;5143.074246635604;5150.639455238135;5184.7148406837605;4982.103221420143;5094.46508116648;5099.821506247282;5102.591792656579;5105.5149760772665;3543.2559162575762;3739.2708421857747;5060.898782024357;5709.543236541067;5969.5821292509545;5778.422157784188;5960.493358064569;5984.072468767326;5986.431289027535;5988.640681559121;5183.092958732207;5201.063808514466;5207.791688332462;5211.973940130313;5215.478452154792;19813.405597832087;20182.394528164034;20257.29099481526;20415.48961275965;20637.277695280594;1922.327185485083;1962.528993041674;2119.1417475922276;2340.8361414700807;2375.239923224569;12183.208091474025;13213.207207567577;13617.455301787917;13688.247146406944;13759.931200344034;1607.815101263358;1676.379739496382;1692.0524506276524;1712.8030276518236;1728.9827101729072;62832.68583657053;63239;64515.354846451875;64753;66984.30633396168;8668.219860212612;8832.8675069874;9046;9226.07739226072;9322.627094916263;12644.241345519298;12663.176893501894;12668.176568523017;12676.049296302814;12684.746305073846;6804.965975170093;7015.929840701528;7035.401990830735;7128.251533588898;7135.179454362711;6715.3620406061345;6725.293844146392;6745.258021617618;6900.275471075565;6918.411934985482;5769.826905192851;5774.88450230993;5782.161586569924;5833;5854.531637468992;1640.425850952181;1682.0832646207602;1692.5260926940477;1703.2420572844965;1741.7387391891318;776.281939206232;832.379876991633;848.6011574559947;966.0629189685993;985.3299756165876;15728.68542629141;16375.181240938144;16886.311368863262;16946.23741931616;17002.659946800995;871.263782104121;874.0421455938779;897.2552781191596;904.516083895113;967.1585720423277;9131;9421.670241541513;9702.75743106428;9822.214222862154;9856.802863942681;349421;349963;350086;352314;362335;37643.81178094092;48091.519084809406;62295;63191.68404158042;64403.67798160979;909.6997990663066;918.4994178172911;960.274992380762;960.9903900961041;961.4423634292094;14244.36189838182;14839.777403338743;15023.02350347224;15505.534833955;15561.922190388976;34929.30141397208;35418.8229058853;35674.643253567134;35740;36287.11386584067;42417;43082.138357232056;44311.55688443074;44766.3285050718;46206.76896615495;10005.299629025898;10144.492775361055;10148.289619726549;10171.593136274467;10308.278420510793;10594.4702764863;11069.723256918642;11193.66419007431;11255.437228138724;11699.2980421175;9251.35240533183;9271.165595096474;9582.952085239807;9736.95131524338;9930.006999300012;9589.184919281939;9615.51922403891;9821.558029888529;9877.357971731815;9886.75283117899;6836.692348844414;6897.827554310981;6916.377526022481;7021.613811240431;9829.557669904729;10338.534765935401;10831.05041092611;10871.619493317696;10943.179261555257;11089.722756931142;9228.769280767767;9349.766255843659;9635.855462168212;9663.323567350219;9711.36876103051 16:11:35 INFO - PROCESS | 20412 | |3;mootools.html;1222.9571964981228;1349.878510934016;1392.8537503562127;1495.5438591229677;1698.0660636649839;6129.632222066673;7270;7616.428767842406;7626.618669066545;7727.995360603128;7562.508436951608;7634.694612215505;7634.88547671784;7638.770836874889;7648.617569121536;2094.8009939055764;2113.5138918048856;2118.152738904435;2123.373604786584;2124.861883977544;2070.3892351756267;2121.872687638739;2164.956700865982;2165.1447678167115;2168.0677308757226;2105.2842033708534;2111.5460176062143;2121.7772133925946;2130.286354071388;2132.829373650104;2103.4215590712524;2112.355731501891;2114.7356580427368;2120.2155202575145;2124.468882779305;2039.836813054952;2079.688046792978;2090.707300977864;2091.184438069154;2092;7299.598522081284;7613.733519326797;7669.73155939545;7685.807854803618;7812.3359514441345;4439.933400998988;4559.110973360196;4566.155261276641;4573.268277075652;4573.428321459817;2767.8200916940336;2935.3102021025043;2973.8067025643263;2975.747061499775;2985.31337792309;929.9116583924516;935.4667839331584;945.4988855906381;969.2924165359327;977.8582105594649;9822.410655360629;9839.754006149831;9889.307748457612;9891.90108098917;9916.454594997344;3772.8868133956025;3915.804209789499;3920.921581568353;4078.1639763848934;4286.207051695384;8229.382796290301;8362.958185209034;8373.665053397795;8388.8741668875;8391.160883911682;4542.364069030338;4549.09018196362;4551.249043907785;4556.908861822745;4560.315952607069;3479.973407844692;3576.946345804815;4103.302438585388;4268.061026574149;4268.658507319407;3150.1966998415255;3173.6826317368077;3294.769366144347;3294.8682052718104;3321.4353559894876;936.7377134402242;940.2825833341648;943.2406912435418;955.5843208204453;956.32101208143;833.5832083958021;841.3773807382493;857.9313654907593;878.0517041595062;884.2837301785574;5150.175971844562;5163.380394352626;5179.171332586768;5398.838034858961;5419.403865574784;407.49267162383023;409.51677021114773;409.7561950639365;414.29156142995816;415.7256210900791;3653.378925582604;3760.5675347335405;3763.473113764075;3783.6783873371073;3845.788481633481;9188.632454701738;9494.477803720723;9586.185174260267;9620.75948101303;9623.807523849624;9403.247740180906;9463.479508626953;9466.242700583936;9469.479178645102;9484.668036618685;7206.7117315306805;7281.745138920112;7282.453815963824;7285.089363829521;7288.489805713549;5154.252633368065;5219.19102539107;5230.843074707765;5291.76187071575;5516.062269414129;8624.78438039054;8728.825423491622;8793.824123517366;8806.119388061143;8889.866652000355;8616.396852220536;9048.819023619622;9104.13510716481;9151.679691210775;9152.222061124612;5371.355437347544;6319.526035547445;6352.460040896575;6402.199725034371;6405.359464053744;6398;6515.250746164252;6557.344265573404;6591.736330546724;7008.474364422791;6617.470602351704;6748.089007984056;6766.93233067663;6859.485538584726;6884.311568843075;6485.8702825944165;6550.737970481127;6618.900716489353;6716.496262780213;6778.694958726967;6258.718357673824;6380.585261957958;6380.617162970237;6383.521235907233;6396.840078998062;4370.300751879684;4384.802683879297;4467.955320446754;4533.455985281787;4613.746243956614;4496.3255511673515;4565.634749220121;4567.063751930913;4641.86074417768;4653.790579424001 16:11:35 INFO - PROCESS | 20412 | |4;prototype.html;280.9943801123978;292.7526240326924;294.37739181630855;295.0896484345793;298.955156726491;4787.863949113328;4849.733264670442;4883.780229889655;4891.706497610146;4902.411710594733;4735.147673418784;4749.883777312329;4767.928481072787;4773.403324584427;4779.71321720697;3800.277947190039;3801.3157631626295;3804.695624350059;3813.561440434344;3826.9617303826885;3709.591944886074;3798.5061941947506;3819.4461803038544;3819.9809000954956;3837.2901013312626;3740.2519496100754;3760.1163726524246;3760.52993375828;3770.849166033369;3779;3741.5884252732176;3750.3123594382637;3755.267722794056;3763.1909139535132;3770.396736522157;3127.702868227515;3233.1917020744813;3337.599488061424;3341.3818443588016;3353.4634458486526;4519.435070616173;4635.745034023127;4659.906801863944;4678.836240731558;4682.438107427097;4271.551487093841;4286.57134286572;4286.678499112579;4296.699231053827;4310.547392523771;4652;4729.83101322115;4992.177855082905;4995.075910956485;5007.223880298523;3606.350856845767;3631.6757275343803;3637.381645120336;3639.1811842335264;3639.854405823764;5242.423333433358;5264.789408423659;5267.420583735786;5271.920921186147;5276.472352764731;3645.3802853514435;3737.588865224823;3744.85020599173;3755.549334079928;3776.773393596393;3750.5124333836425;3761.247750449921;3771.981140094282;3786.905327366838;3787.4697542344093;4225.859018065166;4232.687866761314;4246.44796176495;4248.111284326687;4261.573842615776;4937.753112344369;4938.43208031081;4939.999300283391;4969.652124351333;5016.523430274118;1179.8525184351956;1250.6992727563231;1256.2901960392348;1296.8508621508458;1314.9737005259842;796.5463029970211;797.3541431440551;812.8821320908553;813.3818298093373;824.6989848705299;3927.371620540757;3928.194720082376;3931.309536899161;3934.11482416454;3937.8031098444962;4489.618382437529;4510.368548403226;4511.390962220124;4516.570925762047;4531.3882625845745;3921.9801802071956;3930.194310166466;3948.8350936473807;3951.427043078795;3957.584453632385;2440.596656922277;2452.5340185364726;2529.380301826028;2721.71422000691;2749.4363655450584;4645.605123564535;4716.858494245178;4790.257510085942;4837.975810120927;4849.175640141185;5265.736713164327;5266.973665131726;5271;5277.445868183862;5286.867828304323;4828.782704778293;4833.326671729441;4841.612670986242;4849.224124140121;4859.902801943941;4990.575801056805;5124.666896651705;5147.279380886604;5153.922691159711;5169.327987361619;5057.949420505895;5066.9746651266505;5067.847964561069;5068.26510156018;5078.339815823919;4825.445073816556;4881.73150476713;4897.094037603055;4897.869426799353;4901.946081592475;3474.774139680913;3599.5500562429697;3624.855005799844;3643.2531331077594;3656;5147.9227811582105;5187.740612969261;5203.869903252297;5210.114280572236;5213.76538055796;5030.0694371541385;5032.421271553818;5038.093143234253;5050.368703912011;5059.848204553869;4847.878803029953;5002.874928126826;5012.649114561946;5014.7994080236385;5030.522834677214;4924.803007879645;4931.728754918514;4934.18585933317;4943.431505376928;4949.950500494949;5010.8246211383885;5023.723695196799;5025.120603894377;5033.92449113271;5071.492850714899;4703.717776933258;4894.608431325557;4913.950860491493;4935.851924442272;4952.702837829742 16:11:35 INFO - PROCESS | 20412 | |5;yui.html;636.5639536917212;654.5320096131265;664.5348256220647;677.7356830835975;764.6291548598929;12873;13911;14027.719445611081;14056.64858378541;14071.366788494517;13528.323583820795;13745;13756.243406612657;13776;13777.724445511083;765.2118318132304;788.1291173253559;806.2421323955492;807.0718673525434;807.4509333653114;794.0907660728462;810.1331575214523;810.6554714246422;811.0551207842885;811.1523457986418;829.1956801902145;838.1116017021945;840.6007146605344;841.4614646626164;842.1704620948392;825.1500954017341;825.2490233887164;826.9297109745619;827.7392621324294;828.3125006244802;611.5810669691231;616.017452163798;617.5121653893464;617.5800455690129;617.7528988404674;14560.344784484723;14683.559493215114;14700.632484187874;14706;14710.926445367812;12835;12877.227366358049;13164.210147391188;13229.536966206233;13491;9993;10078.697639070839;10134.89865101347;10232.641857535025;10619.30974486656;3273.083536609753;3326.750493712981;3329.217633856042;3337.499375093731;3341.6491268416707;57758.42241577614;59632.10551841682;65414;65477.34522654808;66482.66758666224;9850.556724947395;9935.552900119512;10001.549930253155;10009.349392289478;10146.44194569291;16825.32698692063;17472.126393680264;17472.475825725247;18320.45038648843;18412.171452284678;6802.081718967876;6843.931560684429;6850.6574671266235;6867.141607299088;6872.175338959357;3514.4552594347915;3670.3026424979703;3689.1883785567134;3718.0890681782594;3743.1577894973957;2985.7163569460868;3080.4147212029643;3100.472919603673;3103.053568661535;3112.3930833487707;494.5796073337634;495.8239824862194;497.437895178446;501.0930216308493;506.172408112731;573.4552175433355;574.8476653686777;581.2908251932636;582.4117641182436;586.4838941731334;7277.2358902315555;7396.519226250384;7468;7946.404019698546;8200.097989221182;575.2295482174779;580.9273840769904;581.5318668471921;584.3513699793226;593.9881202375929;3610.797413577768;3649.543807024122;3686.64976827201;3772.6981841452616;3778.4332350147697;57824;58122.418775811704;58311.50392929229;59735;102329;81461.1123332602;82867;83719;85147.5742621283;85876;69878;74948;75222;75857.62071189609;78102;6919.792406227822;7127.964360178166;7161.856762864818;7266.564006159648;7274.599897005503;43273.56726432696;43749.12501750011;43844.56155438405;44722;45317.32024019576;57022;58917;65148.674256628416;65593;67917;9468.05979618533;9524.714258572254;9685.515724213901;9834.262430317898;9981.051800078982;10443.477826108512;10672.83990740155;11057.944710276397;11066.446677665923;11377.488013039267;10096.596136154472;10149.188064954933;10530.789384212427;10739.301945373838;10820.296680715728;10370.844437333597;10635.468226588795;10640.095591874777;10904.945475272572;11088.112950964065;10336.17310615134;10465.47672616351;11004.724881877697;11048.337099774039;11052.834207486734;8627.87058194115;8799.384043116921;8831.646734130563;9127.179319013856;9213.861792073258;8506.191911768372;8751.168638979287;9204.171624553823;9263.675771347971;9502.762430939281 16:11:35 INFO - PROCESS | 20412 | __end_tp_report 16:11:35 INFO - PROCESS | 20412 | __start_cc_report 16:11:35 INFO - PROCESS | 20412 | _x_x_mozilla_cycle_collect,1892 16:11:35 INFO - PROCESS | 20412 | __end_cc_report 16:11:35 INFO - PROCESS | 20412 | __startTimestamp1477091495960__endTimestamp 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | ------- Summary: start ------- 16:11:35 INFO - PROCESS | 20412 | Number of tests: 6 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#0] dojo.html Cycles:165 Average:4675.27 Median:4798.64 stddev:484.91 (10.1%) stddev-sans-first:458.91 16:11:35 INFO - PROCESS | 20412 | Values: 2623.5 2640.9 2667.1 2680.5 2692.7 4558.0 4636.6 4739.8 4796.6 4814.0 4663.8 4761.7 4777.6 4832.0 4880.2 4312.0 4333.3 4377.6 4383.0 4385.5 4310.6 4472.2 4481.2 4505.1 4557.3 4229.7 4444.5 4451.5 4481.7 4577.0 4254.6 4317.4 4332.2 4379.9 4392.0 4317.4 4331.2 4331.7 4390.7 4396.3 4702.0 4713.2 4732.8 4737.7 4756.7 4863.7 4937.4 4938.0 5060.1 5068.7 5046.0 5076.7 5089.6 5167.8 5195.9 4721.3 4725.5 4752.2 4756.6 4776.4 5171.4 5172.1 5180.1 5180.2 5249.4 4796.6 4856.2 4860.7 4938.6 4956.6 4972.6 4982.3 4989.6 5032.0 5106.9 4953.6 4978.3 4984.8 4996.3 5001.4 4795.6 4842.6 4844.6 4967.5 4981.6 4229.9 4260.8 4264.3 4301.8 4318.3 3720.4 3728.0 3733.6 3743.9 3766.9 4218.6 4261.8 4365.6 4366.5 4413.2 4997.8 5066.6 5075.1 5086.3 5181.9 4334.2 4340.3 4341.9 4357.1 4399.8 4574.2 4595.1 4597.1 4603.4 4638.8 4668.8 4715.6 4720.2 4770.5 4808.7 5065.9 5124.3 5126.1 5174.3 5189.5 4798.6 4804.5 4804.9 4811.2 4865.0 4846.8 4900.6 4966.4 5039.3 5098.7 5092.7 5106.5 5119.2 5184.3 5190.8 4919.3 4935.1 4960.1 4990.7 5052.2 4798.0 4851.2 4942.0 4944.9 5017.7 4836.5 4845.2 4845.5 4848.8 4850.7 4953.6 4968.6 4989.7 5013.2 5080.5 4643.9 4676.0 4681.1 4856.2 4922.3 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#1] ext.html Cycles:180 Average:43227.52 Median:19309.58 stddev:76804.50 (397.8%) stddev-sans-first:76953.02 16:11:35 INFO - PROCESS | 20412 | Values: 518.6 585.3 587.5 594.1 594.5 27459.3 38602.0 39827.0 39958.0 39974.6 39262.2 39751.8 39878.0 40163.6 40236.6 7626.4 7774.7 7775.7 7777.9 7782.0 7654.2 7757.9 7757.9 7760.2 7763.0 7732.9 7750.5 7756.9 7781.8 7785.1 7710.3 7738.0 7749.9 7756.8 7758.1 7388.4 7457.0 7460.1 7461.2 7461.9 37840.0 38016.4 38035.8 38164.9 38333.4 2882.3 3031.1 3105.8 3211.7 3345.4 27758.4 28050.3 28059.6 28081.3 28081.3 3246.8 3338.0 3503.8 3509.5 3524.2 222808.0 223428.0 224270.0 225198.0 228125.0 31174.6 52441.2 52795.5 52953.4 53036.7 31311.2 33330.3 33333.5 33337.2 33339.3 12697.0 12756.1 12767.7 12779.1 12786.6 10601.4 10634.0 10646.4 10674.4 10713.7 7693.5 7720.3 7800.3 7814.9 7819.8 3050.9 3073.9 3077.1 3102.3 3113.5 795.5 903.8 915.4 954.8 956.6 27129.9 27630.9 27758.7 27864.1 28086.4 935.2 945.8 955.8 963.6 987.3 14000.9 14910.5 15205.5 15289.6 15297.8 354103.0 354592.0 355213.0 355604.0 356742.0 49382.5 49908.8 49910.0 49976.0 50006.5 1068.8 1115.1 1163.2 1164.2 1171.9 25708.4 28762.4 29277.0 29445.6 29690.7 41645.6 42323.0 42399.8 42437.8 42454.0 278034.8 278953.0 280927.0 281623.0 283958.0 21822.7 22593.2 23773.0 24854.9 24985.8 39360.8 40205.6 40256.6 40657.6 40836.6 34675.5 34836.7 35074.6 35189.6 35471.8 34443.0 34984.8 34993.3 35113.8 35500.0 33919.0 34005.5 34941.5 35001.0 35109.6 29935.7 32142.0 32168.0 32317.8 32509.3 24043.4 24213.9 24404.9 24674.8 25190.5 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#2] jquery.html Cycles:180 Average:22287.78 Median:4962.88 stddev:57900.68 (1166.7%) stddev-sans-first:58039.68 16:11:35 INFO - PROCESS | 20412 | Values: 349.4 350.7 352.3 355.8 358.0 13095.0 13698.5 15899.5 16089.8 17209.2 13540.6 15892.4 16079.9 16195.4 17019.5 4928.1 4943.7 5143.1 5150.6 5184.7 4982.1 5094.5 5099.8 5102.6 5105.5 3543.3 3739.3 5060.9 5709.5 5969.6 5778.4 5960.5 5984.1 5986.4 5988.6 5183.1 5201.1 5207.8 5212.0 5215.5 19813.4 20182.4 20257.3 20415.5 20637.3 1922.3 1962.5 2119.1 2340.8 2375.2 12183.2 13213.2 13617.5 13688.2 13759.9 1607.8 1676.4 1692.1 1712.8 1729.0 62832.7 63239.0 64515.4 64753.0 66984.3 8668.2 8832.9 9046.0 9226.1 9322.6 12644.2 12663.2 12668.2 12676.0 12684.7 6805.0 7015.9 7035.4 7128.3 7135.2 6715.4 6725.3 6745.3 6900.3 6918.4 5769.8 5774.9 5782.2 5833.0 5854.5 1640.4 1682.1 1692.5 1703.2 1741.7 776.3 832.4 848.6 966.1 985.3 15728.7 16375.2 16886.3 16946.2 17002.7 871.3 874.0 897.3 904.5 967.2 9131.0 9421.7 9702.8 9822.2 9856.8 349421.0 349963.0 350086.0 352314.0 362335.0 37643.8 48091.5 62295.0 63191.7 64403.7 909.7 918.5 960.3 961.0 961.4 14244.4 14839.8 15023.0 15505.5 15561.9 34929.3 35418.8 35674.6 35740.0 36287.1 42417.0 43082.1 44311.6 44766.3 46206.8 10005.3 10144.5 10148.3 10171.6 10308.3 10594.5 11069.7 11193.7 11255.4 11699.3 9251.4 9271.2 9583.0 9737.0 9930.0 9589.2 9615.5 9821.6 9877.4 9886.8 6836.7 6897.8 6916.4 7021.6 9829.6 10338.5 10831.1 10871.6 10943.2 11089.7 9228.8 9349.8 9635.9 9663.3 9711.4 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#3] mootools.html Cycles:180 Average:4973.14 Median:5822.85 stddev:2793.97 (48.0%) stddev-sans-first:2787.59 16:11:35 INFO - PROCESS | 20412 | Values: 1223.0 1349.9 1392.9 1495.5 1698.1 6129.6 7270.0 7616.4 7626.6 7728.0 7562.5 7634.7 7634.9 7638.8 7648.6 2094.8 2113.5 2118.2 2123.4 2124.9 2070.4 2121.9 2165.0 2165.1 2168.1 2105.3 2111.5 2121.8 2130.3 2132.8 2103.4 2112.4 2114.7 2120.2 2124.5 2039.8 2079.7 2090.7 2091.2 2092.0 7299.6 7613.7 7669.7 7685.8 7812.3 4439.9 4559.1 4566.2 4573.3 4573.4 2767.8 2935.3 2973.8 2975.7 2985.3 929.9 935.5 945.5 969.3 977.9 9822.4 9839.8 9889.3 9891.9 9916.5 3772.9 3915.8 3920.9 4078.2 4286.2 8229.4 8363.0 8373.7 8388.9 8391.2 4542.4 4549.1 4551.2 4556.9 4560.3 3480.0 3576.9 4103.3 4268.1 4268.7 3150.2 3173.7 3294.8 3294.9 3321.4 936.7 940.3 943.2 955.6 956.3 833.6 841.4 857.9 878.1 884.3 5150.2 5163.4 5179.2 5398.8 5419.4 407.5 409.5 409.8 414.3 415.7 3653.4 3760.6 3763.5 3783.7 3845.8 9188.6 9494.5 9586.2 9620.8 9623.8 9403.2 9463.5 9466.2 9469.5 9484.7 7206.7 7281.7 7282.5 7285.1 7288.5 5154.3 5219.2 5230.8 5291.8 5516.1 8624.8 8728.8 8793.8 8806.1 8889.9 8616.4 9048.8 9104.1 9151.7 9152.2 5371.4 6319.5 6352.5 6402.2 6405.4 6398.0 6515.3 6557.3 6591.7 7008.5 6617.5 6748.1 6766.9 6859.5 6884.3 6485.9 6550.7 6618.9 6716.5 6778.7 6258.7 6380.6 6380.6 6383.5 6396.8 4370.3 4384.8 4468.0 4533.5 4613.7 4496.3 4565.6 4567.1 4641.9 4653.8 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#4] prototype.html Cycles:180 Average:4121.47 Median:4680.64 stddev:1203.58 (25.7%) stddev-sans-first:1171.93 16:11:35 INFO - PROCESS | 20412 | Values: 281.0 292.8 294.4 295.1 299.0 4787.9 4849.7 4883.8 4891.7 4902.4 4735.1 4749.9 4767.9 4773.4 4779.7 3800.3 3801.3 3804.7 3813.6 3827.0 3709.6 3798.5 3819.4 3820.0 3837.3 3740.3 3760.1 3760.5 3770.8 3779.0 3741.6 3750.3 3755.3 3763.2 3770.4 3127.7 3233.2 3337.6 3341.4 3353.5 4519.4 4635.7 4659.9 4678.8 4682.4 4271.6 4286.6 4286.7 4296.7 4310.5 4652.0 4729.8 4992.2 4995.1 5007.2 3606.4 3631.7 3637.4 3639.2 3639.9 5242.4 5264.8 5267.4 5271.9 5276.5 3645.4 3737.6 3744.9 3755.5 3776.8 3750.5 3761.2 3772.0 3786.9 3787.5 4225.9 4232.7 4246.4 4248.1 4261.6 4937.8 4938.4 4940.0 4969.7 5016.5 1179.9 1250.7 1256.3 1296.9 1315.0 796.5 797.4 812.9 813.4 824.7 3927.4 3928.2 3931.3 3934.1 3937.8 4489.6 4510.4 4511.4 4516.6 4531.4 3922.0 3930.2 3948.8 3951.4 3957.6 2440.6 2452.5 2529.4 2721.7 2749.4 4645.6 4716.9 4790.3 4838.0 4849.2 5265.7 5267.0 5271.0 5277.4 5286.9 4828.8 4833.3 4841.6 4849.2 4859.9 4990.6 5124.7 5147.3 5153.9 5169.3 5057.9 5067.0 5067.8 5068.3 5078.3 4825.4 4881.7 4897.1 4897.9 4901.9 3474.8 3599.6 3624.9 3643.3 3656.0 5147.9 5187.7 5203.9 5210.1 5213.8 5030.1 5032.4 5038.1 5050.4 5059.8 4847.9 5002.9 5012.6 5014.8 5030.5 4924.8 4931.7 4934.2 4943.4 4950.0 5010.8 5023.7 5025.1 5033.9 5071.5 4703.7 4894.6 4914.0 4935.9 4952.7 16:11:35 INFO - PROCESS | 20412 | 16:11:35 INFO - PROCESS | 20412 | [#5] yui.html Cycles:180 Average:16703.89 Median:581.41 stddev:23357.14 (4017.3%) stddev-sans-first:23391.50 16:11:35 INFO - PROCESS | 20412 | Values: 636.6 654.5 664.5 677.7 764.6 12873.0 13911.0 14027.7 14056.6 14071.4 13528.3 13745.0 13756.2 13776.0 13777.7 765.2 788.1 806.2 807.1 807.5 794.1 810.1 810.7 811.1 811.2 829.2 838.1 840.6 841.5 842.2 825.2 825.2 826.9 827.7 828.3 611.6 616.0 617.5 617.6 617.8 14560.3 14683.6 14700.6 14706.0 14710.9 12835.0 12877.2 13164.2 13229.5 13491.0 9993.0 10078.7 10134.9 10232.6 10619.3 3273.1 3326.8 3329.2 3337.5 3341.6 57758.4 59632.1 65414.0 65477.3 66482.7 9850.6 9935.6 10001.5 10009.3 10146.4 16825.3 17472.1 17472.5 18320.5 18412.2 6802.1 6843.9 6850.7 6867.1 6872.2 3514.5 3670.3 3689.2 3718.1 3743.2 2985.7 3080.4 3100.5 3103.1 3112.4 494.6 495.8 497.4 501.1 506.2 573.5 574.8 581.3 582.4 586.5 7277.2 7396.5 7468.0 7946.4 8200.1 575.2 580.9 581.5 584.4 594.0 3610.8 3649.5 3686.6 3772.7 3778.4 57824.0 58122.4 58311.5 59735.0 102329.0 81461.1 82867.0 83719.0 85147.6 85876.0 69878.0 74948.0 75222.0 75857.6 78102.0 6919.8 7128.0 7161.9 7266.6 7274.6 43273.6 43749.1 43844.6 44722.0 45317.3 57022.0 58917.0 65148.7 65593.0 67917.0 9468.1 9524.7 9685.5 9834.3 9981.1 10443.5 10672.8 11057.9 11066.4 11377.5 10096.6 10149.2 10530.8 10739.3 10820.3 10370.8 10635.5 10640.1 10904.9 11088.1 10336.2 10465.5 11004.7 11048.3 11052.8 8627.9 8799.4 8831.6 9127.2 9213.9 8506.2 8751.2 9204.2 9263.7 9502.8 16:11:35 INFO - PROCESS | 20412 | -------- Summary: end -------- 16:11:35 INFO - PROCESS | 20412 | 16:11:36 INFO - TEST-INFO | 20412: exit 0 16:11:36 INFO - TEST-OK | dromaeo_css | took 1123244ms 16:11:36 INFO - TEST-START | kraken 16:11:36 INFO - operating with platform_type : linux_ 16:11:36 INFO - Initialising browser for kraken test... 16:11:36 INFO - TEST-INFO | started process 20718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAlISg3/profile http://localhost:55716/getInfo.html) 16:11:41 INFO - PROCESS | 20718 | __metrics Screen width/height:1600/1200 16:11:41 INFO - PROCESS | 20718 | colorDepth:24 16:11:41 INFO - PROCESS | 20718 | Browser inner width/height: 1024/697 16:11:41 INFO - PROCESS | 20718 | __metrics 16:11:41 INFO - PROCESS | 20718 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:11:41 INFO - PROCESS | 20718 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:11:42 INFO - PROCESS | 20718 | console.error: PushService: 16:11:42 INFO - PROCESS | 20718 | stateChangeProcessEnqueue: Error transitioning state 16:11:42 INFO - PROCESS | 20718 | UnknownError 16:11:43 INFO - TEST-INFO | 20718: exit 0 16:11:43 INFO - Browser initialized. 16:11:43 INFO - Running cycle 1/1 for kraken test... 16:11:43 INFO - TEST-INFO | started process 20801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAlISg3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:55 INFO - PROCESS | 20801 | RSS: Main: 173498368 16:11:55 INFO - PROCESS | 20801 | 16:11:58 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55716/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:59 INFO - PROCESS | 20801 | RSS: Main: 230035456 16:11:59 INFO - PROCESS | 20801 | 16:12:02 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55716/tests/kraken/driver.html?testName=audio-dft) 16:12:02 INFO - PROCESS | 20801 | RSS: Main: 217489408 16:12:02 INFO - PROCESS | 20801 | 16:12:05 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55716/tests/kraken/driver.html?testName=audio-fft) 16:12:06 INFO - PROCESS | 20801 | RSS: Main: 299491328 16:12:06 INFO - PROCESS | 20801 | 16:12:08 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55716/tests/kraken/driver.html?testName=audio-oscillator) 16:12:09 INFO - PROCESS | 20801 | RSS: Main: 210247680 16:12:09 INFO - PROCESS | 20801 | 16:12:11 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55716/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:12 INFO - PROCESS | 20801 | RSS: Main: 212865024 16:12:12 INFO - PROCESS | 20801 | 16:12:15 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55716/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:15 INFO - PROCESS | 20801 | RSS: Main: 249094144 16:12:15 INFO - PROCESS | 20801 | 16:12:19 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55716/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:19 INFO - PROCESS | 20801 | RSS: Main: 248377344 16:12:19 INFO - PROCESS | 20801 | 16:12:22 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55716/tests/kraken/driver.html?testName=json-parse-financial) 16:12:23 INFO - PROCESS | 20801 | RSS: Main: 248045568 16:12:23 INFO - PROCESS | 20801 | 16:12:25 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55716/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:25 INFO - PROCESS | 20801 | RSS: Main: 210042880 16:12:25 INFO - PROCESS | 20801 | 16:12:27 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:28 INFO - PROCESS | 20801 | RSS: Main: 218157056 16:12:28 INFO - PROCESS | 20801 | 16:12:30 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:30 INFO - PROCESS | 20801 | RSS: Main: 227082240 16:12:30 INFO - PROCESS | 20801 | 16:12:33 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:34 INFO - PROCESS | 20801 | RSS: Main: 234868736 16:12:34 INFO - PROCESS | 20801 | 16:12:37 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:38 INFO - PROCESS | 20801 | RSS: Main: 232534016 16:12:38 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | Cycle 1(1): loaded http://localhost:55716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55716/tests/kraken/driver.html?testName=ai-astar) 16:12:40 INFO - PROCESS | 20801 | RSS: Main: 282611712 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | __start_tp_report 16:12:40 INFO - PROCESS | 20801 | _x_x_mozilla_page_load 16:12:40 INFO - PROCESS | 20801 | _x_x_mozilla_page_load_details 16:12:40 INFO - PROCESS | 20801 | |i|pagename|runs| 16:12:40 INFO - PROCESS | 20801 | |0;ai-astar;107;114;114;114;113;114;114;115;114;116 16:12:40 INFO - PROCESS | 20801 | |1;audio-beat-detection;161;127;130;181;131;128;129;128;159;135 16:12:40 INFO - PROCESS | 20801 | |2;audio-dft;161;162;161;162;161;162;161;161;161;160 16:12:40 INFO - PROCESS | 20801 | |3;audio-fft;76;77;77;116;77;76;77;76;101;76 16:12:40 INFO - PROCESS | 20801 | |4;audio-oscillator;83;84;111;83;84;84;104;84;83;122 16:12:40 INFO - PROCESS | 20801 | |5;imaging-gaussian-blur;118;118;117;117;117;117;116;117;118;118 16:12:40 INFO - PROCESS | 20801 | |6;imaging-darkroom;148;146;146;148;147;148;147;146;147;147 16:12:40 INFO - PROCESS | 20801 | |7;imaging-desaturate;84;85;84;85;85;84;84;84;84;85 16:12:40 INFO - PROCESS | 20801 | |8;json-parse-financial;65;64;64;62;63;65;65;67;64;65 16:12:40 INFO - PROCESS | 20801 | |9;json-stringify-tinderbox;67;67;67;67;67;68;67;68;68;67 16:12:40 INFO - PROCESS | 20801 | |10;stanford-crypto-aes;86;90;85;94;87;83;83;90;83;83 16:12:40 INFO - PROCESS | 20801 | |11;stanford-crypto-ccm;157;142;142;149;145;141;139;145;195;150 16:12:40 INFO - PROCESS | 20801 | |12;stanford-crypto-pbkdf2;177;176;176;176;174;178;182;181;174;186 16:12:40 INFO - PROCESS | 20801 | |13;stanford-crypto-sha256-iterative;70;72;70;74;70;71;69;71;72;70 16:12:40 INFO - PROCESS | 20801 | __end_tp_report 16:12:40 INFO - PROCESS | 20801 | __start_cc_report 16:12:40 INFO - PROCESS | 20801 | _x_x_mozilla_cycle_collect,1966 16:12:40 INFO - PROCESS | 20801 | __end_cc_report 16:12:40 INFO - PROCESS | 20801 | __startTimestamp1477091560321__endTimestamp 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | ------- Summary: start ------- 16:12:40 INFO - PROCESS | 20801 | Number of tests: 14 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.42 (2.1%) stddev-sans-first:0.83 16:12:40 INFO - PROCESS | 20801 | Values: 107.0 114.0 114.0 114.0 113.0 114.0 114.0 115.0 114.0 116.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:133.00 stddev:19.03 (14.3%) stddev-sans-first:18.74 16:12:40 INFO - PROCESS | 20801 | Values: 161.0 127.0 130.0 181.0 131.0 128.0 129.0 128.0 159.0 135.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:12:40 INFO - PROCESS | 20801 | Values: 161.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 160.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:13.96 (18.2%) stddev-sans-first:14.58 16:12:40 INFO - PROCESS | 20801 | Values: 76.0 77.0 77.0 116.0 77.0 76.0 77.0 76.0 101.0 76.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.50 stddev:14.54 (17.4%) stddev-sans-first:15.04 16:12:40 INFO - PROCESS | 20801 | Values: 83.0 84.0 111.0 83.0 84.0 84.0 104.0 84.0 83.0 122.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 16:12:40 INFO - PROCESS | 20801 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 16:12:40 INFO - PROCESS | 20801 | Values: 148.0 146.0 146.0 148.0 147.0 148.0 147.0 146.0 147.0 147.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 16:12:40 INFO - PROCESS | 20801 | Values: 84.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 85.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.41 16:12:40 INFO - PROCESS | 20801 | Values: 65.0 64.0 64.0 62.0 63.0 65.0 65.0 67.0 64.0 65.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 16:12:40 INFO - PROCESS | 20801 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:3.84 (4.4%) stddev-sans-first:4.07 16:12:40 INFO - PROCESS | 20801 | Values: 86.0 90.0 85.0 94.0 87.0 83.0 83.0 90.0 83.0 83.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:147.00 stddev:16.51 (11.2%) stddev-sans-first:17.34 16:12:40 INFO - PROCESS | 20801 | Values: 157.0 142.0 142.0 149.0 145.0 141.0 139.0 145.0 195.0 150.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:177.50 stddev:3.86 (2.2%) stddev-sans-first:4.08 16:12:40 INFO - PROCESS | 20801 | Values: 177.0 176.0 176.0 176.0 174.0 178.0 182.0 181.0 174.0 186.0 16:12:40 INFO - PROCESS | 20801 | 16:12:40 INFO - PROCESS | 20801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.45 (2.0%) stddev-sans-first:1.50 16:12:40 INFO - PROCESS | 20801 | Values: 70.0 72.0 70.0 74.0 70.0 71.0 69.0 71.0 72.0 70.0 16:12:40 INFO - PROCESS | 20801 | -------- Summary: end -------- 16:12:40 INFO - PROCESS | 20801 | 16:12:41 INFO - TEST-INFO | 20801: exit 0 16:12:41 INFO - TEST-OK | kraken | took 65000ms 16:12:41 INFO - SUITE-END | took 1188s 16:12:41 INFO - Completed test suite (00:19:48) 16:12:41 INFO - javascript benchmark 16:12:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.488419758147, 2640.907568235112, 2667.0931883159724, 2680.5309070912585, 2692.744189302017, 4557.954420455794, 4636.559526844952, 4739.810407583697, 4796.6162706983405, 4813.951860481398, 4663.766811659412, 4761.738104404257, 4777.641676874231, 4831.951680483203, 4880.243562247849, 4312.0, 4333.349997500369, 4377.627901628365, 4382.978085109586, 4385.495667998189, 4310.59049390309, 4472.195004899117, 4481.2381895077915, 4505.053938672866, 4557.316402539613, 4229.746215227096, 4444.488883778342, 4451.5103338632725, 4481.708688935225, 4577.015941572561, 4254.574542545752, 4317.41714868495, 4332.155229730204, 4379.912401751947, 4391.9780401098105, 4317.352397140423, 4331.177076355482, 4331.6534677225745, 4390.714603550759, 4396.318570621559, 4702.0, 4713.175194340976, 4732.763361831929, 4737.692050016738, 4756.690815097042, 4863.732494712789, 4937.432195297515, 4937.975310123462, 5060.139776238048, 5068.72122033288, 5046.016026874761, 5076.695398276078, 5089.592832573422, 5167.819126330598, 5195.948040519622, 4721.3390125382475, 4725.527447255247, 4752.239641657318, 4756.6432517561325, 4776.355192049029, 5171.379434467888, 5172.120739474299, 5180.067587834226, 5180.171172612364, 5249.396319423316, 4796.592289655418, 4856.1987272099705, 4860.73265970368, 4938.580220681282, 4956.603471722254, 4972.627052971042, 4982.302477653131, 4989.5758860496535, 5032.043911656773, 5106.872328191825, 4953.554180123806, 4978.327925730053, 4984.825531106394, 4996.275540046673, 5001.424836143818, 4795.568398844121, 4842.612590992712, 4844.563989240985, 4967.503249675004, 4981.6014718823135, 4229.851955181553, 4260.808263628144, 4264.275073237557, 4301.78491075445, 4318.330658747836, 3720.4419337099653, 3727.962720372816, 3733.6079711629886, 3743.8502459901842, 3766.8681596144, 4218.557051509609, 4261.808218630169, 4365.607095361433, 4366.519682834885, 4413.183561041217, 4997.750112494361, 5066.569341606005, 5075.111855425286, 5086.287919691172, 5181.922271165936, 4334.19817333788, 4340.327249276367, 4341.913161736811, 4357.085012147421, 4399.758013309235, 4574.222382195035, 4595.0809838031855, 4597.057603191338, 4603.401557797465, 4638.768061596907, 4668.78990445424, 4715.622750180046, 4720.150372932905, 4770.499097594703, 4808.711477311373, 5065.898682026413, 5124.308218390619, 5126.077306084941, 5174.301469301747, 5189.532942035235, 4798.640101992434, 4804.471508134172, 4804.8798780030775, 4811.206150985048, 4865.026994601165, 4846.781894814671, 4900.558949694545, 4966.354373931365, 5039.294498770102, 5098.719570423662, 5092.668976516515, 5106.540411362995, 5119.232115182753, 5184.274201611702, 5190.766415511235, 4919.286703427912, 4935.136351138608, 4960.131976903956, 4990.6506544541535, 5052.1663925451885, 4797.976010120066, 4851.223804191453, 4941.9868926869185, 4944.851654450372, 5017.749112544431, 4836.46798852133, 4845.1520983828395, 4845.49122342149, 4848.781804818862, 4850.733209673502, 4953.578945789648, 4968.602511798975, 4989.675671081368, 5013.172826483589, 5080.46655101209, 4643.86068417948, 4676.041411510564, 4681.063787242633, 4856.150173719656, 4922.261660750916], "value": 4644.812875131322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.6423096870859, 585.3385674188166, 587.5358466811219, 594.1029046140327, 594.5422025040722, 27459.313517162056, 38602.0, 39827.0, 39958.0, 39974.60025399745, 39262.21475570494, 39751.801240993824, 39878.0, 40163.598364016354, 40236.59763402365, 7626.4280178986655, 7774.727884524043, 7775.6500957456765, 7777.883331750028, 7782.0, 7654.158042615336, 7757.8836317455, 7757.922420775776, 7760.223977602251, 7762.961185194066, 7732.922670773305, 7750.534967901944, 7756.922430775677, 7781.805454863617, 7785.065792104955, 7710.267524585155, 7738.0, 7749.883751743729, 7756.844863102763, 7758.069031716173, 7388.3719883809945, 7456.962715186443, 7460.104787425544, 7461.179270280265, 7461.8507629847645, 37840.0, 38016.42975355372, 38035.80982095099, 38164.9468042556, 38333.42499862504, 2882.2506148401358, 3031.1209749172713, 3105.813651180914, 3211.7109460148463, 3345.414552453335, 27758.44483110347, 28050.2987425316, 28059.564215482915, 28081.29796755077, 28081.29796755077, 3246.788958717676, 3338.0, 3503.8248087595516, 3509.508668786372, 3524.1894364296354, 222808.0, 223428.0, 224269.99999999837, 225198.0, 228125.0, 31174.609205112898, 52441.21338179854, 52795.47204527982, 52953.38082739658, 53036.73481632644, 31311.21721956969, 33330.333393331995, 33333.499997500054, 33337.16657083544, 33339.33231350676, 12697.0, 12756.107072504836, 12767.744645107046, 12779.105462617528, 12786.552470663482, 10601.41692206936, 10634.042936135786, 10646.414447205323, 10674.359538427563, 10713.732156695989, 7693.538387696756, 7720.266574675396, 7800.297973182441, 7814.921850781533, 7819.843603127905, 3050.8627111780024, 3073.877044918223, 3077.07687693691, 3102.3329984053535, 3113.470709979309, 795.4988357334842, 903.7740564858785, 915.4004127296631, 954.8472244440995, 956.6077908057663, 27129.864350678516, 27630.861845690644, 27758.722412775613, 27864.080093875695, 28086.43827123446, 935.2144198872979, 945.7682867697458, 955.7849483866074, 963.6097380560884, 987.274353350287, 14000.859991400159, 14910.478133265284, 15205.467808626867, 15289.636280018378, 15297.770533442008, 354103.0, 354592.0, 355213.0, 355604.0, 356742.0, 49382.50617493779, 49908.750456247486, 49910.0, 49976.0, 50006.49993500091, 1068.7969285835666, 1115.0856297835696, 1163.2380790582183, 1164.2374244869625, 1171.8652354979286, 25708.357291067874, 28762.42475150527, 29277.0, 29445.558316625695, 29690.703092968793, 41645.58354416417, 42323.0, 42399.788001059795, 42437.78781106075, 42454.0, 278034.82947755395, 278953.0, 280927.0, 281623.0, 283958.0, 21822.672659909796, 22593.2092376766, 23773.0, 24854.875725621256, 24985.750142498342, 39360.80319598383, 40205.597944021356, 40256.59743402529, 40657.59342406538, 40836.59163408328, 34675.47986780251, 34836.65163348334, 35074.649253508156, 35189.64810351864, 35471.82264088663, 34443.0, 34984.825075874454, 34993.300133996665, 35113.824430877685, 35500.0, 33919.0, 34005.48991765175, 34941.47587786236, 35001.0, 35109.648903510635, 29935.70064299329, 32142.0, 32168.0, 32317.838410808738, 32509.34981300408, 24043.398915027265, 24213.941814945927, 24404.87797561001, 24674.753252467963, 25190.49619007573], "value": 16023.845783116523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.37287568813974, 350.68963966889294, 352.3094734320731, 355.7794167616078, 357.99105022374454, 13094.999999999976, 13698.452061917511, 15899.523014309574, 16089.75865362019, 17209.225584848682, 13540.593782186526, 15892.443764468246, 16079.91960040201, 16195.352185912549, 17019.48941531753, 4928.137575924199, 4943.6539442239055, 5143.074246635604, 5150.639455238135, 5184.7148406837605, 4982.103221420143, 5094.46508116648, 5099.821506247282, 5102.591792656579, 5105.5149760772665, 3543.2559162575762, 3739.2708421857747, 5060.898782024357, 5709.543236541067, 5969.5821292509545, 5778.422157784188, 5960.493358064569, 5984.072468767326, 5986.431289027535, 5988.640681559121, 5183.092958732207, 5201.063808514466, 5207.791688332462, 5211.973940130313, 5215.478452154792, 19813.405597832087, 20182.394528164034, 20257.29099481526, 20415.48961275965, 20637.277695280594, 1922.327185485083, 1962.528993041674, 2119.1417475922276, 2340.8361414700807, 2375.239923224569, 12183.208091474025, 13213.207207567577, 13617.455301787917, 13688.247146406944, 13759.931200344034, 1607.815101263358, 1676.379739496382, 1692.0524506276524, 1712.8030276518236, 1728.9827101729072, 62832.68583657053, 63239.0, 64515.354846451875, 64753.0, 66984.30633396168, 8668.219860212612, 8832.8675069874, 9046.0, 9226.07739226072, 9322.627094916263, 12644.241345519298, 12663.176893501894, 12668.176568523017, 12676.049296302814, 12684.746305073846, 6804.965975170093, 7015.929840701528, 7035.401990830735, 7128.251533588898, 7135.179454362711, 6715.3620406061345, 6725.293844146392, 6745.258021617618, 6900.275471075565, 6918.411934985482, 5769.826905192851, 5774.88450230993, 5782.161586569924, 5833.0, 5854.531637468992, 1640.425850952181, 1682.0832646207602, 1692.5260926940477, 1703.2420572844965, 1741.7387391891318, 776.281939206232, 832.379876991633, 848.6011574559947, 966.0629189685993, 985.3299756165876, 15728.68542629141, 16375.181240938144, 16886.311368863262, 16946.23741931616, 17002.659946800995, 871.263782104121, 874.0421455938779, 897.2552781191596, 904.516083895113, 967.1585720423277, 9131.0, 9421.670241541513, 9702.75743106428, 9822.214222862154, 9856.802863942681, 349421.0, 349963.0, 350086.0, 352314.0, 362335.0, 37643.81178094092, 48091.519084809406, 62295.0, 63191.68404158042, 64403.67798160979, 909.6997990663066, 918.4994178172911, 960.274992380762, 960.9903900961041, 961.4423634292094, 14244.36189838182, 14839.777403338743, 15023.02350347224, 15505.534833955, 15561.922190388976, 34929.30141397208, 35418.8229058853, 35674.643253567134, 35740.0, 36287.11386584067, 42417.0, 43082.138357232056, 44311.55688443074, 44766.3285050718, 46206.76896615495, 10005.299629025898, 10144.492775361055, 10148.289619726549, 10171.593136274467, 10308.278420510793, 10594.4702764863, 11069.723256918642, 11193.66419007431, 11255.437228138724, 11699.2980421175, 9251.35240533183, 9271.165595096474, 9582.952085239807, 9736.95131524338, 9930.006999300012, 9589.184919281939, 9615.51922403891, 9821.558029888529, 9877.357971731815, 9886.75283117899, 6836.692348844414, 6897.827554310981, 6916.377526022481, 7021.613811240431, 9829.557669904729, 10338.534765935401, 10831.05041092611, 10871.619493317696, 10943.179261555257, 11089.722756931142, 9228.769280767767, 9349.766255843659, 9635.855462168212, 9663.323567350219, 9711.36876103051], "value": 8091.466426882635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.9571964981228, 1349.878510934016, 1392.8537503562127, 1495.5438591229677, 1698.0660636649839, 6129.632222066673, 7270.0, 7616.428767842406, 7626.618669066545, 7727.995360603128, 7562.508436951608, 7634.694612215505, 7634.88547671784, 7638.770836874889, 7648.617569121536, 2094.8009939055764, 2113.5138918048856, 2118.152738904435, 2123.373604786584, 2124.861883977544, 2070.3892351756267, 2121.872687638739, 2164.956700865982, 2165.1447678167115, 2168.0677308757226, 2105.2842033708534, 2111.5460176062143, 2121.7772133925946, 2130.286354071388, 2132.829373650104, 2103.4215590712524, 2112.355731501891, 2114.7356580427368, 2120.2155202575145, 2124.468882779305, 2039.836813054952, 2079.688046792978, 2090.707300977864, 2091.184438069154, 2092.0, 7299.598522081284, 7613.733519326797, 7669.73155939545, 7685.807854803618, 7812.3359514441345, 4439.933400998988, 4559.110973360196, 4566.155261276641, 4573.268277075652, 4573.428321459817, 2767.8200916940336, 2935.3102021025043, 2973.8067025643263, 2975.747061499775, 2985.31337792309, 929.9116583924516, 935.4667839331584, 945.4988855906381, 969.2924165359327, 977.8582105594649, 9822.410655360629, 9839.754006149831, 9889.307748457612, 9891.90108098917, 9916.454594997344, 3772.8868133956025, 3915.804209789499, 3920.921581568353, 4078.1639763848934, 4286.207051695384, 8229.382796290301, 8362.958185209034, 8373.665053397795, 8388.8741668875, 8391.160883911682, 4542.364069030338, 4549.09018196362, 4551.249043907785, 4556.908861822745, 4560.315952607069, 3479.973407844692, 3576.946345804815, 4103.302438585388, 4268.061026574149, 4268.658507319407, 3150.1966998415255, 3173.6826317368077, 3294.769366144347, 3294.8682052718104, 3321.4353559894876, 936.7377134402242, 940.2825833341648, 943.2406912435418, 955.5843208204453, 956.32101208143, 833.5832083958021, 841.3773807382493, 857.9313654907593, 878.0517041595062, 884.2837301785574, 5150.175971844562, 5163.380394352626, 5179.171332586768, 5398.838034858961, 5419.403865574784, 407.49267162383023, 409.51677021114773, 409.7561950639365, 414.29156142995816, 415.7256210900791, 3653.378925582604, 3760.5675347335405, 3763.473113764075, 3783.6783873371073, 3845.788481633481, 9188.632454701738, 9494.477803720723, 9586.185174260267, 9620.75948101303, 9623.807523849624, 9403.247740180906, 9463.479508626953, 9466.242700583936, 9469.479178645102, 9484.668036618685, 7206.7117315306805, 7281.745138920112, 7282.453815963824, 7285.089363829521, 7288.489805713549, 5154.252633368065, 5219.19102539107, 5230.843074707765, 5291.76187071575, 5516.062269414129, 8624.78438039054, 8728.825423491622, 8793.824123517366, 8806.119388061143, 8889.866652000355, 8616.396852220536, 9048.819023619622, 9104.13510716481, 9151.679691210775, 9152.222061124612, 5371.355437347544, 6319.526035547445, 6352.460040896575, 6402.199725034371, 6405.359464053744, 6398.0, 6515.250746164252, 6557.344265573404, 6591.736330546724, 7008.474364422791, 6617.470602351704, 6748.089007984056, 6766.93233067663, 6859.485538584726, 6884.311568843075, 6485.8702825944165, 6550.737970481127, 6618.900716489353, 6716.496262780213, 6778.694958726967, 6258.718357673824, 6380.585261957958, 6380.617162970237, 6383.521235907233, 6396.840078998062, 4370.300751879684, 4384.802683879297, 4467.955320446754, 4533.455985281787, 4613.746243956614, 4496.3255511673515, 4565.634749220121, 4567.063751930913, 4641.86074417768, 4653.790579424001], "value": 3937.6552697023694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.9943801123978, 292.7526240326924, 294.37739181630855, 295.0896484345793, 298.955156726491, 4787.863949113328, 4849.733264670442, 4883.780229889655, 4891.706497610146, 4902.411710594733, 4735.147673418784, 4749.883777312329, 4767.928481072787, 4773.403324584427, 4779.71321720697, 3800.277947190039, 3801.3157631626295, 3804.695624350059, 3813.561440434344, 3826.9617303826885, 3709.591944886074, 3798.5061941947506, 3819.4461803038544, 3819.9809000954956, 3837.2901013312626, 3740.2519496100754, 3760.1163726524246, 3760.52993375828, 3770.849166033369, 3779.0, 3741.5884252732176, 3750.3123594382637, 3755.267722794056, 3763.1909139535132, 3770.396736522157, 3127.702868227515, 3233.1917020744813, 3337.599488061424, 3341.3818443588016, 3353.4634458486526, 4519.435070616173, 4635.745034023127, 4659.906801863944, 4678.836240731558, 4682.438107427097, 4271.551487093841, 4286.57134286572, 4286.678499112579, 4296.699231053827, 4310.547392523771, 4652.0, 4729.83101322115, 4992.177855082905, 4995.075910956485, 5007.223880298523, 3606.350856845767, 3631.6757275343803, 3637.381645120336, 3639.1811842335264, 3639.854405823764, 5242.423333433358, 5264.789408423659, 5267.420583735786, 5271.920921186147, 5276.472352764731, 3645.3802853514435, 3737.588865224823, 3744.85020599173, 3755.549334079928, 3776.773393596393, 3750.5124333836425, 3761.247750449921, 3771.981140094282, 3786.905327366838, 3787.4697542344093, 4225.859018065166, 4232.687866761314, 4246.44796176495, 4248.111284326687, 4261.573842615776, 4937.753112344369, 4938.43208031081, 4939.999300283391, 4969.652124351333, 5016.523430274118, 1179.8525184351956, 1250.6992727563231, 1256.2901960392348, 1296.8508621508458, 1314.9737005259842, 796.5463029970211, 797.3541431440551, 812.8821320908553, 813.3818298093373, 824.6989848705299, 3927.371620540757, 3928.194720082376, 3931.309536899161, 3934.11482416454, 3937.8031098444962, 4489.618382437529, 4510.368548403226, 4511.390962220124, 4516.570925762047, 4531.3882625845745, 3921.9801802071956, 3930.194310166466, 3948.8350936473807, 3951.427043078795, 3957.584453632385, 2440.596656922277, 2452.5340185364726, 2529.380301826028, 2721.71422000691, 2749.4363655450584, 4645.605123564535, 4716.858494245178, 4790.257510085942, 4837.975810120927, 4849.175640141185, 5265.736713164327, 5266.973665131726, 5271.0, 5277.445868183862, 5286.867828304323, 4828.782704778293, 4833.326671729441, 4841.612670986242, 4849.224124140121, 4859.902801943941, 4990.575801056805, 5124.666896651705, 5147.279380886604, 5153.922691159711, 5169.327987361619, 5057.949420505895, 5066.9746651266505, 5067.847964561069, 5068.26510156018, 5078.339815823919, 4825.445073816556, 4881.73150476713, 4897.094037603055, 4897.869426799353, 4901.946081592475, 3474.774139680913, 3599.5500562429697, 3624.855005799844, 3643.2531331077594, 3656.0, 5147.9227811582105, 5187.740612969261, 5203.869903252297, 5210.114280572236, 5213.76538055796, 5030.0694371541385, 5032.421271553818, 5038.093143234253, 5050.368703912011, 5059.848204553869, 4847.878803029953, 5002.874928126826, 5012.649114561946, 5014.7994080236385, 5030.522834677214, 4924.803007879645, 4931.728754918514, 4934.18585933317, 4943.431505376928, 4949.950500494949, 5010.8246211383885, 5023.723695196799, 5025.120603894377, 5033.92449113271, 5071.492850714899, 4703.717776933258, 4894.608431325557, 4913.950860491493, 4935.851924442272, 4952.702837829742], "value": 3735.7146413001296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.5639536917212, 654.5320096131265, 664.5348256220647, 677.7356830835975, 764.6291548598929, 12873.0, 13911.0, 14027.719445611081, 14056.64858378541, 14071.366788494517, 13528.323583820795, 13745.0, 13756.243406612657, 13776.0, 13777.724445511083, 765.2118318132304, 788.1291173253559, 806.2421323955492, 807.0718673525434, 807.4509333653114, 794.0907660728462, 810.1331575214523, 810.6554714246422, 811.0551207842885, 811.1523457986418, 829.1956801902145, 838.1116017021945, 840.6007146605344, 841.4614646626164, 842.1704620948392, 825.1500954017341, 825.2490233887164, 826.9297109745619, 827.7392621324294, 828.3125006244802, 611.5810669691231, 616.017452163798, 617.5121653893464, 617.5800455690129, 617.7528988404674, 14560.344784484723, 14683.559493215114, 14700.632484187874, 14706.0, 14710.926445367812, 12835.0, 12877.227366358049, 13164.210147391188, 13229.536966206233, 13491.0, 9993.0, 10078.697639070839, 10134.89865101347, 10232.641857535025, 10619.30974486656, 3273.083536609753, 3326.750493712981, 3329.217633856042, 3337.499375093731, 3341.6491268416707, 57758.42241577614, 59632.10551841682, 65414.0, 65477.34522654808, 66482.66758666224, 9850.556724947395, 9935.552900119512, 10001.549930253155, 10009.349392289478, 10146.44194569291, 16825.32698692063, 17472.126393680264, 17472.475825725247, 18320.45038648843, 18412.171452284678, 6802.081718967876, 6843.931560684429, 6850.6574671266235, 6867.141607299088, 6872.175338959357, 3514.4552594347915, 3670.3026424979703, 3689.1883785567134, 3718.0890681782594, 3743.1577894973957, 2985.7163569460868, 3080.4147212029643, 3100.472919603673, 3103.053568661535, 3112.3930833487707, 494.5796073337634, 495.8239824862194, 497.437895178446, 501.0930216308493, 506.172408112731, 573.4552175433355, 574.8476653686777, 581.2908251932636, 582.4117641182436, 586.4838941731334, 7277.2358902315555, 7396.519226250384, 7468.0, 7946.404019698546, 8200.097989221182, 575.2295482174779, 580.9273840769904, 581.5318668471921, 584.3513699793226, 593.9881202375929, 3610.797413577768, 3649.543807024122, 3686.64976827201, 3772.6981841452616, 3778.4332350147697, 57824.0, 58122.418775811704, 58311.50392929229, 59735.0, 102329.0, 81461.1123332602, 82867.0, 83719.0, 85147.5742621283, 85876.0, 69878.0, 74948.0, 75222.0, 75857.62071189609, 78102.0, 6919.792406227822, 7127.964360178166, 7161.856762864818, 7266.564006159648, 7274.599897005503, 43273.56726432696, 43749.12501750011, 43844.56155438405, 44722.0, 45317.32024019576, 57022.0, 58917.0, 65148.674256628416, 65593.0, 67917.0, 9468.05979618533, 9524.714258572254, 9685.515724213901, 9834.262430317898, 9981.051800078982, 10443.477826108512, 10672.83990740155, 11057.944710276397, 11066.446677665923, 11377.488013039267, 10096.596136154472, 10149.188064954933, 10530.789384212427, 10739.301945373838, 10820.296680715728, 10370.844437333597, 10635.468226588795, 10640.095591874777, 10904.945475272572, 11088.112950964065, 10336.17310615134, 10465.47672616351, 11004.724881877697, 11048.337099774039, 11052.834207486734, 8627.87058194115, 8799.384043116921, 8831.646734130563, 9127.179319013856, 9213.861792073258, 8506.191911768372, 8751.168638979287, 9204.171624553823, 9263.675771347971, 9502.762430939281], "value": 6357.494299138877, "unit": "score"}], "name": "dromaeo_css", "value": 6191.3397754149555, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 130.0, 181.0, 131.0, 128.0, 129.0, 128.0, 159.0, 135.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 116.0, 77.0, 76.0, 77.0, 76.0, 101.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 83.0, 84.0, 84.0, 104.0, 84.0, 83.0, 122.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 62.0, 63.0, 65.0, 65.0, 67.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 85.0, 94.0, 87.0, 83.0, 83.0, 90.0, 83.0, 83.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 142.0, 142.0, 149.0, 145.0, 141.0, 139.0, 145.0, 195.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 176.0, 176.0, 174.0, 178.0, 182.0, 181.0, 174.0, 186.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 74.0, 70.0, 71.0, 69.0, 71.0, 72.0, 70.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1556.9, "alertThreshold": 2.0}]} 16:12:42 INFO - Return code: 0 16:12:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:42 INFO - # TBPL SUCCESS # 16:12:42 INFO - Running post-action listener: _resource_record_post_action 16:12:42 INFO - [mozharness: 2016-10-21 23:12:42.120412Z] Finished run-tests step (success) 16:12:42 INFO - Running post-run listener: _resource_record_post_run 16:12:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407416832; Read time: 20; Write time: 350664 16:12:42 INFO - TinderboxPrint: CPU usage
13.1% 16:12:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 16:12:42 INFO - TinderboxPrint: I/O write bytes / time
407,416,832 / 350,664 16:12:42 INFO - TinderboxPrint: CPU idle
8,350.9 (86.9%) 16:12:42 INFO - TinderboxPrint: CPU user
1,206.5 (12.6%) 16:12:42 INFO - TinderboxPrint: Swap in / out
0 / 0 16:12:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99635200; Read time: 0; Write time: 114780 16:12:42 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290840576; Read time: 8; Write time: 231556 16:12:42 INFO - Running post-run listener: _upload_blobber_files 16:12:42 INFO - Blob upload gear active. 16:12:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:12:43 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:12:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:44 INFO - (blobuploader) - INFO - Done attempting. 16:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:44 INFO - (blobuploader) - INFO - Done attempting. 16:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:48 INFO - (blobuploader) - INFO - Done attempting. 16:12:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:48 INFO - Return code: 0 16:12:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4496e97d682b9e7a13ca591156ab8018e60f78766917a3de3d7eb48551359b8d78df0505e9679699e6cb0221d3697cd0f0b6a63a75e350af097e9b50f1651c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06f78ca0f9f1bfce2c5f2a66f4e3f87ad99a77837ef6ca64ce1b85e99bf337646a7963a1bb74dd4bcaed6fc0a3fc59acdb3e8150ce5f4b96a9d70ae40955a1f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dd4a83e6c08cbf8ceb9e30e5677774e19ab70027b1339d58b952f6b2b5de2810c8273dd89bd8978f64163ddf2466ec5b44dc2079b970658a5dd1a2d7df8eb4"} 16:12:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:48 INFO - Contents: 16:12:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4496e97d682b9e7a13ca591156ab8018e60f78766917a3de3d7eb48551359b8d78df0505e9679699e6cb0221d3697cd0f0b6a63a75e350af097e9b50f1651c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06f78ca0f9f1bfce2c5f2a66f4e3f87ad99a77837ef6ca64ce1b85e99bf337646a7963a1bb74dd4bcaed6fc0a3fc59acdb3e8150ce5f4b96a9d70ae40955a1f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dd4a83e6c08cbf8ceb9e30e5677774e19ab70027b1339d58b952f6b2b5de2810c8273dd89bd8978f64163ddf2466ec5b44dc2079b970658a5dd1a2d7df8eb4"} 16:12:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:48 INFO - Copying logs to upload dir... 16:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.574013 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-21 16:12:48.255004) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 16:12:48.258897) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4496e97d682b9e7a13ca591156ab8018e60f78766917a3de3d7eb48551359b8d78df0505e9679699e6cb0221d3697cd0f0b6a63a75e350af097e9b50f1651c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06f78ca0f9f1bfce2c5f2a66f4e3f87ad99a77837ef6ca64ce1b85e99bf337646a7963a1bb74dd4bcaed6fc0a3fc59acdb3e8150ce5f4b96a9d70ae40955a1f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dd4a83e6c08cbf8ceb9e30e5677774e19ab70027b1339d58b952f6b2b5de2810c8273dd89bd8978f64163ddf2466ec5b44dc2079b970658a5dd1a2d7df8eb4"} build_url:https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/JrVv-8yWR022FMrZNzyhKA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4496e97d682b9e7a13ca591156ab8018e60f78766917a3de3d7eb48551359b8d78df0505e9679699e6cb0221d3697cd0f0b6a63a75e350af097e9b50f1651c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06f78ca0f9f1bfce2c5f2a66f4e3f87ad99a77837ef6ca64ce1b85e99bf337646a7963a1bb74dd4bcaed6fc0a3fc59acdb3e8150ce5f4b96a9d70ae40955a1f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5dd4a83e6c08cbf8ceb9e30e5677774e19ab70027b1339d58b952f6b2b5de2810c8273dd89bd8978f64163ddf2466ec5b44dc2079b970658a5dd1a2d7df8eb4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 16:12:48.284164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 16:12:48.284505) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1477089387.838451-1551930226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 16:12:48.366516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 16:12:48.366857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 16:12:48.367151) ========= ========= Total master_lag: 0.18 =========