builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1485978027.27 results: success (0) buildid: 20170201095009 builduid: 5eccfe982b0344a7ae945cccfeb09d9a revision: 964388f3501946027b15ef9af6e6bca2f4096552 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.274212) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.274701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.275070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.291680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.292085) ========= 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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-01 11:40:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-02-01 11:40:28 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116021 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.421706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.422046) ========= 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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016675 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:27.472151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 11:40:27.472504) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 964388f3501946027b15ef9af6e6bca2f4096552 --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-beta --rev 964388f3501946027b15ef9af6e6bca2f4096552 --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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-01 11:40:28,212 truncating revision to first 12 chars 2017-02-01 11:40:28,212 Setting DEBUG logging. 2017-02-01 11:40:28,212 attempt 1/10 2017-02-01 11:40:28,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/964388f35019?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 11:40:29,024 unpacking tar archive at: mozilla-beta-964388f35019/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 11:40:28.611361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:28.611689) ========= script_repo_revision: 964388f3501946027b15ef9af6e6bca2f4096552 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:28.612075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:28.612333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 11:40:28.622808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-01 11:40:28.623231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:29 INFO - MultiFileLogger online at 20170201 11:40:29 in /builds/slave/test 11:40:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:40:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:29 INFO - {'append_to_log': False, 11:40:29 INFO - 'base_work_dir': '/builds/slave/test', 11:40:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:40:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:29 INFO - 'branch': 'Mozilla-Beta', 11:40:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:29 INFO - 'config_files': ('talos/linux_config.py',), 11:40:29 INFO - 'default_actions': ('clobber', 11:40:29 INFO - 'read-buildbot-config', 11:40:29 INFO - 'download-and-extract', 11:40:29 INFO - 'populate-webroot', 11:40:29 INFO - 'create-virtualenv', 11:40:29 INFO - 'install', 11:40:29 INFO - 'run-tests'), 11:40:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:29 INFO - 'download_minidump_stackwalk': True, 11:40:29 INFO - 'download_symbols': 'ondemand', 11:40:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:29 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:29 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:29 INFO - 'installer_path': 'installer.exe', 11:40:29 INFO - 'log_level': 'info', 11:40:29 INFO - 'log_name': 'talos', 11:40:29 INFO - 'log_to_console': True, 11:40:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:29 INFO - 'opt_config_files': (), 11:40:29 INFO - 'pip_index': False, 11:40:29 INFO - 'sps_profile': False, 11:40:29 INFO - 'sps_profile_interval': 0, 11:40:29 INFO - 'suite': 'dromaeojs', 11:40:29 INFO - 'system_bits': '32', 11:40:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:29 INFO - 'title': 'talos-linux64-ix-020', 11:40:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:29 INFO - 'use_talos_json': True, 11:40:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:29 INFO - 'work_dir': 'build'} 11:40:29 INFO - [mozharness: 2017-02-01 19:40:29.458892Z] Running clobber step. 11:40:29 INFO - Running pre-action listener: _resource_record_pre_action 11:40:29 INFO - Running main action method: clobber 11:40:29 INFO - rmtree: /builds/slave/test/build 11:40:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:29 INFO - Running post-action listener: _resource_record_post_action 11:40:29 INFO - [mozharness: 2017-02-01 19:40:29.910196Z] Finished clobber step (success) 11:40:29 INFO - [mozharness: 2017-02-01 19:40:29.910296Z] Running read-buildbot-config step. 11:40:29 INFO - Running pre-action listener: _resource_record_pre_action 11:40:29 INFO - Running main action method: read_buildbot_config 11:40:29 INFO - Using buildbot properties: 11:40:29 INFO - { 11:40:29 INFO - "project": "", 11:40:29 INFO - "product": "firefox", 11:40:29 INFO - "script_repo_revision": "production", 11:40:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:40:29 INFO - "repository": "", 11:40:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:40:29 INFO - "buildid": "20170201095009", 11:40:29 INFO - "pgo_build": "True", 11:40:29 INFO - "basedir": "/builds/slave/test", 11:40:29 INFO - "buildnumber": 122, 11:40:29 INFO - "slavename": "talos-linux64-ix-020", 11:40:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:40:29 INFO - "platform": "ubuntu64_hw", 11:40:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:40:29 INFO - "branch": "mozilla-beta", 11:40:29 INFO - "repo_path": "releases/mozilla-beta", 11:40:29 INFO - "revision": "964388f3501946027b15ef9af6e6bca2f4096552", 11:40:29 INFO - "stage_platform": "linux64-pgo", 11:40:29 INFO - "builduid": "5eccfe982b0344a7ae945cccfeb09d9a", 11:40:29 INFO - "slavebuilddir": "test" 11:40:29 INFO - } 11:40:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 11:40:29 INFO - Running post-action listener: _resource_record_post_action 11:40:29 INFO - [mozharness: 2017-02-01 19:40:29.912749Z] Finished read-buildbot-config step (success) 11:40:29 INFO - [mozharness: 2017-02-01 19:40:29.912838Z] Running download-and-extract step. 11:40:29 INFO - Running pre-action listener: _resource_record_pre_action 11:40:29 INFO - Running main action method: download_and_extract 11:40:29 INFO - mkdir: /builds/slave/test/build/tests 11:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:29 INFO - trying https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:40:30 INFO - Downloaded 1327 bytes. 11:40:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:40:30 INFO - Using the following test package requirements: 11:40:30 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:40:30 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:40:30 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 11:40:30 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'jsshell-linux-x86_64.zip'], 11:40:30 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:40:30 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:40:30 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 11:40:30 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 11:40:30 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:40:30 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:40:30 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:40:30 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:40:31 INFO - Http code: 200 11:40:31 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 11:40:31 INFO - x-amz-cf-id: JDTUkR_9bfMd9esW1HsDvNonQn_klJ1-BoeHzh08-KY2LBCgiRCXjg== 11:40:31 INFO - x-amz-version-id: eVoMEQEi7V6IFweNd5EcQfp3gopt9Nlx 11:40:31 INFO - Expected file size: 21953776 11:40:31 INFO - Obtained file size: 21953776 11:40:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:40:35 INFO - Http code: 200 11:40:35 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 11:40:35 INFO - x-amz-cf-id: YIB2sFXzKFDZ4Sbkso2dpg5iM0RGOxFCLRcjo9AuYe1W9NWdCSA-oQ== 11:40:35 INFO - x-amz-version-id: eVoMEQEi7V6IFweNd5EcQfp3gopt9Nlx 11:40:36 INFO - Expected file size: 21953776 11:40:36 INFO - Obtained file size: 21953776 11:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 11:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 11:40:41 INFO - Http code: 200 11:40:41 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 11:40:41 INFO - x-amz-cf-id: PdSzDYDuqfa8BhVaul-44zt4ApGNNQOIknjzEr9i6-CCXU6eE2Aw4A== 11:40:41 INFO - x-amz-version-id: Irf1tlULyP0lWOJD2zvjGSMx3gLrRmYb 11:40:41 INFO - Expected file size: 14403005 11:40:41 INFO - Obtained file size: 14403005 11:40:41 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:40:41 INFO - trying https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:40:41 INFO - Downloading https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:40:42 INFO - Downloaded 57696977 bytes. 11:40:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:40:42 INFO - mkdir: /builds/slave/test/properties 11:40:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:42 INFO - Contents: 11:40:42 INFO - build_url:https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:40:43 INFO - Running post-action listener: _resource_record_post_action 11:40:43 INFO - Running post-action listener: set_extra_try_arguments 11:40:43 INFO - [mozharness: 2017-02-01 19:40:43.637570Z] Finished download-and-extract step (success) 11:40:43 INFO - [mozharness: 2017-02-01 19:40:43.637798Z] Running populate-webroot step. 11:40:43 INFO - Running pre-action listener: _resource_record_pre_action 11:40:43 INFO - Running main action method: populate_webroot 11:40:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:40:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:40:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:40:43 INFO - '--tppagecycles', 11:40:43 INFO - '7'], 11:40:43 INFO - 'tests': ['tsvgm']}}, 11:40:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:40:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:40:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['damp', 'tps']}, 11:40:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'tests': ['damp', 'tps']}, 11:40:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['dromaeo_dom']}, 11:40:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['basic_compositor_video']}, 11:40:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:40:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['a11yr', 11:40:43 INFO - 'ts_paint', 11:40:43 INFO - 'tpaint', 11:40:43 INFO - 'sessionrestore', 11:40:43 INFO - 'sessionrestore_no_auto_restore', 11:40:43 INFO - 'tabpaint']}, 11:40:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['tsvgx', 11:40:43 INFO - 'tsvgr_opacity', 11:40:43 INFO - 'tart', 11:40:43 INFO - 'tscrollx', 11:40:43 INFO - 'cart']}, 11:40:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:43 INFO - 'tsvgr_opacity', 11:40:43 INFO - 'tart', 11:40:43 INFO - 'tscrollx', 11:40:43 INFO - 'cart']}, 11:40:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'talos_options': ['--disable-e10s'], 11:40:43 INFO - 'tests': ['tp5o']}, 11:40:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'tests': ['tp5o']}, 11:40:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'talos_options': ['--disable-e10s', 11:40:43 INFO - '--xperf_path', 11:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:43 INFO - 'tests': ['tp5n']}, 11:40:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:43 INFO - 'talos_options': ['--xperf_path', 11:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:43 INFO - 'tests': ['tp5n']}}, 11:40:43 INFO - 'talos.zip': {'path': '', 11:40:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:40:43 INFO - Running post-action listener: _resource_record_post_action 11:40:43 INFO - [mozharness: 2017-02-01 19:40:43.659255Z] Finished populate-webroot step (success) 11:40:43 INFO - [mozharness: 2017-02-01 19:40:43.659343Z] Running create-virtualenv step. 11:40:43 INFO - Running pre-action listener: _resource_record_pre_action 11:40:43 INFO - Running main action method: create_virtualenv 11:40:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:43 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:40:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:40:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:43 INFO - Using real prefix '/usr' 11:40:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:46 INFO - Installing pip.................done. 11:40:46 INFO - Return code: 0 11:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:40:46 INFO - Reading from file tmpfile_stdout 11:40:46 INFO - Output received: 11:40:46 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:40:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:46 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:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:46 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:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:46 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:46 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:40:46 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:40:46 INFO - Using env: {'DISPLAY': ':0', 11:40:46 INFO - 'HOME': '/home/cltbld', 11:40:46 INFO - 'LANG': 'en_US.UTF-8', 11:40:46 INFO - 'LANGUAGE': 'en_US:en', 11:40:46 INFO - 'LOGNAME': 'cltbld', 11:40:46 INFO - 'MAIL': '/var/mail/cltbld', 11:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:46 INFO - 'MOZ_NO_REMOTE': '1', 11:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:46 INFO - 'NO_EM_RESTART': '1', 11:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:46 INFO - 'PWD': '/builds/slave/test', 11:40:46 INFO - 'SHELL': '/bin/bash', 11:40:46 INFO - 'SHLVL': '1', 11:40:46 INFO - 'TERM': 'linux', 11:40:46 INFO - 'TMOUT': '86400', 11:40:46 INFO - 'USER': 'cltbld', 11:40:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:46 INFO - '_': '/tools/buildbot/bin/python'} 11:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:46 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:40:46 INFO - Cleaning up... 11:40:46 INFO - Return code: 0 11:40:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:46 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:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:46 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:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:46 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:46 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:40:46 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:40:46 INFO - Using env: {'DISPLAY': ':0', 11:40:46 INFO - 'HOME': '/home/cltbld', 11:40:46 INFO - 'LANG': 'en_US.UTF-8', 11:40:46 INFO - 'LANGUAGE': 'en_US:en', 11:40:46 INFO - 'LOGNAME': 'cltbld', 11:40:46 INFO - 'MAIL': '/var/mail/cltbld', 11:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:46 INFO - 'MOZ_NO_REMOTE': '1', 11:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:46 INFO - 'NO_EM_RESTART': '1', 11:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:46 INFO - 'PWD': '/builds/slave/test', 11:40:46 INFO - 'SHELL': '/bin/bash', 11:40:46 INFO - 'SHLVL': '1', 11:40:46 INFO - 'TERM': 'linux', 11:40:46 INFO - 'TMOUT': '86400', 11:40:46 INFO - 'USER': 'cltbld', 11:40:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:46 INFO - '_': '/tools/buildbot/bin/python'} 11:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:46 INFO - Downloading/unpacking psutil>=3.1.1 11:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:48 INFO - Installing collected packages: psutil 11:40:48 INFO - Running setup.py install for psutil 11:40:49 INFO - building 'psutil._psutil_linux' extension 11:40:49 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:40:49 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:40:49 INFO - building 'psutil._psutil_posix' extension 11:40:49 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:40:49 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:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:49 INFO - Successfully installed psutil 11:40:49 INFO - Cleaning up... 11:40:49 INFO - Return code: 0 11:40:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:49 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:49 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:40:49 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:40:49 INFO - Using env: {'DISPLAY': ':0', 11:40:49 INFO - 'HOME': '/home/cltbld', 11:40:49 INFO - 'LANG': 'en_US.UTF-8', 11:40:49 INFO - 'LANGUAGE': 'en_US:en', 11:40:49 INFO - 'LOGNAME': 'cltbld', 11:40:49 INFO - 'MAIL': '/var/mail/cltbld', 11:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:49 INFO - 'MOZ_NO_REMOTE': '1', 11:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:49 INFO - 'NO_EM_RESTART': '1', 11:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:49 INFO - 'PWD': '/builds/slave/test', 11:40:49 INFO - 'SHELL': '/bin/bash', 11:40:49 INFO - 'SHLVL': '1', 11:40:49 INFO - 'TERM': 'linux', 11:40:49 INFO - 'TMOUT': '86400', 11:40:49 INFO - 'USER': 'cltbld', 11:40:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:49 INFO - '_': '/tools/buildbot/bin/python'} 11:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40:49 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:40:49 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:40:49 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:40:49 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:40:49 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:40:49 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:40:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:51 INFO - Installing collected packages: mozsystemmonitor 11:40:51 INFO - Running setup.py install for mozsystemmonitor 11:40:51 INFO - Successfully installed mozsystemmonitor 11:40:51 INFO - Cleaning up... 11:40:51 INFO - Return code: 0 11:40:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40:51 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:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:51 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:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:51 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:51 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:40:51 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:40:51 INFO - Using env: {'DISPLAY': ':0', 11:40:51 INFO - 'HOME': '/home/cltbld', 11:40:51 INFO - 'LANG': 'en_US.UTF-8', 11:40:51 INFO - 'LANGUAGE': 'en_US:en', 11:40:51 INFO - 'LOGNAME': 'cltbld', 11:40:51 INFO - 'MAIL': '/var/mail/cltbld', 11:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:51 INFO - 'MOZ_NO_REMOTE': '1', 11:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:51 INFO - 'NO_EM_RESTART': '1', 11:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:51 INFO - 'PWD': '/builds/slave/test', 11:40:51 INFO - 'SHELL': '/bin/bash', 11:40:51 INFO - 'SHLVL': '1', 11:40:51 INFO - 'TERM': 'linux', 11:40:51 INFO - 'TMOUT': '86400', 11:40:51 INFO - 'USER': 'cltbld', 11:40:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:51 INFO - '_': '/tools/buildbot/bin/python'} 11:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 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:40:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:54 INFO - warning: no files found matching '*.txt' 11:40:54 INFO - no previously-included directories found matching 'build' 11:40:54 INFO - no previously-included directories found matching 'dist' 11:40:54 INFO - no previously-included directories found matching '.git*' 11:40:54 INFO - Installing collected packages: jsonschema, functools32 11:40:54 INFO - Running setup.py install for functools32 11:40:54 INFO - warning: no files found matching '*.txt' 11:40:54 INFO - no previously-included directories found matching 'build' 11:40:54 INFO - no previously-included directories found matching 'dist' 11:40:54 INFO - no previously-included directories found matching '.git*' 11:40:54 INFO - Successfully installed jsonschema functools32 11:40:54 INFO - Cleaning up... 11:40:54 INFO - Return code: 0 11:40:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:40:54 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:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:54 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:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:54 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:54 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:40:54 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:40:54 INFO - Using env: {'DISPLAY': ':0', 11:40:54 INFO - 'HOME': '/home/cltbld', 11:40:54 INFO - 'LANG': 'en_US.UTF-8', 11:40:54 INFO - 'LANGUAGE': 'en_US:en', 11:40:54 INFO - 'LOGNAME': 'cltbld', 11:40:54 INFO - 'MAIL': '/var/mail/cltbld', 11:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:54 INFO - 'MOZ_NO_REMOTE': '1', 11:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:54 INFO - 'NO_EM_RESTART': '1', 11:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:54 INFO - 'PWD': '/builds/slave/test', 11:40:54 INFO - 'SHELL': '/bin/bash', 11:40:54 INFO - 'SHLVL': '1', 11:40:54 INFO - 'TERM': 'linux', 11:40:54 INFO - 'TMOUT': '86400', 11:40:54 INFO - 'USER': 'cltbld', 11:40:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:54 INFO - '_': '/tools/buildbot/bin/python'} 11:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:40:54 INFO - Cleaning up... 11:40:54 INFO - Return code: 0 11:40:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:54 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:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:54 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:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:54 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:54 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:40:54 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:40:54 INFO - Using env: {'DISPLAY': ':0', 11:40:54 INFO - 'HOME': '/home/cltbld', 11:40:54 INFO - 'LANG': 'en_US.UTF-8', 11:40:54 INFO - 'LANGUAGE': 'en_US:en', 11:40:54 INFO - 'LOGNAME': 'cltbld', 11:40:54 INFO - 'MAIL': '/var/mail/cltbld', 11:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:54 INFO - 'MOZ_NO_REMOTE': '1', 11:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:54 INFO - 'NO_EM_RESTART': '1', 11:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:54 INFO - 'PWD': '/builds/slave/test', 11:40:54 INFO - 'SHELL': '/bin/bash', 11:40:54 INFO - 'SHLVL': '1', 11:40:54 INFO - 'TERM': 'linux', 11:40:54 INFO - 'TMOUT': '86400', 11:40:54 INFO - 'USER': 'cltbld', 11:40:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:54 INFO - '_': '/tools/buildbot/bin/python'} 11:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 INFO - Downloading docopt-0.6.1.tar.gz 11:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:57 INFO - Running setup.py install for blobuploader 11:40:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:58 INFO - Running setup.py install for requests 11:40:58 INFO - Running setup.py install for docopt 11:40:58 INFO - Successfully installed blobuploader requests docopt 11:40:58 INFO - Cleaning up... 11:40:58 INFO - Return code: 0 11:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:40:58 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:40:58 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:40:58 INFO - Using env: {'DISPLAY': ':0', 11:40:58 INFO - 'HOME': '/home/cltbld', 11:40:58 INFO - 'LANG': 'en_US.UTF-8', 11:40:58 INFO - 'LANGUAGE': 'en_US:en', 11:40:58 INFO - 'LOGNAME': 'cltbld', 11:40:58 INFO - 'MAIL': '/var/mail/cltbld', 11:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:58 INFO - 'MOZ_NO_REMOTE': '1', 11:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:58 INFO - 'NO_EM_RESTART': '1', 11:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:58 INFO - 'PWD': '/builds/slave/test', 11:40:58 INFO - 'SHELL': '/bin/bash', 11:40:58 INFO - 'SHLVL': '1', 11:40:58 INFO - 'TERM': 'linux', 11:40:58 INFO - 'TMOUT': '86400', 11:40:58 INFO - 'USER': 'cltbld', 11:40:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:58 INFO - '_': '/tools/buildbot/bin/python'} 11:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:58 INFO - Running setup.py (path:/tmp/pip-d1eAal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:58 INFO - Running setup.py (path:/tmp/pip-cmEq9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:58 INFO - Running setup.py (path:/tmp/pip-qtNTXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:58 INFO - Running setup.py (path:/tmp/pip-1E1qS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:59 INFO - Running setup.py (path:/tmp/pip-DZJI5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:59 INFO - Running setup.py (path:/tmp/pip-Ez4z80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:59 INFO - Running setup.py (path:/tmp/pip-mJ8U0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:59 INFO - Running setup.py (path:/tmp/pip-G1WaUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:59 INFO - Running setup.py (path:/tmp/pip-Xc5T8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:59 INFO - Running setup.py (path:/tmp/pip-sOqqve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:59 INFO - Running setup.py (path:/tmp/pip-_vUQHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:59 INFO - Running setup.py (path:/tmp/pip-p9NU2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:59 INFO - Running setup.py (path:/tmp/pip-firJjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:59 INFO - Running setup.py (path:/tmp/pip-JdBnYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:59 INFO - Running setup.py (path:/tmp/pip-TM6j52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:59 INFO - Running setup.py (path:/tmp/pip-8rkjz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:59 INFO - Running setup.py (path:/tmp/pip-n2haYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:59 INFO - Running setup.py install for manifestparser 11:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozcrash 11:41:00 INFO - Running setup.py install for mozdebug 11:41:00 INFO - Running setup.py install for mozdevice 11:41:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozfile 11:41:00 INFO - Running setup.py install for mozhttpd 11:41:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozinfo 11:41:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozInstall 11:41:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozleak 11:41:00 INFO - Running setup.py install for mozlog 11:41:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Running setup.py install for moznetwork 11:41:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Running setup.py install for mozprocess 11:41:01 INFO - Running setup.py install for mozprofile 11:41:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Running setup.py install for mozrunner 11:41:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Running setup.py install for mozscreenshot 11:41:01 INFO - Running setup.py install for moztest 11:41:01 INFO - Running setup.py install for mozversion 11:41:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:01 INFO - Cleaning up... 11:41:01 INFO - Return code: 0 11:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:01 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:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:01 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:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:01 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:41:01 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:41:01 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:41:01 INFO - Using env: {'DISPLAY': ':0', 11:41:01 INFO - 'HOME': '/home/cltbld', 11:41:01 INFO - 'LANG': 'en_US.UTF-8', 11:41:01 INFO - 'LANGUAGE': 'en_US:en', 11:41:01 INFO - 'LOGNAME': 'cltbld', 11:41:01 INFO - 'MAIL': '/var/mail/cltbld', 11:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:01 INFO - 'MOZ_NO_REMOTE': '1', 11:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:01 INFO - 'NO_EM_RESTART': '1', 11:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:01 INFO - 'PWD': '/builds/slave/test', 11:41:01 INFO - 'SHELL': '/bin/bash', 11:41:01 INFO - 'SHLVL': '1', 11:41:01 INFO - 'TERM': 'linux', 11:41:01 INFO - 'TMOUT': '86400', 11:41:01 INFO - 'USER': 'cltbld', 11:41:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:01 INFO - '_': '/tools/buildbot/bin/python'} 11:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:02 INFO - Running setup.py (path:/tmp/pip-Qlrvmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:02 INFO - Running setup.py (path:/tmp/pip-2YQHb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:02 INFO - Running setup.py (path:/tmp/pip-qRqXVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:02 INFO - Running setup.py (path:/tmp/pip-_kapy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:02 INFO - Running setup.py (path:/tmp/pip-_s1bhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 INFO - Running setup.py (path:/tmp/pip-4ndDsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 INFO - Running setup.py (path:/tmp/pip-oG19Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:02 INFO - Running setup.py (path:/tmp/pip-bJ4zkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:02 INFO - Running setup.py (path:/tmp/pip-BvSr5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:02 INFO - Running setup.py (path:/tmp/pip-pHMXAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:02 INFO - Running setup.py (path:/tmp/pip-tOTD2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:02 INFO - Running setup.py (path:/tmp/pip-YDhKdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 INFO - Running setup.py (path:/tmp/pip-Q3FGDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:02 INFO - Running setup.py (path:/tmp/pip-UVpNwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:03 INFO - Running setup.py (path:/tmp/pip-VA6cSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:03 INFO - Running setup.py (path:/tmp/pip-v9A53Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:03 INFO - Running setup.py (path:/tmp/pip-3xtFGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:05 INFO - Downloading blessings-1.6.tar.gz 11:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:05 INFO - Installing collected packages: blessings 11:41:05 INFO - Running setup.py install for blessings 11:41:05 INFO - Successfully installed blessings 11:41:05 INFO - Cleaning up... 11:41:05 INFO - Return code: 0 11:41:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:05 INFO - Reading from file tmpfile_stdout 11:41:05 INFO - Current package versions: 11:41:05 INFO - argparse == 1.2.1 11:41:05 INFO - blessings == 1.6 11:41:05 INFO - blobuploader == 1.2.4 11:41:05 INFO - docopt == 0.6.1 11:41:05 INFO - functools32 == 3.2.3-2 11:41:05 INFO - jsonschema == 2.5.1 11:41:05 INFO - manifestparser == 1.1 11:41:05 INFO - mozInstall == 1.12 11:41:05 INFO - mozcrash == 1.0 11:41:05 INFO - mozdebug == 0.1 11:41:05 INFO - mozdevice == 0.48 11:41:05 INFO - mozfile == 1.2 11:41:05 INFO - mozhttpd == 0.7 11:41:05 INFO - mozinfo == 0.9 11:41:05 INFO - mozleak == 0.1 11:41:05 INFO - mozlog == 3.4 11:41:05 INFO - moznetwork == 0.27 11:41:05 INFO - mozprocess == 0.23 11:41:05 INFO - mozprofile == 0.28 11:41:05 INFO - mozrunner == 6.13 11:41:05 INFO - mozscreenshot == 0.1 11:41:05 INFO - mozsystemmonitor == 0.3 11:41:05 INFO - moztest == 0.8 11:41:05 INFO - mozversion == 1.4 11:41:05 INFO - psutil == 3.1.1 11:41:05 INFO - requests == 1.2.3 11:41:05 INFO - wsgiref == 0.1.2 11:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 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 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:41:05 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:41:05 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:41:05 INFO - Using env: {'DISPLAY': ':0', 11:41:05 INFO - 'HOME': '/home/cltbld', 11:41:05 INFO - 'LANG': 'en_US.UTF-8', 11:41:05 INFO - 'LANGUAGE': 'en_US:en', 11:41:05 INFO - 'LOGNAME': 'cltbld', 11:41:05 INFO - 'MAIL': '/var/mail/cltbld', 11:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:05 INFO - 'MOZ_NO_REMOTE': '1', 11:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:05 INFO - 'NO_EM_RESTART': '1', 11:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:05 INFO - 'PWD': '/builds/slave/test', 11:41:05 INFO - 'SHELL': '/bin/bash', 11:41:05 INFO - 'SHLVL': '1', 11:41:05 INFO - 'TERM': 'linux', 11:41:05 INFO - 'TMOUT': '86400', 11:41:05 INFO - 'USER': 'cltbld', 11:41:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:05 INFO - '_': '/tools/buildbot/bin/python'} 11:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 INFO - Cleaning up... 11:41:05 INFO - Return code: 0 11:41:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d94f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', '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:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:41:05 INFO - Using env: {'DISPLAY': ':0', 11:41:05 INFO - 'HOME': '/home/cltbld', 11:41:05 INFO - 'LANG': 'en_US.UTF-8', 11:41:05 INFO - 'LANGUAGE': 'en_US:en', 11:41:05 INFO - 'LOGNAME': 'cltbld', 11:41:05 INFO - 'MAIL': '/var/mail/cltbld', 11:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:05 INFO - 'MOZ_NO_REMOTE': '1', 11:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:05 INFO - 'NO_EM_RESTART': '1', 11:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:05 INFO - 'PWD': '/builds/slave/test', 11:41:05 INFO - 'SHELL': '/bin/bash', 11:41:05 INFO - 'SHLVL': '1', 11:41:05 INFO - 'TERM': 'linux', 11:41:05 INFO - 'TMOUT': '86400', 11:41:05 INFO - 'USER': 'cltbld', 11:41:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:05 INFO - '_': '/tools/buildbot/bin/python'} 11:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:06 INFO - Cleaning up... 11:41:06 INFO - Return code: 0 11:41:06 INFO - Running post-action listener: _resource_record_post_action 11:41:06 INFO - Running post-action listener: _start_resource_monitoring 11:41:06 INFO - Starting resource monitoring. 11:41:06 INFO - [mozharness: 2017-02-01 19:41:06.203138Z] Finished create-virtualenv step (success) 11:41:06 INFO - [mozharness: 2017-02-01 19:41:06.203633Z] Running install step. 11:41:06 INFO - Running pre-action listener: _resource_record_pre_action 11:41:06 INFO - Running main action method: install 11:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:06 INFO - Reading from file tmpfile_stdout 11:41:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:06 INFO - Reading from file tmpfile_stdout 11:41:06 INFO - Output received: 11:41:06 INFO - Usage: mozinstall [options] installer 11:41:06 INFO - Options: 11:41:06 INFO - -h, --help show this help message and exit 11:41:06 INFO - -d DEST, --destination=DEST 11:41:06 INFO - Directory to install application into. [default: 11:41:06 INFO - "/builds/slave/test"] 11:41:06 INFO - --app=APP Application being installed. [default: firefox] 11:41:06 INFO - mkdir: /builds/slave/test/build/application 11:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:41:20 INFO - Reading from file tmpfile_stdout 11:41:20 INFO - Output received: 11:41:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:20 INFO - Running post-action listener: _resource_record_post_action 11:41:20 INFO - [mozharness: 2017-02-01 19:41:20.171071Z] Finished install step (success) 11:41:20 INFO - [mozharness: 2017-02-01 19:41:20.171311Z] Running run-tests step. 11:41:20 INFO - Running pre-action listener: _resource_record_pre_action 11:41:20 INFO - Running main action method: run_tests 11:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:20 INFO - Python 2.7.3 11:41:20 INFO - Return code: 0 11:41:20 INFO - grabbing minidump binary from tooltool 11:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x15d4f60>, '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 0x15d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:41:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:41:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:41:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:20 INFO - Return code: 0 11:41:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:41:20 INFO - Using env: {'DISPLAY': ':0', 11:41:20 INFO - 'HOME': '/home/cltbld', 11:41:20 INFO - 'LANG': 'en_US.UTF-8', 11:41:20 INFO - 'LANGUAGE': 'en_US:en', 11:41:20 INFO - 'LOGNAME': 'cltbld', 11:41:20 INFO - 'MAIL': '/var/mail/cltbld', 11:41:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:20 INFO - 'MOZ_NO_REMOTE': '1', 11:41:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:20 INFO - 'NO_EM_RESTART': '1', 11:41:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:20 INFO - 'PWD': '/builds/slave/test', 11:41:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:20 INFO - 'SHELL': '/bin/bash', 11:41:20 INFO - 'SHLVL': '1', 11:41:20 INFO - 'TERM': 'linux', 11:41:20 INFO - 'TMOUT': '86400', 11:41:20 INFO - 'USER': 'cltbld', 11:41:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203', 11:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:20 INFO - '_': '/tools/buildbot/bin/python'} 11:41:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:41:20 INFO - mozversion application_buildid: 20170201095009 11:41:20 INFO - mozversion application_changeset: 964388f3501946027b15ef9af6e6bca2f4096552 11:41:20 INFO - mozversion application_display_name: Firefox 11:41:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:20 INFO - mozversion application_name: Firefox 11:41:20 INFO - mozversion application_remotingname: firefox 11:41:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:41:20 INFO - mozversion application_vendor: Mozilla 11:41:20 INFO - mozversion application_version: 52.0 11:41:20 INFO - mozversion platform_buildid: 20170201095009 11:41:20 INFO - mozversion platform_changeset: 964388f3501946027b15ef9af6e6bca2f4096552 11:41:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:41:20 INFO - mozversion platform_version: 52.0 11:41:20 INFO - using testdate: 1485978080 11:41:20 INFO - actual date: 1485978080 11:41:20 INFO - starting webserver on 'localhost:59834' 11:41:20 INFO - SUITE-START | Running 2 tests 11:41:20 INFO - TEST-START | dromaeo_css 11:41:20 INFO - operating with platform_type : linux_ 11:41:20 INFO - Initialising browser for dromaeo_css test... 11:41:20 INFO - TEST-INFO | started process 29219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtX4HK/profile http://localhost:59834/getInfo.html) 11:41:24 INFO - PROCESS | 29219 | __metrics Screen width/height:1600/1200 11:41:24 INFO - PROCESS | 29219 | colorDepth:24 11:41:24 INFO - PROCESS | 29219 | Browser inner width/height: 1024/697 11:41:24 INFO - PROCESS | 29219 | __metrics 11:41:25 INFO - PROCESS | 29219 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:41:25 INFO - PROCESS | 29219 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:25 INFO - PROCESS | 29219 | console.error: PushService: 11:41:25 INFO - PROCESS | 29219 | stateChangeProcessEnqueue: Error transitioning state 11:41:25 INFO - PROCESS | 29219 | UnknownError 11:41:26 INFO - TEST-INFO | 29219: exit 0 11:41:26 INFO - Browser initialized. 11:41:26 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:26 INFO - TEST-INFO | started process 29312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtX4HK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:38 INFO - PROCESS | 29312 | RSS: Main: 141967360 11:41:38 INFO - PROCESS | 29312 | 11:44:39 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59834/tests/dromaeo/cssquery-ext.html) 11:44:40 INFO - PROCESS | 29312 | RSS: Main: 249090048 11:44:40 INFO - PROCESS | 29312 | 11:47:43 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-ext.html (next: http://localhost:59834/tests/dromaeo/cssquery-jquery.html) 11:47:43 INFO - PROCESS | 29312 | RSS: Main: 231587840 11:47:43 INFO - PROCESS | 29312 | 11:50:45 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59834/tests/dromaeo/cssquery-mootools.html) 11:50:46 INFO - PROCESS | 29312 | RSS: Main: 174465024 11:50:46 INFO - PROCESS | 29312 | 11:53:48 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59834/tests/dromaeo/cssquery-prototype.html) 11:53:48 INFO - PROCESS | 29312 | RSS: Main: 221396992 11:53:48 INFO - PROCESS | 29312 | 11:56:51 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59834/tests/dromaeo/cssquery-yui.html) 11:56:51 INFO - PROCESS | 29312 | RSS: Main: 174641152 11:56:51 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | Cycle 1(1): loaded http://localhost:59834/tests/dromaeo/cssquery-yui.html (next: http://localhost:59834/tests/dromaeo/cssquery-dojo.html) 11:59:54 INFO - PROCESS | 29312 | RSS: Main: 262922240 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | __start_tp_report 11:59:54 INFO - PROCESS | 29312 | _x_x_mozilla_page_load 11:59:54 INFO - PROCESS | 29312 | _x_x_mozilla_page_load_details 11:59:54 INFO - PROCESS | 29312 | |i|pagename|runs| 11:59:54 INFO - PROCESS | 29312 | |0;dojo.html;3257.902262932112;3287.950680739788;3292.753043521736;3318.950215746766;3347.8995630131103;5626.184203290521;5696.287964004499;5716.771329146829;5728.541716662668;5746.569007324451;5644.943550564493;5677.801276955297;5710.1434784782305;5717.971410142944;5731.054376027961;5153.56194723449;5155.690658560479;5183.248428977796;5196.454372290912;5226.08543504887;5041.521055499722;5050.924236136461;5248.8425347239645;5256.973715131419;5266.81566145185;5050.46970068143;5055.898882022358;5088.465711100337;5152.665076770017;5201.505856943584;5263.657862238962;5293.682379057269;5295;5301.416844147141;5317.813876514303;4999.525045120708;5103.055934652101;5182.222666600041;5231.790728370861;5240.895182096337;5447.373552041527;5477.67133971959;5512.751926163292;5525.751341189656;5546.972265138689;5926.940730592725;5930.614510056876;6011.57918945674;6024.1566180734735;6048.788292409745;5876.08920617305;6063.787767428119;6074.787382441594;6075.635461872302;6093.146959425684;5545.029619816556;5567.4432556744005;5629.043062679354;5632.070708333079;5667.263255776723;6192.256929168439;6209.223847019122;6210.161628180228;6213.099100630383;6227.06594010902;5731.770729170787;5950.761969521257;5955.553333499918;5968.074948383008;5969.880602387928;5856.180134781134;5984.910226346608;6041.72812223451;6048.395160483917;6108.888502348253;6078.665673387918;6079.422454866781;6081.27024757032;6089.756409743649;6130.264368275835;6060.878782424327;6112.083187521907;6118.082287656798;6121.84695382619;6126.326104128542;4575.22221222393;4624.930626040612;4630.21286381316;4658.068386322749;4686.976565117221;4123.793810309473;4146.958530414658;4158.875233742992;4160.687948403882;4184.476940382452;5831.0378787499585;5847.502962248172;5851.410599025615;5852.736626851802;5899.970500147472;5884.235049443545;5952.821415357546;6002.459778619946;6010.278766547955;6047;5795.913061304083;5798.275215598051;5800.129980502874;5807.157962095473;5819.127130930395;4984.327115839315;4993.90012199754;4997.100521906092;5001.149804533238;5020.297158397827;6131.3766666500715;6140.078988151724;6191.504679625529;6255;6322.873542529123;6125.47964319526;6139.8601398601395;6140.653343927481;6140.749659041455;6147.047207682816;6315.873682526416;6353.618782873043;6355.586886852525;6356.237251529846;6364.4908407326375;5772.278465191851;5781.768729250951;5787.36339002701;5980.820575382745;5999.760009599567;5938.465538101592;6035.1249068885645;6040.818775436744;6058.303295120942;6072.332043475302;5853.473187413153;5854.297484301911;5858.297004359334;5859.589828711949;5870.14882841994;5732.05421105513;5857.941420585739;5859.853503662443;5862.267216597926;5871.4715675589405;5816.5055970243;5839.941600583939;5849.824505264849;5914.142449344735;5931.3178984417345;5984.790532331347;5985.191999080069;5985.790497332572;5990.131430942576;5990.940090599038;5636.098224284095;5682;5836.533077353886;5839.795607153729;5895.380984996514 11:59:54 INFO - PROCESS | 29312 | |1;ext.html;574.7586013874172;621.0528943361373;643.3566433566432;665.304756529427;670.1087553553774;34340.4848927266;37412;37585.81207093964;44349.7782511087;44987.550124498746;46529;46993.295100573516;47076.293855592194;47209.29186062212;47218;8968.820623587524;9137.954310228439;9148.313876459259;9157.221636160933;9158.542072896362;8442.324614030893;8679.826403471927;8687.348448866329;8875.156860098312;9014.819703605925;10819.621313254038;11082.16883733719;11087.72280692981;11374.203805733601;11388.430578471085;10920.453977301104;10971.067459265973;10986.670399888017;10989.395583242918;10992.615258465916;10875.401852898087;10936.671899843017;10946.288491248122;10948.781024379547;10956.178286628534;43435.78282108601;43700;43720;43786.34320485195;43789.56210437887;3525.312564050011;3613.94579081314;3621.89134325968;3625.29306785177;3726.0312318797037;32609.347813043845;32611;32751.836240818644;33231.33537329264;33258.66741332604;4241.809118589671;4469.1732029574305;4495.505494395614;4524.457065152203;4554.339620755005;343755;346675;347162;347436;348399;64064.35935640677;64315;64596.354036459976;64676.67661661661;64770.676146618964;39532.2093558133;40597.39103913444;40742.79628601897;43268.783656082145;43275;17271.74092388615;17426.738598921027;17427.215775290144;17429.738553921703;17445.47663570095;12570.497180112692;12652.430640621194;12653.36733163338;12660.556880509139;12674.429650665743;18139.365122220657;18488.815111848977;19382.326888722862;20264.898675506527;21219.15123395078;7608.163102058769;7672.462927595015;7682.389277039782;7706.38348932084;7854.096778870388;922.1608336413831;970.4904924914476;997.5560875410517;1023.5598692562121;1081.5133190064503;31603;31901.840490797862;32291;32372;32541.837290813393;1077.5366592365358;1125.4372813593204;1147.4778975566264;1153.210051114989;1155.595541560464;17243.568910777332;17254.568635784206;17297.221625026905;17393.565160870825;17405.477835664697;151797;154131;536563;538921;540384;57993.71003144957;58437;58598;58657;58669;1369.472752990086;1416.539624622002;1417.7164567086625;1432.0619993904008;1451.2380999974887;29979.535307787322;31611.84194079015;31781.682183177873;31924.36151277008;32063.519047213846;51493.742531287106;51514;51973.22040169325;51994.74002629962;52211.216831748316;346692;347648;347803;348374;350975;29463.55804662889;29879.253018674706;31529.684703152674;32713.672863271062;38447.23105537818;38919.221615568094;46825;48198.759006204746;48494.515054849;53523.25337226357;41765.37351939784;41823.37264940968;42187.578124218366;42663.7866810664;43521;40239.1952160961;40896;41102.79448602738;42039;42229.36655950225;42283;42843.785781070896;42856.35715464208;42914.78542607267;43025;36482;38642.6135738639;38652.6134738649;38715.22569548649;38801.223975519766;28694.543727661945;28862.929042536773;28884.133475995754;29059.418811623225;29359.55960660549 11:59:54 INFO - PROCESS | 29312 | |2;jquery.html;403.2720938705637;411.4507132977474;413.580216080678;429.80229094616476;442.2459706200926;19242;19831.801681983194;20646.38060858173;20928;21088.789112108876;20008.299709510135;20073.698894516594;20212;20357.898210508927;20359.185632574678;5723.570732195081;5980.6112602680905;5988.520918326545;5994.310654274771;5998.310194327664;5826.096954971986;5840.766369345221;5919.289685237777;5939.020061689837;6043.758249670008;6163.753449862;6175.444210021097;6178.8455288617915;6179.474744646711;6181.690915454232;6027.336992930796;6165.075238714161;6173.753049878;6243.032329988859;6251.156093927307;5880.294364676266;6063.939360606381;6077.3314935357075;6078.756849726005;6078.908816367758;14836;15254.08475491474;15256.38974441021;15284.617884552865;18315.542111447186;2300.0454811253308;2326.232343326698;2396.628522579003;2406.639004149374;2442.7312995570474;10745.247832651718;10992.560297588087;11018.173636977179;11186.720331991684;11538.365389903553;1973.3685220729371;2004.4888553418784;2041.3365656161807;2061.6704023002894;2066.173530587762;87115.56442217811;88216;89822.5508872458;90624.5468772652;91559.54220228923;11480.368579728029;11557.537698491966;11658.358790266617;11702.180847340604;11908;16821.32714691423;16833;16856.07291598974;16868.325266989184;16897.746533802;8136.4711293766895;8268.669253229924;8297.709580164665;8441.535715535581;8606.26846718036;7799.49303295284;7826;7949.165337639464;8051.194880511902;8091.878621820678;4949.90100197994;5111.156659151273;5112.824050468413;5120.564751996122;5250.973745131327;2093.36152473494;2129.6960995453323;2139.101577337522;2152.677098435216;2168.6313326734175;903.4308385717088;957.042957042957;957.8419560772534;1018.7096677446892;1044.9707038567005;19357.51606209856;19395.127219275168;19959.702619329986;20427.080781364875;20459.795402045787;969.6266937229218;983.537737263485;985.6008316631776;1020.8111499372492;1037.818381783185;10751.871053539422;11333.603323883624;11376;11378.544858205745;11409.543618255342;461859;466461;499627;503937;506852;72542.27457725356;76097.61951190319;94305.5284723572;100163.49918250508;102260;971.577363846729;1042.6663467690419;1079.5411949921252;1082.7239054041327;1091.2961140064615;17913.641727165643;18312.359067432575;18356.816431835512;18569.44291671252;18771.6245675083;35817.82091089528;39315.60684393119;43315.35026974535;45484;45568.54431455776;61977;62345.06482402858;62880;64061.679691601246;64386.35613643804;8500.14998500145;8828.558572071499;9157.267418606361;9210.585523651318;9417.717468475958;12725.363731813557;13586.592402227554;13632.182069075887;13704.3833027516;13935.930320348334;11777.470013849568;12096.939515302367;12171.208871423329;12201.633950981484;12457.12800103984;11791.587294444653;11825.113116516124;11886.108541859569;12175.39123043862;12371.257724536557;11377;11499.252548584314;12247.75504489923;12361.690957725768;12456.065795065588;8444.071152173134;8647.654093836427;8677.479351238946;8695.913040869511;8698.130186981505;6200.782972596118;10940.781184376427;11113.44432778374;11769.293842369485;11925.344106073902 11:59:54 INFO - PROCESS | 29312 | |3;mootools.html;1488.9553313400595;1531.0966529747448;1697.4483292929792;1751.0719318761062;1803.7925638551553;8500.872486912693;9056.320775941815;9064.682736104238;9072.63709451622;9076.455412675245;7761.107472640648;7963.641636126374;8487.236148746611;8692.43499172555;8894.510801905893;2498.4128729748495;2498.9500209995836;2519.533886231044;2533.7086235082925;2539.21284401836;2498.3254521279246;2523.2430270918744;2541.8856151473137;2544.8473091614565;2569.5760199567144;2533.8353007054575;2538.2892790018823;2540.7078186008566;2543.9745602544017;2546.6689330387026;2456.2262887190477;2461.729209786922;2469.333280014395;2470.789982851442;2493.127405408111;2498.1381423408893;2513;2522.4576716005963;2534.8986040558357;2536.4293034067373;9142.405743626643;9287.535623218879;9334.20659243965;9338;9346.299027572959;5625.38120806711;5768.307803063617;5771.220885180489;5794.5943783935145;5802.419758024206;3577.266660334651;3636.709063274932;3660.213054193361;3666.211764470652;3747.5315585551807;1206.7043574324346;1207.420438189665;1218.1533833985384;1254.6737848159453;1257.0132446029913;12774.61676149717;12782.360881955865;12816.80774788379;12820.487180512768;12828.486860525567;4806.375171227718;5081.923771143436;5151.665141765773;5169.715665638426;5183.45573714762;10767.83848242277;10772.676819695265;10785.514651840529;10793.460326983619;10808.405537695502;5693.800716974969;5697.572682048863;5723.685197314105;5732;5735.254416925856;4637.233500151015;4707.152712511781;5175.094358487249;5188.195829646335;5270.420253772082;4204.747715137101;4304.849330273425;4346.239408103569;4370.2570563004365;4403.603675669206;1410.4358256697199;1441.7260720463078;1444.5738507140418;1448.4713079725825;1461.371610207621;867.8784970104191;980.1913421427352;980.887197972228;981.1954197557934;983.6262220356219;5796.3913789052385;5836.970815145897;5911.674857882857;6022.307434644984;6064.848378790565;472.8155969296889;480.28437627934125;492.7339236812153;496.9801207951714;499.62528103922057;4089.20260549196;4089.8159582818844;4127.9174416512105;4171.186618609342;4171.853985110507;11131.499082541142;11414.942925285486;11477.36874471912;11496.655100347003;11547.480363383667;11391.316521008766;11396.829047564293;11398.772024559463;11409.714757130972;11420.771584568261;8119.188081191834;8643.222110010129;8654.697085601974;8657.740267791976;8658;5969.701514924323;6014;6154.169187159855;6168.290646575521;6226.875462490634;10192.439415832201;10320.741981450525;10364.792704145724;10477.057064864199;10485.633002844865;10377.688669339932;10420.791584168122;10533.578656853946;10656.360618362924;10706.571737130738;7525.887111693439;7772.805679858049;7864.4888082274465;8234;8364.456310339809;8859.51272679983;8919.687810926587;8934.195922367018;8941.284697224077;8944.105589441004;7481.364084052699;7705.6147192641265;7760.029996250469;7772.650230739518;7881.645325960231;7494.425572033572;7540.622968851645;7556.319931206218;7634.160242373224;7792.727254546064;7101.325374089453;7126.574685062905;7222.422206223595;7231.819204519929;7232.276772322725;4934.309196712535;5087.847364579068;5105.668131571584;5154.690718556899;5242.18746094356;5326.387465441524;5382;5387.138057910715;5388.622796404214;5521.641093328921 11:59:54 INFO - PROCESS | 29312 | |4;prototype.html;336.98652053917846;350.09500441359086;351.3991075261303;355.9555055618048;356.08486190490436;5511.5039646431815;5529.198266251391;5531.5298199653025;5540.3628582713;5571.832845014651;5199.674083108812;5255.789768409259;5340.91988620171;5376.1398176291805;5446.459801129258;4248.532661407243;4263.616274535283;4281.357796330544;4286.721363111404;4293.763842988635;4277.294246449332;4283.907603561103;4295.377170310303;4295.914081718363;4306.504751953534;4111.259973204822;4244.851430199944;4246.341817018351;4253.893652658678;4255.510616279121;4233.661307095425;4243.957560424403;4244.915101697964;4249.532551419341;4268.125034367947;3742.4760533525327;3757.5490941086973;3762.6454476388476;3762.9059273518105;3774.226283611853;5085.644004919657;5303;5327.813526526553;5336;5339.652922560022;4826.541478559531;4859.1739404301;4861.492937189447;4873;4880.658353915192;5703.572232082611;5706;5707.543396528268;5734.885302293973;5746.339170995348;4045.0785876708624;4123.9175216495805;4133.772642504661;4147;4148.336266197394;5870.73581688825;5923.4076592340425;5923.644581325134;5931.792387266468;5937.70311484424;4162.500499939966;4173.123644034787;4175.0188705654145;4186.1418409226035;4203.684723645739;4158.6673066154635;4212.873613791591;4256.7445953242905;4266.957330426718;4282.528921818597;4827.8551643450755;4832.106060378841;4852.587530059914;4864.586510146606;4874.2201247800185;5765.711714414262;5767.596268261265;5778.162166485836;5805.709714514257;5812;1396.5964205972932;1435.2393231587275;1437.8849692024612;1437.9137251764719;1446.5009571697747;953.7281874665687;978.9853152202722;979.8775153105862;981.65642025292;993.1855878179967;5378.354597448331;5386.434424385383;5386.48828361305;5395.109806881821;5395.433479484676;5650.333151720252;5664.405237450091;5671.808920126737;5683.346415162227;5684.573656975744;5159.329287192641;5347.2781174541715;5353.411124776271;5399.57019341298;5413.539849112791;3016.909492715222;3024.410240003222;3024.9697503025127;3028.8939887103847;3037.924051898676;5854.912176317359;5857.238558987389;5870.503021729432;5884.823455296348;5893.2044174035955;5693;6028.2766068072115;6051.092336149525;6053.818385448443;6058.242719660043;6089.817305480754;6138.324784273726;6146.416090471398;6158.599691020159;6188.409344048484;5677.829665110054;5936.376680448663;5960.672163031075;5990.221271234712;6001.579099913182;5834.737436815269;5892.175095486721;5909.168157870902;5923.763049477972;5946.402426531886;5884.823455296348;6169.753209871555;6170.784022559189;6185.165002724574;6187;4228.365745138254;4266.741311313108;4307.181635489373;4341.413909122354;4368.706429124735;5843.561732870136;5848.6783226921225;5987.461128498456;5996.160537524663;6060.515158787198;5837.824865254049;5857;5859.619124756877;5866.853328666817;5885.61743486672;5657.264555607745;5784.859601947306;5825.592208545361;5848.619839710575;5865.94134058654;5725.227094342377;5816.680082595498;5830.708464576669;5831.620944638585;5833.854153646193;5727.1695604138;5787.826365209051;5811.970940145272;5825.475707186373;5855.502282306052;5380.542653874308;5674.092145256739;5679.062954612443;5683.232763576864;5690.3456102548735 11:59:54 INFO - PROCESS | 29312 | |5;yui.html;782.2373186143507;782.3350152370482;844.539725849412;851.4763420496392;859.6905114158898;14538.781918271221;14684.706305873877;14693.77959330611;15034.548963531099;15197.696046079072;13473.730525389487;14562.199079050648;14685.265736713149;14815.407383704665;14820.036697614674;834.5076404921095;868.700298397052;874.5933141089392;875.3566128895256;875.7285241575132;861.1044513705739;865.8398196333667;867.8784970104191;868.7784614923186;869.5739087846941;916.2120576304372;916.4363916191561;916.720400277915;917.2111983694018;917.3028498341275;917.1882883647953;917.5228880981851;918.1874041473277;918.4581097152678;918.7197904639082;672.6905623413236;672.9596224226563;673.1316601583951;673.2325149329768;673.8517526144241;13801.585952421443;13939.790903136462;14076.155430674089;14105.153690778587;14181.716365672628;11825.822612660817;13004.21974681522;13035.478580856754;13215;13318.352059925093;11050.881111938446;11136.498857551429;11195.832062519068;11302.265352752045;11392.94303528477;3766.9058273543105;3818.751781134245;3822.3310920588788;3844.8462061517507;3893.824777885002;46855.29717054247;48329.75835120802;55953.601159970916;64673.353266467675;65363.34636653668;11580.305181689126;11776;11842.585509507298;11882.168248222715;11997.100217483723;20611.79388206099;20742.688859667116;20755.792442075384;20861.269855554983;20902.47743806417;8734.344924130715;8813.911860881437;8859.64561417536;8919.42023768453;8984.8652270216;4559.088182363541;4578.313253012075;4702.293705185591;4797.544233297831;4958.851234462972;3667.779933203963;3793.260314238752;3795.772253664789;3797.2974999625158;3800.35393983018;657.7927952694886;676.4723515657795;685.2222727204659;688.9975086249596;698.2947223304398;655.3413819111762;722.7506510253954;735.9742409015658;769.6344236487623;771.5679219637021;9081.81836363269;9168.129027742354;9400.858987115198;9545.90454095464;9942;547.6932917566096;574.8390450673818;577.1688768173816;649.8797722421367;652.0740548421159;4526.23054080807;4553.749543775058;4620.630349572026;4689.273162659793;4753.952460475351;91565.54217228871;92587;92893;94286.52856735673;96365;49927;53125.46874531283;54598.454015460135;79430;80867;60974.695126524086;70662.64668676624;71050.64474677593;71924.64037679778;71961.64019179871;9812.26408019387;10409.1672666185;10447.738806529898;10565.894341056492;10617.734556636145;35542;37839;46985.53014469812;47238.29142562933;48262.27606585974;59040.704796475744;60903.69548152231;65305.34694652993;65700.67149664412;65933.67033164804;12267.202631828903;12612.936935315265;13094.214347139203;13159.802602960772;13203.273819939996;12958.157719748186;12989.545365912149;13048.086633935913;14596.85403145955;15164.848351516344;12549.498020079094;13271.734565308832;13393.464261429823;13427;13584.660383490493;12258.693532661398;13019.739605208033;13725.931370343083;13765.174089554659;13765.174089554659;12163.695907602027;12190.390480476119;12476.438560264629;12711.173773704679;12721.872781272068;10231.28381013322;11339.716507087389;11378.43107844621;11434.599789007345;11620.477078531318;9070.229030532215;10549.261551691308;10561.788764224519;10682.73293167677;10928 11:59:54 INFO - PROCESS | 29312 | __end_tp_report 11:59:54 INFO - PROCESS | 29312 | __start_cc_report 11:59:54 INFO - PROCESS | 29312 | _x_x_mozilla_cycle_collect,1013 11:59:54 INFO - PROCESS | 29312 | __end_cc_report 11:59:54 INFO - PROCESS | 29312 | __startTimestamp1485979194474__endTimestamp 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | ------- Summary: start ------- 11:59:54 INFO - PROCESS | 29312 | Number of tests: 6 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#0] dojo.html Cycles:165 Average:5619.13 Median:5847.50 stddev:635.66 (10.9%) stddev-sans-first:610.02 11:59:54 INFO - PROCESS | 29312 | Values: 3257.9 3288.0 3292.8 3319.0 3347.9 5626.2 5696.3 5716.8 5728.5 5746.6 5644.9 5677.8 5710.1 5718.0 5731.1 5153.6 5155.7 5183.2 5196.5 5226.1 5041.5 5050.9 5248.8 5257.0 5266.8 5050.5 5055.9 5088.5 5152.7 5201.5 5263.7 5293.7 5295.0 5301.4 5317.8 4999.5 5103.1 5182.2 5231.8 5240.9 5447.4 5477.7 5512.8 5525.8 5547.0 5926.9 5930.6 6011.6 6024.2 6048.8 5876.1 6063.8 6074.8 6075.6 6093.1 5545.0 5567.4 5629.0 5632.1 5667.3 6192.3 6209.2 6210.2 6213.1 6227.1 5731.8 5950.8 5955.6 5968.1 5969.9 5856.2 5984.9 6041.7 6048.4 6108.9 6078.7 6079.4 6081.3 6089.8 6130.3 6060.9 6112.1 6118.1 6121.8 6126.3 4575.2 4624.9 4630.2 4658.1 4687.0 4123.8 4147.0 4158.9 4160.7 4184.5 5831.0 5847.5 5851.4 5852.7 5900.0 5884.2 5952.8 6002.5 6010.3 6047.0 5795.9 5798.3 5800.1 5807.2 5819.1 4984.3 4993.9 4997.1 5001.1 5020.3 6131.4 6140.1 6191.5 6255.0 6322.9 6125.5 6139.9 6140.7 6140.7 6147.0 6315.9 6353.6 6355.6 6356.2 6364.5 5772.3 5781.8 5787.4 5980.8 5999.8 5938.5 6035.1 6040.8 6058.3 6072.3 5853.5 5854.3 5858.3 5859.6 5870.1 5732.1 5857.9 5859.9 5862.3 5871.5 5816.5 5839.9 5849.8 5914.1 5931.3 5984.8 5985.2 5985.8 5990.1 5990.9 5636.1 5682.0 5836.5 5839.8 5895.4 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#1] ext.html Cycles:180 Average:53711.03 Median:37498.91 stddev:99524.46 (265.4%) stddev-sans-first:99723.69 11:59:54 INFO - PROCESS | 29312 | Values: 574.8 621.1 643.4 665.3 670.1 34340.5 37412.0 37585.8 44349.8 44987.6 46529.0 46993.3 47076.3 47209.3 47218.0 8968.8 9138.0 9148.3 9157.2 9158.5 8442.3 8679.8 8687.3 8875.2 9014.8 10819.6 11082.2 11087.7 11374.2 11388.4 10920.5 10971.1 10986.7 10989.4 10992.6 10875.4 10936.7 10946.3 10948.8 10956.2 43435.8 43700.0 43720.0 43786.3 43789.6 3525.3 3613.9 3621.9 3625.3 3726.0 32609.3 32611.0 32751.8 33231.3 33258.7 4241.8 4469.2 4495.5 4524.5 4554.3 343755.0 346675.0 347162.0 347436.0 348399.0 64064.4 64315.0 64596.4 64676.7 64770.7 39532.2 40597.4 40742.8 43268.8 43275.0 17271.7 17426.7 17427.2 17429.7 17445.5 12570.5 12652.4 12653.4 12660.6 12674.4 18139.4 18488.8 19382.3 20264.9 21219.2 7608.2 7672.5 7682.4 7706.4 7854.1 922.2 970.5 997.6 1023.6 1081.5 31603.0 31901.8 32291.0 32372.0 32541.8 1077.5 1125.4 1147.5 1153.2 1155.6 17243.6 17254.6 17297.2 17393.6 17405.5 151797.0 154131.0 536563.0 538921.0 540384.0 57993.7 58437.0 58598.0 58657.0 58669.0 1369.5 1416.5 1417.7 1432.1 1451.2 29979.5 31611.8 31781.7 31924.4 32063.5 51493.7 51514.0 51973.2 51994.7 52211.2 346692.0 347648.0 347803.0 348374.0 350975.0 29463.6 29879.3 31529.7 32713.7 38447.2 38919.2 46825.0 48198.8 48494.5 53523.3 41765.4 41823.4 42187.6 42663.8 43521.0 40239.2 40896.0 41102.8 42039.0 42229.4 42283.0 42843.8 42856.4 42914.8 43025.0 36482.0 38642.6 38652.6 38715.2 38801.2 28694.5 28862.9 28884.1 29059.4 29359.6 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#2] jquery.html Cycles:180 Average:29337.61 Median:2361.43 stddev:80651.41 (3415.4%) stddev-sans-first:80848.39 11:59:54 INFO - PROCESS | 29312 | Values: 403.3 411.5 413.6 429.8 442.2 19242.0 19831.8 20646.4 20928.0 21088.8 20008.3 20073.7 20212.0 20357.9 20359.2 5723.6 5980.6 5988.5 5994.3 5998.3 5826.1 5840.8 5919.3 5939.0 6043.8 6163.8 6175.4 6178.8 6179.5 6181.7 6027.3 6165.1 6173.8 6243.0 6251.2 5880.3 6063.9 6077.3 6078.8 6078.9 14836.0 15254.1 15256.4 15284.6 18315.5 2300.0 2326.2 2396.6 2406.6 2442.7 10745.2 10992.6 11018.2 11186.7 11538.4 1973.4 2004.5 2041.3 2061.7 2066.2 87115.6 88216.0 89822.6 90624.5 91559.5 11480.4 11557.5 11658.4 11702.2 11908.0 16821.3 16833.0 16856.1 16868.3 16897.7 8136.5 8268.7 8297.7 8441.5 8606.3 7799.5 7826.0 7949.2 8051.2 8091.9 4949.9 5111.2 5112.8 5120.6 5251.0 2093.4 2129.7 2139.1 2152.7 2168.6 903.4 957.0 957.8 1018.7 1045.0 19357.5 19395.1 19959.7 20427.1 20459.8 969.6 983.5 985.6 1020.8 1037.8 10751.9 11333.6 11376.0 11378.5 11409.5 461859.0 466461.0 499627.0 503937.0 506852.0 72542.3 76097.6 94305.5 100163.5 102260.0 971.6 1042.7 1079.5 1082.7 1091.3 17913.6 18312.4 18356.8 18569.4 18771.6 35817.8 39315.6 43315.4 45484.0 45568.5 61977.0 62345.1 62880.0 64061.7 64386.4 8500.1 8828.6 9157.3 9210.6 9417.7 12725.4 13586.6 13632.2 13704.4 13935.9 11777.5 12096.9 12171.2 12201.6 12457.1 11791.6 11825.1 11886.1 12175.4 12371.3 11377.0 11499.3 12247.8 12361.7 12456.1 8444.1 8647.7 8677.5 8695.9 8698.1 6200.8 10940.8 11113.4 11769.3 11925.3 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#3] mootools.html Cycles:180 Average:6011.01 Median:2713.52 stddev:3395.37 (125.1%) stddev-sans-first:3387.88 11:59:54 INFO - PROCESS | 29312 | Values: 1489.0 1531.1 1697.4 1751.1 1803.8 8500.9 9056.3 9064.7 9072.6 9076.5 7761.1 7963.6 8487.2 8692.4 8894.5 2498.4 2499.0 2519.5 2533.7 2539.2 2498.3 2523.2 2541.9 2544.8 2569.6 2533.8 2538.3 2540.7 2544.0 2546.7 2456.2 2461.7 2469.3 2470.8 2493.1 2498.1 2513.0 2522.5 2534.9 2536.4 9142.4 9287.5 9334.2 9338.0 9346.3 5625.4 5768.3 5771.2 5794.6 5802.4 3577.3 3636.7 3660.2 3666.2 3747.5 1206.7 1207.4 1218.2 1254.7 1257.0 12774.6 12782.4 12816.8 12820.5 12828.5 4806.4 5081.9 5151.7 5169.7 5183.5 10767.8 10772.7 10785.5 10793.5 10808.4 5693.8 5697.6 5723.7 5732.0 5735.3 4637.2 4707.2 5175.1 5188.2 5270.4 4204.7 4304.8 4346.2 4370.3 4403.6 1410.4 1441.7 1444.6 1448.5 1461.4 867.9 980.2 980.9 981.2 983.6 5796.4 5837.0 5911.7 6022.3 6064.8 472.8 480.3 492.7 497.0 499.6 4089.2 4089.8 4127.9 4171.2 4171.9 11131.5 11414.9 11477.4 11496.7 11547.5 11391.3 11396.8 11398.8 11409.7 11420.8 8119.2 8643.2 8654.7 8657.7 8658.0 5969.7 6014.0 6154.2 6168.3 6226.9 10192.4 10320.7 10364.8 10477.1 10485.6 10377.7 10420.8 10533.6 10656.4 10706.6 7525.9 7772.8 7864.5 8234.0 8364.5 8859.5 8919.7 8934.2 8941.3 8944.1 7481.4 7705.6 7760.0 7772.7 7881.6 7494.4 7540.6 7556.3 7634.2 7792.7 7101.3 7126.6 7222.4 7231.8 7232.3 4934.3 5087.8 5105.7 5154.7 5242.2 5326.4 5382.0 5387.1 5388.6 5521.6 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#4] prototype.html Cycles:180 Average:4829.15 Median:5478.98 stddev:1426.41 (26.0%) stddev-sans-first:1389.99 11:59:54 INFO - PROCESS | 29312 | Values: 337.0 350.1 351.4 356.0 356.1 5511.5 5529.2 5531.5 5540.4 5571.8 5199.7 5255.8 5340.9 5376.1 5446.5 4248.5 4263.6 4281.4 4286.7 4293.8 4277.3 4283.9 4295.4 4295.9 4306.5 4111.3 4244.9 4246.3 4253.9 4255.5 4233.7 4244.0 4244.9 4249.5 4268.1 3742.5 3757.5 3762.6 3762.9 3774.2 5085.6 5303.0 5327.8 5336.0 5339.7 4826.5 4859.2 4861.5 4873.0 4880.7 5703.6 5706.0 5707.5 5734.9 5746.3 4045.1 4123.9 4133.8 4147.0 4148.3 5870.7 5923.4 5923.6 5931.8 5937.7 4162.5 4173.1 4175.0 4186.1 4203.7 4158.7 4212.9 4256.7 4267.0 4282.5 4827.9 4832.1 4852.6 4864.6 4874.2 5765.7 5767.6 5778.2 5805.7 5812.0 1396.6 1435.2 1437.9 1437.9 1446.5 953.7 979.0 979.9 981.7 993.2 5378.4 5386.4 5386.5 5395.1 5395.4 5650.3 5664.4 5671.8 5683.3 5684.6 5159.3 5347.3 5353.4 5399.6 5413.5 3016.9 3024.4 3025.0 3028.9 3037.9 5854.9 5857.2 5870.5 5884.8 5893.2 5693.0 6028.3 6051.1 6053.8 6058.2 6089.8 6138.3 6146.4 6158.6 6188.4 5677.8 5936.4 5960.7 5990.2 6001.6 5834.7 5892.2 5909.2 5923.8 5946.4 5884.8 6169.8 6170.8 6185.2 6187.0 4228.4 4266.7 4307.2 4341.4 4368.7 5843.6 5848.7 5987.5 5996.2 6060.5 5837.8 5857.0 5859.6 5866.9 5885.6 5657.3 5784.9 5825.6 5848.6 5865.9 5725.2 5816.7 5830.7 5831.6 5833.9 5727.2 5787.8 5812.0 5825.5 5855.5 5380.5 5674.1 5679.1 5683.2 5690.3 11:59:54 INFO - PROCESS | 29312 | 11:59:54 INFO - PROCESS | 29312 | [#5] yui.html Cycles:180 Average:17475.18 Median:25772.29 stddev:22971.16 (89.1%) stddev-sans-first:23001.40 11:59:54 INFO - PROCESS | 29312 | Values: 782.2 782.3 844.5 851.5 859.7 14538.8 14684.7 14693.8 15034.5 15197.7 13473.7 14562.2 14685.3 14815.4 14820.0 834.5 868.7 874.6 875.4 875.7 861.1 865.8 867.9 868.8 869.6 916.2 916.4 916.7 917.2 917.3 917.2 917.5 918.2 918.5 918.7 672.7 673.0 673.1 673.2 673.9 13801.6 13939.8 14076.2 14105.2 14181.7 11825.8 13004.2 13035.5 13215.0 13318.4 11050.9 11136.5 11195.8 11302.3 11392.9 3766.9 3818.8 3822.3 3844.8 3893.8 46855.3 48329.8 55953.6 64673.4 65363.3 11580.3 11776.0 11842.6 11882.2 11997.1 20611.8 20742.7 20755.8 20861.3 20902.5 8734.3 8813.9 8859.6 8919.4 8984.9 4559.1 4578.3 4702.3 4797.5 4958.9 3667.8 3793.3 3795.8 3797.3 3800.4 657.8 676.5 685.2 689.0 698.3 655.3 722.8 736.0 769.6 771.6 9081.8 9168.1 9400.9 9545.9 9942.0 547.7 574.8 577.2 649.9 652.1 4526.2 4553.7 4620.6 4689.3 4754.0 91565.5 92587.0 92893.0 94286.5 96365.0 49927.0 53125.5 54598.5 79430.0 80867.0 60974.7 70662.6 71050.6 71924.6 71961.6 9812.3 10409.2 10447.7 10565.9 10617.7 35542.0 37839.0 46985.5 47238.3 48262.3 59040.7 60903.7 65305.3 65700.7 65933.7 12267.2 12612.9 13094.2 13159.8 13203.3 12958.2 12989.5 13048.1 14596.9 15164.8 12549.5 13271.7 13393.5 13427.0 13584.7 12258.7 13019.7 13725.9 13765.2 13765.2 12163.7 12190.4 12476.4 12711.2 12721.9 10231.3 11339.7 11378.4 11434.6 11620.5 9070.2 10549.3 10561.8 10682.7 10928.0 11:59:54 INFO - PROCESS | 29312 | -------- Summary: end -------- 11:59:54 INFO - PROCESS | 29312 | 11:59:55 INFO - TEST-INFO | 29312: exit 0 11:59:55 INFO - TEST-OK | dromaeo_css | took 1114831ms 11:59:55 INFO - TEST-START | kraken 11:59:55 INFO - operating with platform_type : linux_ 11:59:55 INFO - Initialising browser for kraken test... 11:59:55 INFO - TEST-INFO | started process 29608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyyDagJ/profile http://localhost:59834/getInfo.html) 11:59:59 INFO - PROCESS | 29608 | __metrics Screen width/height:1600/1200 11:59:59 INFO - PROCESS | 29608 | colorDepth:24 11:59:59 INFO - PROCESS | 29608 | Browser inner width/height: 1024/697 11:59:59 INFO - PROCESS | 29608 | __metrics 11:59:59 INFO - PROCESS | 29608 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:59:59 INFO - PROCESS | 29608 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:00 INFO - PROCESS | 29608 | console.error: PushService: 12:00:00 INFO - PROCESS | 29608 | stateChangeProcessEnqueue: Error transitioning state 12:00:00 INFO - PROCESS | 29608 | UnknownError 12:00:01 INFO - TEST-INFO | 29608: exit 0 12:00:01 INFO - Browser initialized. 12:00:01 INFO - Running cycle 1/1 for kraken test... 12:00:01 INFO - TEST-INFO | started process 29703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyyDagJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:13 INFO - PROCESS | 29703 | RSS: Main: 142376960 12:00:13 INFO - PROCESS | 29703 | 12:00:15 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59834/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:16 INFO - PROCESS | 29703 | RSS: Main: 183394304 12:00:16 INFO - PROCESS | 29703 | 12:00:18 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59834/tests/kraken/driver.html?testName=audio-dft) 12:00:19 INFO - PROCESS | 29703 | RSS: Main: 173162496 12:00:19 INFO - PROCESS | 29703 | 12:00:22 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59834/tests/kraken/driver.html?testName=audio-fft) 12:00:22 INFO - PROCESS | 29703 | RSS: Main: 264306688 12:00:22 INFO - PROCESS | 29703 | 12:00:24 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59834/tests/kraken/driver.html?testName=audio-oscillator) 12:00:25 INFO - PROCESS | 29703 | RSS: Main: 170991616 12:00:25 INFO - PROCESS | 29703 | 12:00:27 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:28 INFO - PROCESS | 29703 | RSS: Main: 173072384 12:00:28 INFO - PROCESS | 29703 | 12:00:31 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59834/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:31 INFO - PROCESS | 29703 | RSS: Main: 210964480 12:00:31 INFO - PROCESS | 29703 | 12:00:35 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59834/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:35 INFO - PROCESS | 29703 | RSS: Main: 210427904 12:00:35 INFO - PROCESS | 29703 | 12:00:38 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59834/tests/kraken/driver.html?testName=json-parse-financial) 12:00:38 INFO - PROCESS | 29703 | RSS: Main: 208969728 12:00:38 INFO - PROCESS | 29703 | 12:00:40 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:40 INFO - PROCESS | 29703 | RSS: Main: 172027904 12:00:40 INFO - PROCESS | 29703 | 12:00:42 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:43 INFO - PROCESS | 29703 | RSS: Main: 179159040 12:00:43 INFO - PROCESS | 29703 | 12:00:45 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:45 INFO - PROCESS | 29703 | RSS: Main: 188547072 12:00:45 INFO - PROCESS | 29703 | 12:00:48 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:48 INFO - PROCESS | 29703 | RSS: Main: 197808128 12:00:48 INFO - PROCESS | 29703 | 12:00:51 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:52 INFO - PROCESS | 29703 | RSS: Main: 192761856 12:00:52 INFO - PROCESS | 29703 | 12:00:53 INFO - PROCESS | 29703 | Cycle 1(1): loaded http://localhost:59834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59834/tests/kraken/driver.html?testName=ai-astar) 12:00:54 INFO - PROCESS | 29703 | RSS: Main: 245686272 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | __start_tp_report 12:00:54 INFO - PROCESS | 29703 | _x_x_mozilla_page_load 12:00:54 INFO - PROCESS | 29703 | _x_x_mozilla_page_load_details 12:00:54 INFO - PROCESS | 29703 | |i|pagename|runs| 12:00:54 INFO - PROCESS | 29703 | |0;ai-astar;101;110;109;109;111;110;110;111;109;108 12:00:54 INFO - PROCESS | 29703 | |1;audio-beat-detection;148;121;116;160;119;119;122;121;146;118 12:00:54 INFO - PROCESS | 29703 | |2;audio-dft;159;160;160;160;164;160;161;161;160;161 12:00:54 INFO - PROCESS | 29703 | |3;audio-fft;74;74;75;116;76;76;76;74;97;76 12:00:54 INFO - PROCESS | 29703 | |4;audio-oscillator;82;81;120;83;83;83;101;83;82;114 12:00:54 INFO - PROCESS | 29703 | |5;imaging-gaussian-blur;116;117;116;117;117;118;116;117;117;116 12:00:54 INFO - PROCESS | 29703 | |6;imaging-darkroom;145;146;147;146;146;146;147;146;146;145 12:00:54 INFO - PROCESS | 29703 | |7;imaging-desaturate;84;84;84;85;84;84;85;84;84;84 12:00:54 INFO - PROCESS | 29703 | |8;json-parse-financial;52;51;55;52;52;54;52;51;52;52 12:00:54 INFO - PROCESS | 29703 | |9;json-stringify-tinderbox;58;60;59;59;60;59;59;60;60;60 12:00:54 INFO - PROCESS | 29703 | |10;stanford-crypto-aes;75;80;74;75;75;74;75;73;75;75 12:00:54 INFO - PROCESS | 29703 | |11;stanford-crypto-ccm;121;121;126;137;118;120;125;121;173;122 12:00:54 INFO - PROCESS | 29703 | |12;stanford-crypto-pbkdf2;155;156;155;157;158;159;157;158;155;161 12:00:54 INFO - PROCESS | 29703 | |13;stanford-crypto-sha256-iterative;63;62;67;63;62;61;65;65;64;60 12:00:54 INFO - PROCESS | 29703 | __end_tp_report 12:00:54 INFO - PROCESS | 29703 | __start_cc_report 12:00:54 INFO - PROCESS | 29703 | _x_x_mozilla_cycle_collect,1588 12:00:54 INFO - PROCESS | 29703 | __end_cc_report 12:00:54 INFO - PROCESS | 29703 | __startTimestamp1485979254116__endTimestamp 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | ------- Summary: start ------- 12:00:54 INFO - PROCESS | 29703 | Number of tests: 14 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.90 (2.6%) stddev-sans-first:1.00 12:00:54 INFO - PROCESS | 29703 | Values: 101.0 110.0 109.0 109.0 111.0 110.0 110.0 111.0 109.0 108.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:121.50 stddev:15.91 (13.1%) stddev-sans-first:15.32 12:00:54 INFO - PROCESS | 29703 | Values: 148.0 121.0 116.0 160.0 119.0 119.0 122.0 121.0 146.0 118.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 12:00:54 INFO - PROCESS | 29703 | Values: 159.0 160.0 160.0 160.0 164.0 160.0 161.0 161.0 160.0 161.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:13.99 (18.4%) stddev-sans-first:14.58 12:00:54 INFO - PROCESS | 29703 | Values: 74.0 74.0 75.0 116.0 76.0 76.0 76.0 74.0 97.0 76.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:14.86 (18.0%) stddev-sans-first:15.38 12:00:54 INFO - PROCESS | 29703 | Values: 82.0 81.0 120.0 83.0 83.0 83.0 101.0 83.0 82.0 114.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:00:54 INFO - PROCESS | 29703 | Values: 116.0 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 12:00:54 INFO - PROCESS | 29703 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 12:00:54 INFO - PROCESS | 29703 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.32 12:00:54 INFO - PROCESS | 29703 | Values: 52.0 51.0 55.0 52.0 52.0 54.0 52.0 51.0 52.0 52.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.53 12:00:54 INFO - PROCESS | 29703 | Values: 58.0 60.0 59.0 59.0 60.0 59.0 59.0 60.0 60.0 60.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.85 (2.5%) stddev-sans-first:1.96 12:00:54 INFO - PROCESS | 29703 | Values: 75.0 80.0 74.0 75.0 75.0 74.0 75.0 73.0 75.0 75.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:123.50 stddev:16.55 (13.4%) stddev-sans-first:17.33 12:00:54 INFO - PROCESS | 29703 | Values: 121.0 121.0 126.0 137.0 118.0 120.0 125.0 121.0 173.0 122.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:1.97 (1.3%) stddev-sans-first:1.94 12:00:54 INFO - PROCESS | 29703 | Values: 155.0 156.0 155.0 157.0 158.0 159.0 157.0 158.0 155.0 161.0 12:00:54 INFO - PROCESS | 29703 | 12:00:54 INFO - PROCESS | 29703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:2.10 (3.3%) stddev-sans-first:2.22 12:00:54 INFO - PROCESS | 29703 | Values: 63.0 62.0 67.0 63.0 62.0 61.0 65.0 65.0 64.0 60.0 12:00:54 INFO - PROCESS | 29703 | -------- Summary: end -------- 12:00:54 INFO - PROCESS | 29703 | 12:00:55 INFO - TEST-INFO | 29703: exit 0 12:00:55 INFO - TEST-OK | kraken | took 59868ms 12:00:55 INFO - SUITE-END | took 1174s 12:00:55 INFO - Completed test suite (00:19:34) 12:00:55 INFO - javascript benchmark 12:00:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.902262932112, 3287.950680739788, 3292.753043521736, 3318.950215746766, 3347.8995630131103, 5626.184203290521, 5696.287964004499, 5716.771329146829, 5728.541716662668, 5746.569007324451, 5644.943550564493, 5677.801276955297, 5710.1434784782305, 5717.971410142944, 5731.054376027961, 5153.56194723449, 5155.690658560479, 5183.248428977796, 5196.454372290912, 5226.08543504887, 5041.521055499722, 5050.924236136461, 5248.8425347239645, 5256.973715131419, 5266.81566145185, 5050.46970068143, 5055.898882022358, 5088.465711100337, 5152.665076770017, 5201.505856943584, 5263.657862238962, 5293.682379057269, 5295.0, 5301.416844147141, 5317.813876514303, 4999.525045120708, 5103.055934652101, 5182.222666600041, 5231.790728370861, 5240.895182096337, 5447.373552041527, 5477.67133971959, 5512.751926163292, 5525.751341189656, 5546.972265138689, 5926.940730592725, 5930.614510056876, 6011.57918945674, 6024.1566180734735, 6048.788292409745, 5876.08920617305, 6063.787767428119, 6074.787382441594, 6075.635461872302, 6093.146959425684, 5545.029619816556, 5567.4432556744005, 5629.043062679354, 5632.070708333079, 5667.263255776723, 6192.256929168439, 6209.223847019122, 6210.161628180228, 6213.099100630383, 6227.06594010902, 5731.770729170787, 5950.761969521257, 5955.553333499918, 5968.074948383008, 5969.880602387928, 5856.180134781134, 5984.910226346608, 6041.72812223451, 6048.395160483917, 6108.888502348253, 6078.665673387918, 6079.422454866781, 6081.27024757032, 6089.756409743649, 6130.264368275835, 6060.878782424327, 6112.083187521907, 6118.082287656798, 6121.84695382619, 6126.326104128542, 4575.22221222393, 4624.930626040612, 4630.21286381316, 4658.068386322749, 4686.976565117221, 4123.793810309473, 4146.958530414658, 4158.875233742992, 4160.687948403882, 4184.476940382452, 5831.0378787499585, 5847.502962248172, 5851.410599025615, 5852.736626851802, 5899.970500147472, 5884.235049443545, 5952.821415357546, 6002.459778619946, 6010.278766547955, 6047.0, 5795.913061304083, 5798.275215598051, 5800.129980502874, 5807.157962095473, 5819.127130930395, 4984.327115839315, 4993.90012199754, 4997.100521906092, 5001.149804533238, 5020.297158397827, 6131.3766666500715, 6140.078988151724, 6191.504679625529, 6255.0, 6322.873542529123, 6125.47964319526, 6139.8601398601395, 6140.653343927481, 6140.749659041455, 6147.047207682816, 6315.873682526416, 6353.618782873043, 6355.586886852525, 6356.237251529846, 6364.4908407326375, 5772.278465191851, 5781.768729250951, 5787.36339002701, 5980.820575382745, 5999.760009599567, 5938.465538101592, 6035.1249068885645, 6040.818775436744, 6058.303295120942, 6072.332043475302, 5853.473187413153, 5854.297484301911, 5858.297004359334, 5859.589828711949, 5870.14882841994, 5732.05421105513, 5857.941420585739, 5859.853503662443, 5862.267216597926, 5871.4715675589405, 5816.5055970243, 5839.941600583939, 5849.824505264849, 5914.142449344735, 5931.3178984417345, 5984.790532331347, 5985.191999080069, 5985.790497332572, 5990.131430942576, 5990.940090599038, 5636.098224284095, 5682.0, 5836.533077353886, 5839.795607153729, 5895.380984996514], "value": 5576.619329679689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.7586013874172, 621.0528943361373, 643.3566433566432, 665.304756529427, 670.1087553553774, 34340.4848927266, 37412.0, 37585.81207093964, 44349.7782511087, 44987.550124498746, 46529.0, 46993.295100573516, 47076.293855592194, 47209.29186062212, 47218.0, 8968.820623587524, 9137.954310228439, 9148.313876459259, 9157.221636160933, 9158.542072896362, 8442.324614030893, 8679.826403471927, 8687.348448866329, 8875.156860098312, 9014.819703605925, 10819.621313254038, 11082.16883733719, 11087.72280692981, 11374.203805733601, 11388.430578471085, 10920.453977301104, 10971.067459265973, 10986.670399888017, 10989.395583242918, 10992.615258465916, 10875.401852898087, 10936.671899843017, 10946.288491248122, 10948.781024379547, 10956.178286628534, 43435.78282108601, 43700.0, 43720.0, 43786.34320485195, 43789.56210437887, 3525.312564050011, 3613.94579081314, 3621.89134325968, 3625.29306785177, 3726.0312318797037, 32609.347813043845, 32611.0, 32751.836240818644, 33231.33537329264, 33258.66741332604, 4241.809118589671, 4469.1732029574305, 4495.505494395614, 4524.457065152203, 4554.339620755005, 343755.0, 346675.0, 347162.0, 347436.0, 348399.0, 64064.35935640677, 64315.0, 64596.354036459976, 64676.67661661661, 64770.676146618964, 39532.2093558133, 40597.39103913444, 40742.79628601897, 43268.783656082145, 43275.0, 17271.74092388615, 17426.738598921027, 17427.215775290144, 17429.738553921703, 17445.47663570095, 12570.497180112692, 12652.430640621194, 12653.36733163338, 12660.556880509139, 12674.429650665743, 18139.365122220657, 18488.815111848977, 19382.326888722862, 20264.898675506527, 21219.15123395078, 7608.163102058769, 7672.462927595015, 7682.389277039782, 7706.38348932084, 7854.096778870388, 922.1608336413831, 970.4904924914476, 997.5560875410517, 1023.5598692562121, 1081.5133190064503, 31603.0, 31901.840490797862, 32291.0, 32372.0, 32541.837290813393, 1077.5366592365358, 1125.4372813593204, 1147.4778975566264, 1153.210051114989, 1155.595541560464, 17243.568910777332, 17254.568635784206, 17297.221625026905, 17393.565160870825, 17405.477835664697, 151797.0, 154131.0, 536563.0, 538921.0, 540384.0, 57993.71003144957, 58437.0, 58598.0, 58657.0, 58669.0, 1369.472752990086, 1416.539624622002, 1417.7164567086625, 1432.0619993904008, 1451.2380999974887, 29979.535307787322, 31611.84194079015, 31781.682183177873, 31924.36151277008, 32063.519047213846, 51493.742531287106, 51514.0, 51973.22040169325, 51994.74002629962, 52211.216831748316, 346692.0, 347648.0, 347803.0, 348374.0, 350975.0, 29463.55804662889, 29879.253018674706, 31529.684703152674, 32713.672863271062, 38447.23105537818, 38919.221615568094, 46825.0, 48198.759006204746, 48494.515054849, 53523.25337226357, 41765.37351939784, 41823.37264940968, 42187.578124218366, 42663.7866810664, 43521.0, 40239.1952160961, 40896.0, 41102.79448602738, 42039.0, 42229.36655950225, 42283.0, 42843.785781070896, 42856.35715464208, 42914.78542607267, 43025.0, 36482.0, 38642.6135738639, 38652.6134738649, 38715.22569548649, 38801.223975519766, 28694.543727661945, 28862.929042536773, 28884.133475995754, 29059.418811623225, 29359.55960660549], "value": 20359.623505014377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.2720938705637, 411.4507132977474, 413.580216080678, 429.80229094616476, 442.2459706200926, 19242.0, 19831.801681983194, 20646.38060858173, 20928.0, 21088.789112108876, 20008.299709510135, 20073.698894516594, 20212.0, 20357.898210508927, 20359.185632574678, 5723.570732195081, 5980.6112602680905, 5988.520918326545, 5994.310654274771, 5998.310194327664, 5826.096954971986, 5840.766369345221, 5919.289685237777, 5939.020061689837, 6043.758249670008, 6163.753449862, 6175.444210021097, 6178.8455288617915, 6179.474744646711, 6181.690915454232, 6027.336992930796, 6165.075238714161, 6173.753049878, 6243.032329988859, 6251.156093927307, 5880.294364676266, 6063.939360606381, 6077.3314935357075, 6078.756849726005, 6078.908816367758, 14836.0, 15254.08475491474, 15256.38974441021, 15284.617884552865, 18315.542111447186, 2300.0454811253308, 2326.232343326698, 2396.628522579003, 2406.639004149374, 2442.7312995570474, 10745.247832651718, 10992.560297588087, 11018.173636977179, 11186.720331991684, 11538.365389903553, 1973.3685220729371, 2004.4888553418784, 2041.3365656161807, 2061.6704023002894, 2066.173530587762, 87115.56442217811, 88216.0, 89822.5508872458, 90624.5468772652, 91559.54220228923, 11480.368579728029, 11557.537698491966, 11658.358790266617, 11702.180847340604, 11908.0, 16821.32714691423, 16833.0, 16856.07291598974, 16868.325266989184, 16897.746533802, 8136.4711293766895, 8268.669253229924, 8297.709580164665, 8441.535715535581, 8606.26846718036, 7799.49303295284, 7826.0, 7949.165337639464, 8051.194880511902, 8091.878621820678, 4949.90100197994, 5111.156659151273, 5112.824050468413, 5120.564751996122, 5250.973745131327, 2093.36152473494, 2129.6960995453323, 2139.101577337522, 2152.677098435216, 2168.6313326734175, 903.4308385717088, 957.042957042957, 957.8419560772534, 1018.7096677446892, 1044.9707038567005, 19357.51606209856, 19395.127219275168, 19959.702619329986, 20427.080781364875, 20459.795402045787, 969.6266937229218, 983.537737263485, 985.6008316631776, 1020.8111499372492, 1037.818381783185, 10751.871053539422, 11333.603323883624, 11376.0, 11378.544858205745, 11409.543618255342, 461859.0, 466461.0, 499627.0, 503937.0, 506852.0, 72542.27457725356, 76097.61951190319, 94305.5284723572, 100163.49918250508, 102260.0, 971.577363846729, 1042.6663467690419, 1079.5411949921252, 1082.7239054041327, 1091.2961140064615, 17913.641727165643, 18312.359067432575, 18356.816431835512, 18569.44291671252, 18771.6245675083, 35817.82091089528, 39315.60684393119, 43315.35026974535, 45484.0, 45568.54431455776, 61977.0, 62345.06482402858, 62880.0, 64061.679691601246, 64386.35613643804, 8500.14998500145, 8828.558572071499, 9157.267418606361, 9210.585523651318, 9417.717468475958, 12725.363731813557, 13586.592402227554, 13632.182069075887, 13704.3833027516, 13935.930320348334, 11777.470013849568, 12096.939515302367, 12171.208871423329, 12201.633950981484, 12457.12800103984, 11791.587294444653, 11825.113116516124, 11886.108541859569, 12175.39123043862, 12371.257724536557, 11377.0, 11499.252548584314, 12247.75504489923, 12361.690957725768, 12456.065795065588, 8444.071152173134, 8647.654093836427, 8677.479351238946, 8695.913040869511, 8698.130186981505, 6200.782972596118, 10940.781184376427, 11113.44432778374, 11769.293842369485, 11925.344106073902], "value": 9469.159769948148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.9553313400595, 1531.0966529747448, 1697.4483292929792, 1751.0719318761062, 1803.7925638551553, 8500.872486912693, 9056.320775941815, 9064.682736104238, 9072.63709451622, 9076.455412675245, 7761.107472640648, 7963.641636126374, 8487.236148746611, 8692.43499172555, 8894.510801905893, 2498.4128729748495, 2498.9500209995836, 2519.533886231044, 2533.7086235082925, 2539.21284401836, 2498.3254521279246, 2523.2430270918744, 2541.8856151473137, 2544.8473091614565, 2569.5760199567144, 2533.8353007054575, 2538.2892790018823, 2540.7078186008566, 2543.9745602544017, 2546.6689330387026, 2456.2262887190477, 2461.729209786922, 2469.333280014395, 2470.789982851442, 2493.127405408111, 2498.1381423408893, 2513.0, 2522.4576716005963, 2534.8986040558357, 2536.4293034067373, 9142.405743626643, 9287.535623218879, 9334.20659243965, 9338.0, 9346.299027572959, 5625.38120806711, 5768.307803063617, 5771.220885180489, 5794.5943783935145, 5802.419758024206, 3577.266660334651, 3636.709063274932, 3660.213054193361, 3666.211764470652, 3747.5315585551807, 1206.7043574324346, 1207.420438189665, 1218.1533833985384, 1254.6737848159453, 1257.0132446029913, 12774.61676149717, 12782.360881955865, 12816.80774788379, 12820.487180512768, 12828.486860525567, 4806.375171227718, 5081.923771143436, 5151.665141765773, 5169.715665638426, 5183.45573714762, 10767.83848242277, 10772.676819695265, 10785.514651840529, 10793.460326983619, 10808.405537695502, 5693.800716974969, 5697.572682048863, 5723.685197314105, 5732.0, 5735.254416925856, 4637.233500151015, 4707.152712511781, 5175.094358487249, 5188.195829646335, 5270.420253772082, 4204.747715137101, 4304.849330273425, 4346.239408103569, 4370.2570563004365, 4403.603675669206, 1410.4358256697199, 1441.7260720463078, 1444.5738507140418, 1448.4713079725825, 1461.371610207621, 867.8784970104191, 980.1913421427352, 980.887197972228, 981.1954197557934, 983.6262220356219, 5796.3913789052385, 5836.970815145897, 5911.674857882857, 6022.307434644984, 6064.848378790565, 472.8155969296889, 480.28437627934125, 492.7339236812153, 496.9801207951714, 499.62528103922057, 4089.20260549196, 4089.8159582818844, 4127.9174416512105, 4171.186618609342, 4171.853985110507, 11131.499082541142, 11414.942925285486, 11477.36874471912, 11496.655100347003, 11547.480363383667, 11391.316521008766, 11396.829047564293, 11398.772024559463, 11409.714757130972, 11420.771584568261, 8119.188081191834, 8643.222110010129, 8654.697085601974, 8657.740267791976, 8658.0, 5969.701514924323, 6014.0, 6154.169187159855, 6168.290646575521, 6226.875462490634, 10192.439415832201, 10320.741981450525, 10364.792704145724, 10477.057064864199, 10485.633002844865, 10377.688669339932, 10420.791584168122, 10533.578656853946, 10656.360618362924, 10706.571737130738, 7525.887111693439, 7772.805679858049, 7864.4888082274465, 8234.0, 8364.456310339809, 8859.51272679983, 8919.687810926587, 8934.195922367018, 8941.284697224077, 8944.105589441004, 7481.364084052699, 7705.6147192641265, 7760.029996250469, 7772.650230739518, 7881.645325960231, 7494.425572033572, 7540.622968851645, 7556.319931206218, 7634.160242373224, 7792.727254546064, 7101.325374089453, 7126.574685062905, 7222.422206223595, 7231.819204519929, 7232.276772322725, 4934.309196712535, 5087.847364579068, 5105.668131571584, 5154.690718556899, 5242.18746094356, 5326.387465441524, 5382.0, 5387.138057910715, 5388.622796404214, 5521.641093328921], "value": 4768.561301943064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.98652053917846, 350.09500441359086, 351.3991075261303, 355.9555055618048, 356.08486190490436, 5511.5039646431815, 5529.198266251391, 5531.5298199653025, 5540.3628582713, 5571.832845014651, 5199.674083108812, 5255.789768409259, 5340.91988620171, 5376.1398176291805, 5446.459801129258, 4248.532661407243, 4263.616274535283, 4281.357796330544, 4286.721363111404, 4293.763842988635, 4277.294246449332, 4283.907603561103, 4295.377170310303, 4295.914081718363, 4306.504751953534, 4111.259973204822, 4244.851430199944, 4246.341817018351, 4253.893652658678, 4255.510616279121, 4233.661307095425, 4243.957560424403, 4244.915101697964, 4249.532551419341, 4268.125034367947, 3742.4760533525327, 3757.5490941086973, 3762.6454476388476, 3762.9059273518105, 3774.226283611853, 5085.644004919657, 5303.0, 5327.813526526553, 5336.0, 5339.652922560022, 4826.541478559531, 4859.1739404301, 4861.492937189447, 4873.0, 4880.658353915192, 5703.572232082611, 5706.0, 5707.543396528268, 5734.885302293973, 5746.339170995348, 4045.0785876708624, 4123.9175216495805, 4133.772642504661, 4147.0, 4148.336266197394, 5870.73581688825, 5923.4076592340425, 5923.644581325134, 5931.792387266468, 5937.70311484424, 4162.500499939966, 4173.123644034787, 4175.0188705654145, 4186.1418409226035, 4203.684723645739, 4158.6673066154635, 4212.873613791591, 4256.7445953242905, 4266.957330426718, 4282.528921818597, 4827.8551643450755, 4832.106060378841, 4852.587530059914, 4864.586510146606, 4874.2201247800185, 5765.711714414262, 5767.596268261265, 5778.162166485836, 5805.709714514257, 5812.0, 1396.5964205972932, 1435.2393231587275, 1437.8849692024612, 1437.9137251764719, 1446.5009571697747, 953.7281874665687, 978.9853152202722, 979.8775153105862, 981.65642025292, 993.1855878179967, 5378.354597448331, 5386.434424385383, 5386.48828361305, 5395.109806881821, 5395.433479484676, 5650.333151720252, 5664.405237450091, 5671.808920126737, 5683.346415162227, 5684.573656975744, 5159.329287192641, 5347.2781174541715, 5353.411124776271, 5399.57019341298, 5413.539849112791, 3016.909492715222, 3024.410240003222, 3024.9697503025127, 3028.8939887103847, 3037.924051898676, 5854.912176317359, 5857.238558987389, 5870.503021729432, 5884.823455296348, 5893.2044174035955, 5693.0, 6028.2766068072115, 6051.092336149525, 6053.818385448443, 6058.242719660043, 6089.817305480754, 6138.324784273726, 6146.416090471398, 6158.599691020159, 6188.409344048484, 5677.829665110054, 5936.376680448663, 5960.672163031075, 5990.221271234712, 6001.579099913182, 5834.737436815269, 5892.175095486721, 5909.168157870902, 5923.763049477972, 5946.402426531886, 5884.823455296348, 6169.753209871555, 6170.784022559189, 6185.165002724574, 6187.0, 4228.365745138254, 4266.741311313108, 4307.181635489373, 4341.413909122354, 4368.706429124735, 5843.561732870136, 5848.6783226921225, 5987.461128498456, 5996.160537524663, 6060.515158787198, 5837.824865254049, 5857.0, 5859.619124756877, 5866.853328666817, 5885.61743486672, 5657.264555607745, 5784.859601947306, 5825.592208545361, 5848.619839710575, 5865.94134058654, 5725.227094342377, 5816.680082595498, 5830.708464576669, 5831.620944638585, 5833.854153646193, 5727.1695604138, 5787.826365209051, 5811.970940145272, 5825.475707186373, 5855.502282306052, 5380.542653874308, 5674.092145256739, 5679.062954612443, 5683.232763576864, 5690.3456102548735], "value": 4375.186107396675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.2373186143507, 782.3350152370482, 844.539725849412, 851.4763420496392, 859.6905114158898, 14538.781918271221, 14684.706305873877, 14693.77959330611, 15034.548963531099, 15197.696046079072, 13473.730525389487, 14562.199079050648, 14685.265736713149, 14815.407383704665, 14820.036697614674, 834.5076404921095, 868.700298397052, 874.5933141089392, 875.3566128895256, 875.7285241575132, 861.1044513705739, 865.8398196333667, 867.8784970104191, 868.7784614923186, 869.5739087846941, 916.2120576304372, 916.4363916191561, 916.720400277915, 917.2111983694018, 917.3028498341275, 917.1882883647953, 917.5228880981851, 918.1874041473277, 918.4581097152678, 918.7197904639082, 672.6905623413236, 672.9596224226563, 673.1316601583951, 673.2325149329768, 673.8517526144241, 13801.585952421443, 13939.790903136462, 14076.155430674089, 14105.153690778587, 14181.716365672628, 11825.822612660817, 13004.21974681522, 13035.478580856754, 13215.0, 13318.352059925093, 11050.881111938446, 11136.498857551429, 11195.832062519068, 11302.265352752045, 11392.94303528477, 3766.9058273543105, 3818.751781134245, 3822.3310920588788, 3844.8462061517507, 3893.824777885002, 46855.29717054247, 48329.75835120802, 55953.601159970916, 64673.353266467675, 65363.34636653668, 11580.305181689126, 11776.0, 11842.585509507298, 11882.168248222715, 11997.100217483723, 20611.79388206099, 20742.688859667116, 20755.792442075384, 20861.269855554983, 20902.47743806417, 8734.344924130715, 8813.911860881437, 8859.64561417536, 8919.42023768453, 8984.8652270216, 4559.088182363541, 4578.313253012075, 4702.293705185591, 4797.544233297831, 4958.851234462972, 3667.779933203963, 3793.260314238752, 3795.772253664789, 3797.2974999625158, 3800.35393983018, 657.7927952694886, 676.4723515657795, 685.2222727204659, 688.9975086249596, 698.2947223304398, 655.3413819111762, 722.7506510253954, 735.9742409015658, 769.6344236487623, 771.5679219637021, 9081.81836363269, 9168.129027742354, 9400.858987115198, 9545.90454095464, 9942.0, 547.6932917566096, 574.8390450673818, 577.1688768173816, 649.8797722421367, 652.0740548421159, 4526.23054080807, 4553.749543775058, 4620.630349572026, 4689.273162659793, 4753.952460475351, 91565.54217228871, 92587.0, 92893.0, 94286.52856735673, 96365.0, 49927.0, 53125.46874531283, 54598.454015460135, 79430.0, 80867.0, 60974.695126524086, 70662.64668676624, 71050.64474677593, 71924.64037679778, 71961.64019179871, 9812.26408019387, 10409.1672666185, 10447.738806529898, 10565.894341056492, 10617.734556636145, 35542.0, 37839.0, 46985.53014469812, 47238.29142562933, 48262.27606585974, 59040.704796475744, 60903.69548152231, 65305.34694652993, 65700.67149664412, 65933.67033164804, 12267.202631828903, 12612.936935315265, 13094.214347139203, 13159.802602960772, 13203.273819939996, 12958.157719748186, 12989.545365912149, 13048.086633935913, 14596.85403145955, 15164.848351516344, 12549.498020079094, 13271.734565308832, 13393.464261429823, 13427.0, 13584.660383490493, 12258.693532661398, 13019.739605208033, 13725.931370343083, 13765.174089554659, 13765.174089554659, 12163.695907602027, 12190.390480476119, 12476.438560264629, 12711.173773704679, 12721.872781272068, 10231.28381013322, 11339.716507087389, 11378.43107844621, 11434.599789007345, 11620.477078531318, 9070.229030532215, 10549.261551691308, 10561.788764224519, 10682.73293167677, 10928.0], "value": 7237.457172273069, "unit": "score"}], "name": "dromaeo_css", "value": 7386.025182074504, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 111.0, 109.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 116.0, 160.0, 119.0, 119.0, 122.0, 121.0, 146.0, 118.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 164.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 116.0, 76.0, 76.0, 76.0, 74.0, 97.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 120.0, 83.0, 83.0, 83.0, 101.0, 83.0, 82.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 55.0, 52.0, 52.0, 54.0, 52.0, 51.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 74.0, 75.0, 75.0, 74.0, 75.0, 73.0, 75.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 126.0, 137.0, 118.0, 120.0, 125.0, 121.0, 173.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 157.0, 158.0, 159.0, 157.0, 158.0, 155.0, 161.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 67.0, 63.0, 62.0, 61.0, 65.0, 65.0, 64.0, 60.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1453.4, "alertThreshold": 2.0}]} 12:00:55 INFO - Return code: 0 12:00:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:55 INFO - # TBPL SUCCESS # 12:00:55 INFO - Running post-action listener: _resource_record_post_action 12:00:55 INFO - [mozharness: 2017-02-01 20:00:55.419220Z] Finished run-tests step (success) 12:00:55 INFO - Running post-run listener: _resource_record_post_run 12:00:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 49152; Write bytes: 323575808; Read time: 16; Write time: 287148 12:00:55 INFO - TinderboxPrint: CPU usage
12.9% 12:00:55 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 16 12:00:55 INFO - TinderboxPrint: I/O write bytes / time
323,575,808 / 287,148 12:00:55 INFO - TinderboxPrint: CPU idle
8,262.9 (87.0%) 12:00:55 INFO - TinderboxPrint: CPU user
1,184.5 (12.5%) 12:00:55 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:55 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 106414080; Read time: 0; Write time: 130244 12:00:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 49152; Write bytes: 217161728; Read time: 16; Write time: 156904 12:00:56 INFO - Running post-run listener: _upload_blobber_files 12:00:56 INFO - Blob upload gear active. 12:00:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:56 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 12:00:56 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:00:56 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:00:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:59 INFO - (blobuploader) - INFO - Done attempting. 12:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:00 INFO - (blobuploader) - INFO - Done attempting. 12:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:01 INFO - (blobuploader) - INFO - Done attempting. 12:01:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:01 INFO - Return code: 0 12:01:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f780a2c605f176a1afc96019e81159d8143be548512e698290e907780d9a43e31308b40da71d63bbdcc4c3826355d68b94515ee7741b9f2ac2d8f67b069030bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dab27f2c17ede7fcc8c8147345e88a170555a39f21685a6dd6717698515ee72b5fff502e8338fb5429a670b5d19519d531d739f2cfe4a3d9ae0843acffbb0ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f743dbd473cd9bbe02fa002445f0dd9a9cde05f795ad92a1664b03d2968188e3a866f5b2ab91691d55007ac06b02bd47f179d529c61c58a64b4b0023016fc841"} 12:01:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:01 INFO - Contents: 12:01:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f780a2c605f176a1afc96019e81159d8143be548512e698290e907780d9a43e31308b40da71d63bbdcc4c3826355d68b94515ee7741b9f2ac2d8f67b069030bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dab27f2c17ede7fcc8c8147345e88a170555a39f21685a6dd6717698515ee72b5fff502e8338fb5429a670b5d19519d531d739f2cfe4a3d9ae0843acffbb0ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f743dbd473cd9bbe02fa002445f0dd9a9cde05f795ad92a1664b03d2968188e3a866f5b2ab91691d55007ac06b02bd47f179d529c61c58a64b4b0023016fc841"} 12:01:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:01 INFO - Copying logs to upload dir... 12:01:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.333846 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-01 12:01:00.968762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 12:01:00.972283) ========= 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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f780a2c605f176a1afc96019e81159d8143be548512e698290e907780d9a43e31308b40da71d63bbdcc4c3826355d68b94515ee7741b9f2ac2d8f67b069030bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dab27f2c17ede7fcc8c8147345e88a170555a39f21685a6dd6717698515ee72b5fff502e8338fb5429a670b5d19519d531d739f2cfe4a3d9ae0843acffbb0ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f743dbd473cd9bbe02fa002445f0dd9a9cde05f795ad92a1664b03d2968188e3a866f5b2ab91691d55007ac06b02bd47f179d529c61c58a64b4b0023016fc841"} build_url:https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/dPfyrJoeQQCbeN4uMaPBxA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f780a2c605f176a1afc96019e81159d8143be548512e698290e907780d9a43e31308b40da71d63bbdcc4c3826355d68b94515ee7741b9f2ac2d8f67b069030bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dab27f2c17ede7fcc8c8147345e88a170555a39f21685a6dd6717698515ee72b5fff502e8338fb5429a670b5d19519d531d739f2cfe4a3d9ae0843acffbb0ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f743dbd473cd9bbe02fa002445f0dd9a9cde05f795ad92a1664b03d2968188e3a866f5b2ab91691d55007ac06b02bd47f179d529c61c58a64b4b0023016fc841"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 12:01:01.004236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 12:01:01.004587) ========= 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=af724c981e2a0f424dbabf99000001e7-1485978027.417134-1262358203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 12:01:01.087977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 12:01:01.088308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 12:01:01.088632) ========= ========= Total master_lag: 0.17 =========