builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1482346801.24 results: success (0) buildid: 20161221092053 builduid: d9cd92c2e1c74995a16a5b9419719058 revision: c3f401e19160ed979541940f21ff70a111cc5972 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.241337) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.241908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.242215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.280192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.280536) ========= 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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 11:00:01-- 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% 223M=0s 2016-12-21 11:00:01 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.448509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.449078) ========= 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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015083 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.499350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:01.499715) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3f401e19160ed979541940f21ff70a111cc5972 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3f401e19160ed979541940f21ff70a111cc5972 --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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 11:00:01,758 truncating revision to first 12 chars 2016-12-21 11:00:01,758 Setting DEBUG logging. 2016-12-21 11:00:01,759 attempt 1/10 2016-12-21 11:00:01,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3f401e19160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 11:00:02,228 unpacking tar archive at: mozilla-aurora-c3f401e19160/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:02.281595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:02.281901) ========= script_repo_revision: c3f401e19160ed979541940f21ff70a111cc5972 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:02.282308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:02.282587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 11:00:02.299757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-21 11:00:02.300095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:02 INFO - MultiFileLogger online at 20161221 11:00:02 in /builds/slave/test 11:00:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:00:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:02 INFO - {'append_to_log': False, 11:00:02 INFO - 'base_work_dir': '/builds/slave/test', 11:00:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:00:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:02 INFO - 'branch': 'Mozilla-Aurora', 11:00:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:02 INFO - 'config_files': ('talos/linux_config.py',), 11:00:02 INFO - 'default_actions': ('clobber', 11:00:02 INFO - 'read-buildbot-config', 11:00:02 INFO - 'download-and-extract', 11:00:02 INFO - 'populate-webroot', 11:00:02 INFO - 'create-virtualenv', 11:00:02 INFO - 'install', 11:00:02 INFO - 'run-tests'), 11:00:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:02 INFO - 'download_minidump_stackwalk': True, 11:00:02 INFO - 'download_symbols': 'ondemand', 11:00:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:02 INFO - 'installer_path': 'installer.exe', 11:00:02 INFO - 'log_level': 'info', 11:00:02 INFO - 'log_name': 'talos', 11:00:02 INFO - 'log_to_console': True, 11:00:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:02 INFO - 'opt_config_files': (), 11:00:02 INFO - 'pip_index': False, 11:00:02 INFO - 'sps_profile': False, 11:00:02 INFO - 'sps_profile_interval': 0, 11:00:02 INFO - 'suite': 'dromaeojs-e10s', 11:00:02 INFO - 'system_bits': '32', 11:00:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:02 INFO - 'title': 'talos-linux64-ix-052', 11:00:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:02 INFO - 'use_talos_json': True, 11:00:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:02 INFO - 'work_dir': 'build'} 11:00:02 INFO - [mozharness: 2016-12-21 19:00:02.652951Z] Running clobber step. 11:00:02 INFO - Running pre-action listener: _resource_record_pre_action 11:00:02 INFO - Running main action method: clobber 11:00:02 INFO - rmtree: /builds/slave/test/build 11:00:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:03 INFO - Running post-action listener: _resource_record_post_action 11:00:03 INFO - [mozharness: 2016-12-21 19:00:03.120151Z] Finished clobber step (success) 11:00:03 INFO - [mozharness: 2016-12-21 19:00:03.120250Z] Running read-buildbot-config step. 11:00:03 INFO - Running pre-action listener: _resource_record_pre_action 11:00:03 INFO - Running main action method: read_buildbot_config 11:00:03 INFO - Using buildbot properties: 11:00:03 INFO - { 11:00:03 INFO - "project": "", 11:00:03 INFO - "product": "firefox", 11:00:03 INFO - "script_repo_revision": "production", 11:00:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:00:03 INFO - "repository": "", 11:00:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:00:03 INFO - "buildid": "20161221092053", 11:00:03 INFO - "pgo_build": "True", 11:00:03 INFO - "basedir": "/builds/slave/test", 11:00:03 INFO - "buildnumber": 692, 11:00:03 INFO - "slavename": "talos-linux64-ix-052", 11:00:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:00:03 INFO - "platform": "ubuntu64_hw", 11:00:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:00:03 INFO - "branch": "mozilla-aurora", 11:00:03 INFO - "repo_path": "releases/mozilla-aurora", 11:00:03 INFO - "revision": "c3f401e19160ed979541940f21ff70a111cc5972", 11:00:03 INFO - "stage_platform": "linux64-pgo", 11:00:03 INFO - "builduid": "d9cd92c2e1c74995a16a5b9419719058", 11:00:03 INFO - "slavebuilddir": "test" 11:00:03 INFO - } 11:00:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:00:03 INFO - Running post-action listener: _resource_record_post_action 11:00:03 INFO - [mozharness: 2016-12-21 19:00:03.122855Z] Finished read-buildbot-config step (success) 11:00:03 INFO - [mozharness: 2016-12-21 19:00:03.122942Z] Running download-and-extract step. 11:00:03 INFO - Running pre-action listener: _resource_record_pre_action 11:00:03 INFO - Running main action method: download_and_extract 11:00:03 INFO - mkdir: /builds/slave/test/build/tests 11:00:03 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')]} 11:00:03 INFO - trying https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:00:03 INFO - Downloading https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:00:03 INFO - Downloaded 1361 bytes. 11:00:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:00:03 INFO - Using the following test package requirements: 11:00:03 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:00:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:00:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'jsshell-linux-x86_64.zip'], 11:00:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:00:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:00:03 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:00:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:00:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:00:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:03 INFO - Fetch https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:00:04 INFO - Http code: 200 11:00:04 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:00:04 INFO - x-amz-cf-id: jiKP3FWuqN_M31K6poyE78i74Z4pYai1B8UDKMf1jZ_L1F6ibDDYYA== 11:00:04 INFO - x-amz-version-id: KGMRlIix.m9fkH1sk9sCCTcWKyW5Bk.V 11:00:04 INFO - Expected file size: 21942688 11:00:04 INFO - Obtained file size: 21942688 11:00:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:00:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:00:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:08 INFO - Fetch https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:00:09 INFO - Http code: 200 11:00:09 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 11:00:09 INFO - x-amz-cf-id: OK2FFBR_1XDjyrfj3n-sUyO5Nm7rn2hwyCfvCH3JQTVcg8MgZ7ZikA== 11:00:09 INFO - x-amz-version-id: KGMRlIix.m9fkH1sk9sCCTcWKyW5Bk.V 11:00:09 INFO - Expected file size: 21942688 11:00:09 INFO - Obtained file size: 21942688 11:00:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:00:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:00:13 INFO - Fetch https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:00:14 INFO - Http code: 200 11:00:14 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 11:00:14 INFO - x-amz-cf-id: mQC450ybhivOHTx-F4iY0f9GX-Sob6C-OfivsDK7yvXH7_33PDuLcA== 11:00:14 INFO - x-amz-version-id: 86WnzXwJAj1T7X4sOxG1ES2bvIfZuN3V 11:00:14 INFO - Expected file size: 14409038 11:00:14 INFO - Obtained file size: 14409038 11:00:15 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')]} 11:00:15 INFO - trying https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:00:15 INFO - Downloading https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:00:16 INFO - Downloaded 64008521 bytes. 11:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:00:16 INFO - mkdir: /builds/slave/test/properties 11:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:16 INFO - Contents: 11:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:00:16 INFO - Running post-action listener: _resource_record_post_action 11:00:16 INFO - Running post-action listener: set_extra_try_arguments 11:00:16 INFO - [mozharness: 2016-12-21 19:00:16.934014Z] Finished download-and-extract step (success) 11:00:16 INFO - [mozharness: 2016-12-21 19:00:16.934245Z] Running populate-webroot step. 11:00:16 INFO - Running pre-action listener: _resource_record_pre_action 11:00:16 INFO - Running main action method: populate_webroot 11:00:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:16 INFO - '--tppagecycles', 11:00:16 INFO - '7'], 11:00:16 INFO - 'tests': ['tsvgm']}}, 11:00:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:00:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:00:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['damp', 'tps']}, 11:00:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'tests': ['damp', 'tps']}, 11:00:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['dromaeo_dom']}, 11:00:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['basic_compositor_video']}, 11:00:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:00:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['a11yr', 11:00:16 INFO - 'ts_paint', 11:00:16 INFO - 'tpaint', 11:00:16 INFO - 'sessionrestore', 11:00:16 INFO - 'sessionrestore_no_auto_restore', 11:00:16 INFO - 'tabpaint']}, 11:00:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['tsvgx', 11:00:16 INFO - 'tsvgr_opacity', 11:00:16 INFO - 'tart', 11:00:16 INFO - 'tscrollx', 11:00:16 INFO - 'cart']}, 11:00:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:00:16 INFO - 'tsvgr_opacity', 11:00:16 INFO - 'tart', 11:00:16 INFO - 'tscrollx', 11:00:16 INFO - 'cart']}, 11:00:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'talos_options': ['--disable-e10s'], 11:00:16 INFO - 'tests': ['tp5o']}, 11:00:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'tests': ['tp5o']}, 11:00:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'talos_options': ['--disable-e10s', 11:00:16 INFO - '--xperf_path', 11:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:16 INFO - 'tests': ['tp5n']}, 11:00:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:16 INFO - 'talos_options': ['--xperf_path', 11:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:16 INFO - 'tests': ['tp5n']}}, 11:00:16 INFO - 'talos.zip': {'path': '', 11:00:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:16 INFO - Running post-action listener: _resource_record_post_action 11:00:16 INFO - [mozharness: 2016-12-21 19:00:16.952231Z] Finished populate-webroot step (success) 11:00:16 INFO - [mozharness: 2016-12-21 19:00:16.952319Z] Running create-virtualenv step. 11:00:16 INFO - Running pre-action listener: _resource_record_pre_action 11:00:16 INFO - Running main action method: create_virtualenv 11:00:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:16 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 11:00:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:17 INFO - Using real prefix '/usr' 11:00:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:19 INFO - Installing pip.................done. 11:00:19 INFO - Return code: 0 11:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:00:19 INFO - Reading from file tmpfile_stdout 11:00:19 INFO - Output received: 11:00:19 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) 11:00:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:19 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')]} 11:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 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')]} 11:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:19 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 11:00:19 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 11:00:19 INFO - Using env: {'DISPLAY': ':0', 11:00:19 INFO - 'HOME': '/home/cltbld', 11:00:19 INFO - 'LANG': 'en_US.UTF-8', 11:00:19 INFO - 'LANGUAGE': 'en_US:en', 11:00:19 INFO - 'LOGNAME': 'cltbld', 11:00:19 INFO - 'MAIL': '/var/mail/cltbld', 11:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:19 INFO - 'MOZ_NO_REMOTE': '1', 11:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:19 INFO - 'NO_EM_RESTART': '1', 11:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:19 INFO - 'PWD': '/builds/slave/test', 11:00:19 INFO - 'SHELL': '/bin/bash', 11:00:19 INFO - 'SHLVL': '1', 11:00:19 INFO - 'TERM': 'linux', 11:00:19 INFO - 'TMOUT': '86400', 11:00:19 INFO - 'USER': 'cltbld', 11:00:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:19 INFO - '_': '/tools/buildbot/bin/python'} 11:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:19 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 11:00:19 INFO - Cleaning up... 11:00:19 INFO - Return code: 0 11:00:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:00:19 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')]} 11:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 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')]} 11:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:19 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:19 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 11:00:19 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 11:00:19 INFO - Using env: {'DISPLAY': ':0', 11:00:19 INFO - 'HOME': '/home/cltbld', 11:00:19 INFO - 'LANG': 'en_US.UTF-8', 11:00:19 INFO - 'LANGUAGE': 'en_US:en', 11:00:19 INFO - 'LOGNAME': 'cltbld', 11:00:19 INFO - 'MAIL': '/var/mail/cltbld', 11:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:19 INFO - 'MOZ_NO_REMOTE': '1', 11:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:19 INFO - 'NO_EM_RESTART': '1', 11:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:19 INFO - 'PWD': '/builds/slave/test', 11:00:19 INFO - 'SHELL': '/bin/bash', 11:00:19 INFO - 'SHLVL': '1', 11:00:19 INFO - 'TERM': 'linux', 11:00:19 INFO - 'TMOUT': '86400', 11:00:19 INFO - 'USER': 'cltbld', 11:00:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:19 INFO - '_': '/tools/buildbot/bin/python'} 11:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:20 INFO - Downloading/unpacking psutil>=3.1.1 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:22 INFO - Installing collected packages: psutil 11:00:22 INFO - Running setup.py install for psutil 11:00:22 INFO - building 'psutil._psutil_linux' extension 11:00:22 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 11:00:22 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 11:00:22 INFO - building 'psutil._psutil_posix' extension 11:00:22 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 11:00:22 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 11:00:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:22 INFO - Successfully installed psutil 11:00:22 INFO - Cleaning up... 11:00:22 INFO - Return code: 0 11:00:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:00:22 INFO - Using env: {'DISPLAY': ':0', 11:00:22 INFO - 'HOME': '/home/cltbld', 11:00:22 INFO - 'LANG': 'en_US.UTF-8', 11:00:22 INFO - 'LANGUAGE': 'en_US:en', 11:00:22 INFO - 'LOGNAME': 'cltbld', 11:00:22 INFO - 'MAIL': '/var/mail/cltbld', 11:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:22 INFO - 'MOZ_NO_REMOTE': '1', 11:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:22 INFO - 'NO_EM_RESTART': '1', 11:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:22 INFO - 'PWD': '/builds/slave/test', 11:00:22 INFO - 'SHELL': '/bin/bash', 11:00:22 INFO - 'SHLVL': '1', 11:00:22 INFO - 'TERM': 'linux', 11:00:22 INFO - 'TMOUT': '86400', 11:00:22 INFO - 'USER': 'cltbld', 11:00:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:22 INFO - '_': '/tools/buildbot/bin/python'} 11:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:00:25 INFO - Installing collected packages: mozsystemmonitor 11:00:25 INFO - Running setup.py install for mozsystemmonitor 11:00:25 INFO - Successfully installed mozsystemmonitor 11:00:25 INFO - Cleaning up... 11:00:25 INFO - Return code: 0 11:00:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:00:25 INFO - Using env: {'DISPLAY': ':0', 11:00:25 INFO - 'HOME': '/home/cltbld', 11:00:25 INFO - 'LANG': 'en_US.UTF-8', 11:00:25 INFO - 'LANGUAGE': 'en_US:en', 11:00:25 INFO - 'LOGNAME': 'cltbld', 11:00:25 INFO - 'MAIL': '/var/mail/cltbld', 11:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:25 INFO - 'MOZ_NO_REMOTE': '1', 11:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:25 INFO - 'NO_EM_RESTART': '1', 11:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:25 INFO - 'PWD': '/builds/slave/test', 11:00:25 INFO - 'SHELL': '/bin/bash', 11:00:25 INFO - 'SHLVL': '1', 11:00:25 INFO - 'TERM': 'linux', 11:00:25 INFO - 'TMOUT': '86400', 11:00:25 INFO - 'USER': 'cltbld', 11:00:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:25 INFO - '_': '/tools/buildbot/bin/python'} 11:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:00:27 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 11:00:27 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 11:00:27 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 11:00:27 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 11:00:27 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 11:00:27 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 11:00:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:27 INFO - warning: no files found matching '*.txt' 11:00:27 INFO - no previously-included directories found matching 'build' 11:00:27 INFO - no previously-included directories found matching 'dist' 11:00:27 INFO - no previously-included directories found matching '.git*' 11:00:27 INFO - Installing collected packages: jsonschema, functools32 11:00:27 INFO - Running setup.py install for functools32 11:00:27 INFO - warning: no files found matching '*.txt' 11:00:27 INFO - no previously-included directories found matching 'build' 11:00:27 INFO - no previously-included directories found matching 'dist' 11:00:27 INFO - no previously-included directories found matching '.git*' 11:00:27 INFO - Successfully installed jsonschema functools32 11:00:27 INFO - Cleaning up... 11:00:27 INFO - Return code: 0 11:00:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:00:27 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')]} 11:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:27 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')]} 11:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:27 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:27 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 11:00:27 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 11:00:27 INFO - Using env: {'DISPLAY': ':0', 11:00:27 INFO - 'HOME': '/home/cltbld', 11:00:27 INFO - 'LANG': 'en_US.UTF-8', 11:00:27 INFO - 'LANGUAGE': 'en_US:en', 11:00:27 INFO - 'LOGNAME': 'cltbld', 11:00:27 INFO - 'MAIL': '/var/mail/cltbld', 11:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:27 INFO - 'MOZ_NO_REMOTE': '1', 11:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:27 INFO - 'NO_EM_RESTART': '1', 11:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:27 INFO - 'PWD': '/builds/slave/test', 11:00:27 INFO - 'SHELL': '/bin/bash', 11:00:27 INFO - 'SHLVL': '1', 11:00:27 INFO - 'TERM': 'linux', 11:00:27 INFO - 'TMOUT': '86400', 11:00:27 INFO - 'USER': 'cltbld', 11:00:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:27 INFO - '_': '/tools/buildbot/bin/python'} 11:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:00:28 INFO - Cleaning up... 11:00:28 INFO - Return code: 0 11:00:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:00:28 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')]} 11:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:28 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')]} 11:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:28 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:28 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 11:00:28 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 11:00:28 INFO - Using env: {'DISPLAY': ':0', 11:00:28 INFO - 'HOME': '/home/cltbld', 11:00:28 INFO - 'LANG': 'en_US.UTF-8', 11:00:28 INFO - 'LANGUAGE': 'en_US:en', 11:00:28 INFO - 'LOGNAME': 'cltbld', 11:00:28 INFO - 'MAIL': '/var/mail/cltbld', 11:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:28 INFO - 'MOZ_NO_REMOTE': '1', 11:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:28 INFO - 'NO_EM_RESTART': '1', 11:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:28 INFO - 'PWD': '/builds/slave/test', 11:00:28 INFO - 'SHELL': '/bin/bash', 11:00:28 INFO - 'SHLVL': '1', 11:00:28 INFO - 'TERM': 'linux', 11:00:28 INFO - 'TMOUT': '86400', 11:00:28 INFO - 'USER': 'cltbld', 11:00:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:28 INFO - '_': '/tools/buildbot/bin/python'} 11:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:00:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:30 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 11:00:31 INFO - Downloading docopt-0.6.1.tar.gz 11:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:31 INFO - Running setup.py install for blobuploader 11:00:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:00:31 INFO - Running setup.py install for requests 11:00:31 INFO - Running setup.py install for docopt 11:00:31 INFO - Successfully installed blobuploader requests docopt 11:00:31 INFO - Cleaning up... 11:00:31 INFO - Return code: 0 11:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:31 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:31 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 11:00:31 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 11:00:31 INFO - Using env: {'DISPLAY': ':0', 11:00:31 INFO - 'HOME': '/home/cltbld', 11:00:31 INFO - 'LANG': 'en_US.UTF-8', 11:00:31 INFO - 'LANGUAGE': 'en_US:en', 11:00:31 INFO - 'LOGNAME': 'cltbld', 11:00:31 INFO - 'MAIL': '/var/mail/cltbld', 11:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:31 INFO - 'MOZ_NO_REMOTE': '1', 11:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:31 INFO - 'NO_EM_RESTART': '1', 11:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:31 INFO - 'PWD': '/builds/slave/test', 11:00:31 INFO - 'SHELL': '/bin/bash', 11:00:31 INFO - 'SHLVL': '1', 11:00:31 INFO - 'TERM': 'linux', 11:00:31 INFO - 'TMOUT': '86400', 11:00:31 INFO - 'USER': 'cltbld', 11:00:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:31 INFO - '_': '/tools/buildbot/bin/python'} 11:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:32 INFO - Running setup.py (path:/tmp/pip-vMpSEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:32 INFO - Running setup.py (path:/tmp/pip-sOLo3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:32 INFO - Running setup.py (path:/tmp/pip-7GL1d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:32 INFO - Running setup.py (path:/tmp/pip-UeafQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:32 INFO - Running setup.py (path:/tmp/pip-Pd8MGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:32 INFO - Running setup.py (path:/tmp/pip-begBw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:32 INFO - Running setup.py (path:/tmp/pip-UmLcNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:32 INFO - Running setup.py (path:/tmp/pip-9FBKQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:32 INFO - Running setup.py (path:/tmp/pip-nRGKsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:32 INFO - Running setup.py (path:/tmp/pip-5rtO6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:32 INFO - Running setup.py (path:/tmp/pip-S0xH6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:32 INFO - Running setup.py (path:/tmp/pip-53jVP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:32 INFO - Running setup.py (path:/tmp/pip-ntCGny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:32 INFO - Running setup.py (path:/tmp/pip-LYbc_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:33 INFO - Running setup.py (path:/tmp/pip-9Wo0v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:33 INFO - Running setup.py (path:/tmp/pip-XL49yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:33 INFO - Running setup.py (path:/tmp/pip-SjG9S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:33 INFO - Running setup.py install for manifestparser 11:00:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:00:33 INFO - Running setup.py install for mozcrash 11:00:33 INFO - Running setup.py install for mozdebug 11:00:33 INFO - Running setup.py install for mozdevice 11:00:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:00:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:00:33 INFO - Running setup.py install for mozfile 11:00:33 INFO - Running setup.py install for mozhttpd 11:00:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:00:33 INFO - Running setup.py install for mozinfo 11:00:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:00:33 INFO - Running setup.py install for mozInstall 11:00:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Running setup.py install for mozleak 11:00:34 INFO - Running setup.py install for mozlog 11:00:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Running setup.py install for moznetwork 11:00:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Running setup.py install for mozprocess 11:00:34 INFO - Running setup.py install for mozprofile 11:00:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Running setup.py install for mozrunner 11:00:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:00:34 INFO - Running setup.py install for mozscreenshot 11:00:34 INFO - Running setup.py install for moztest 11:00:34 INFO - Running setup.py install for mozversion 11:00:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:00:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:35 INFO - Cleaning up... 11:00:35 INFO - Return code: 0 11:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:35 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:35 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 11:00:35 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 11:00:35 INFO - Using env: {'DISPLAY': ':0', 11:00:35 INFO - 'HOME': '/home/cltbld', 11:00:35 INFO - 'LANG': 'en_US.UTF-8', 11:00:35 INFO - 'LANGUAGE': 'en_US:en', 11:00:35 INFO - 'LOGNAME': 'cltbld', 11:00:35 INFO - 'MAIL': '/var/mail/cltbld', 11:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:35 INFO - 'MOZ_NO_REMOTE': '1', 11:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:35 INFO - 'NO_EM_RESTART': '1', 11:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:35 INFO - 'PWD': '/builds/slave/test', 11:00:35 INFO - 'SHELL': '/bin/bash', 11:00:35 INFO - 'SHLVL': '1', 11:00:35 INFO - 'TERM': 'linux', 11:00:35 INFO - 'TMOUT': '86400', 11:00:35 INFO - 'USER': 'cltbld', 11:00:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:35 INFO - '_': '/tools/buildbot/bin/python'} 11:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:35 INFO - Running setup.py (path:/tmp/pip-_fZeUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:35 INFO - Running setup.py (path:/tmp/pip-yT6sOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:35 INFO - Running setup.py (path:/tmp/pip-1H4RnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:35 INFO - Running setup.py (path:/tmp/pip-n5NuKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:35 INFO - Running setup.py (path:/tmp/pip-wvZLWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:35 INFO - Running setup.py (path:/tmp/pip-kuLpVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:35 INFO - Running setup.py (path:/tmp/pip-lQuE2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:35 INFO - Running setup.py (path:/tmp/pip-12e5kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:35 INFO - Running setup.py (path:/tmp/pip-iEYafC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:35 INFO - Running setup.py (path:/tmp/pip-vJmJie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:35 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)) 11:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:35 INFO - Running setup.py (path:/tmp/pip-fihSdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:36 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)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:36 INFO - Running setup.py (path:/tmp/pip-UKdyIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:36 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)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:36 INFO - Running setup.py (path:/tmp/pip-LRID2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:36 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)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:36 INFO - Running setup.py (path:/tmp/pip-oDkzCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:36 INFO - Running setup.py (path:/tmp/pip-K_YKta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:36 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)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:36 INFO - Running setup.py (path:/tmp/pip-k6a6Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:36 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)) 11:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:36 INFO - Running setup.py (path:/tmp/pip-vJ8mNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:36 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)) 11:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:00:36 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)) 11:00:36 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)) 11:00:36 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)) 11:00:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:36 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 11:00:36 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 11:00:36 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 11:00:36 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 11:00:36 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 11:00:36 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 11:00:38 INFO - Downloading blessings-1.6.tar.gz 11:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:38 INFO - Installing collected packages: blessings 11:00:38 INFO - Running setup.py install for blessings 11:00:38 INFO - Successfully installed blessings 11:00:38 INFO - Cleaning up... 11:00:38 INFO - Return code: 0 11:00:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:38 INFO - Reading from file tmpfile_stdout 11:00:38 INFO - Current package versions: 11:00:38 INFO - argparse == 1.2.1 11:00:38 INFO - blessings == 1.6 11:00:38 INFO - blobuploader == 1.2.4 11:00:38 INFO - docopt == 0.6.1 11:00:38 INFO - functools32 == 3.2.3-2 11:00:38 INFO - jsonschema == 2.5.1 11:00:38 INFO - manifestparser == 1.1 11:00:38 INFO - mozInstall == 1.12 11:00:38 INFO - mozcrash == 1.0 11:00:38 INFO - mozdebug == 0.1 11:00:38 INFO - mozdevice == 0.48 11:00:38 INFO - mozfile == 1.2 11:00:38 INFO - mozhttpd == 0.7 11:00:38 INFO - mozinfo == 0.9 11:00:38 INFO - mozleak == 0.1 11:00:38 INFO - mozlog == 3.4 11:00:38 INFO - moznetwork == 0.27 11:00:38 INFO - mozprocess == 0.23 11:00:38 INFO - mozprofile == 0.28 11:00:38 INFO - mozrunner == 6.13 11:00:38 INFO - mozscreenshot == 0.1 11:00:38 INFO - mozsystemmonitor == 0.3 11:00:38 INFO - moztest == 0.7 11:00:38 INFO - mozversion == 1.4 11:00:38 INFO - psutil == 3.1.1 11:00:38 INFO - requests == 1.2.3 11:00:38 INFO - wsgiref == 0.1.2 11:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:38 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:38 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 11:00:38 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 11:00:38 INFO - Using env: {'DISPLAY': ':0', 11:00:38 INFO - 'HOME': '/home/cltbld', 11:00:38 INFO - 'LANG': 'en_US.UTF-8', 11:00:38 INFO - 'LANGUAGE': 'en_US:en', 11:00:38 INFO - 'LOGNAME': 'cltbld', 11:00:38 INFO - 'MAIL': '/var/mail/cltbld', 11:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:38 INFO - 'MOZ_NO_REMOTE': '1', 11:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:38 INFO - 'NO_EM_RESTART': '1', 11:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:38 INFO - 'PWD': '/builds/slave/test', 11:00:38 INFO - 'SHELL': '/bin/bash', 11:00:38 INFO - 'SHLVL': '1', 11:00:38 INFO - 'TERM': 'linux', 11:00:38 INFO - 'TMOUT': '86400', 11:00:38 INFO - 'USER': 'cltbld', 11:00:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:38 INFO - '_': '/tools/buildbot/bin/python'} 11:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 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)) 11:00:39 INFO - Cleaning up... 11:00:39 INFO - Return code: 0 11:00:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00:39 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')]} 11:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:39 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')]} 11:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:39 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 0x7f966b870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e13ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, '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': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', '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 11:00:39 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 11:00:39 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 11:00:39 INFO - Using env: {'DISPLAY': ':0', 11:00:39 INFO - 'HOME': '/home/cltbld', 11:00:39 INFO - 'LANG': 'en_US.UTF-8', 11:00:39 INFO - 'LANGUAGE': 'en_US:en', 11:00:39 INFO - 'LOGNAME': 'cltbld', 11:00:39 INFO - 'MAIL': '/var/mail/cltbld', 11:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:39 INFO - 'MOZ_NO_REMOTE': '1', 11:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:39 INFO - 'NO_EM_RESTART': '1', 11:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:39 INFO - 'PWD': '/builds/slave/test', 11:00:39 INFO - 'SHELL': '/bin/bash', 11:00:39 INFO - 'SHLVL': '1', 11:00:39 INFO - 'TERM': 'linux', 11:00:39 INFO - 'TMOUT': '86400', 11:00:39 INFO - 'USER': 'cltbld', 11:00:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:39 INFO - '_': '/tools/buildbot/bin/python'} 11:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:00:39 INFO - Cleaning up... 11:00:39 INFO - Return code: 0 11:00:39 INFO - Running post-action listener: _resource_record_post_action 11:00:39 INFO - Running post-action listener: _start_resource_monitoring 11:00:39 INFO - Starting resource monitoring. 11:00:39 INFO - [mozharness: 2016-12-21 19:00:39.470211Z] Finished create-virtualenv step (success) 11:00:39 INFO - [mozharness: 2016-12-21 19:00:39.470668Z] Running install step. 11:00:39 INFO - Running pre-action listener: _resource_record_pre_action 11:00:39 INFO - Running main action method: install 11:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:39 INFO - Reading from file tmpfile_stdout 11:00:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:39 INFO - Reading from file tmpfile_stdout 11:00:39 INFO - Output received: 11:00:39 INFO - Usage: mozinstall [options] installer 11:00:39 INFO - Options: 11:00:39 INFO - -h, --help show this help message and exit 11:00:39 INFO - -d DEST, --destination=DEST 11:00:39 INFO - Directory to install application into. [default: 11:00:39 INFO - "/builds/slave/test"] 11:00:39 INFO - --app=APP Application being installed. [default: firefox] 11:00:39 INFO - mkdir: /builds/slave/test/build/application 11:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:00:55 INFO - Reading from file tmpfile_stdout 11:00:55 INFO - Output received: 11:00:55 INFO - /builds/slave/test/build/application/firefox/firefox 11:00:55 INFO - Running post-action listener: _resource_record_post_action 11:00:55 INFO - [mozharness: 2016-12-21 19:00:55.677258Z] Finished install step (success) 11:00:55 INFO - [mozharness: 2016-12-21 19:00:55.677561Z] Running run-tests step. 11:00:55 INFO - Running pre-action listener: _resource_record_pre_action 11:00:55 INFO - Running main action method: run_tests 11:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:55 INFO - Python 2.7.3 11:00:55 INFO - Return code: 0 11:00:55 INFO - grabbing minidump binary from tooltool 11:00:55 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')]} 11:00:55 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 0x1e10f60>, '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 0x1e11d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e121d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:55 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 11:00:55 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 11:00:55 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 11:00:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:55 INFO - Return code: 0 11:00:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:00:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:00:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:00:55 INFO - Using env: {'DISPLAY': ':0', 11:00:55 INFO - 'HOME': '/home/cltbld', 11:00:55 INFO - 'LANG': 'en_US.UTF-8', 11:00:55 INFO - 'LANGUAGE': 'en_US:en', 11:00:55 INFO - 'LOGNAME': 'cltbld', 11:00:55 INFO - 'MAIL': '/var/mail/cltbld', 11:00:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:55 INFO - 'MOZ_NO_REMOTE': '1', 11:00:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:55 INFO - 'NO_EM_RESTART': '1', 11:00:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:55 INFO - 'PWD': '/builds/slave/test', 11:00:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:55 INFO - 'SHELL': '/bin/bash', 11:00:55 INFO - 'SHLVL': '1', 11:00:55 INFO - 'TERM': 'linux', 11:00:55 INFO - 'TMOUT': '86400', 11:00:55 INFO - 'USER': 'cltbld', 11:00:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600', 11:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:55 INFO - '_': '/tools/buildbot/bin/python'} 11:00:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:00:55 INFO - mozversion application_buildid: 20161221092053 11:00:55 INFO - mozversion application_changeset: c3f401e19160ed979541940f21ff70a111cc5972 11:00:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:00:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:55 INFO - mozversion application_name: Firefox 11:00:55 INFO - mozversion application_remotingname: firefox-dev 11:00:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:00:55 INFO - mozversion application_vendor: Mozilla 11:00:55 INFO - mozversion application_version: 52.0a2 11:00:55 INFO - mozversion platform_buildid: 20161221092053 11:00:55 INFO - mozversion platform_changeset: c3f401e19160ed979541940f21ff70a111cc5972 11:00:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:00:55 INFO - mozversion platform_version: 52.0a2 11:00:55 INFO - using testdate: 1482346855 11:00:55 INFO - actual date: 1482346855 11:00:55 INFO - starting webserver on 'localhost:51789' 11:00:55 INFO - SUITE-START | Running 2 tests 11:00:55 INFO - TEST-START | dromaeo_css 11:00:55 INFO - operating with platform_type : linux_ 11:00:55 INFO - Initialising browser for dromaeo_css test... 11:00:55 INFO - TEST-INFO | started process 26230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlHa4y/profile http://localhost:51789/getInfo.html) 11:01:00 INFO - PROCESS | 26230 | __metrics Screen width/height:1600/1200 11:01:00 INFO - PROCESS | 26230 | colorDepth:24 11:01:00 INFO - PROCESS | 26230 | Browser inner width/height: 1024/697 11:01:00 INFO - PROCESS | 26230 | __metrics 11:01:00 ERROR - PROCESS | 26230 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 11:01:01 INFO - TEST-INFO | 26230: exit 0 11:01:01 INFO - Browser initialized. 11:01:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:01 INFO - TEST-INFO | started process 26362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlHa4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:13 INFO - PROCESS | 26362 | RSS: Main: 152121344 11:01:13 INFO - PROCESS | 26362 | 11:02:02 INFO - PROCESS | 26362 | 1482346922943 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] 11:04:13 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51789/tests/dromaeo/cssquery-ext.html) 11:04:15 INFO - PROCESS | 26362 | RSS: Main: 156741632 11:04:15 INFO - PROCESS | 26362 | 11:07:17 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-ext.html (next: http://localhost:51789/tests/dromaeo/cssquery-jquery.html) 11:07:17 INFO - PROCESS | 26362 | RSS: Main: 153317376 11:07:17 INFO - PROCESS | 26362 | 11:10:19 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51789/tests/dromaeo/cssquery-mootools.html) 11:10:20 INFO - PROCESS | 26362 | RSS: Main: 153108480 11:10:20 INFO - PROCESS | 26362 | 11:13:21 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51789/tests/dromaeo/cssquery-prototype.html) 11:13:22 INFO - PROCESS | 26362 | RSS: Main: 152006656 11:13:22 INFO - PROCESS | 26362 | 11:16:25 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51789/tests/dromaeo/cssquery-yui.html) 11:16:25 INFO - PROCESS | 26362 | RSS: Main: 154632192 11:16:25 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | Cycle 1(1): loaded http://localhost:51789/tests/dromaeo/cssquery-yui.html (next: http://localhost:51789/tests/dromaeo/cssquery-dojo.html) 11:19:28 INFO - PROCESS | 26362 | RSS: Main: 155480064 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | __start_tp_report 11:19:28 INFO - PROCESS | 26362 | _x_x_mozilla_page_load 11:19:28 INFO - PROCESS | 26362 | _x_x_mozilla_page_load_details 11:19:28 INFO - PROCESS | 26362 | |i|pagename|runs| 11:19:28 INFO - PROCESS | 26362 | |0;dojo.html;3262.706356427921;3283.835808209589;3292.3579901919134;3304.60344758629;3323.219043524772;5651.265335506384;5659.377468478469;5692.686902220376;5702.087665973445;5710.257666503359;5563.109902415615;5618.2415373924505;5630.577706671996;5637.126245431965;5640.294963129609;5022.974885125569;5104.412992505872;5142.665726727751;5145.81989630363;5159.14874045782;5160.845174644748;5182.689038657692;5188.896222075557;5192.117340052181;5198.92201616976;5047.369078865142;5047.848564543051;5176.0683077046115;5179.611529135311;5208.5051920067535;5106.591472682195;5164.1995490699;5182.119039763249;5215.556677682402;5232.39827419844;5170.991656626959;5190.221466779975;5203.349581302337;5203.713795741232;5276.050310944029;5702.7433765480655;5747.626404283708;5806.535477161817;5822.854428639318;5837.328707198684;5997.830423067504;6006.459418652343;6031.125486804389;6072.817815465543;6077.817665470043;6068.817935461943;6088.269407671063;6092.299385570672;6110.419510146529;6117.296510901258;5490.560755139659;5535.667859928417;5711.828645140652;5726.169705392695;5727.169560413717;6041.939580604226;6056.727447264883;6064.4541991221;6077.969610151921;6078.665673388006;5798.623089499169;5858.648481091063;5859.912101318484;5862.237909071879;5863.442972917566;5929.229200204032;5938.317093534212;5941.524678025748;5948.196993405922;5953.166556682068;5854.4730974212525;5915.940840591539;5920.703964801743;6001.759929602855;6059.1820104286235;6119.228375855631;6129.08063790435;6134.742747059107;6141.792871882685;6144.047672610753;4690.038542098861;4704.5765881070865;4710.458297295855;4732.95267047332;4748.430188377348;4123.113530590937;4155.355919832431;4204.07510347723;4230.386593943923;4255.76593287366;5732.6847023413275;5824.504917082096;5854.443827836349;5857.179994800731;5938.732757025944;6168.784092556829;6185.195924529782;6206.937930620636;6207.81376558704;6211.16149319845;5638.069718496484;5691.971540142273;5761.107028410603;5816.127580862904;5822.737976791054;5308.071087559739;5309.150535914235;5315.840524784263;5331.493508116722;5332.493413125747;6396.968015159988;6399.7440102395385;6414.9679251604375;6418.422341989243;6421.678916054178;5871;5951.047832346804;6109.327973922776;6114.847128821815;6132.5707200495535;6353.491720662243;6367.808965731036;6373.58571692857;6379;6462.935370646233;6020.488258497901;6027.819165425044;6088.025915853442;6102.328743838086;6117.480014198843;5987.161797348288;6056.06131049688;6092.573519853745;6229.595076320024;6233.283172435046;5972.910406343822;6022.488088512526;6060.363661815622;6067.453929146398;6079.452849243589;6020.90968635462;6028.788992385245;6041.909371359521;6051.0923361496125;6055.485283750754;5623.959567480029;5711.600187986801;5961.314448838266;5989.861926234002;5994.88010239784;5907.261592300963;5952.613080149777;5952.851178720567;5958.940410596012;5980.581359304807;5825.417458254141;5830.300363956352;5830.416958304136;5838.095095260242;5850.063989761617 11:19:28 INFO - PROCESS | 26362 | |1;ext.html;574.2964868036655;607.696151924038;615.8799034188332;658.9769358072468;679.0730652659122;43275.350869736976;44103.338449923234;44480.332795008064;48603.51396486034;48684.513154868444;45840;45928.54071459285;46127.53872461274;46294.53705462944;46399.536004639944;8715.302775777955;8890.822183556325;8976.23701985332;8978.955105224464;8981.77545561363;8785.209331160195;8861.867071993925;8865.468071915706;8897.199252067312;8897.866532002025;8867.778305542348;8933.285337173043;8945.284377249804;8951.776205594879;8960.193582577567;8890.73327800167;8900.332475064364;8911.554422278892;8915.509646969447;8970.820583588356;8854.601542930584;8880.911190888137;8899.955500222522;8904.109589041109;8917.464952102895;43103.56896431058;43186.35220471695;43518.34722479165;43572.564274357166;43608.3458748119;3704.518412606371;3704.8888533344043;3754.0614846288427;3873.4964454621;3880.3209438348176;32951.17622059444;33077.6692233077;33402.331953360794;33612.15969600755;33685.83157084223;4086.080631857838;4144.979275103636;4164;4202.831886724527;4250.149970006011;365849;366065;367003;367461;368248.9999999973;66456.6677166611;66652.66673666601;67149.66425167843;67236.66381668061;67401;70231;70328.64835675892;70365.2963470369;70462;70753.64623176851;19344.61310773805;19373.32193373225;19560.804391956182;19593.70609440831;19598.510037248896;14883.10701357922;15057.17185554805;15117.848821511863;15196;15289.388424463119;19602.803971960384;20313.390598282076;20364.796352036585;20487.38537843867;20695.58608827815;7013.423154191297;7153.141623005273;7217.566945983152;7280.235575264627;7313.341799238094;973.352720440913;1093.4095588382183;1112.9054030407506;1135.642272684102;1152.4813833774667;33473;33755.83122084423;33937.83031084878;33943.66056339405;34000.659993400244;1112.1603189591806;1123.4944275076248;1176.8528933883265;1191.3804821492774;1225.6478531217115;17734.91132544329;17741.201645925965;17832.821671783116;17873.374431894823;17958.640827183644;545151;545477;547377;549659;552721;61808.38191618116;61824.381756181865;62194.378056219764;62295.68852155801;62505.374946250864;1409.8519655436237;1434.4262295081842;1445.2123592642035;1452.4117732318216;1458.1251249250365;32328;33853.32293354168;33914.49128263127;34490.310193795485;35910;60913;60938;61457.38542614695;61761;61781.69109154426;477950;481842;482216;482267;483416;45512.54487455083;47119;47340;48041;48731.269030965275;48457;48757.268640971124;49477.50522494873;51901.22148167705;52145;43671;43942.34086488641;44895.77552112349;45084.32373514334;46055.53944460647;44077.55922440863;45719.77140114278;45839.77080114578;46250.30624540567;46882.296765549225;44215.55784442114;44671.77664111659;44734.77632611946;44854.3271850916;45100;35774.642253577134;39449;40532.79733601313;40750;41167.588324116376;30607.234819128807;30956.845215773777;31139.37721245608;31260;31480.842595786875 11:19:28 INFO - PROCESS | 26362 | |2;jquery.html;419.4756554307116;427.4656679151061;430.2750060842054;438.46069334718294;439.6614606752801;18430.170642321093;18532.907335463322;20100;20188.69716954247;20294.391168264938;19321.420357389266;19326.13032413541;19560.706589401136;19851.404457866287;19869.3045743399;5505.697186654733;5807.883842323151;5827.621204621707;5836.328822185439;5839.503642190398;5544.334679838405;5721.628094173886;5731.914021289684;5754.568407369443;5808.825735227929;5714.71426428679;5724.914126288109;5746.367899531048;5748.137779333092;5763.827085187451;5522.199281104237;5677.659340439587;5701.287339082614;5726.055200891848;5744.19581258622;5127.9743601282125;5133.332666753298;5147.510986456281;5166.5866730661455;5168.5606723428555;22649.773502265096;23627.409314767097;23825;23835.284941451784;23917;2452.5217582571404;2455.4229756007326;2546.8344557603696;2625.5142798582324;2655.341443569036;14778;15116.773248401172;15210.011349262373;15320.463783767626;15756.369745210293;1946.980530194694;1965.557749506364;1976.6738488149438;2003.849711271646;2009.577988622391;84601;86539.56730216308;86568.13431865664;86750.13249867484;87987.56006219992;10887.455627218607;10948.671539853816;11023.669289921316;11321.660350189508;11370.886291136983;16136;16180.19099045043;16208.108554029406;16212.189390530426;16238.188090595422;8837.823243535222;8855.822883542292;8860.803791488195;9080.636774529077;9200.263978881807;8537;8653.610587523577;8687.391882568287;8885.600147993357;8891;6863.725450982005;6962.477814163958;6977.1278590176225;6981.82545436358;7091.652586008642;1933.9613207736047;2003.8797672139717;2047.1504325704964;2088.467440802616;2099.433153048699;944.1644144931785;992.6228033347281;1040.380973320888;1047.6490375724065;1089.84476454958;20420.38738837837;20693.375422683333;20801.06395212219;20987.475313117295;21084.262050828147;1084.159776173472;1099.6755956992706;1100.136392931561;1128.041165009735;1178.80549709297;10511.597465316801;11749.177557570887;11856.399386082769;11885.346305953082;11958.701032474257;457751;461591;468395;471591;471809;85139.5743021281;90713;93676.53161734284;93797.06202938019;96241.5187924056;1046.2467023742893;1091.6888686724246;1095.5782023920688;1101.6694991502518;1109.3343993603773;17570.38503652366;18401;18485.907570462063;18523.81476185221;18681.719774203128;32712.509312359856;44522.10955780801;44711;44991.55008449873;45901.31148032849;63064.684676576326;64081.67959160174;64541;64690;64907.67546162239;8739.781505462413;8752.47485150893;8766.956165219133;8882.111788821067;8930.821383572422;8537.573121343783;12444.315562644142;12657.81013284783;12912.16070955385;13514.59456216315;10768.730781730519;10835.51240194209;11006.889931100586;11022.44887755593;11113;11501.769964600493;11651.242669226473;11875.703107422383;12148.75702485963;12263.509459621871;11109.388983605979;11126;11154.88845111571;11408.657740267805;11668.183227174017;8969.10308969124;8978.37151399422;9047.773805654911;9098.863517047117;9349.532523373668;10685.19861010443;10964.232503724663;11019.504122314354;11084.113270938144;11091.944540277247 11:19:28 INFO - PROCESS | 26362 | |3;mootools.html;1470.1546610698847;1487.4273404739176;1612.5001249612615;1759.7536344911723;1785.7410675452052;7647.197044310351;7855.685772569091;8300.792480187998;8860.424072435288;9002.234810041138;8249.835003299946;8511.27654149398;8512.361572882028;8671.479711217331;8740.694075707352;2460.4095017195878;2488.8382255153447;2507.69907611086;2510.3598582361565;2511.5307545086057;2463.7782599566035;2500.299916023507;2501.8999240030375;2509;2516.937076573091;2360.716713994323;2380.1669415704537;2409.9036038558525;2413.8431001984814;2417.8549287042747;2424.4423782530116;2424.6363045543135;2427.6965379327494;2452.766987136219;2477.900883964648;2461.4707837814954;2477.417806815397;2493.7007559093026;2504.111040580604;2507.7241503434607;8647.783805404852;8807.64769409223;8812.206901378842;8844.955775221082;8884.156005179497;5567.4432556744405;5644.4073372295725;5657.547396208334;5671.092625179993;5678.772849086032;3558.982205088984;3599;3660.7803531788177;3665.3952097903816;3682.502862113607;1269.447790211252;1272.821804947308;1287.9034072444604;1314.7436249931268;1331.4407948661585;12248.571300004458;12285.262884226975;12334.938325308316;12345.629631111082;12394.876051239462;4896.3389942358035;4967.2549117631925;4981.078500477423;4998.600111991032;5053.722045287471;10457;10494.68515944523;10515.316504427341;10581.047705706524;10593.84109238362;5587.469190426903;5608.971955140199;5619.578531610146;5643.1535269709875;5657.519110875622;4417.933730994037;5139.974300128475;5157.200633901676;5180.611454140954;5271.551918087006;4162.250794856895;4162.4796900387455;4173.5409104998425;4245.469316335458;4303.096349766522;1406.3249640172774;1418.5673369622157;1426.1656930695451;1430.2705620133806;1439.6976634906578;980.6861804222581;983.8425851863667;984.3355734878928;992.6228033347426;1007.6019972110975;6097;6099.4205550473525;6180.227471566054;6187.876242475125;6214.533909956771;957.1911734584265;967.7919247361851;1010.0808264479289;1010.4543546484816;1031.5512751952924;4210.642095421862;4342.848000319974;4353.085851971058;4373.431453910971;4422.5356337584735;10581.206409519316;10900.34597924127;10938.453077346101;10946.945265273782;10948.835767463494;10720.785584288271;10836.837447438294;10849.511771970281;10897.073748731447;10899.891001090045;7853.293203611703;8146.714864979697;8185.508869467851;8394.286485648789;8395.874061889077;5773.16289138081;6093.847653808691;6151.507879369729;6168.814935551941;6423.29343772194;9955.552000159865;10034.09693127622;10074.244431667801;10081.949590252001;10241.027102425258;10137.138343240907;10150;10245.897541024793;10295.588176472857;10384.896151038694;6974.407175390149;7066.735282214783;7579.128400233823;7921.405894557816;8051.798705032421;8572.657093716181;8608.311335093304;8654.004789449295;8654.567271636519;8688.044315125457;7740.612969351622;7746.109197442141;7852.803679908048;7858.5677787722225;7919.762407127795;7724.7682569523;7769.145394006768;7774.883376749466;7782.5330480169105;7900.802479938047;7289.453291003302;7346.742863999734;7347.889781653386;7358.822588385832;7381.224971378143;5077.796888124433;5135.486451354835;5204.479552044917;5208.192730126836;5278.023565640369;5147.562457191031;5170.793168273227;5221;5231.006108839309;5248.9737551312 11:19:28 INFO - PROCESS | 26362 | |4;prototype.html;356.6772071275495;365.404390842926;372.7595700773;375.72759749181847;376.61020843427025;5532.529734972532;5586.966411213928;5685.545156387484;5694.572907031974;5757.827265182052;5559;5619.550435965123;5620.4660557247;5631.465010823976;5641.68970706611;4426.513083560806;4443.333499974998;4446.7554284514335;4448.933266001012;4455.175792478386;4289.6353809926195;4389.47326320842;4393.406890069831;4450.933236001462;4458;4369.300911854088;4373.759443230621;4381.474223093217;4383.430154079981;4390.846320378788;4359.738415695053;4361.454818147731;4385.846495372647;4387.934180987288;4402.339649052636;3612.837422316002;3897.8635747748976;3897.941530877039;3905.33609286422;3908.687305015592;5438.8912221755345;5453.23654688344;5455.618106732531;5477.233187353773;5483.698396588186;5018.749062546858;5033.3389981306445;5052.949470505321;5056.140456122468;5061.417936937262;5649.519790817785;5856.502197313233;5874.853128671774;5904.704764761787;5920.141579470996;4289.463817022872;4294.9785251073545;4313.28830742927;4316.870493885189;4323.589259020419;6070.757169713206;6100.298465676459;6107.541934354941;6116.299638718556;6129.356417576135;4225.3873188387515;4353.1293741251875;4380.430544029319;4385.539518350591;4402.757848318309;4442.555744425532;4444.355568442557;4447.73313601185;4449.13241917823;4460.531644177379;5015.24771284303;5025.170846810235;5030.89938201234;5031.119554078022;5038.261799679105;5709.771609135588;5835.562332825055;5875.706214689334;5917.911231331534;5917.928724946234;1472.8674419302315;1475.3729664892378;1494.4395851555666;1498.7452133137392;1504.9097054176784;1008.9445080520642;1031.9484025798681;1033.194108595297;1045.2630895218851;1051.7896420715736;5429.968306021843;5477.890442191134;5484.314460692413;5505.229267902497;5549.640338117187;5811.418858114239;5831.3877042910735;5846.210761547221;5892.263467066617;5897.911531327033;5388.245645609618;5498.780048798003;5544.390117087117;5748.2180524037685;5750.2237197978575;3109.3159504908886;3128.3899639570063;3134.3887941851576;3136.184592006049;3158;6036.758529658852;6189.288231853305;6196.442320191204;6197.349278325711;6204.906926396107;6099.603525770811;6144.846378840565;6179.393357727024;6189.195404597373;6227.408396202353;6303.470056768225;6344.511997122456;6354.934646239991;6356.66510032889;6375.075614036032;5984.546336002219;6005.3694362091355;6097.756089756537;6109.725062372293;6110.022396416552;5993.460588547052;6048.667323297261;6049.758009679564;6050.122732203894;6050.364711705208;6132.9386706134155;6256.593321434092;6283.7800676976085;6347.650879201504;6348.619082855043;4348.195583817004;4368.322909948963;4369.650427965692;4407.713498622579;4424.7123936944;5932.644041357532;6110.480609148272;6113.847153821012;6119.204503414528;6122.755089796537;5928.213739542408;5928.258967629046;5929.495992840484;5943.791967281124;5974.803480138279;5933.940660593339;5945.940540594539;5979.4917432018765;5987.580869339278;6021.578489505692;5743.10981797822;5866.472017518444;5867.794627188028;5870.735816888165;5906.86935923961;5932.13983972313;5968.731407086779;5969.253843269591;5987.97607208357;6009.789657361971;5670.257033069981;5858.209141765807;5859.619124756877;5874.148248503858;5892.585779412996 11:19:28 INFO - PROCESS | 26362 | |5;yui.html;771.4599780153894;796.2077732656008;807.9676812927487;812.5368539932239;857.2627540315332;13315.267660278681;13397.263150526716;13444.126131801451;13471.461141554351;13479.730405391898;14645;14707.705845883103;14978.325975331109;14990.625234369147;15028.6994260115;820.1880138662741;838.7819167016559;854.150120629971;857.6697971281039;862.3877047296427;864.5979619476942;867.3148212911792;870.8171284030361;871.6687658689689;874.8556488179474;904.5477261369315;912.0605776050678;912.6075787411411;914.0630853375277;914.2457472585111;905.6649039855263;909.4725059465494;910.9453432793987;913.3195769151957;913.5751875377981;658.3449467779542;661.190042198308;661.2362721057186;662.4005275225928;664.0968283134932;15077.321520531603;15111.622209444851;15147.54557363281;15161.848381516264;15173;14265.928670356685;14886.851131488655;14889.553313400615;15073.170975596338;15130.86518511116;11556.53773849045;11559.133065020158;11567.421628918604;11622.767544649145;11788.882111178864;3815.7138214634015;3887.3197190491833;3905.1799122184375;3944.1322908959983;3949.9605003949882;52079.47920520822;67294.3270567293;67629;67675.3232467674;68871;10573.312734672376;10883.346999180074;10905.999999999842;10944.890551094546;11119.888801111885;20045.298414555422;20193.697094543593;20871.478213044797;21095.789042109383;21123.894380528305;7751.806204844924;7948.483348582324;8141.918580814235;8277.172282771675;8293.33653307734;4628.514006029319;4764.404449443819;4859.07677541266;4905.55849973497;4924.285978533093;3498.8075655839175;3609.1698909251018;3945.2504024235304;4107.466029416157;4125.360569111733;693.7918624412656;694.121935751275;702.3117345001926;705.7106586299695;712.8574285142992;658.8912829383194;743.1453828097731;779.4621711019379;799.6681377228385;826.3430572694722;9907.306488545733;10185.439800811026;10201.795964080826;10260.897391026143;10342.224333175041;779.668640827646;799.3046049936477;809.7246936041774;818.2635627934907;821.4742564758559;5145.639805213674;5214.2508929193;5260;5274.287971123926;5296.947030529723;90979;92346;92585.53707231555;93677;95491;81659.18340816516;82580.76128858072;82890.17109828825;83030;84212.15787842165;71843.6407817968;73630;73967.63016184993;74056;74406;9883.604655813688;9930.801383972135;10202.744931376776;10242.692719218436;10272.075513203847;43433.565664342954;48616.2707559394;49005.26492102692;49125.50874491209;49515;59998.70000649969;64336.678316608115;66836;68857.3114268871;69243.30756692369;12172.2696638202;12324.198927069712;12393.504259829866;12461.314627695201;12497.812532812197;13234.536791212262;13278.336083195994;13282.734345312847;13285.535006274735;13460.46158153702;12908.741825163632;13016.414261358072;13099.410526526139;13206.867931320563;13217.471301147847;12341.616419698583;12455.875441245471;12840.55058072963;13158.60524184276;13198.07613467048;12682.175658582162;12984.935075324564;13195.670108246986;13261.80107298372;13460.798088028492;10587.20595955291;10592.523336450033;10745.409002504937;10770.946145269538;10858.619948301772;11032.227744057838;11079.5568177272;11181;11385.316880987168;11560 11:19:28 INFO - PROCESS | 26362 | __end_tp_report 11:19:28 INFO - PROCESS | 26362 | __start_cc_report 11:19:28 INFO - PROCESS | 26362 | _x_x_mozilla_cycle_collect,309 11:19:28 INFO - PROCESS | 26362 | __end_cc_report 11:19:28 INFO - PROCESS | 26362 | __startTimestamp1482347968280__endTimestamp 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | ------- Summary: start ------- 11:19:28 INFO - PROCESS | 26362 | Number of tests: 6 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#0] dojo.html Cycles:165 Average:5656.61 Median:5857.18 stddev:639.36 (10.9%) stddev-sans-first:613.12 11:19:28 INFO - PROCESS | 26362 | Values: 3262.7 3283.8 3292.4 3304.6 3323.2 5651.3 5659.4 5692.7 5702.1 5710.3 5563.1 5618.2 5630.6 5637.1 5640.3 5023.0 5104.4 5142.7 5145.8 5159.1 5160.8 5182.7 5188.9 5192.1 5198.9 5047.4 5047.8 5176.1 5179.6 5208.5 5106.6 5164.2 5182.1 5215.6 5232.4 5171.0 5190.2 5203.3 5203.7 5276.1 5702.7 5747.6 5806.5 5822.9 5837.3 5997.8 6006.5 6031.1 6072.8 6077.8 6068.8 6088.3 6092.3 6110.4 6117.3 5490.6 5535.7 5711.8 5726.2 5727.2 6041.9 6056.7 6064.5 6078.0 6078.7 5798.6 5858.6 5859.9 5862.2 5863.4 5929.2 5938.3 5941.5 5948.2 5953.2 5854.5 5915.9 5920.7 6001.8 6059.2 6119.2 6129.1 6134.7 6141.8 6144.0 4690.0 4704.6 4710.5 4733.0 4748.4 4123.1 4155.4 4204.1 4230.4 4255.8 5732.7 5824.5 5854.4 5857.2 5938.7 6168.8 6185.2 6206.9 6207.8 6211.2 5638.1 5692.0 5761.1 5816.1 5822.7 5308.1 5309.2 5315.8 5331.5 5332.5 6397.0 6399.7 6415.0 6418.4 6421.7 5871.0 5951.0 6109.3 6114.8 6132.6 6353.5 6367.8 6373.6 6379.0 6462.9 6020.5 6027.8 6088.0 6102.3 6117.5 5987.2 6056.1 6092.6 6229.6 6233.3 5972.9 6022.5 6060.4 6067.5 6079.5 6020.9 6028.8 6041.9 6051.1 6055.5 5624.0 5711.6 5961.3 5989.9 5994.9 5907.3 5952.6 5952.9 5958.9 5980.6 5825.4 5830.3 5830.4 5838.1 5850.1 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#1] ext.html Cycles:180 Average:64835.71 Median:45092.16 stddev:124779.43 (276.7%) stddev-sans-first:125036.19 11:19:28 INFO - PROCESS | 26362 | Values: 574.3 607.7 615.9 659.0 679.1 43275.4 44103.3 44480.3 48603.5 48684.5 45840.0 45928.5 46127.5 46294.5 46399.5 8715.3 8890.8 8976.2 8979.0 8981.8 8785.2 8861.9 8865.5 8897.2 8897.9 8867.8 8933.3 8945.3 8951.8 8960.2 8890.7 8900.3 8911.6 8915.5 8970.8 8854.6 8880.9 8900.0 8904.1 8917.5 43103.6 43186.4 43518.3 43572.6 43608.3 3704.5 3704.9 3754.1 3873.5 3880.3 32951.2 33077.7 33402.3 33612.2 33685.8 4086.1 4145.0 4164.0 4202.8 4250.1 365849.0 366065.0 367003.0 367461.0 368249.0 66456.7 66652.7 67149.7 67236.7 67401.0 70231.0 70328.6 70365.3 70462.0 70753.6 19344.6 19373.3 19560.8 19593.7 19598.5 14883.1 15057.2 15117.8 15196.0 15289.4 19602.8 20313.4 20364.8 20487.4 20695.6 7013.4 7153.1 7217.6 7280.2 7313.3 973.4 1093.4 1112.9 1135.6 1152.5 33473.0 33755.8 33937.8 33943.7 34000.7 1112.2 1123.5 1176.9 1191.4 1225.6 17734.9 17741.2 17832.8 17873.4 17958.6 545151.0 545477.0 547377.0 549659.0 552721.0 61808.4 61824.4 62194.4 62295.7 62505.4 1409.9 1434.4 1445.2 1452.4 1458.1 32328.0 33853.3 33914.5 34490.3 35910.0 60913.0 60938.0 61457.4 61761.0 61781.7 477950.0 481842.0 482216.0 482267.0 483416.0 45512.5 47119.0 47340.0 48041.0 48731.3 48457.0 48757.3 49477.5 51901.2 52145.0 43671.0 43942.3 44895.8 45084.3 46055.5 44077.6 45719.8 45839.8 46250.3 46882.3 44215.6 44671.8 44734.8 44854.3 45100.0 35774.6 39449.0 40532.8 40750.0 41167.6 30607.2 30956.8 31139.4 31260.0 31480.8 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#2] jquery.html Cycles:180 Average:29037.11 Median:23876.14 stddev:77133.81 (323.1%) stddev-sans-first:77320.27 11:19:28 INFO - PROCESS | 26362 | Values: 419.5 427.5 430.3 438.5 439.7 18430.2 18532.9 20100.0 20188.7 20294.4 19321.4 19326.1 19560.7 19851.4 19869.3 5505.7 5807.9 5827.6 5836.3 5839.5 5544.3 5721.6 5731.9 5754.6 5808.8 5714.7 5724.9 5746.4 5748.1 5763.8 5522.2 5677.7 5701.3 5726.1 5744.2 5128.0 5133.3 5147.5 5166.6 5168.6 22649.8 23627.4 23825.0 23835.3 23917.0 2452.5 2455.4 2546.8 2625.5 2655.3 14778.0 15116.8 15210.0 15320.5 15756.4 1947.0 1965.6 1976.7 2003.8 2009.6 84601.0 86539.6 86568.1 86750.1 87987.6 10887.5 10948.7 11023.7 11321.7 11370.9 16136.0 16180.2 16208.1 16212.2 16238.2 8837.8 8855.8 8860.8 9080.6 9200.3 8537.0 8653.6 8687.4 8885.6 8891.0 6863.7 6962.5 6977.1 6981.8 7091.7 1934.0 2003.9 2047.2 2088.5 2099.4 944.2 992.6 1040.4 1047.6 1089.8 20420.4 20693.4 20801.1 20987.5 21084.3 1084.2 1099.7 1100.1 1128.0 1178.8 10511.6 11749.2 11856.4 11885.3 11958.7 457751.0 461591.0 468395.0 471591.0 471809.0 85139.6 90713.0 93676.5 93797.1 96241.5 1046.2 1091.7 1095.6 1101.7 1109.3 17570.4 18401.0 18485.9 18523.8 18681.7 32712.5 44522.1 44711.0 44991.6 45901.3 63064.7 64081.7 64541.0 64690.0 64907.7 8739.8 8752.5 8767.0 8882.1 8930.8 8537.6 12444.3 12657.8 12912.2 13514.6 10768.7 10835.5 11006.9 11022.4 11113.0 11501.8 11651.2 11875.7 12148.8 12263.5 11109.4 11126.0 11154.9 11408.7 11668.2 8969.1 8978.4 9047.8 9098.9 9349.5 10685.2 10964.2 11019.5 11084.1 11091.9 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#3] mootools.html Cycles:180 Average:5906.30 Median:4974.17 stddev:3235.76 (65.1%) stddev-sans-first:3227.66 11:19:28 INFO - PROCESS | 26362 | Values: 1470.2 1487.4 1612.5 1759.8 1785.7 7647.2 7855.7 8300.8 8860.4 9002.2 8249.8 8511.3 8512.4 8671.5 8740.7 2460.4 2488.8 2507.7 2510.4 2511.5 2463.8 2500.3 2501.9 2509.0 2516.9 2360.7 2380.2 2409.9 2413.8 2417.9 2424.4 2424.6 2427.7 2452.8 2477.9 2461.5 2477.4 2493.7 2504.1 2507.7 8647.8 8807.6 8812.2 8845.0 8884.2 5567.4 5644.4 5657.5 5671.1 5678.8 3559.0 3599.0 3660.8 3665.4 3682.5 1269.4 1272.8 1287.9 1314.7 1331.4 12248.6 12285.3 12334.9 12345.6 12394.9 4896.3 4967.3 4981.1 4998.6 5053.7 10457.0 10494.7 10515.3 10581.0 10593.8 5587.5 5609.0 5619.6 5643.2 5657.5 4417.9 5140.0 5157.2 5180.6 5271.6 4162.3 4162.5 4173.5 4245.5 4303.1 1406.3 1418.6 1426.2 1430.3 1439.7 980.7 983.8 984.3 992.6 1007.6 6097.0 6099.4 6180.2 6187.9 6214.5 957.2 967.8 1010.1 1010.5 1031.6 4210.6 4342.8 4353.1 4373.4 4422.5 10581.2 10900.3 10938.5 10946.9 10948.8 10720.8 10836.8 10849.5 10897.1 10899.9 7853.3 8146.7 8185.5 8394.3 8395.9 5773.2 6093.8 6151.5 6168.8 6423.3 9955.6 10034.1 10074.2 10081.9 10241.0 10137.1 10150.0 10245.9 10295.6 10384.9 6974.4 7066.7 7579.1 7921.4 8051.8 8572.7 8608.3 8654.0 8654.6 8688.0 7740.6 7746.1 7852.8 7858.6 7919.8 7724.8 7769.1 7774.9 7782.5 7900.8 7289.5 7346.7 7347.9 7358.8 7381.2 5077.8 5135.5 5204.5 5208.2 5278.0 5147.6 5170.8 5221.0 5231.0 5249.0 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#4] prototype.html Cycles:180 Average:4977.58 Median:5603.26 stddev:1458.38 (26.0%) stddev-sans-first:1420.63 11:19:28 INFO - PROCESS | 26362 | Values: 356.7 365.4 372.8 375.7 376.6 5532.5 5587.0 5685.5 5694.6 5757.8 5559.0 5619.6 5620.5 5631.5 5641.7 4426.5 4443.3 4446.8 4448.9 4455.2 4289.6 4389.5 4393.4 4450.9 4458.0 4369.3 4373.8 4381.5 4383.4 4390.8 4359.7 4361.5 4385.8 4387.9 4402.3 3612.8 3897.9 3897.9 3905.3 3908.7 5438.9 5453.2 5455.6 5477.2 5483.7 5018.7 5033.3 5052.9 5056.1 5061.4 5649.5 5856.5 5874.9 5904.7 5920.1 4289.5 4295.0 4313.3 4316.9 4323.6 6070.8 6100.3 6107.5 6116.3 6129.4 4225.4 4353.1 4380.4 4385.5 4402.8 4442.6 4444.4 4447.7 4449.1 4460.5 5015.2 5025.2 5030.9 5031.1 5038.3 5709.8 5835.6 5875.7 5917.9 5917.9 1472.9 1475.4 1494.4 1498.7 1504.9 1008.9 1031.9 1033.2 1045.3 1051.8 5430.0 5477.9 5484.3 5505.2 5549.6 5811.4 5831.4 5846.2 5892.3 5897.9 5388.2 5498.8 5544.4 5748.2 5750.2 3109.3 3128.4 3134.4 3136.2 3158.0 6036.8 6189.3 6196.4 6197.3 6204.9 6099.6 6144.8 6179.4 6189.2 6227.4 6303.5 6344.5 6354.9 6356.7 6375.1 5984.5 6005.4 6097.8 6109.7 6110.0 5993.5 6048.7 6049.8 6050.1 6050.4 6132.9 6256.6 6283.8 6347.7 6348.6 4348.2 4368.3 4369.7 4407.7 4424.7 5932.6 6110.5 6113.8 6119.2 6122.8 5928.2 5928.3 5929.5 5943.8 5974.8 5933.9 5945.9 5979.5 5987.6 6021.6 5743.1 5866.5 5867.8 5870.7 5906.9 5932.1 5968.7 5969.3 5988.0 6009.8 5670.3 5858.2 5859.6 5874.1 5892.6 11:19:28 INFO - PROCESS | 26362 | 11:19:28 INFO - PROCESS | 26362 | [#5] yui.html Cycles:180 Average:18597.81 Median:26737.67 stddev:24977.17 (93.4%) stddev-sans-first:25011.37 11:19:28 INFO - PROCESS | 26362 | Values: 771.5 796.2 808.0 812.5 857.3 13315.3 13397.3 13444.1 13471.5 13479.7 14645.0 14707.7 14978.3 14990.6 15028.7 820.2 838.8 854.2 857.7 862.4 864.6 867.3 870.8 871.7 874.9 904.5 912.1 912.6 914.1 914.2 905.7 909.5 910.9 913.3 913.6 658.3 661.2 661.2 662.4 664.1 15077.3 15111.6 15147.5 15161.8 15173.0 14265.9 14886.9 14889.6 15073.2 15130.9 11556.5 11559.1 11567.4 11622.8 11788.9 3815.7 3887.3 3905.2 3944.1 3950.0 52079.5 67294.3 67629.0 67675.3 68871.0 10573.3 10883.3 10906.0 10944.9 11119.9 20045.3 20193.7 20871.5 21095.8 21123.9 7751.8 7948.5 8141.9 8277.2 8293.3 4628.5 4764.4 4859.1 4905.6 4924.3 3498.8 3609.2 3945.3 4107.5 4125.4 693.8 694.1 702.3 705.7 712.9 658.9 743.1 779.5 799.7 826.3 9907.3 10185.4 10201.8 10260.9 10342.2 779.7 799.3 809.7 818.3 821.5 5145.6 5214.3 5260.0 5274.3 5296.9 90979.0 92346.0 92585.5 93677.0 95491.0 81659.2 82580.8 82890.2 83030.0 84212.2 71843.6 73630.0 73967.6 74056.0 74406.0 9883.6 9930.8 10202.7 10242.7 10272.1 43433.6 48616.3 49005.3 49125.5 49515.0 59998.7 64336.7 66836.0 68857.3 69243.3 12172.3 12324.2 12393.5 12461.3 12497.8 13234.5 13278.3 13282.7 13285.5 13460.5 12908.7 13016.4 13099.4 13206.9 13217.5 12341.6 12455.9 12840.6 13158.6 13198.1 12682.2 12984.9 13195.7 13261.8 13460.8 10587.2 10592.5 10745.4 10770.9 10858.6 11032.2 11079.6 11181.0 11385.3 11560.0 11:19:28 INFO - PROCESS | 26362 | -------- Summary: end -------- 11:19:28 INFO - PROCESS | 26362 | 11:19:29 INFO - TEST-INFO | 26362: exit 0 11:19:29 INFO - TEST-OK | dromaeo_css | took 1113092ms 11:19:29 INFO - TEST-START | kraken 11:19:29 INFO - operating with platform_type : linux_ 11:19:29 INFO - Initialising browser for kraken test... 11:19:29 INFO - TEST-INFO | started process 26740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprDopnv/profile http://localhost:51789/getInfo.html) 11:19:33 INFO - PROCESS | 26740 | __metrics Screen width/height:1600/1200 11:19:33 INFO - PROCESS | 26740 | colorDepth:24 11:19:33 INFO - PROCESS | 26740 | Browser inner width/height: 1024/697 11:19:33 INFO - PROCESS | 26740 | __metrics 11:19:33 ERROR - PROCESS | 26740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 11:19:34 INFO - TEST-INFO | 26740: exit 0 11:19:34 INFO - Browser initialized. 11:19:34 INFO - Running cycle 1/1 for kraken test... 11:19:34 INFO - TEST-INFO | started process 26873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprDopnv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:46 INFO - PROCESS | 26873 | RSS: Main: 152006656 11:19:46 INFO - PROCESS | 26873 | 11:19:48 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51789/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:49 INFO - PROCESS | 26873 | RSS: Main: 157159424 11:19:49 INFO - PROCESS | 26873 | 11:19:52 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51789/tests/kraken/driver.html?testName=audio-dft) 11:19:52 INFO - PROCESS | 26873 | RSS: Main: 155283456 11:19:52 INFO - PROCESS | 26873 | 11:19:55 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51789/tests/kraken/driver.html?testName=audio-fft) 11:19:56 INFO - PROCESS | 26873 | RSS: Main: 155930624 11:19:56 INFO - PROCESS | 26873 | 11:19:58 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51789/tests/kraken/driver.html?testName=audio-oscillator) 11:19:59 INFO - PROCESS | 26873 | RSS: Main: 155979776 11:19:59 INFO - PROCESS | 26873 | 11:20:01 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:01 INFO - PROCESS | 26873 | RSS: Main: 155279360 11:20:01 INFO - PROCESS | 26873 | 11:20:04 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51789/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:05 INFO - PROCESS | 26873 | RSS: Main: 158564352 11:20:05 INFO - PROCESS | 26873 | 11:20:08 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51789/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:09 INFO - PROCESS | 26873 | RSS: Main: 158789632 11:20:09 INFO - PROCESS | 26873 | 11:20:12 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51789/tests/kraken/driver.html?testName=json-parse-financial) 11:20:12 INFO - PROCESS | 26873 | RSS: Main: 158781440 11:20:12 INFO - PROCESS | 26873 | 11:20:14 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:14 INFO - PROCESS | 26873 | RSS: Main: 157413376 11:20:14 INFO - PROCESS | 26873 | 11:20:16 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:17 INFO - PROCESS | 26873 | RSS: Main: 157691904 11:20:17 INFO - PROCESS | 26873 | 11:20:19 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:19 INFO - PROCESS | 26873 | RSS: Main: 157745152 11:20:19 INFO - PROCESS | 26873 | 11:20:22 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:23 INFO - PROCESS | 26873 | RSS: Main: 157548544 11:20:23 INFO - PROCESS | 26873 | 11:20:25 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:26 INFO - PROCESS | 26873 | RSS: Main: 158068736 11:20:26 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | Cycle 1(1): loaded http://localhost:51789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51789/tests/kraken/driver.html?testName=ai-astar) 11:20:28 INFO - PROCESS | 26873 | RSS: Main: 159571968 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | __start_tp_report 11:20:28 INFO - PROCESS | 26873 | _x_x_mozilla_page_load 11:20:28 INFO - PROCESS | 26873 | _x_x_mozilla_page_load_details 11:20:28 INFO - PROCESS | 26873 | |i|pagename|runs| 11:20:28 INFO - PROCESS | 26873 | |0;ai-astar;103;112;111;113;112;112;112;112;113;111 11:20:28 INFO - PROCESS | 26873 | |1;audio-beat-detection;144;123;122;159;123;120;119;119;146;121 11:20:28 INFO - PROCESS | 26873 | |2;audio-dft;162;161;163;165;162;162;162;160;163;160 11:20:28 INFO - PROCESS | 26873 | |3;audio-fft;74;75;76;111;75;76;77;77;114;76 11:20:28 INFO - PROCESS | 26873 | |4;audio-oscillator;80;81;113;81;81;81;95;82;82;119 11:20:28 INFO - PROCESS | 26873 | |5;imaging-gaussian-blur;117;119;118;118;117;118;117;118;119;117 11:20:28 INFO - PROCESS | 26873 | |6;imaging-darkroom;147;146;146;146;146;147;148;147;148;148 11:20:28 INFO - PROCESS | 26873 | |7;imaging-desaturate;86;86;85;84;84;85;89;85;85;85 11:20:28 INFO - PROCESS | 26873 | |8;json-parse-financial;51;52;51;51;52;51;51;55;52;50 11:20:28 INFO - PROCESS | 26873 | |9;json-stringify-tinderbox;60;61;59;60;59;60;60;60;60;59 11:20:28 INFO - PROCESS | 26873 | |10;stanford-crypto-aes;75;81;81;76;74;75;75;74;76;75 11:20:28 INFO - PROCESS | 26873 | |11;stanford-crypto-ccm;126;123;130;129;124;119;123;123;164;123 11:20:28 INFO - PROCESS | 26873 | |12;stanford-crypto-pbkdf2;153;161;155;150;153;157;153;150;153;157 11:20:28 INFO - PROCESS | 26873 | |13;stanford-crypto-sha256-iterative;64;61;65;63;64;63;62;62;65;64 11:20:28 INFO - PROCESS | 26873 | __end_tp_report 11:20:28 INFO - PROCESS | 26873 | __start_cc_report 11:20:28 INFO - PROCESS | 26873 | _x_x_mozilla_cycle_collect,811 11:20:28 INFO - PROCESS | 26873 | __end_cc_report 11:20:28 INFO - PROCESS | 26873 | __startTimestamp1482348028367__endTimestamp 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | ------- Summary: start ------- 11:20:28 INFO - PROCESS | 26873 | Number of tests: 14 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 11:20:28 INFO - PROCESS | 26873 | Values: 103.0 112.0 111.0 113.0 112.0 112.0 112.0 112.0 113.0 111.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:123.00 stddev:14.44 (11.7%) stddev-sans-first:14.34 11:20:28 INFO - PROCESS | 26873 | Values: 144.0 123.0 122.0 159.0 123.0 120.0 119.0 119.0 146.0 121.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 11:20:28 INFO - PROCESS | 26873 | Values: 162.0 161.0 163.0 165.0 162.0 162.0 162.0 160.0 163.0 160.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:15.54 (20.4%) stddev-sans-first:16.13 11:20:28 INFO - PROCESS | 26873 | Values: 74.0 75.0 76.0 111.0 75.0 76.0 77.0 77.0 114.0 76.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:81.00 stddev:14.70 (18.1%) stddev-sans-first:15.18 11:20:28 INFO - PROCESS | 26873 | Values: 80.0 81.0 113.0 81.0 81.0 81.0 95.0 82.0 82.0 119.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 11:20:28 INFO - PROCESS | 26873 | Values: 117.0 119.0 118.0 118.0 117.0 118.0 117.0 118.0 119.0 117.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 11:20:28 INFO - PROCESS | 26873 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 148.0 147.0 148.0 148.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 11:20:28 INFO - PROCESS | 26873 | Values: 86.0 86.0 85.0 84.0 84.0 85.0 89.0 85.0 85.0 85.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.35 (2.6%) stddev-sans-first:1.41 11:20:28 INFO - PROCESS | 26873 | Values: 51.0 52.0 51.0 51.0 52.0 51.0 51.0 55.0 52.0 50.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 11:20:28 INFO - PROCESS | 26873 | Values: 60.0 61.0 59.0 60.0 59.0 60.0 60.0 60.0 60.0 59.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.50 stddev:2.62 (3.5%) stddev-sans-first:2.74 11:20:28 INFO - PROCESS | 26873 | Values: 75.0 81.0 81.0 76.0 74.0 75.0 75.0 74.0 76.0 75.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:125.00 stddev:12.91 (10.3%) stddev-sans-first:13.67 11:20:28 INFO - PROCESS | 26873 | Values: 126.0 123.0 130.0 129.0 124.0 119.0 123.0 123.0 164.0 123.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:154.00 stddev:3.39 (2.2%) stddev-sans-first:3.57 11:20:28 INFO - PROCESS | 26873 | Values: 153.0 161.0 155.0 150.0 153.0 157.0 153.0 150.0 153.0 157.0 11:20:28 INFO - PROCESS | 26873 | 11:20:28 INFO - PROCESS | 26873 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.39 11:20:28 INFO - PROCESS | 26873 | Values: 64.0 61.0 65.0 63.0 64.0 63.0 62.0 62.0 65.0 64.0 11:20:28 INFO - PROCESS | 26873 | -------- Summary: end -------- 11:20:28 INFO - PROCESS | 26873 | 11:20:29 INFO - TEST-INFO | 26873: exit 0 11:20:29 INFO - TEST-OK | kraken | took 60358ms 11:20:29 INFO - SUITE-END | took 1173s 11:20:29 INFO - Completed test suite (00:19:33) 11:20:29 INFO - javascript benchmark 11:20:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7585.104191961162, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.706356427921, 3283.835808209589, 3292.3579901919134, 3304.60344758629, 3323.219043524772, 5651.265335506384, 5659.377468478469, 5692.686902220376, 5702.087665973445, 5710.257666503359, 5563.109902415615, 5618.2415373924505, 5630.577706671996, 5637.126245431965, 5640.294963129609, 5022.974885125569, 5104.412992505872, 5142.665726727751, 5145.81989630363, 5159.14874045782, 5160.845174644748, 5182.689038657692, 5188.896222075557, 5192.117340052181, 5198.92201616976, 5047.369078865142, 5047.848564543051, 5176.0683077046115, 5179.611529135311, 5208.5051920067535, 5106.591472682195, 5164.1995490699, 5182.119039763249, 5215.556677682402, 5232.39827419844, 5170.991656626959, 5190.221466779975, 5203.349581302337, 5203.713795741232, 5276.050310944029, 5702.7433765480655, 5747.626404283708, 5806.535477161817, 5822.854428639318, 5837.328707198684, 5997.830423067504, 6006.459418652343, 6031.125486804389, 6072.817815465543, 6077.817665470043, 6068.817935461943, 6088.269407671063, 6092.299385570672, 6110.419510146529, 6117.296510901258, 5490.560755139659, 5535.667859928417, 5711.828645140652, 5726.169705392695, 5727.169560413717, 6041.939580604226, 6056.727447264883, 6064.4541991221, 6077.969610151921, 6078.665673388006, 5798.623089499169, 5858.648481091063, 5859.912101318484, 5862.237909071879, 5863.442972917566, 5929.229200204032, 5938.317093534212, 5941.524678025748, 5948.196993405922, 5953.166556682068, 5854.4730974212525, 5915.940840591539, 5920.703964801743, 6001.759929602855, 6059.1820104286235, 6119.228375855631, 6129.08063790435, 6134.742747059107, 6141.792871882685, 6144.047672610753, 4690.038542098861, 4704.5765881070865, 4710.458297295855, 4732.95267047332, 4748.430188377348, 4123.113530590937, 4155.355919832431, 4204.07510347723, 4230.386593943923, 4255.76593287366, 5732.6847023413275, 5824.504917082096, 5854.443827836349, 5857.179994800731, 5938.732757025944, 6168.784092556829, 6185.195924529782, 6206.937930620636, 6207.81376558704, 6211.16149319845, 5638.069718496484, 5691.971540142273, 5761.107028410603, 5816.127580862904, 5822.737976791054, 5308.071087559739, 5309.150535914235, 5315.840524784263, 5331.493508116722, 5332.493413125747, 6396.968015159988, 6399.7440102395385, 6414.9679251604375, 6418.422341989243, 6421.678916054178, 5871.0, 5951.047832346804, 6109.327973922776, 6114.847128821815, 6132.5707200495535, 6353.491720662243, 6367.808965731036, 6373.58571692857, 6379.0, 6462.935370646233, 6020.488258497901, 6027.819165425044, 6088.025915853442, 6102.328743838086, 6117.480014198843, 5987.161797348288, 6056.06131049688, 6092.573519853745, 6229.595076320024, 6233.283172435046, 5972.910406343822, 6022.488088512526, 6060.363661815622, 6067.453929146398, 6079.452849243589, 6020.90968635462, 6028.788992385245, 6041.909371359521, 6051.0923361496125, 6055.485283750754, 5623.959567480029, 5711.600187986801, 5961.314448838266, 5989.861926234002, 5994.88010239784, 5907.261592300963, 5952.613080149777, 5952.851178720567, 5958.940410596012, 5980.581359304807, 5825.417458254141, 5830.300363956352, 5830.416958304136, 5838.095095260242, 5850.063989761617], "value": 5613.745373166134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2964868036655, 607.696151924038, 615.8799034188332, 658.9769358072468, 679.0730652659122, 43275.350869736976, 44103.338449923234, 44480.332795008064, 48603.51396486034, 48684.513154868444, 45840.0, 45928.54071459285, 46127.53872461274, 46294.53705462944, 46399.536004639944, 8715.302775777955, 8890.822183556325, 8976.23701985332, 8978.955105224464, 8981.77545561363, 8785.209331160195, 8861.867071993925, 8865.468071915706, 8897.199252067312, 8897.866532002025, 8867.778305542348, 8933.285337173043, 8945.284377249804, 8951.776205594879, 8960.193582577567, 8890.73327800167, 8900.332475064364, 8911.554422278892, 8915.509646969447, 8970.820583588356, 8854.601542930584, 8880.911190888137, 8899.955500222522, 8904.109589041109, 8917.464952102895, 43103.56896431058, 43186.35220471695, 43518.34722479165, 43572.564274357166, 43608.3458748119, 3704.518412606371, 3704.8888533344043, 3754.0614846288427, 3873.4964454621, 3880.3209438348176, 32951.17622059444, 33077.6692233077, 33402.331953360794, 33612.15969600755, 33685.83157084223, 4086.080631857838, 4144.979275103636, 4164.0, 4202.831886724527, 4250.149970006011, 365849.0, 366065.0, 367003.0, 367461.0, 368248.9999999973, 66456.6677166611, 66652.66673666601, 67149.66425167843, 67236.66381668061, 67401.0, 70231.0, 70328.64835675892, 70365.2963470369, 70462.0, 70753.64623176851, 19344.61310773805, 19373.32193373225, 19560.804391956182, 19593.70609440831, 19598.510037248896, 14883.10701357922, 15057.17185554805, 15117.848821511863, 15196.0, 15289.388424463119, 19602.803971960384, 20313.390598282076, 20364.796352036585, 20487.38537843867, 20695.58608827815, 7013.423154191297, 7153.141623005273, 7217.566945983152, 7280.235575264627, 7313.341799238094, 973.352720440913, 1093.4095588382183, 1112.9054030407506, 1135.642272684102, 1152.4813833774667, 33473.0, 33755.83122084423, 33937.83031084878, 33943.66056339405, 34000.659993400244, 1112.1603189591806, 1123.4944275076248, 1176.8528933883265, 1191.3804821492774, 1225.6478531217115, 17734.91132544329, 17741.201645925965, 17832.821671783116, 17873.374431894823, 17958.640827183644, 545151.0, 545477.0, 547377.0, 549659.0, 552721.0, 61808.38191618116, 61824.381756181865, 62194.378056219764, 62295.68852155801, 62505.374946250864, 1409.8519655436237, 1434.4262295081842, 1445.2123592642035, 1452.4117732318216, 1458.1251249250365, 32328.0, 33853.32293354168, 33914.49128263127, 34490.310193795485, 35910.0, 60913.0, 60938.0, 61457.38542614695, 61761.0, 61781.69109154426, 477950.0, 481842.0, 482216.0, 482267.0, 483416.0, 45512.54487455083, 47119.0, 47340.0, 48041.0, 48731.269030965275, 48457.0, 48757.268640971124, 49477.50522494873, 51901.22148167705, 52145.0, 43671.0, 43942.34086488641, 44895.77552112349, 45084.32373514334, 46055.53944460647, 44077.55922440863, 45719.77140114278, 45839.77080114578, 46250.30624540567, 46882.296765549225, 44215.55784442114, 44671.77664111659, 44734.77632611946, 44854.3271850916, 45100.0, 35774.642253577134, 39449.0, 40532.79733601313, 40750.0, 41167.588324116376, 30607.234819128807, 30956.845215773777, 31139.37721245608, 31260.0, 31480.842595786875], "value": 21694.053188950173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.4756554307116, 427.4656679151061, 430.2750060842054, 438.46069334718294, 439.6614606752801, 18430.170642321093, 18532.907335463322, 20100.0, 20188.69716954247, 20294.391168264938, 19321.420357389266, 19326.13032413541, 19560.706589401136, 19851.404457866287, 19869.3045743399, 5505.697186654733, 5807.883842323151, 5827.621204621707, 5836.328822185439, 5839.503642190398, 5544.334679838405, 5721.628094173886, 5731.914021289684, 5754.568407369443, 5808.825735227929, 5714.71426428679, 5724.914126288109, 5746.367899531048, 5748.137779333092, 5763.827085187451, 5522.199281104237, 5677.659340439587, 5701.287339082614, 5726.055200891848, 5744.19581258622, 5127.9743601282125, 5133.332666753298, 5147.510986456281, 5166.5866730661455, 5168.5606723428555, 22649.773502265096, 23627.409314767097, 23825.0, 23835.284941451784, 23917.0, 2452.5217582571404, 2455.4229756007326, 2546.8344557603696, 2625.5142798582324, 2655.341443569036, 14778.0, 15116.773248401172, 15210.011349262373, 15320.463783767626, 15756.369745210293, 1946.980530194694, 1965.557749506364, 1976.6738488149438, 2003.849711271646, 2009.577988622391, 84601.0, 86539.56730216308, 86568.13431865664, 86750.13249867484, 87987.56006219992, 10887.455627218607, 10948.671539853816, 11023.669289921316, 11321.660350189508, 11370.886291136983, 16136.0, 16180.19099045043, 16208.108554029406, 16212.189390530426, 16238.188090595422, 8837.823243535222, 8855.822883542292, 8860.803791488195, 9080.636774529077, 9200.263978881807, 8537.0, 8653.610587523577, 8687.391882568287, 8885.600147993357, 8891.0, 6863.725450982005, 6962.477814163958, 6977.1278590176225, 6981.82545436358, 7091.652586008642, 1933.9613207736047, 2003.8797672139717, 2047.1504325704964, 2088.467440802616, 2099.433153048699, 944.1644144931785, 992.6228033347281, 1040.380973320888, 1047.6490375724065, 1089.84476454958, 20420.38738837837, 20693.375422683333, 20801.06395212219, 20987.475313117295, 21084.262050828147, 1084.159776173472, 1099.6755956992706, 1100.136392931561, 1128.041165009735, 1178.80549709297, 10511.597465316801, 11749.177557570887, 11856.399386082769, 11885.346305953082, 11958.701032474257, 457751.0, 461591.0, 468395.0, 471591.0, 471809.0, 85139.5743021281, 90713.0, 93676.53161734284, 93797.06202938019, 96241.5187924056, 1046.2467023742893, 1091.6888686724246, 1095.5782023920688, 1101.6694991502518, 1109.3343993603773, 17570.38503652366, 18401.0, 18485.907570462063, 18523.81476185221, 18681.719774203128, 32712.509312359856, 44522.10955780801, 44711.0, 44991.55008449873, 45901.31148032849, 63064.684676576326, 64081.67959160174, 64541.0, 64690.0, 64907.67546162239, 8739.781505462413, 8752.47485150893, 8766.956165219133, 8882.111788821067, 8930.821383572422, 8537.573121343783, 12444.315562644142, 12657.81013284783, 12912.16070955385, 13514.59456216315, 10768.730781730519, 10835.51240194209, 11006.889931100586, 11022.44887755593, 11113.0, 11501.769964600493, 11651.242669226473, 11875.703107422383, 12148.75702485963, 12263.509459621871, 11109.388983605979, 11126.0, 11154.88845111571, 11408.657740267805, 11668.183227174017, 8969.10308969124, 8978.37151399422, 9047.773805654911, 9098.863517047117, 9349.532523373668, 10685.19861010443, 10964.232503724663, 11019.504122314354, 11084.113270938144, 11091.944540277247], "value": 9658.96518846877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.1546610698847, 1487.4273404739176, 1612.5001249612615, 1759.7536344911723, 1785.7410675452052, 7647.197044310351, 7855.685772569091, 8300.792480187998, 8860.424072435288, 9002.234810041138, 8249.835003299946, 8511.27654149398, 8512.361572882028, 8671.479711217331, 8740.694075707352, 2460.4095017195878, 2488.8382255153447, 2507.69907611086, 2510.3598582361565, 2511.5307545086057, 2463.7782599566035, 2500.299916023507, 2501.8999240030375, 2509.0, 2516.937076573091, 2360.716713994323, 2380.1669415704537, 2409.9036038558525, 2413.8431001984814, 2417.8549287042747, 2424.4423782530116, 2424.6363045543135, 2427.6965379327494, 2452.766987136219, 2477.900883964648, 2461.4707837814954, 2477.417806815397, 2493.7007559093026, 2504.111040580604, 2507.7241503434607, 8647.783805404852, 8807.64769409223, 8812.206901378842, 8844.955775221082, 8884.156005179497, 5567.4432556744405, 5644.4073372295725, 5657.547396208334, 5671.092625179993, 5678.772849086032, 3558.982205088984, 3599.0, 3660.7803531788177, 3665.3952097903816, 3682.502862113607, 1269.447790211252, 1272.821804947308, 1287.9034072444604, 1314.7436249931268, 1331.4407948661585, 12248.571300004458, 12285.262884226975, 12334.938325308316, 12345.629631111082, 12394.876051239462, 4896.3389942358035, 4967.2549117631925, 4981.078500477423, 4998.600111991032, 5053.722045287471, 10457.0, 10494.68515944523, 10515.316504427341, 10581.047705706524, 10593.84109238362, 5587.469190426903, 5608.971955140199, 5619.578531610146, 5643.1535269709875, 5657.519110875622, 4417.933730994037, 5139.974300128475, 5157.200633901676, 5180.611454140954, 5271.551918087006, 4162.250794856895, 4162.4796900387455, 4173.5409104998425, 4245.469316335458, 4303.096349766522, 1406.3249640172774, 1418.5673369622157, 1426.1656930695451, 1430.2705620133806, 1439.6976634906578, 980.6861804222581, 983.8425851863667, 984.3355734878928, 992.6228033347426, 1007.6019972110975, 6097.0, 6099.4205550473525, 6180.227471566054, 6187.876242475125, 6214.533909956771, 957.1911734584265, 967.7919247361851, 1010.0808264479289, 1010.4543546484816, 1031.5512751952924, 4210.642095421862, 4342.848000319974, 4353.085851971058, 4373.431453910971, 4422.5356337584735, 10581.206409519316, 10900.34597924127, 10938.453077346101, 10946.945265273782, 10948.835767463494, 10720.785584288271, 10836.837447438294, 10849.511771970281, 10897.073748731447, 10899.891001090045, 7853.293203611703, 8146.714864979697, 8185.508869467851, 8394.286485648789, 8395.874061889077, 5773.16289138081, 6093.847653808691, 6151.507879369729, 6168.814935551941, 6423.29343772194, 9955.552000159865, 10034.09693127622, 10074.244431667801, 10081.949590252001, 10241.027102425258, 10137.138343240907, 10150.0, 10245.897541024793, 10295.588176472857, 10384.896151038694, 6974.407175390149, 7066.735282214783, 7579.128400233823, 7921.405894557816, 8051.798705032421, 8572.657093716181, 8608.311335093304, 8654.004789449295, 8654.567271636519, 8688.044315125457, 7740.612969351622, 7746.109197442141, 7852.803679908048, 7858.5677787722225, 7919.762407127795, 7724.7682569523, 7769.145394006768, 7774.883376749466, 7782.5330480169105, 7900.802479938047, 7289.453291003302, 7346.742863999734, 7347.889781653386, 7358.822588385832, 7381.224971378143, 5077.796888124433, 5135.486451354835, 5204.479552044917, 5208.192730126836, 5278.023565640369, 5147.562457191031, 5170.793168273227, 5221.0, 5231.006108839309, 5248.9737551312], "value": 4801.616770960932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6772071275495, 365.404390842926, 372.7595700773, 375.72759749181847, 376.61020843427025, 5532.529734972532, 5586.966411213928, 5685.545156387484, 5694.572907031974, 5757.827265182052, 5559.0, 5619.550435965123, 5620.4660557247, 5631.465010823976, 5641.68970706611, 4426.513083560806, 4443.333499974998, 4446.7554284514335, 4448.933266001012, 4455.175792478386, 4289.6353809926195, 4389.47326320842, 4393.406890069831, 4450.933236001462, 4458.0, 4369.300911854088, 4373.759443230621, 4381.474223093217, 4383.430154079981, 4390.846320378788, 4359.738415695053, 4361.454818147731, 4385.846495372647, 4387.934180987288, 4402.339649052636, 3612.837422316002, 3897.8635747748976, 3897.941530877039, 3905.33609286422, 3908.687305015592, 5438.8912221755345, 5453.23654688344, 5455.618106732531, 5477.233187353773, 5483.698396588186, 5018.749062546858, 5033.3389981306445, 5052.949470505321, 5056.140456122468, 5061.417936937262, 5649.519790817785, 5856.502197313233, 5874.853128671774, 5904.704764761787, 5920.141579470996, 4289.463817022872, 4294.9785251073545, 4313.28830742927, 4316.870493885189, 4323.589259020419, 6070.757169713206, 6100.298465676459, 6107.541934354941, 6116.299638718556, 6129.356417576135, 4225.3873188387515, 4353.1293741251875, 4380.430544029319, 4385.539518350591, 4402.757848318309, 4442.555744425532, 4444.355568442557, 4447.73313601185, 4449.13241917823, 4460.531644177379, 5015.24771284303, 5025.170846810235, 5030.89938201234, 5031.119554078022, 5038.261799679105, 5709.771609135588, 5835.562332825055, 5875.706214689334, 5917.911231331534, 5917.928724946234, 1472.8674419302315, 1475.3729664892378, 1494.4395851555666, 1498.7452133137392, 1504.9097054176784, 1008.9445080520642, 1031.9484025798681, 1033.194108595297, 1045.2630895218851, 1051.7896420715736, 5429.968306021843, 5477.890442191134, 5484.314460692413, 5505.229267902497, 5549.640338117187, 5811.418858114239, 5831.3877042910735, 5846.210761547221, 5892.263467066617, 5897.911531327033, 5388.245645609618, 5498.780048798003, 5544.390117087117, 5748.2180524037685, 5750.2237197978575, 3109.3159504908886, 3128.3899639570063, 3134.3887941851576, 3136.184592006049, 3158.0, 6036.758529658852, 6189.288231853305, 6196.442320191204, 6197.349278325711, 6204.906926396107, 6099.603525770811, 6144.846378840565, 6179.393357727024, 6189.195404597373, 6227.408396202353, 6303.470056768225, 6344.511997122456, 6354.934646239991, 6356.66510032889, 6375.075614036032, 5984.546336002219, 6005.3694362091355, 6097.756089756537, 6109.725062372293, 6110.022396416552, 5993.460588547052, 6048.667323297261, 6049.758009679564, 6050.122732203894, 6050.364711705208, 6132.9386706134155, 6256.593321434092, 6283.7800676976085, 6347.650879201504, 6348.619082855043, 4348.195583817004, 4368.322909948963, 4369.650427965692, 4407.713498622579, 4424.7123936944, 5932.644041357532, 6110.480609148272, 6113.847153821012, 6119.204503414528, 6122.755089796537, 5928.213739542408, 5928.258967629046, 5929.495992840484, 5943.791967281124, 5974.803480138279, 5933.940660593339, 5945.940540594539, 5979.4917432018765, 5987.580869339278, 6021.578489505692, 5743.10981797822, 5866.472017518444, 5867.794627188028, 5870.735816888165, 5906.86935923961, 5932.13983972313, 5968.731407086779, 5969.253843269591, 5987.97607208357, 6009.789657361971, 5670.257033069981, 5858.209141765807, 5859.619124756877, 5874.148248503858, 5892.585779412996], "value": 4517.754314530287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.4599780153894, 796.2077732656008, 807.9676812927487, 812.5368539932239, 857.2627540315332, 13315.267660278681, 13397.263150526716, 13444.126131801451, 13471.461141554351, 13479.730405391898, 14645.0, 14707.705845883103, 14978.325975331109, 14990.625234369147, 15028.6994260115, 820.1880138662741, 838.7819167016559, 854.150120629971, 857.6697971281039, 862.3877047296427, 864.5979619476942, 867.3148212911792, 870.8171284030361, 871.6687658689689, 874.8556488179474, 904.5477261369315, 912.0605776050678, 912.6075787411411, 914.0630853375277, 914.2457472585111, 905.6649039855263, 909.4725059465494, 910.9453432793987, 913.3195769151957, 913.5751875377981, 658.3449467779542, 661.190042198308, 661.2362721057186, 662.4005275225928, 664.0968283134932, 15077.321520531603, 15111.622209444851, 15147.54557363281, 15161.848381516264, 15173.0, 14265.928670356685, 14886.851131488655, 14889.553313400615, 15073.170975596338, 15130.86518511116, 11556.53773849045, 11559.133065020158, 11567.421628918604, 11622.767544649145, 11788.882111178864, 3815.7138214634015, 3887.3197190491833, 3905.1799122184375, 3944.1322908959983, 3949.9605003949882, 52079.47920520822, 67294.3270567293, 67629.0, 67675.3232467674, 68871.0, 10573.312734672376, 10883.346999180074, 10905.999999999842, 10944.890551094546, 11119.888801111885, 20045.298414555422, 20193.697094543593, 20871.478213044797, 21095.789042109383, 21123.894380528305, 7751.806204844924, 7948.483348582324, 8141.918580814235, 8277.172282771675, 8293.33653307734, 4628.514006029319, 4764.404449443819, 4859.07677541266, 4905.55849973497, 4924.285978533093, 3498.8075655839175, 3609.1698909251018, 3945.2504024235304, 4107.466029416157, 4125.360569111733, 693.7918624412656, 694.121935751275, 702.3117345001926, 705.7106586299695, 712.8574285142992, 658.8912829383194, 743.1453828097731, 779.4621711019379, 799.6681377228385, 826.3430572694722, 9907.306488545733, 10185.439800811026, 10201.795964080826, 10260.897391026143, 10342.224333175041, 779.668640827646, 799.3046049936477, 809.7246936041774, 818.2635627934907, 821.4742564758559, 5145.639805213674, 5214.2508929193, 5260.0, 5274.287971123926, 5296.947030529723, 90979.0, 92346.0, 92585.53707231555, 93677.0, 95491.0, 81659.18340816516, 82580.76128858072, 82890.17109828825, 83030.0, 84212.15787842165, 71843.6407817968, 73630.0, 73967.63016184993, 74056.0, 74406.0, 9883.604655813688, 9930.801383972135, 10202.744931376776, 10242.692719218436, 10272.075513203847, 43433.565664342954, 48616.2707559394, 49005.26492102692, 49125.50874491209, 49515.0, 59998.70000649969, 64336.678316608115, 66836.0, 68857.3114268871, 69243.30756692369, 12172.2696638202, 12324.198927069712, 12393.504259829866, 12461.314627695201, 12497.812532812197, 13234.536791212262, 13278.336083195994, 13282.734345312847, 13285.535006274735, 13460.46158153702, 12908.741825163632, 13016.414261358072, 13099.410526526139, 13206.867931320563, 13217.471301147847, 12341.616419698583, 12455.875441245471, 12840.55058072963, 13158.60524184276, 13198.07613467048, 12682.175658582162, 12984.935075324564, 13195.670108246986, 13261.80107298372, 13460.798088028492, 10587.20595955291, 10592.523336450033, 10745.409002504937, 10770.946145269538, 10858.619948301772, 11032.227744057838, 11079.5568177272, 11181.0, 11385.316880987168, 11560.0], "value": 7462.624998531947, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 122.0, 159.0, 123.0, 120.0, 119.0, 119.0, 146.0, 121.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 165.0, 162.0, 162.0, 162.0, 160.0, 163.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 111.0, 75.0, 76.0, 77.0, 77.0, 114.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 113.0, 81.0, 81.0, 81.0, 95.0, 82.0, 82.0, 119.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 84.0, 85.0, 89.0, 85.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 51.0, 52.0, 51.0, 51.0, 55.0, 52.0, 50.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 81.0, 76.0, 74.0, 75.0, 75.0, 74.0, 76.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 130.0, 129.0, 124.0, 119.0, 123.0, 123.0, 164.0, 123.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 161.0, 155.0, 150.0, 153.0, 157.0, 153.0, 150.0, 153.0, 157.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 65.0, 63.0, 64.0, 63.0, 62.0, 62.0, 65.0, 64.0], "value": 63.3, "unit": "score"}]}]} 11:20:29 INFO - Return code: 0 11:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:20:29 ERROR - # TBPL SUCCESS # 11:20:29 INFO - Running post-action listener: _resource_record_post_action 11:20:29 INFO - [mozharness: 2016-12-21 19:20:29.665746Z] Finished run-tests step (success) 11:20:29 INFO - Running post-run listener: _resource_record_post_run 11:20:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367452160; Read time: 12; Write time: 285772 11:20:29 INFO - TinderboxPrint: CPU usage
13.3% 11:20:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:20:29 INFO - TinderboxPrint: I/O write bytes / time
367,452,160 / 285,772 11:20:29 INFO - TinderboxPrint: CPU idle
8,231.8 (86.7%) 11:20:29 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 11:20:29 INFO - TinderboxPrint: Swap in / out
0 / 0 11:20:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118616064; Read time: 0; Write time: 86512 11:20:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 248307712; Read time: 0; Write time: 199240 11:20:30 INFO - Running post-run listener: _upload_blobber_files 11:20:30 INFO - Blob upload gear active. 11:20:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:20:30 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 11:20:30 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:20:30 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:20:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:31 INFO - (blobuploader) - INFO - Done attempting. 11:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:35 INFO - (blobuploader) - INFO - Done attempting. 11:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:36 INFO - (blobuploader) - INFO - Done attempting. 11:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:36 INFO - Return code: 0 11:20:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00d9550d478edd5ad80c7c722fb8b522ca702873b18f8048c7c99c5207decc2c477551e1febc14a22286450fafc7721c44e4441e781ae84503fe9e8f4718f68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d9712c43b56a5a759b7fc2d6ebe603433fcb37f690a038d1f2b28c2a7185e2f12dcc74bfe5dae13df74734dd905d5fb368af9afc620a8a86636bfab0a591ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d6589ed2a76e3312852b65ad2065e5d275140ec108ab83fa7a46b8e7d9a482a525b15424e2def657ca10846624a400123a675582138ee7c9ead4cd376b401d"} 11:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:36 INFO - Contents: 11:20:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00d9550d478edd5ad80c7c722fb8b522ca702873b18f8048c7c99c5207decc2c477551e1febc14a22286450fafc7721c44e4441e781ae84503fe9e8f4718f68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d9712c43b56a5a759b7fc2d6ebe603433fcb37f690a038d1f2b28c2a7185e2f12dcc74bfe5dae13df74734dd905d5fb368af9afc620a8a86636bfab0a591ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d6589ed2a76e3312852b65ad2065e5d275140ec108ab83fa7a46b8e7d9a482a525b15424e2def657ca10846624a400123a675582138ee7c9ead4cd376b401d"} 11:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:36 INFO - Copying logs to upload dir... 11:20:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.928834 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-21 11:20:36.232507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 11:20:36.236399) ========= 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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00d9550d478edd5ad80c7c722fb8b522ca702873b18f8048c7c99c5207decc2c477551e1febc14a22286450fafc7721c44e4441e781ae84503fe9e8f4718f68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d9712c43b56a5a759b7fc2d6ebe603433fcb37f690a038d1f2b28c2a7185e2f12dcc74bfe5dae13df74734dd905d5fb368af9afc620a8a86636bfab0a591ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d6589ed2a76e3312852b65ad2065e5d275140ec108ab83fa7a46b8e7d9a482a525b15424e2def657ca10846624a400123a675582138ee7c9ead4cd376b401d"} build_url:https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/I2UxYkSLSeyjXMbVW_Kofw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00d9550d478edd5ad80c7c722fb8b522ca702873b18f8048c7c99c5207decc2c477551e1febc14a22286450fafc7721c44e4441e781ae84503fe9e8f4718f68f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d9712c43b56a5a759b7fc2d6ebe603433fcb37f690a038d1f2b28c2a7185e2f12dcc74bfe5dae13df74734dd905d5fb368af9afc620a8a86636bfab0a591ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05d6589ed2a76e3312852b65ad2065e5d275140ec108ab83fa7a46b8e7d9a482a525b15424e2def657ca10846624a400123a675582138ee7c9ead4cd376b401d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 11:20:36.261840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:20:36.262164) ========= 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=826874ccc97bd7bf541b4875000001d5-1482343621.135160-2089354600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 11:20:36.344970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 11:20:36.345282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 11:20:36.345638) ========= ========= Total master_lag: 0.16 =========